Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-master/958/

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

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

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


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

Error Message:
Captured an uncaught exception in thread: Thread[id=57254, 
name=testExecutor-6007-thread-10, state=RUNNABLE, 
group=TGRP-UnloadDistributedZkTest]

Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught 
exception in thread: Thread[id=57254, name=testExecutor-6007-thread-10, 
state=RUNNABLE, group=TGRP-UnloadDistributedZkTest]
Caused by: java.lang.RuntimeException: 
org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting 
response from server at: http://127.0.0.1:42425
        at __randomizedtesting.SeedInfo.seed([5DE653939C2C8B2C]:0)
        at 
org.apache.solr.cloud.BasicDistributedZkTest.lambda$createCores$3(BasicDistributedZkTest.java:583)
        at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$6(ExecutorUtil.java:229)
        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
        at java.lang.Thread.run(Thread.java:745)
Caused by: org.apache.solr.client.solrj.SolrServerException: Timeout occured 
while waiting response from server at: http://127.0.0.1:42425
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:588)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:241)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:230)
        at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219)
        at 
org.apache.solr.cloud.BasicDistributedZkTest.lambda$createCores$3(BasicDistributedZkTest.java:581)
        ... 4 more
Caused by: java.net.SocketTimeoutException: Read timed out
        at java.net.SocketInputStream.socketRead0(Native Method)
        at java.net.SocketInputStream.socketRead(SocketInputStream.java:116)
        at java.net.SocketInputStream.read(SocketInputStream.java:170)
        at java.net.SocketInputStream.read(SocketInputStream.java:141)
        at 
org.apache.http.impl.io.AbstractSessionInputBuffer.fillBuffer(AbstractSessionInputBuffer.java:160)
        at 
org.apache.http.impl.io.SocketInputBuffer.fillBuffer(SocketInputBuffer.java:84)
        at 
org.apache.http.impl.io.AbstractSessionInputBuffer.readLine(AbstractSessionInputBuffer.java:273)
        at 
org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:140)
        at 
org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:57)
        at 
org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:261)
        at 
org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:283)
        at 
org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:251)
        at 
org.apache.http.impl.conn.ManagedClientConnectionImpl.receiveResponseHeader(ManagedClientConnectionImpl.java:197)
        at 
org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:272)
        at 
org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:124)
        at 
org.apache.http.impl.client.DefaultRequestDirector.tryExecute(DefaultRequestDirector.java:685)
        at 
org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:487)
        at 
org.apache.http.impl.client.AbstractHttpClient.doExecute(AbstractHttpClient.java:882)
        at 
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82)
        at 
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:107)
        at 
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:55)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:482)
        ... 8 more




Build Log:
[...truncated 11873 lines...]
   [junit4] Suite: org.apache.solr.cloud.UnloadDistributedZkTest
   [junit4]   2> Creating dataDir: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J1/temp/solr.cloud.UnloadDistributedZkTest_5DE653939C2C8B2C-001/init-core-data-001
   [junit4]   2> 2527031 INFO  
(SUITE-UnloadDistributedZkTest-seed#[5DE653939C2C8B2C]-worker) [    ] 
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /
   [junit4]   2> 2527034 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 2527034 INFO  (Thread-50083) [    ] o.a.s.c.ZkTestServer 
client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 2527034 INFO  (Thread-50083) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 2527134 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.ZkTestServer start zk server on port:35128
   [junit4]   2> 2527134 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 2527160 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2527169 INFO  (zkCallback-1433-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@19af8267 
name:ZooKeeperConnection Watcher:127.0.0.1:35128 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2527169 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2527169 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 2527170 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 2527173 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 2527178 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2527180 INFO  (zkCallback-1434-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@77d768ee 
name:ZooKeeperConnection Watcher:127.0.0.1:35128/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2527180 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2527181 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 2527181 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/collection1
   [junit4]   2> 2527185 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/collection1/shards
   [junit4]   2> 2527189 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection
   [junit4]   2> 2527191 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/shards
   [junit4]   2> 2527192 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
 to /configs/conf1/solrconfig.xml
   [junit4]   2> 2527192 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.xml
   [junit4]   2> 2527195 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/src/test-files/solr/collection1/conf/schema.xml
 to /configs/conf1/schema.xml
   [junit4]   2> 2527195 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/schema.xml
   [junit4]   2> 2527198 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
 to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 2527199 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.c.SolrZkClient makePath: 
/configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 2527200 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
 to /configs/conf1/stopwords.txt
   [junit4]   2> 2527200 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/stopwords.txt
   [junit4]   2> 2527201 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/src/test-files/solr/collection1/conf/protwords.txt
 to /configs/conf1/protwords.txt
   [junit4]   2> 2527202 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/protwords.txt
   [junit4]   2> 2527203 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/src/test-files/solr/collection1/conf/currency.xml
 to /configs/conf1/currency.xml
   [junit4]   2> 2527203 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/currency.xml
   [junit4]   2> 2527204 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
 to /configs/conf1/enumsConfig.xml
   [junit4]   2> 2527204 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/enumsConfig.xml
   [junit4]   2> 2527206 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
 to /configs/conf1/open-exchange-rates.json
   [junit4]   2> 2527207 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/open-exchange-rates.json
   [junit4]   2> 2527210 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
 to /configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 2527210 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 2527212 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
 to /configs/conf1/old_synonyms.txt
   [junit4]   2> 2527212 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/old_synonyms.txt
   [junit4]   2> 2527215 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
 to /configs/conf1/synonyms.txt
   [junit4]   2> 2527215 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/synonyms.txt
   [junit4]   2> 2527344 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J1/temp/solr.cloud.UnloadDistributedZkTest_5DE653939C2C8B2C-001/control-001/cores/collection1
   [junit4]   2> 2527346 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.e.j.s.Server jetty-9.3.6.v20151106
   [junit4]   2> 2527368 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@147c2cd1{/,null,AVAILABLE}
   [junit4]   2> 2527369 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.e.j.s.ServerConnector Started 
ServerConnector@45c031a7{HTTP/1.1,[http/1.1]}{127.0.0.1:57948}
   [junit4]   2> 2527369 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.e.j.s.Server Started @2531090ms
   [junit4]   2> 2527369 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J1/temp/solr.cloud.UnloadDistributedZkTest_5DE653939C2C8B2C-001/tempDir-001/control/data,
 hostContext=/, hostPort=57948, 
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J1/temp/solr.cloud.UnloadDistributedZkTest_5DE653939C2C8B2C-001/control-001/cores}
   [junit4]   2> 2527370 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): 
sun.misc.Launcher$AppClassLoader@4e0e2f2a
   [junit4]   2> 2527370 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J1/temp/solr.cloud.UnloadDistributedZkTest_5DE653939C2C8B2C-001/control-001'
   [junit4]   2> 2527370 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 2527370 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find 
system property or JNDI)
   [junit4]   2> 2527370 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 2527371 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2527373 INFO  (zkCallback-1435-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@33a1208e 
name:ZooKeeperConnection Watcher:127.0.0.1:35128/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2527373 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2527373 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 2527374 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in 
ZooKeeper)
   [junit4]   2> 2527374 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J1/temp/solr.cloud.UnloadDistributedZkTest_5DE653939C2C8B2C-001/control-001/solr.xml
   [junit4]   2> 2527380 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.CorePropertiesLocator Config-defined core root directory: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J1/temp/solr.cloud.UnloadDistributedZkTest_5DE653939C2C8B2C-001/control-001/cores
   [junit4]   2> 2527380 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.CoreContainer New CoreContainer 1813833528
   [junit4]   2> 2527380 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.CoreContainer Loading cores into CoreContainer 
[instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J1/temp/solr.cloud.UnloadDistributedZkTest_5DE653939C2C8B2C-001/control-001]
   [junit4]   2> 2527380 WARN  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.CoreContainer Couldn't add files from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J1/temp/solr.cloud.UnloadDistributedZkTest_5DE653939C2C8B2C-001/control-001/lib
 to classpath: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J1/temp/solr.cloud.UnloadDistributedZkTest_5DE653939C2C8B2C-001/control-001/lib
   [junit4]   2> 2527381 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
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> 2527382 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 2527382 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 2527382 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.l.LogWatcher Registering Log Listener [Log4j 
(org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 2527382 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:35128/solr
   [junit4]   2> 2527382 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.ZkController zkHost includes chroot
   [junit4]   2> 2527382 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 2527389 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2527390 INFO  (zkCallback-1438-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@14746d40 
name:ZooKeeperConnection Watcher:127.0.0.1:35128 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2527390 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2527390 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 2527404 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [n:127.0.0.1:57948_ 
   ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2527411 INFO  
(zkCallback-1439-thread-1-processing-n:127.0.0.1:57948_) [n:127.0.0.1:57948_    
] o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@48518f78 
name:ZooKeeperConnection Watcher:127.0.0.1:35128/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2527412 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [n:127.0.0.1:57948_ 
   ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2527413 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [n:127.0.0.1:57948_ 
   ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue
   [junit4]   2> 2527417 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [n:127.0.0.1:57948_ 
   ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work
   [junit4]   2> 2527421 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [n:127.0.0.1:57948_ 
   ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running
   [junit4]   2> 2527423 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [n:127.0.0.1:57948_ 
   ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed
   [junit4]   2> 2527425 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [n:127.0.0.1:57948_ 
   ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure
   [junit4]   2> 2527426 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [n:127.0.0.1:57948_ 
   ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 2527429 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [n:127.0.0.1:57948_ 
   ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 2527430 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [n:127.0.0.1:57948_ 
   ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 2527431 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [n:127.0.0.1:57948_ 
   ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 2527432 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [n:127.0.0.1:57948_ 
   ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 2527434 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [n:127.0.0.1:57948_ 
   ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 2527436 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [n:127.0.0.1:57948_ 
   ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect
   [junit4]   2> 2527437 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [n:127.0.0.1:57948_ 
   ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election
   [junit4]   2> 2527438 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [n:127.0.0.1:57948_ 
   ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 2527438 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [n:127.0.0.1:57948_ 
   ] o.a.s.c.LeaderElector Joined leadership election with path: 
/overseer_elect/election/95537501088514052-127.0.0.1:57948_-n_0000000000
   [junit4]   2> 2527438 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [n:127.0.0.1:57948_ 
   ] o.a.s.c.OverseerElectionContext I am going to be the leader 
127.0.0.1:57948_
   [junit4]   2> 2527438 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [n:127.0.0.1:57948_ 
   ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader
   [junit4]   2> 2527439 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [n:127.0.0.1:57948_ 
   ] o.a.s.c.Overseer Overseer 
(id=95537501088514052-127.0.0.1:57948_-n_0000000000) starting
   [junit4]   2> 2527441 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [n:127.0.0.1:57948_ 
   ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work
   [junit4]   2> 2527450 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [n:127.0.0.1:57948_ 
   ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting 
OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 
autoReplicaFailoverWaitAfterExpiration=10000 
autoReplicaFailoverBadNodeExpiration=60000
   [junit4]   2> 2527452 INFO  
(OverseerCollectionConfigSetProcessor-95537501088514052-127.0.0.1:57948_-n_0000000000)
 [n:127.0.0.1:57948_    ] o.a.s.c.OverseerTaskProcessor Process current queue 
of overseer operations
   [junit4]   2> 2527453 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [n:127.0.0.1:57948_ 
   ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:57948_
   [junit4]   2> 2527453 INFO  
(OverseerStateUpdate-95537501088514052-127.0.0.1:57948_-n_0000000000) 
[n:127.0.0.1:57948_    ] o.a.s.c.Overseer Starting to work on the main queue
   [junit4]   2> 2527454 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [n:127.0.0.1:57948_ 
   ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:57948_
   [junit4]   2> 2527456 INFO  
(zkCallback-1439-thread-1-processing-n:127.0.0.1:57948_) [n:127.0.0.1:57948_    
] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live 
nodes size: [0])
   [junit4]   2> 2527467 INFO  
(zkCallback-1439-thread-1-processing-n:127.0.0.1:57948_) [n:127.0.0.1:57948_    
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 2527473 INFO  
(OverseerStateUpdate-95537501088514052-127.0.0.1:57948_-n_0000000000) 
[n:127.0.0.1:57948_    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (1)
   [junit4]   2> 2527474 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [n:127.0.0.1:57948_ 
   ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for 
authorization module.
   [junit4]   2> 2527475 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [n:127.0.0.1:57948_ 
   ] o.a.s.c.CoreContainer No authentication plugin used.
   [junit4]   2> 2527476 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [n:127.0.0.1:57948_ 
   ] o.a.s.c.CorePropertiesLocator Looking for core definitions underneath 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J1/temp/solr.cloud.UnloadDistributedZkTest_5DE653939C2C8B2C-001/control-001/cores
   [junit4]   2> 2527477 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [n:127.0.0.1:57948_ 
   ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection1, 
config=solrconfig.xml, transient=false, schema=schema.xml, loadOnStartup=true, 
configSetProperties=configsetprops.json, collection=control_collection, 
coreNodeName=, dataDir=data/, shard=}
   [junit4]   2> 2527477 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [n:127.0.0.1:57948_ 
   ] o.a.s.c.CorePropertiesLocator Found core collection1 in 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J1/temp/solr.cloud.UnloadDistributedZkTest_5DE653939C2C8B2C-001/control-001/cores/collection1
   [junit4]   2> 2527477 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [n:127.0.0.1:57948_ 
   ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
   [junit4]   2> 2527486 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ c:control_collection   x:collection1] o.a.s.c.ZkController 
publishing state=down
   [junit4]   2> 2527487 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ c:control_collection   x:collection1] o.a.s.c.ZkController 
numShards not found on descriptor - reading it from system property
   [junit4]   2> 2527493 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ c:control_collection   x:collection1] o.a.s.c.ZkController 
look for our core node name
   [junit4]   2> 2527495 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [n:127.0.0.1:57948_ 
   ] o.a.s.s.SolrDispatchFilter 
user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J1
   [junit4]   2> 2527495 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [n:127.0.0.1:57948_ 
   ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
   [junit4]   2> 2527495 INFO  
(OverseerStateUpdate-95537501088514052-127.0.0.1:57948_-n_0000000000) 
[n:127.0.0.1:57948_    ] 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:57948";,
   [junit4]   2>   "node_name":"127.0.0.1:57948_",
   [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> 2527496 INFO  
(OverseerStateUpdate-95537501088514052-127.0.0.1:57948_-n_0000000000) 
[n:127.0.0.1:57948_    ] 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:57948";,
   [junit4]   2>   "node_name":"127.0.0.1:57948_",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":null,
   [junit4]   2>   "collection":"control_collection",
   [junit4]   2>   "operation":"state"}
   [junit4]   2> 2527496 INFO  
(OverseerStateUpdate-95537501088514052-127.0.0.1:57948_-n_0000000000) 
[n:127.0.0.1:57948_    ] o.a.s.c.o.ClusterStateMutator building a new cName: 
control_collection
   [junit4]   2> 2527497 INFO  
(OverseerStateUpdate-95537501088514052-127.0.0.1:57948_-n_0000000000) 
[n:127.0.0.1:57948_    ] o.a.s.c.o.ReplicaMutator Assigning new node to shard 
shard=shard1
   [junit4]   2> 2527498 INFO  
(zkCallback-1439-thread-1-processing-n:127.0.0.1:57948_) [n:127.0.0.1:57948_    
] 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> 2528493 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ c:control_collection   x:collection1] o.a.s.c.ZkController 
waiting to find shard id in clusterstate for collection1
   [junit4]   2> 2528493 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ c:control_collection   x:collection1] o.a.s.c.ZkController 
Check for collection zkNode:control_collection
   [junit4]   2> 2528494 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ c:control_collection   x:collection1] o.a.s.c.ZkController 
Collection zkNode exists
   [junit4]   2> 2528494 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ c:control_collection   x:collection1] 
o.a.s.c.c.ZkStateReader Load collection config from: 
[/collections/control_collection]
   [junit4]   2> 2528495 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ c:control_collection   x:collection1] 
o.a.s.c.c.ZkStateReader path=[/collections/control_collection] 
[configName]=[conf1] specified config exists in ZooKeeper
   [junit4]   2> 2528495 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ c:control_collection   x:collection1] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J1/temp/solr.cloud.UnloadDistributedZkTest_5DE653939C2C8B2C-001/control-001/cores/collection1'
   [junit4]   2> 2528495 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ c:control_collection   x:collection1] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 2528495 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ c:control_collection   x:collection1] 
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find 
system property or JNDI)
   [junit4]   2> 2528497 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ c:control_collection   x:collection1] o.a.s.c.Config loaded 
config solrconfig.xml with version 0 
   [junit4]   2> 2528502 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ c:control_collection   x:collection1] o.a.s.c.SolrConfig 
current version of requestparams : -1
   [junit4]   2> 2528505 WARN  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ c:control_collection   x:collection1] o.a.s.c.Config 
Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> 
instead.
   [junit4]   2> 2528506 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ c:control_collection   x:collection1] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 2528515 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ c:control_collection   x:collection1] o.a.s.c.SolrConfig 
Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 2528521 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ c:control_collection   x:collection1] o.a.s.s.IndexSchema 
[collection1] Schema name=test
   [junit4]   2> 2528638 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ c:control_collection   x:collection1] 
o.a.s.s.OpenExchangeRatesOrgProvider Initialized with 
rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 2528644 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ c:control_collection   x:collection1] o.a.s.s.IndexSchema 
default search field in schema is text
   [junit4]   2> 2528645 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ c:control_collection   x:collection1] o.a.s.s.IndexSchema 
unique key field: id
   [junit4]   2> 2528653 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ c:control_collection   x:collection1] 
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 2528655 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ c:control_collection   x:collection1] 
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 2528657 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ c:control_collection   x:collection1] 
o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from 
open-exchange-rates.json
   [junit4]   2> 2528657 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ c:control_collection   x:collection1] 
o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from 
open-exchange-rates.json
   [junit4]   2> 2528659 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ 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-master/solr/build/solr-core/test/J1
   [junit4]   2> 2528659 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ c:control_collection   x:collection1] o.a.s.c.CoreContainer 
Creating SolrCore 'collection1' using configuration from collection 
control_collection
   [junit4]   2> 2528659 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 2528659 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ 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-master/solr/build/solr-core/test/J1/temp/solr.cloud.UnloadDistributedZkTest_5DE653939C2C8B2C-001/control-001/cores/collection1],
 
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J1/temp/solr.cloud.UnloadDistributedZkTest_5DE653939C2C8B2C-001/control-001/cores/collection1/data/]
   [junit4]   2> 2528660 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ 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@670671ce
   [junit4]   2> 2528660 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ 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-master/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J1/temp/solr.cloud.UnloadDistributedZkTest_5DE653939C2C8B2C-001/control-001/cores/collection1/data
   [junit4]   2> 2528661 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ 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-master/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J1/temp/solr.cloud.UnloadDistributedZkTest_5DE653939C2C8B2C-001/control-001/cores/collection1/data/index/
   [junit4]   2> 2528661 WARN  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ 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-master/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J1/temp/solr.cloud.UnloadDistributedZkTest_5DE653939C2C8B2C-001/control-001/cores/collection1/data/index'
 doesn't exist. Creating new index...
   [junit4]   2> 2528661 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ 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-master/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J1/temp/solr.cloud.UnloadDistributedZkTest_5DE653939C2C8B2C-001/control-001/cores/collection1/data/index
   [junit4]   2> 2528661 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ 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=42, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=1.607421875, noCFSRatio=1.0]
   [junit4]   2> 2528662 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@4ded2a12 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@701aa1c2),segFN=segments_1,generation=1}
   [junit4]   2> 2528662 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 2528670 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain 
"nodistrib"
   [junit4]   2> 2528670 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain 
"dedupe"
   [junit4]   2> 2528671 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.p.UpdateRequestProcessorChain inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 2528671 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain 
"stored_sig"
   [junit4]   2> 2528671 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.p.UpdateRequestProcessorChain inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 2528671 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ 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> 2528671 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ 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> 2528671 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ 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> 2528671 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ 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> 2528671 WARN  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ 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> 2528672 INFO  
(OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:57948_ 
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-master/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J1/temp/solr.cloud.UnloadDistributedZkTest_5DE653939C2C8B2C-001/control-001/cores/collection1/data/
   [junit4]   2> 2528672 WARN  
(OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:57948_ 
c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.DirectoryFactory 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J1/temp/solr.cloud.UnloadDistributedZkTest_5DE653939C2C8B2C-001/control-001/cores/collection1/data/
 does not point to a valid data directory; skipping clean-up of old index 
directories.
   [junit4]   2> 2528674 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 2528675 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 2528676 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 2528677 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 2528681 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.RequestHandlers Registered paths: 
/admin/mbeans,standard,/dump,/update/csv,/sql,/update/json/docs,/admin/luke,/export,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/stream,/schema,/admin/plugins,/admin/logging,/update/json,/admin/ping,/admin/threads,/update,/admin/file
   [junit4]   2> 2528681 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ 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> 2528681 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ 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> 2528681 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ 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> 2528682 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2528682 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2528683 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ 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=38, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=1.0]
   [junit4]   2> 2528683 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@4ded2a12 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@701aa1c2),segFN=segments_1,generation=1}
   [junit4]   2> 2528683 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 2528683 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@5b829b35[collection1] main]
   [junit4]   2> 2528683 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ 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> 2528684 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ 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> 2528684 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ 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> 2528685 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf1
   [junit4]   2> 2528685 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.r.RestManager Initializing RestManager with initArgs: {}
   [junit4]   2> 2528685 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ 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> 2528685 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ 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> 2528685 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ 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> 2528685 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.r.RestManager Initializing 0 registered ManagedResources
   [junit4]   2> 2528685 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 2528686 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ 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> 2528686 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ 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> 2528686 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ 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> 2528686 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ 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 1528600019140083712
   [junit4]   2> 2528688 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ 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 
1528600019140083712
   [junit4]   2> 2528688 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.ZkController watch zkdir /configs/conf1
   [junit4]   2> 2528689 INFO  
(coreLoadExecutor-5929-thread-1-processing-n:127.0.0.1:57948_) 
[n:127.0.0.1:57948_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.CoreContainer registering core: collection1
   [junit4]   2> 2528690 INFO  
(searcherExecutor-5930-thread-1-processing-n:127.0.0.1:57948_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:57948_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore 
[collection1] Registered new searcher Searcher@5b829b35[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2528690 INFO  
(coreZkRegister-5923-thread-1-processing-n:127.0.0.1:57948_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:57948_ 
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:57948 
collection:control_collection shard:shard1
   [junit4]   2> 2528690 INFO  
(coreZkRegister-5923-thread-1-processing-n:127.0.0.1:57948_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:57948_ 
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> 2528693 INFO  
(coreZkRegister-5923-thread-1-processing-n:127.0.0.1:57948_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:57948_ 
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/95537501088514052-core_node1-n_0000000000
   [junit4]   2> 2528694 INFO  
(coreZkRegister-5923-thread-1-processing-n:127.0.0.1:57948_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:57948_ 
c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.ShardLeaderElectionContext Running the leader process for shard=shard1 
and weAreReplacement=false and leaderVoteWait=180000
   [junit4]   2> 2528695 INFO  
(OverseerStateUpdate-95537501088514052-127.0.0.1:57948_-n_0000000000) 
[n:127.0.0.1:57948_    ] 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> 2528696 INFO  
(coreZkRegister-5923-thread-1-processing-n:127.0.0.1:57948_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:57948_ 
c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 2528696 INFO  
(coreZkRegister-5923-thread-1-processing-n:127.0.0.1:57948_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:57948_ 
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> 2528696 INFO  
(coreZkRegister-5923-thread-1-processing-n:127.0.0.1:57948_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:57948_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy 
Sync replicas to http://127.0.0.1:57948/collection1/
   [junit4]   2> 2528697 INFO  
(coreZkRegister-5923-thread-1-processing-n:127.0.0.1:57948_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:57948_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy 
Sync Success - now sync replicas to me
   [junit4]   2> 2528697 INFO  
(coreZkRegister-5923-thread-1-processing-n:127.0.0.1:57948_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:57948_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy 
http://127.0.0.1:57948/collection1/ has no replicas
   [junit4]   2> 2528698 INFO  
(coreZkRegister-5923-thread-1-processing-n:127.0.0.1:57948_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:57948_ 
c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/leaders/shard1
   [junit4]   2> 2528699 INFO  
(coreZkRegister-5923-thread-1-processing-n:127.0.0.1:57948_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:57948_ 
c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node 
/collections/control_collection/leaders/shard1/leader after winning as 
/collections/control_collection/leader_elect/shard1/election/95537501088514052-core_node1-n_0000000000
   [junit4]   2> 2528701 INFO  
(coreZkRegister-5923-thread-1-processing-n:127.0.0.1:57948_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:57948_ 
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:57948/collection1/ shard1
   [junit4]   2> 2528701 INFO  
(OverseerStateUpdate-95537501088514052-127.0.0.1:57948_-n_0000000000) 
[n:127.0.0.1:57948_    ] 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:57948";,
   [junit4]   2>   "core":"collection1",
   [junit4]   2>   "state":"active"} current state version: 1
   [junit4]   2> 2528803 INFO  
(zkCallback-1439-thread-1-processing-n:127.0.0.1:57948_) [n:127.0.0.1:57948_    
] 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> 2528853 INFO  
(coreZkRegister-5923-thread-1-processing-n:127.0.0.1:57948_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:57948_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController 
We are http://127.0.0.1:57948/collection1/ and leader is 
http://127.0.0.1:57948/collection1/
   [junit4]   2> 2528853 INFO  
(coreZkRegister-5923-thread-1-processing-n:127.0.0.1:57948_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:57948_ 
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:57948
   [junit4]   2> 2528853 INFO  
(coreZkRegister-5923-thread-1-processing-n:127.0.0.1:57948_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:57948_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController 
I am the leader, no recovery necessary
   [junit4]   2> 2528853 INFO  
(coreZkRegister-5923-thread-1-processing-n:127.0.0.1:57948_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:57948_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController 
publishing state=active
   [junit4]   2> 2528853 INFO  
(coreZkRegister-5923-thread-1-processing-n:127.0.0.1:57948_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:57948_ 
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> 2528855 INFO  
(OverseerStateUpdate-95537501088514052-127.0.0.1:57948_-n_0000000000) 
[n:127.0.0.1:57948_    ] 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:57948";,
   [junit4]   2>   "node_name":"127.0.0.1:57948_",
   [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> 2528855 INFO  
(OverseerStateUpdate-95537501088514052-127.0.0.1:57948_-n_0000000000) 
[n:127.0.0.1:57948_    ] 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:57948";,
   [junit4]   2>   "node_name":"127.0.0.1:57948_",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"control_collection",
   [junit4]   2>   "operation":"state"}
   [junit4]   2> 2528957 INFO  
(zkCallback-1439-thread-1-processing-n:127.0.0.1:57948_) [n:127.0.0.1:57948_    
] 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> 2528997 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 2529004 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2529004 INFO  (zkCallback-1441-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@62999f3f 
name:ZooKeeperConnection Watcher:127.0.0.1:35128/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2529005 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2529005 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 2529005 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 2529006 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 2529007 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection 
loss:false
   [junit4]   2> 2529099 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J1/temp/solr.cloud.UnloadDistributedZkTest_5DE653939C2C8B2C-001/shard-1-001/cores/collection1
   [junit4]   2> 2529100 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J1/temp/solr.cloud.UnloadDistributedZkTest_5DE653939C2C8B2C-001/shard-1-001
   [junit4]   2> 2529104 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.e.j.s.Server jetty-9.3.6.v20151106
   [junit4]   2> 2529108 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@474a9adc{/,null,AVAILABLE}
   [junit4]   2> 2529109 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.e.j.s.ServerConnector Started 
ServerConnector@44b91a53{HTTP/1.1,[http/1.1]}{127.0.0.1:53717}
   [junit4]   2> 2529109 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.e.j.s.Server Started @2532830ms
   [junit4]   2> 2529109 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J1/temp/solr.cloud.UnloadDistributedZkTest_5DE653939C2C8B2C-001/tempDir-001/jetty1,
 solrconfig=solrconfig.xml, hostContext=/, hostPort=53717, 
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J1/temp/solr.cloud.UnloadDistributedZkTest_5DE653939C2C8B2C-001/shard-1-001/cores}
   [junit4]   2> 2529109 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): 
sun.misc.Launcher$AppClassLoader@4e0e2f2a
   [junit4]   2> 2529109 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J1/temp/solr.cloud.UnloadDistributedZkTest_5DE653939C2C8B2C-001/shard-1-001'
   [junit4]   2> 2529109 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 2529109 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find 
system property or JNDI)
   [junit4]   2> 2529110 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 2529115 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2529116 INFO  (zkCallback-1442-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@7bae2a2c 
name:ZooKeeperConnection Watcher:127.0.0.1:35128/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2529116 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2529117 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 2529118 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in 
ZooKeeper)
   [junit4]   2> 2529118 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J1/temp/solr.cloud.UnloadDistributedZkTest_5DE653939C2C8B2C-001/shard-1-001/solr.xml
   [junit4]   2> 2529123 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.CorePropertiesLocator Config-defined core root directory: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J1/temp/solr.cloud.UnloadDistributedZkTest_5DE653939C2C8B2C-001/shard-1-001/cores
   [junit4]   2> 2529123 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.CoreContainer New CoreContainer 1901698938
   [junit4]   2> 2529123 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.CoreContainer Loading cores into CoreContainer 
[instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J1/temp/solr.cloud.UnloadDistributedZkTest_5DE653939C2C8B2C-001/shard-1-001]
   [junit4]   2> 2529123 WARN  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.CoreContainer Couldn't add files from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J1/temp/solr.cloud.UnloadDistributedZkTest_5DE653939C2C8B2C-001/shard-1-001/lib
 to classpath: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J1/temp/solr.cloud.UnloadDistributedZkTest_5DE653939C2C8B2C-001/shard-1-001/lib
   [junit4]   2> 2529123 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
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> 2529128 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 2529129 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 2529129 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.l.LogWatcher Registering Log Listener [Log4j 
(org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 2529129 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:35128/solr
   [junit4]   2> 2529129 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.ZkController zkHost includes chroot
   [junit4]   2> 2529129 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 2529130 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2529139 INFO  (zkCallback-1445-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@16b29d3b 
name:ZooKeeperConnection Watcher:127.0.0.1:35128 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2529139 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2529139 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 2529180 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [n:127.0.0.1:53717_ 
   ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2529188 INFO  
(zkCallback-1446-thread-1-processing-n:127.0.0.1:53717_) [n:127.0.0.1:53717_    
] o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@14987c14 
name:ZooKeeperConnection Watcher:127.0.0.1:35128/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2529189 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [n:127.0.0.1:53717_ 
   ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2529198 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [n:127.0.0.1:53717_ 
   ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 2529207 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [n:127.0.0.1:53717_ 
   ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 2529211 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [n:127.0.0.1:53717_ 
   ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 2529212 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [n:127.0.0.1:53717_ 
   ] o.a.s.c.LeaderElector Joined leadership election with path: 
/overseer_elect/election/95537501088514056-127.0.0.1:53717_-n_0000000001
   [junit4]   2> 2529212 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [n:127.0.0.1:53717_ 
   ] o.a.s.c.LeaderElector Watching path 
/overseer_elect/election/95537501088514052-127.0.0.1:57948_-n_0000000000 to 
know if I could be the leader
   [junit4]   2> 2529213 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [n:127.0.0.1:53717_ 
   ] o.a.s.c.ZkController Publish node=127.0.0.1:53717_ as DOWN
   [junit4]   2> 2529214 INFO  
(OverseerStateUpdate-95537501088514052-127.0.0.1:57948_-n_0000000000) 
[n:127.0.0.1:57948_    ] o.a.s.c.Overseer processMessage: queueSize: 1, message 
= {
   [junit4]   2>   "operation":"downnode",
   [junit4]   2>   "node_name":"127.0.0.1:53717_"} current state version: 3
   [junit4]   2> 2529214 INFO  
(OverseerStateUpdate-95537501088514052-127.0.0.1:57948_-n_0000000000) 
[n:127.0.0.1:57948_    ] o.a.s.c.o.NodeMutator DownNode state invoked for node: 
127.0.0.1:53717_
   [junit4]   2> 2529316 INFO  
(zkCallback-1439-thread-1-processing-n:127.0.0.1:57948_) [n:127.0.0.1:57948_    
] 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> 2529316 INFO  
(zkCallback-1446-thread-1-processing-n:127.0.0.1:53717_) [n:127.0.0.1:53717_    
] 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> 2529316 INFO  (zkCallback-1441-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> 2530214 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [n:127.0.0.1:53717_ 
   ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:53717_
   [junit4]   2> 2530215 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [n:127.0.0.1:53717_ 
   ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:53717_
   [junit4]   2> 2530216 INFO  
(zkCallback-1446-thread-1-processing-n:127.0.0.1:53717_) [n:127.0.0.1:53717_    
] 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> 2530216 INFO  
(zkCallback-1439-thread-1-processing-n:127.0.0.1:57948_) [n:127.0.0.1:57948_    
] 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> 2530216 INFO  (zkCallback-1441-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> 2530217 INFO  
(zkCallback-1446-thread-1-processing-n:127.0.0.1:53717_) [n:127.0.0.1:53717_    
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 2530217 INFO  (zkCallback-1441-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 2530217 INFO  
(zkCallback-1439-thread-1-processing-n:127.0.0.1:57948_) [n:127.0.0.1:57948_    
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 2530228 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [n:127.0.0.1:53717_ 
   ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for 
authorization module.
   [junit4]   2> 2530228 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [n:127.0.0.1:53717_ 
   ] o.a.s.c.CoreContainer No authentication plugin used.
   [junit4]   2> 2530229 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [n:127.0.0.1:53717_ 
   ] o.a.s.c.CorePropertiesLocator Looking for core definitions underneath 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J1/temp/solr.cloud.UnloadDistributedZkTest_5DE653939C2C8B2C-001/shard-1-001/cores
   [junit4]   2> 2530229 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [n:127.0.0.1:53717_ 
   ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection1, 
config=solrconfig.xml, transient=false, schema=schema.xml, loadOnStartup=true, 
configSetProperties=configsetprops.json, collection=collection1, coreNodeName=, 
dataDir=data/, shard=}
   [junit4]   2> 2530229 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [n:127.0.0.1:53717_ 
   ] o.a.s.c.CorePropertiesLocator Found core collection1 in 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J1/temp/solr.cloud.UnloadDistributedZkTest_5DE653939C2C8B2C-001/shard-1-001/cores/collection1
   [junit4]   2> 2530230 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [n:127.0.0.1:53717_ 
   ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
   [junit4]   2> 2530231 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [n:127.0.0.1:53717_ 
   ] o.a.s.s.SolrDispatchFilter 
user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J1
   [junit4]   2> 2530231 INFO  
(TEST-UnloadDistributedZkTest.test-seed#[5DE653939C2C8B2C]) [n:127.0.0.1:53717_ 
   ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
   [junit4]   2> 2530232 INFO  
(coreLoadExecutor-5940-thread-1-processing-n:127.0.0.1:53717_) 
[n:127.0.0.1:53717_ c:collection1   x:collection1] o.a.s.c.ZkController 
publishing state=down
   [junit4]   2> 2530232 INFO  
(coreLoadExecutor-5940-thread-1-processing-n:127.0.0.1:53717_) 
[n:127.0.0.1:53717_ c:collection1   x:collection1] o.a.s.c.ZkController 
numShards not found on descriptor - reading it from system property
   [junit4]   2> 2530233 INFO  
(OverseerStateUpdate-95537501088514052-127.0.0.1:57948_-n_0000000000) 
[n:127.0.0.1:57948_    ] 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:53717";,
   [junit4]   2>   "node_name":"127.0.0.1:53717_",
   [junit4]   2>   "numShards":"2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":null,
   [junit4]   2>   "collection":"collection1",
   [junit4]   2>   "operation":"state"} current state version: 4
   [junit4]   2> 2530234 INFO  
(coreLoadExecutor-5940-thread-1-processing-n:127.0.0.1:53717_) 
[n:127.0.0.1:53717_ c:collection1   x:collection1] o.a.s.c.ZkController look 
for our core node name
   [junit4]   2> 2530234 INFO  
(OverseerStateUpdate-95537501088514052-127.0.0.1:57948_-n_0000000000) 
[n:127.0.0.1:57948_    ] 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:53717";,
   [junit4]   2>   "node_name":"127.0.0.1:53717_",
   [junit4]   2>   "numShards":"2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":null,
   [junit4]   2>   "collection":"collection1",
   [junit4]   2>   "operation":"state"}
   [junit4]   2> 2530234 INFO  
(OverseerStateUpdate-95537501088514052-127.0.0.1:57948_-n_0000000000) 
[n:127.0.0.1:57948_    ] o.a.s.c.o.ClusterStateMutator building a new cName: 
collection1
   [junit4]   2> 2530234 INFO  
(OverseerStateUpdate-95537501088514052-127.0.0.1:57948_-n_0000000000) 
[n:127.0.0.1:57948_    ] o.a.s.c.o.ReplicaMutator Assigning new node to shard 
shard=shard2
   [junit4]   2> 2530336 INFO  
(zkCallback-1446-thread-1-processing-n:127.0.0.1:53717_) [n:127.0.0.1:53717_    
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred 
- updating... (live nodes size: [2])
   [junit4]   2> 2530336 INFO  (zkCallback-1441-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: [2])
   [junit4]   2> 2530336 INFO  
(zkCallback-1439-thread-1-processing-n:127.0.0.1:57948_) [n:127.0.0.1:57948_    
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred 
- updating... (live nodes size: [2])
   [junit4]   2> 2531235 INFO  
(coreLoadExecutor-5940-thread-1-processing-n:127.0.0.1:53717_) 
[n:127.0.0.1:53717_ c:collection1   x:collection1] o.a.s.c.ZkController waiting 
to find shard id in clusterstate for collection1
   [junit4]   2> 2531235 INFO  
(coreLoadExecutor-5940-thread-1-processing-n:127.0.0.1:53717_) 
[n:127.0.0.1:53717_ c:collection1   x:collection1] o.a.s.c.ZkController Check 
for collection zkNode:collection1
   [junit4]   2> 2531235 INFO  
(coreLoadExecutor-5940-thread-1-processing-n:127.0.0.1:53717_) 
[n:127.0.0.1:53717_ c:collection1   x:collection1] o.a.s.c.ZkController 
Collection zkNode exists
   [junit4]   2> 2531235 INFO  
(coreLoadExecutor-5940-thread-1-processing-n:127.0.0.1:53717_) 
[n:127.0.0.1:53717_ c:collection1   x:collection1] o.a.s.c.c.ZkStateReader Load 
collection config from: [/collections/collection1]
   [junit4]   2> 2531236 INFO  
(coreLoadExecutor-5940-thread-1-processing-n:127.0.0.1:53717_) 
[n:127.0.0.1:53717_ c:collection1   x:collection1] o.a.s.c.c.ZkStateReader 
path=[/collections/collection1] [configName]=[conf1] specified config exists in 
ZooKeeper
   [junit4]   2> 2531236 INFO  
(coreLoadExecutor-5940-thread-1-processing-n:127.0.0.1:53717_) 
[n:127.0.0.1:53717_ c:collection1   x:collection1] o.a.s.c.SolrResourceLoader 
new SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/buil

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

325)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1100)
   [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:1219)
   [junit4]    >        at 
org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1593)
   [junit4]    >        at 
org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1614)
   [junit4]    >        at 
org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:970)Throwable
 #6: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an 
uncaught exception in thread: Thread[id=41763, name=collection5, 
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:57485/gu_xf: collection already exists: 
awholynewstresscollection_collection5_0
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([5DE653939C2C8B2C]:0)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:577)
   [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:1100)
   [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:1219)
   [junit4]    >        at 
org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1593)
   [junit4]    >        at 
org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1614)
   [junit4]    >        at 
org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:970)Throwable
 #7: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an 
uncaught exception in thread: Thread[id=41759, 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:57485/gu_xf: collection already exists: 
awholynewstresscollection_collection1_0
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([5DE653939C2C8B2C]:0)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:577)
   [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:1100)
   [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:1219)
   [junit4]    >        at 
org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1593)
   [junit4]    >        at 
org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1614)
   [junit4]    >        at 
org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:970)
   [junit4]   2> 2968103 INFO  
(SUITE-CollectionsAPIDistributedZkTest-seed#[5DE653939C2C8B2C]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_5DE653939C2C8B2C-001
   [junit4]   2> Mar 12, 2016 12:50:17 PM 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 1 leaked 
thread(s).
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene60): 
{other_tl1=PostingsFormat(name=LuceneVarGapFixedInterval), 
range_facet_l_dv=FSTOrd50, 
_version_=PostingsFormat(name=LuceneVarGapFixedInterval), 
multiDefault=PostingsFormat(name=LuceneFixedGap), 
a_t=PostingsFormat(name=LuceneVarGapFixedInterval), 
intDefault=PostingsFormat(name=LuceneVarGapFixedInterval), 
a_i1=PostingsFormat(name=LuceneVarGapFixedInterval), id=FSTOrd50, 
range_facet_i_dv=PostingsFormat(name=LuceneVarGapFixedInterval), 
text=BlockTreeOrds(blocksize=128), 
range_facet_l=PostingsFormat(name=LuceneVarGapFixedInterval), 
timestamp=PostingsFormat(name=LuceneVarGapFixedInterval)}, 
docValues:{range_facet_l_dv=DocValuesFormat(name=Asserting), 
range_facet_i_dv=DocValuesFormat(name=Lucene54), 
timestamp=DocValuesFormat(name=Lucene54)}, maxPointsInLeafNode=145, 
maxMBSortInHeap=4.269633692869323, sim=ClassicSimilarity, locale=en-PH, 
timezone=Asia/Yekaterinburg
   [junit4]   2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation 
1.8.0_66 (64-bit)/cpus=4,threads=1,free=115827088,total=514326528
   [junit4]   2> NOTE: All tests run in this JVM: [TestJsonFacets, 
TestFuzzyAnalyzedSuggestions, TestScoreJoinQPNoScore, 
SharedFSAutoReplicaFailoverTest, TestUniqueKeyFieldResource, 
TestPostingsSolrHighlighter, TestSchemaResource, TestReloadDeadlock, 
RegexBoostProcessorTest, TestIndexingPerformance, TestSolrIndexConfig, 
FieldAnalysisRequestHandlerTest, TestAddFieldRealTimeGet, 
DistributedQueryComponentCustomSortTest, TestSortingResponseWriter, 
TestCloudDeleteByQuery, SolrCoreCheckLockOnStartupTest, SuggesterTSTTest, 
HdfsNNFailoverTest, AssignTest, ConnectionManagerTest, ReplicationFactorTest, 
BasicDistributedZk2Test, SuggesterTest, 
OverseerCollectionConfigSetProcessorTest, BitVectorTest, 
HdfsTlogReplayBufferedWhileIndexingTest, SolrTestCaseJ4Test, 
MultiThreadedOCPTest, ResponseHeaderTest, DeleteStatusTest, 
HLLSerializationTest, ZkStateWriterTest, AtomicUpdatesTest, 
TestSortByMinMaxFunction, SimpleFacetsTest, HighlighterConfigTest, 
CoreAdminHandlerTest, TestXIncludeConfig, PrimitiveFieldTypeTest, TestSolrJ, 
TestStressRecovery, LeaderElectionTest, CurrencyFieldXmlFileTest, 
HdfsChaosMonkeyNothingIsSafeTest, TestLeaderInitiatedRecoveryThread, 
TestJettySolrRunner, StatelessScriptUpdateProcessorFactoryTest, 
SuggestComponentTest, ForceLeaderTest, TestSchemaManager, 
TestFieldTypeCollectionResource, TestExtendedDismaxParser, TestReqParamsAPI, 
TestObjectReleaseTracker, MergeStrategyTest, TestPHPSerializedResponseWriter, 
HdfsRestartWhileUpdatingTest, SolrCloudExampleTest, UpdateParamsTest, 
DistribJoinFromCollectionTest, RecoveryZkTest, FullSolrCloudDistribCmdsTest, 
TestCloudSchemaless, DocValuesMissingTest, DeleteLastCustomShardedReplicaTest, 
TestReload, TestDFISimilarityFactory, BaseCdcrDistributedZkTest, 
TestConfigOverlay, DistributedExpandComponentTest, TestTolerantSearch, 
TestInfoStreamLogging, TestElisionMultitermQuery, TestRestManager, 
TestSolrQueryParser, SliceStateTest, TestComplexPhraseQParserPlugin, 
ShowFileRequestHandlerTest, StressHdfsTest, DirectUpdateHandlerTest, 
DistributedFacetPivotSmallAdvancedTest, LukeRequestHandlerTest, 
TestPKIAuthenticationPlugin, CleanupOldIndexTest, CdcrRequestHandlerTest, 
TestSweetSpotSimilarityFactory, CollectionsAPISolrJTest, QueryParsingTest, 
TestFilteredDocIdSet, BasicDistributedZkTest, CollectionsAPIDistributedZkTest]
   [junit4] Completed [307/578 (2!)] on J2 in 414.79s, 1 test, 1 error <<< 
FAILURES!

[...truncated 875 lines...]
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/build.xml:747:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/build.xml:684:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/build.xml:59:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build.xml:233:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/common-build.xml:524:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/lucene/common-build.xml:1457:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/lucene/common-build.xml:1014:
 There were test failures: 578 suites (10 ignored), 2307 tests, 2 errors, 32 
ignored (16 assumptions) [seed: 5DE653939C2C8B2C]

Total time: 200 minutes 50 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