Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-6.x/12/

4 tests failed.
FAILED:  org.apache.solr.cloud.hdfs.HdfsUnloadDistributedZkTest.test

Error Message:
Captured an uncaught exception in thread: Thread[id=28165, 
name=testExecutor-7508-thread-5, state=RUNNABLE, 
group=TGRP-HdfsUnloadDistributedZkTest]

Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught 
exception in thread: Thread[id=28165, name=testExecutor-7508-thread-5, 
state=RUNNABLE, group=TGRP-HdfsUnloadDistributedZkTest]
Caused by: java.lang.RuntimeException: 
org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting 
response from server at: http://127.0.0.1:51367/jfjlx/ef
        at __randomizedtesting.SeedInfo.seed([4834DFA17696430D]: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:51367/jfjlx/ef
        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


FAILED:  
junit.framework.TestSuite.org.apache.solr.handler.TestReplicationHandler

Error Message:
ObjectTracker found 2 object(s) that were not released!!! [NRTCachingDirectory, 
NRTCachingDirectory]

Stack Trace:
java.lang.AssertionError: ObjectTracker found 2 object(s) that were not 
released!!! [NRTCachingDirectory, NRTCachingDirectory]
        at __randomizedtesting.SeedInfo.seed([4834DFA17696430D]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.assertTrue(Assert.java:43)
        at org.junit.Assert.assertNull(Assert.java:551)
        at org.apache.solr.SolrTestCaseJ4.afterClass(SolrTestCaseJ4.java:238)
        at sun.reflect.GeneratedMethodAccessor29.invoke(Unknown Source)
        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$7.evaluate(RandomizedRunner.java:834)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at java.lang.Thread.run(Thread.java:745)


FAILED:  org.apache.solr.security.BasicAuthIntegrationTest.testBasics

Error Message:
must have failed

Stack Trace:
java.lang.AssertionError: must have failed
        at 
__randomizedtesting.SeedInfo.seed([4834DFA17696430D:75EC718D4E781D7D]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at 
org.apache.solr.security.BasicAuthIntegrationTest.doExtraTests(BasicAuthIntegrationTest.java:169)
        at 
org.apache.solr.cloud.TestMiniSolrCloudClusterBase.testCollectionCreateSearchDelete(TestMiniSolrCloudClusterBase.java:196)
        at 
org.apache.solr.cloud.TestMiniSolrCloudClusterBase.testBasics(TestMiniSolrCloudClusterBase.java:79)
        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 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at java.lang.Thread.run(Thread.java:745)


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

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

Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught 
exception in thread: Thread[id=3449, name=collection5, state=RUNNABLE, 
group=TGRP-CollectionsAPIDistributedZkTest]
Caused by: 
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error 
from server at http://127.0.0.1:35143/d/ta: collection already exists: 
awholynewstresscollection_collection5_4
        at __randomizedtesting.SeedInfo.seed([4834DFA17696430D]:0)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:577)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:241)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:230)
        at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:372)
        at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:325)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1100)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:870)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:806)
        at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219)
        at 
org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1593)
        at 
org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1614)
        at 
org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:970)




Build Log:
[...truncated 11547 lines...]
   [junit4] Suite: org.apache.solr.cloud.CollectionsAPIDistributedZkTest
   [junit4]   2> Creating dataDir: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_4834DFA17696430D-001/init-core-data-001
   [junit4]   2> 900298 INFO  
(SUITE-CollectionsAPIDistributedZkTest-seed#[4834DFA17696430D]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false)
   [junit4]   2> 900298 INFO  
(SUITE-CollectionsAPIDistributedZkTest-seed#[4834DFA17696430D]-worker) [    ] 
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /d/ta
   [junit4]   2> 900300 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 900300 INFO  (Thread-1616) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 900300 INFO  (Thread-1616) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 900400 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.ZkTestServer start zk server on port:48239
   [junit4]   2> 900401 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 900401 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 900404 INFO  (zkCallback-272-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@10a5f6af 
name:ZooKeeperConnection Watcher:127.0.0.1:48239 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 900404 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 900404 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 900404 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 900407 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 900411 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 900419 INFO  (zkCallback-273-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@575abcde 
name:ZooKeeperConnection Watcher:127.0.0.1:48239/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 900419 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 900419 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 900419 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/collection1
   [junit4]   2> 900421 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/collection1/shards
   [junit4]   2> 900422 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection
   [junit4]   2> 900423 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/shards
   [junit4]   2> 900424 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
 to /configs/conf1/solrconfig.xml
   [junit4]   2> 900425 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.xml
   [junit4]   2> 900426 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/schema.xml
 to /configs/conf1/schema.xml
   [junit4]   2> 900426 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/schema.xml
   [junit4]   2> 900428 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
 to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 900428 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.SolrZkClient makePath: 
/configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 900429 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
 to /configs/conf1/stopwords.txt
   [junit4]   2> 900429 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/stopwords.txt
   [junit4]   2> 900431 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/protwords.txt
 to /configs/conf1/protwords.txt
   [junit4]   2> 900431 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/protwords.txt
   [junit4]   2> 900432 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/currency.xml
 to /configs/conf1/currency.xml
   [junit4]   2> 900432 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/currency.xml
   [junit4]   2> 900433 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
 to /configs/conf1/enumsConfig.xml
   [junit4]   2> 900433 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/enumsConfig.xml
   [junit4]   2> 900435 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
 to /configs/conf1/open-exchange-rates.json
   [junit4]   2> 900435 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/open-exchange-rates.json
   [junit4]   2> 900436 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
 to /configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 900436 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 900437 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
 to /configs/conf1/old_synonyms.txt
   [junit4]   2> 900437 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/old_synonyms.txt
   [junit4]   2> 900439 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
 to /configs/conf1/synonyms.txt
   [junit4]   2> 900439 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/synonyms.txt
   [junit4]   2> 900442 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 900442 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 900443 INFO  (zkCallback-274-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@386cc731 
name:ZooKeeperConnection Watcher:127.0.0.1:48239 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 900443 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 900443 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 900444 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 900445 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 900445 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 900446 INFO  (zkCallback-275-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@66aa354f 
name:ZooKeeperConnection Watcher:127.0.0.1:48239/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 900447 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 900447 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 900447 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
 to /configs/conf2/solrconfig.xml
   [junit4]   2> 900447 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/solrconfig.xml
   [junit4]   2> 900449 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/schema.xml
 to /configs/conf2/schema.xml
   [junit4]   2> 900449 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/schema.xml
   [junit4]   2> 900451 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
 to /configs/conf2/enumsConfig.xml
   [junit4]   2> 900451 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/enumsConfig.xml
   [junit4]   2> 900453 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
 to /configs/conf2/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 900453 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.SolrZkClient makePath: 
/configs/conf2/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 900454 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
 to /configs/conf2/stopwords.txt
   [junit4]   2> 900455 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/stopwords.txt
   [junit4]   2> 900456 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/protwords.txt
 to /configs/conf2/protwords.txt
   [junit4]   2> 900456 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/protwords.txt
   [junit4]   2> 900457 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/currency.xml
 to /configs/conf2/currency.xml
   [junit4]   2> 900457 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/currency.xml
   [junit4]   2> 900459 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
 to /configs/conf2/open-exchange-rates.json
   [junit4]   2> 900459 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/open-exchange-rates.json
   [junit4]   2> 900460 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
 to /configs/conf2/mapping-ISOLatin1Accent.txt
   [junit4]   2> 900460 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/mapping-ISOLatin1Accent.txt
   [junit4]   2> 900462 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
 to /configs/conf2/old_synonyms.txt
   [junit4]   2> 900462 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/old_synonyms.txt
   [junit4]   2> 900467 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
 to /configs/conf2/synonyms.txt
   [junit4]   2> 900468 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/synonyms.txt
   [junit4]   2> 900470 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/elevate.xml
 to /configs/conf2/elevate.xml
   [junit4]   2> 900470 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/elevate.xml
   [junit4]   2> 900557 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_4834DFA17696430D-001/control-001/cores/collection1
   [junit4]   2> 900559 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.e.j.s.Server jetty-9.3.6.v20151106
   [junit4]   2> 900560 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@6fffeb5d{/d/ta,null,AVAILABLE}
   [junit4]   2> 900564 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.e.j.s.ServerConnector Started 
ServerConnector@3a38df24{HTTP/1.1,[http/1.1]}{127.0.0.1:58097}
   [junit4]   2> 900564 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.e.j.s.Server Started @903637ms
   [junit4]   2> 900564 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_4834DFA17696430D-001/tempDir-001/control/data,
 hostContext=/d/ta, hostPort=58097, 
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_4834DFA17696430D-001/control-001/cores}
   [junit4]   2> 900564 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): 
sun.misc.Launcher$AppClassLoader@4e0e2f2a
   [junit4]   2> 900564 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_4834DFA17696430D-001/control-001'
   [junit4]   2> 900565 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 900565 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find 
system property or JNDI)
   [junit4]   2> 900565 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 900566 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 900566 INFO  (zkCallback-276-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@f394348 name:ZooKeeperConnection 
Watcher:127.0.0.1:48239/solr got event WatchedEvent state:SyncConnected 
type:None path:null path:null type:None
   [junit4]   2> 900567 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 900567 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 900568 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in 
ZooKeeper)
   [junit4]   2> 900568 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_4834DFA17696430D-001/control-001/solr.xml
   [junit4]   2> 900573 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.CorePropertiesLocator Config-defined core root directory: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_4834DFA17696430D-001/control-001/cores
   [junit4]   2> 900573 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.CoreContainer New CoreContainer 1947802622
   [junit4]   2> 900573 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.CoreContainer Loading cores into CoreContainer 
[instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_4834DFA17696430D-001/control-001]
   [junit4]   2> 900573 WARN  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.CoreContainer Couldn't add files from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_4834DFA17696430D-001/control-001/lib
 to classpath: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_4834DFA17696430D-001/control-001/lib
   [junit4]   2> 900574 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
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> 900575 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 900576 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 900576 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.l.LogWatcher Registering Log Listener [Log4j 
(org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 900576 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:48239/solr
   [junit4]   2> 900576 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.ZkController zkHost includes chroot
   [junit4]   2> 900576 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 900577 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 900579 INFO  (zkCallback-279-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@1115ea72 
name:ZooKeeperConnection Watcher:127.0.0.1:48239 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 900580 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 900580 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 900582 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) 
[n:127.0.0.1:58097_d%2Fta    ] o.a.s.c.c.ConnectionManager Waiting for client 
to connect to ZooKeeper
   [junit4]   2> 900583 INFO  
(zkCallback-280-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta    ] o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@a2ff460 name:ZooKeeperConnection 
Watcher:127.0.0.1:48239/solr got event WatchedEvent state:SyncConnected 
type:None path:null path:null type:None
   [junit4]   2> 900583 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) 
[n:127.0.0.1:58097_d%2Fta    ] o.a.s.c.c.ConnectionManager Client is connected 
to ZooKeeper
   [junit4]   2> 900584 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) 
[n:127.0.0.1:58097_d%2Fta    ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue
   [junit4]   2> 900585 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) 
[n:127.0.0.1:58097_d%2Fta    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer/collection-queue-work
   [junit4]   2> 900588 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) 
[n:127.0.0.1:58097_d%2Fta    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer/collection-map-running
   [junit4]   2> 900589 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) 
[n:127.0.0.1:58097_d%2Fta    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer/collection-map-completed
   [junit4]   2> 900591 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) 
[n:127.0.0.1:58097_d%2Fta    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer/collection-map-failure
   [junit4]   2> 900592 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) 
[n:127.0.0.1:58097_d%2Fta    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 900594 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) 
[n:127.0.0.1:58097_d%2Fta    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 900595 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) 
[n:127.0.0.1:58097_d%2Fta    ] o.a.s.c.c.SolrZkClient makePath: 
/clusterstate.json
   [junit4]   2> 900595 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) 
[n:127.0.0.1:58097_d%2Fta    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 900596 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) 
[n:127.0.0.1:58097_d%2Fta    ] o.a.s.c.c.ZkStateReader Updating cluster state 
from ZooKeeper... 
   [junit4]   2> 900597 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) 
[n:127.0.0.1:58097_d%2Fta    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (0)
   [junit4]   2> 900599 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) 
[n:127.0.0.1:58097_d%2Fta    ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect
   [junit4]   2> 900600 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) 
[n:127.0.0.1:58097_d%2Fta    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer_elect/election
   [junit4]   2> 900601 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) 
[n:127.0.0.1:58097_d%2Fta    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 900601 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) 
[n:127.0.0.1:58097_d%2Fta    ] o.a.s.c.LeaderElector Joined leadership election 
with path: 
/overseer_elect/election/95553226453221382-127.0.0.1:58097_d%2Fta-n_0000000000
   [junit4]   2> 900601 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) 
[n:127.0.0.1:58097_d%2Fta    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:58097_d%2Fta
   [junit4]   2> 900601 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) 
[n:127.0.0.1:58097_d%2Fta    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer_elect/leader
   [junit4]   2> 900602 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) 
[n:127.0.0.1:58097_d%2Fta    ] o.a.s.c.Overseer Overseer 
(id=95553226453221382-127.0.0.1:58097_d%2Fta-n_0000000000) starting
   [junit4]   2> 900604 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) 
[n:127.0.0.1:58097_d%2Fta    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer/queue-work
   [junit4]   2> 900609 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) 
[n:127.0.0.1:58097_d%2Fta    ] o.a.s.c.OverseerAutoReplicaFailoverThread 
Starting OverseerAutoReplicaFailoverThread 
autoReplicaFailoverWorkLoopDelay=10000 
autoReplicaFailoverWaitAfterExpiration=10000 
autoReplicaFailoverBadNodeExpiration=60000
   [junit4]   2> 900609 INFO  
(OverseerCollectionConfigSetProcessor-95553226453221382-127.0.0.1:58097_d%2Fta-n_0000000000)
 [n:127.0.0.1:58097_d%2Fta    ] o.a.s.c.OverseerTaskProcessor Process current 
queue of overseer operations
   [junit4]   2> 900609 INFO  
(OverseerStateUpdate-95553226453221382-127.0.0.1:58097_d%2Fta-n_0000000000) 
[n:127.0.0.1:58097_d%2Fta    ] o.a.s.c.Overseer Starting to work on the main 
queue
   [junit4]   2> 900609 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) 
[n:127.0.0.1:58097_d%2Fta    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:58097_d%2Fta
   [junit4]   2> 900610 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) 
[n:127.0.0.1:58097_d%2Fta    ] o.a.s.c.c.SolrZkClient makePath: 
/live_nodes/127.0.0.1:58097_d%2Fta
   [junit4]   2> 900611 INFO  
(zkCallback-280-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta    ] 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> 900611 INFO  
(OverseerStateUpdate-95553226453221382-127.0.0.1:58097_d%2Fta-n_0000000000) 
[n:127.0.0.1:58097_d%2Fta    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 900611 INFO  
(zkCallback-280-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (1)
   [junit4]   2> 900630 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) 
[n:127.0.0.1:58097_d%2Fta    ] o.a.s.c.CoreContainer Security conf doesn't 
exist. Skipping setup for authorization module.
   [junit4]   2> 900630 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) 
[n:127.0.0.1:58097_d%2Fta    ] o.a.s.c.CoreContainer No authentication plugin 
used.
   [junit4]   2> 900630 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) 
[n:127.0.0.1:58097_d%2Fta    ] o.a.s.c.CorePropertiesLocator Looking for core 
definitions underneath 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_4834DFA17696430D-001/control-001/cores
   [junit4]   2> 900631 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) 
[n:127.0.0.1:58097_d%2Fta    ] 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> 900631 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) 
[n:127.0.0.1:58097_d%2Fta    ] o.a.s.c.CorePropertiesLocator Found core 
collection1 in 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_4834DFA17696430D-001/control-001/cores/collection1
   [junit4]   2> 900631 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) 
[n:127.0.0.1:58097_d%2Fta    ] o.a.s.c.CorePropertiesLocator Found 1 core 
definitions
   [junit4]   2> 900633 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) 
[n:127.0.0.1:58097_d%2Fta    ] o.a.s.s.SolrDispatchFilter 
user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1
   [junit4]   2> 900634 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) 
[n:127.0.0.1:58097_d%2Fta    ] o.a.s.s.SolrDispatchFilter 
SolrDispatchFilter.init() done
   [junit4]   2> 900634 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta c:control_collection   x:collection1] 
o.a.s.c.ZkController publishing state=down
   [junit4]   2> 900634 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta c:control_collection   x:collection1] 
o.a.s.c.ZkController numShards not found on descriptor - reading it from system 
property
   [junit4]   2> 900635 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta c:control_collection   x:collection1] 
o.a.s.c.ZkController look for our core node name
   [junit4]   2> 900636 INFO  
(OverseerStateUpdate-95553226453221382-127.0.0.1:58097_d%2Fta-n_0000000000) 
[n:127.0.0.1:58097_d%2Fta    ] 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:58097/d/ta";,
   [junit4]   2>   "node_name":"127.0.0.1:58097_d%2Fta",
   [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> 900636 INFO  
(OverseerStateUpdate-95553226453221382-127.0.0.1:58097_d%2Fta-n_0000000000) 
[n:127.0.0.1:58097_d%2Fta    ] 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:58097/d/ta";,
   [junit4]   2>   "node_name":"127.0.0.1:58097_d%2Fta",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":null,
   [junit4]   2>   "collection":"control_collection",
   [junit4]   2>   "operation":"state"}
   [junit4]   2> 900637 INFO  
(OverseerStateUpdate-95553226453221382-127.0.0.1:58097_d%2Fta-n_0000000000) 
[n:127.0.0.1:58097_d%2Fta    ] o.a.s.c.o.ClusterStateMutator building a new 
cName: control_collection
   [junit4]   2> 900637 INFO  
(OverseerStateUpdate-95553226453221382-127.0.0.1:58097_d%2Fta-n_0000000000) 
[n:127.0.0.1:58097_d%2Fta    ] o.a.s.c.o.ReplicaMutator Assigning new node to 
shard shard=shard1
   [junit4]   2> 900638 INFO  
(zkCallback-280-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta    ] 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> 901636 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta c:control_collection   x:collection1] 
o.a.s.c.ZkController waiting to find shard id in clusterstate for collection1
   [junit4]   2> 901636 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta c:control_collection   x:collection1] 
o.a.s.c.ZkController Check for collection zkNode:control_collection
   [junit4]   2> 901636 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta c:control_collection   x:collection1] 
o.a.s.c.ZkController Collection zkNode exists
   [junit4]   2> 901636 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta c:control_collection   x:collection1] 
o.a.s.c.c.ZkStateReader Load collection config from: 
[/collections/control_collection]
   [junit4]   2> 901637 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta c:control_collection   x:collection1] 
o.a.s.c.c.ZkStateReader path=[/collections/control_collection] 
[configName]=[conf1] specified config exists in ZooKeeper
   [junit4]   2> 901637 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta c:control_collection   x:collection1] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_4834DFA17696430D-001/control-001/cores/collection1'
   [junit4]   2> 901637 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta c:control_collection   x:collection1] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 901637 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta c:control_collection   x:collection1] 
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find 
system property or JNDI)
   [junit4]   2> 901640 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta c:control_collection   x:collection1] o.a.s.c.Config 
loaded config solrconfig.xml with version 0 
   [junit4]   2> 901645 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta c:control_collection   x:collection1] 
o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 901648 WARN  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta c:control_collection   x:collection1] o.a.s.c.Config 
Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> 
instead.
   [junit4]   2> 901649 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta c:control_collection   x:collection1] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.1.0
   [junit4]   2> 901674 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta c:control_collection   x:collection1] 
o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 901680 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta c:control_collection   x:collection1] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 901772 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta c:control_collection   x:collection1] 
o.a.s.s.OpenExchangeRatesOrgProvider Initialized with 
rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 901779 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta c:control_collection   x:collection1] 
o.a.s.s.IndexSchema default search field in schema is text
   [junit4]   2> 901780 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta c:control_collection   x:collection1] 
o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 901788 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta c:control_collection   x:collection1] 
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 901790 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta c:control_collection   x:collection1] 
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 901792 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta c:control_collection   x:collection1] 
o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from 
open-exchange-rates.json
   [junit4]   2> 901792 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta c:control_collection   x:collection1] 
o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from 
open-exchange-rates.json
   [junit4]   2> 901794 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta 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-6.x/solr/build/solr-core/test/J1
   [junit4]   2> 901794 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta c:control_collection   x:collection1] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from 
collection control_collection
   [junit4]   2> 901794 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 901794 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta 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-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_4834DFA17696430D-001/control-001/cores/collection1],
 
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_4834DFA17696430D-001/control-001/cores/collection1/data/]
   [junit4]   2> 901794 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta 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@48c5628b
   [junit4]   2> 901795 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta 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-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_4834DFA17696430D-001/control-001/cores/collection1/data
   [junit4]   2> 901795 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta 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-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_4834DFA17696430D-001/control-001/cores/collection1/data/index/
   [junit4]   2> 901795 WARN  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta 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-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_4834DFA17696430D-001/control-001/cores/collection1/data/index'
 doesn't exist. Creating new index...
   [junit4]   2> 901795 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta 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-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_4834DFA17696430D-001/control-001/cores/collection1/data/index
   [junit4]   2> 901796 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=34, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.0]
   [junit4]   2> 901796 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta 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@1b451812 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@259cbd8e),segFN=segments_1,generation=1}
   [junit4]   2> 901796 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 901797 INFO  
(OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:58097_d%2Fta 
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-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_4834DFA17696430D-001/control-001/cores/collection1/data/
   [junit4]   2> 901797 WARN  
(OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:58097_d%2Fta 
c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.DirectoryFactory 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_4834DFA17696430D-001/control-001/cores/collection1/data/
 does not point to a valid data directory; skipping clean-up of old index 
directories.
   [junit4]   2> 901800 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating 
updateRequestProcessorChain "nodistrib"
   [junit4]   2> 901800 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating 
updateRequestProcessorChain "dedupe"
   [junit4]   2> 901800 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 901801 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating 
updateRequestProcessorChain "stored_sig"
   [junit4]   2> 901801 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 901801 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta 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> 901801 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta 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> 901801 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta 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> 901801 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta 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> 901801 WARN  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta 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> 901803 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 901804 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 901805 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 901806 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 901809 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta 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> 901809 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta 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> 901809 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta 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> 901810 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta 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> 901810 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 901810 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 901811 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=13, maxMergeAtOnceExplicit=45, maxMergedSegmentMB=1.27734375, 
floorSegmentMB=2.09765625, forceMergeDeletesPctAllowed=23.73351544833273, 
segmentsPerTier=15.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.43545747430888493
   [junit4]   2> 901811 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta 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@1b451812 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@259cbd8e),segFN=segments_1,generation=1}
   [junit4]   2> 901811 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 901811 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@17f1922f[collection1] main]
   [junit4]   2> 901811 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta 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> 901812 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta 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> 901812 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta 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> 901812 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO 
with znodeBase: /configs/conf1
   [junit4]   2> 901812 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {}
   [junit4]   2> 901812 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta 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> 901813 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta 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> 901813 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta 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> 901813 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
   [junit4]   2> 901813 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 901814 INFO  
(searcherExecutor-1018-thread-1-processing-n:127.0.0.1:58097_d%2Fta 
x:collection1 s:shard1 c:control_collection r:core_node1) 
[n:127.0.0.1:58097_d%2Fta c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@17f1922f[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 901814 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta 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> 901814 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta 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> 901814 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta 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> 901814 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta 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 1528851624836988928
   [junit4]   2> 901816 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta 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 1528851624836988928
   [junit4]   2> 901816 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.ZkController watch zkdir /configs/conf1
   [junit4]   2> 901817 INFO  
(coreLoadExecutor-1017-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.CoreContainer registering core: collection1
   [junit4]   2> 901817 INFO  
(coreZkRegister-1011-thread-1-processing-n:127.0.0.1:58097_d%2Fta x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:58097_d%2Fta 
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:58097/d/ta 
collection:control_collection shard:shard1
   [junit4]   2> 901818 INFO  
(coreZkRegister-1011-thread-1-processing-n:127.0.0.1:58097_d%2Fta x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:58097_d%2Fta 
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> 901820 INFO  
(coreZkRegister-1011-thread-1-processing-n:127.0.0.1:58097_d%2Fta x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:58097_d%2Fta 
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/95553226453221382-core_node1-n_0000000000
   [junit4]   2> 901821 INFO  
(coreZkRegister-1011-thread-1-processing-n:127.0.0.1:58097_d%2Fta x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:58097_d%2Fta 
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> 901822 INFO  
(coreZkRegister-1011-thread-1-processing-n:127.0.0.1:58097_d%2Fta x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:58097_d%2Fta 
c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 901822 INFO  
(coreZkRegister-1011-thread-1-processing-n:127.0.0.1:58097_d%2Fta x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:58097_d%2Fta 
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> 901822 INFO  
(coreZkRegister-1011-thread-1-processing-n:127.0.0.1:58097_d%2Fta x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:58097_d%2Fta 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy 
Sync replicas to http://127.0.0.1:58097/d/ta/collection1/
   [junit4]   2> 901822 INFO  
(coreZkRegister-1011-thread-1-processing-n:127.0.0.1:58097_d%2Fta x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:58097_d%2Fta 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy 
Sync Success - now sync replicas to me
   [junit4]   2> 901822 INFO  
(coreZkRegister-1011-thread-1-processing-n:127.0.0.1:58097_d%2Fta x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:58097_d%2Fta 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy 
http://127.0.0.1:58097/d/ta/collection1/ has no replicas
   [junit4]   2> 901822 INFO  
(OverseerStateUpdate-95553226453221382-127.0.0.1:58097_d%2Fta-n_0000000000) 
[n:127.0.0.1:58097_d%2Fta    ] 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> 901823 INFO  
(coreZkRegister-1011-thread-1-processing-n:127.0.0.1:58097_d%2Fta x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:58097_d%2Fta 
c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/leaders/shard1
   [junit4]   2> 901825 INFO  
(coreZkRegister-1011-thread-1-processing-n:127.0.0.1:58097_d%2Fta x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:58097_d%2Fta 
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/95553226453221382-core_node1-n_0000000000
   [junit4]   2> 901827 INFO  
(coreZkRegister-1011-thread-1-processing-n:127.0.0.1:58097_d%2Fta x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:58097_d%2Fta 
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:58097/d/ta/collection1/ shard1
   [junit4]   2> 901827 INFO  
(OverseerStateUpdate-95553226453221382-127.0.0.1:58097_d%2Fta-n_0000000000) 
[n:127.0.0.1:58097_d%2Fta    ] 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:58097/d/ta";,
   [junit4]   2>   "core":"collection1",
   [junit4]   2>   "state":"active"} current state version: 1
   [junit4]   2> 901929 INFO  
(zkCallback-280-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta    ] 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> 901978 INFO  
(coreZkRegister-1011-thread-1-processing-n:127.0.0.1:58097_d%2Fta x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:58097_d%2Fta 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController 
We are http://127.0.0.1:58097/d/ta/collection1/ and leader is 
http://127.0.0.1:58097/d/ta/collection1/
   [junit4]   2> 901978 INFO  
(coreZkRegister-1011-thread-1-processing-n:127.0.0.1:58097_d%2Fta x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:58097_d%2Fta 
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:58097/d/ta
   [junit4]   2> 901978 INFO  
(coreZkRegister-1011-thread-1-processing-n:127.0.0.1:58097_d%2Fta x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:58097_d%2Fta 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController 
I am the leader, no recovery necessary
   [junit4]   2> 901978 INFO  
(coreZkRegister-1011-thread-1-processing-n:127.0.0.1:58097_d%2Fta x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:58097_d%2Fta 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController 
publishing state=active
   [junit4]   2> 901978 INFO  
(coreZkRegister-1011-thread-1-processing-n:127.0.0.1:58097_d%2Fta x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:58097_d%2Fta 
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> 901981 INFO  
(OverseerStateUpdate-95553226453221382-127.0.0.1:58097_d%2Fta-n_0000000000) 
[n:127.0.0.1:58097_d%2Fta    ] 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:58097/d/ta";,
   [junit4]   2>   "node_name":"127.0.0.1:58097_d%2Fta",
   [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> 901981 INFO  
(OverseerStateUpdate-95553226453221382-127.0.0.1:58097_d%2Fta-n_0000000000) 
[n:127.0.0.1:58097_d%2Fta    ] 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:58097/d/ta";,
   [junit4]   2>   "node_name":"127.0.0.1:58097_d%2Fta",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"control_collection",
   [junit4]   2>   "operation":"state"}
   [junit4]   2> 902084 INFO  
(zkCallback-280-thread-1-processing-n:127.0.0.1:58097_d%2Fta) 
[n:127.0.0.1:58097_d%2Fta    ] 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> 902136 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 902138 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 902139 INFO  (zkCallback-282-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@7a11bdc name:ZooKeeperConnection 
Watcher:127.0.0.1:48239/solr got event WatchedEvent state:SyncConnected 
type:None path:null path:null type:None
   [junit4]   2> 902139 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 902139 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 902139 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 902140 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 902141 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection 
loss:false
   [junit4]   2> 902141 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.AbstractFullDistribZkTestBase Creating collection1 with stateFormat=2
   [junit4]   2> 902141 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 902141 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 902142 INFO  (zkCallback-283-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@122a68ce 
name:ZooKeeperConnection Watcher:127.0.0.1:48239/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 902142 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 902143 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 902145 INFO  
(OverseerStateUpdate-95553226453221382-127.0.0.1:58097_d%2Fta-n_0000000000) 
[n:127.0.0.1:58097_d%2Fta    ] o.a.s.c.Overseer processMessage: queueSize: 1, 
message = {
   [junit4]   2>   "operation":"create",
   [junit4]   2>   "name":"collection1",
   [junit4]   2>   "numShards":"2",
   [junit4]   2>   "stateFormat":"2"} current state version: 3
   [junit4]   2> 902145 INFO  
(OverseerStateUpdate-95553226453221382-127.0.0.1:58097_d%2Fta-n_0000000000) 
[n:127.0.0.1:58097_d%2Fta    ] o.a.s.c.o.ClusterStateMutator building a new 
cName: collection1
   [junit4]   2> 902231 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_4834DFA17696430D-001/shard-1-001/cores/collection1
   [junit4]   2> 902232 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_4834DFA17696430D-001/shard-1-001
   [junit4]   2> 902233 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.e.j.s.Server jetty-9.3.6.v20151106
   [junit4]   2> 902235 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@55f9c36e{/d/ta,null,AVAILABLE}
   [junit4]   2> 902235 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.e.j.s.ServerConnector Started 
ServerConnector@6dc5b091{HTTP/1.1,[http/1.1]}{127.0.0.1:56295}
   [junit4]   2> 902235 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.e.j.s.Server Started @905308ms
   [junit4]   2> 902236 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_4834DFA17696430D-001/tempDir-001/jetty1,
 solrconfig=solrconfig.xml, hostContext=/d/ta, hostPort=56295, 
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_4834DFA17696430D-001/shard-1-001/cores}
   [junit4]   2> 902236 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): 
sun.misc.Launcher$AppClassLoader@4e0e2f2a
   [junit4]   2> 902236 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_4834DFA17696430D-001/shard-1-001'
   [junit4]   2> 902236 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 902236 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find 
system property or JNDI)
   [junit4]   2> 902236 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 902237 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 902238 INFO  (zkCallback-284-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@1be00fbe 
name:ZooKeeperConnection Watcher:127.0.0.1:48239/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 902238 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 902238 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 902239 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in 
ZooKeeper)
   [junit4]   2> 902240 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_4834DFA17696430D-001/shard-1-001/solr.xml
   [junit4]   2> 902245 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.CorePropertiesLocator Config-defined core root directory: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_4834DFA17696430D-001/shard-1-001/cores
   [junit4]   2> 902245 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.CoreContainer New CoreContainer 1897090152
   [junit4]   2> 902245 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.CoreContainer Loading cores into CoreContainer 
[instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_4834DFA17696430D-001/shard-1-001]
   [junit4]   2> 902245 WARN  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.c.CoreContainer Couldn't add files from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_4834DFA17696430D-001/shard-1-001/lib
 to classpath: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_4834DFA17696430D-001/shard-1-001/lib
   [junit4]   2> 902245 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
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> 902246 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 902247 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[4834DFA17696430D]) [    ] 
o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 902247 INFO  (TEST-CollectionsAPI

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

mpl.java:461)
   [junit4]   2>        at 
org.apache.hadoop.metrics2.impl.MetricsSystemImpl.stop(MetricsSystemImpl.java:212)
   [junit4]   2>        at 
org.apache.hadoop.metrics2.impl.MetricsSystemImpl.shutdown(MetricsSystemImpl.java:592)
   [junit4]   2>        at 
org.apache.hadoop.metrics2.lib.DefaultMetricsSystem.shutdownInstance(DefaultMetricsSystem.java:72)
   [junit4]   2>        at 
org.apache.hadoop.metrics2.lib.DefaultMetricsSystem.shutdown(DefaultMetricsSystem.java:68)
   [junit4]   2>        at 
org.apache.hadoop.hdfs.server.namenode.metrics.NameNodeMetrics.shutdown(NameNodeMetrics.java:145)
   [junit4]   2>        at 
org.apache.hadoop.hdfs.server.namenode.NameNode.stop(NameNode.java:822)
   [junit4]   2>        at 
org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:1720)
   [junit4]   2>        at 
org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:1699)
   [junit4]   2>        at 
org.apache.solr.cloud.hdfs.HdfsTestUtil.teardownClass(HdfsTestUtil.java:198)
   [junit4]   2>        at 
org.apache.solr.cloud.hdfs.HdfsUnloadDistributedZkTest.teardownClass(HdfsUnloadDistributedZkTest.java:46)
   [junit4]   2>        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native 
Method)
   [junit4]   2>        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
   [junit4]   2>        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   [junit4]   2>        at java.lang.reflect.Method.invoke(Method.java:497)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:834)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
   [junit4]   2>        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> Caused by: java.lang.NullPointerException
   [junit4]   2>        at 
org.apache.hadoop.hdfs.server.blockmanagement.BlocksMap.size(BlocksMap.java:198)
   [junit4]   2>        at 
org.apache.hadoop.hdfs.server.blockmanagement.BlockManager.getTotalBlocks(BlockManager.java:3291)
   [junit4]   2>        at 
org.apache.hadoop.hdfs.server.namenode.FSNamesystem.getBlocksTotal(FSNamesystem.java:6223)
   [junit4]   2>        ... 54 more
   [junit4]   2> 3867742 INFO  
(SUITE-HdfsUnloadDistributedZkTest-seed#[4834DFA17696430D]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> Mar 15, 2016 8:11:34 AM 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 3 leaked 
thread(s).
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene60): 
{other_tl1=BlockTreeOrds(blocksize=128), range_facet_l_dv=FST50, 
_version_=BlockTreeOrds(blocksize=128), 
multiDefault=PostingsFormat(name=Asserting), 
a_t=PostingsFormat(name=Asserting), intDefault=BlockTreeOrds(blocksize=128), 
a_i1=PostingsFormat(name=Asserting), id=FST50, 
range_facet_i_dv=PostingsFormat(name=Asserting), 
text=PostingsFormat(name=Direct), range_facet_l=PostingsFormat(name=Asserting), 
timestamp=PostingsFormat(name=Asserting)}, 
docValues:{range_facet_l_dv=DocValuesFormat(name=Lucene54), 
range_facet_i_dv=DocValuesFormat(name=Direct), 
timestamp=DocValuesFormat(name=Direct)}, maxPointsInLeafNode=691, 
maxMBSortInHeap=5.247604174461518, sim=ClassicSimilarity, locale=en, 
timezone=Australia/NSW
   [junit4]   2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation 
1.8.0_66 (64-bit)/cpus=4,threads=2,free=266678448,total=527433728
   [junit4]   2> NOTE: All tests run in this JVM: [TestIndexSearcher, 
TestCoreDiscovery, HdfsNNFailoverTest, TestJsonFacets, SearchHandlerTest, 
PreAnalyzedUpdateProcessorTest, TestSortingResponseWriter, 
VMParamsZkACLAndCredentialsProvidersTest, TestCSVResponseWriter, 
TestFuzzyAnalyzedSuggestions, AddSchemaFieldsUpdateProcessorFactoryTest, 
HardAutoCommitTest, DocValuesMultiTest, TestSolrQueryParser, TestSort, 
SliceStateTest, HighlighterConfigTest, CdcrUpdateLogTest, 
TestRawResponseWriter, TestAuthorizationFramework, BaseCdcrDistributedZkTest, 
TestInfoStreamLogging, HdfsRestartWhileUpdatingTest, 
TestOverriddenPrefixQueryForCustomFieldType, LeaderElectionTest, 
TestAddFieldRealTimeGet, DirectSolrConnectionTest, ScriptEngineTest, 
SharedFSAutoReplicaFailoverTest, TestCopyFieldCollectionResource, 
CircularListTest, TestMacros, BlockJoinFacetRandomTest, 
CoreAdminRequestStatusTest, ReplicationFactorTest, HighlighterMaxOffsetTest, 
SampleTest, CleanupOldIndexTest, TestReloadAndDeleteDocs, TestRebalanceLeaders, 
TestUtils, CloudMLTQParserTest, TestPerFieldSimilarityWithDefaultOverride, 
DistributedFacetPivotSmallAdvancedTest, TestSolrJ, 
TestSolrCloudWithKerberosAlt, TestXIncludeConfig, TestReloadDeadlock, 
FieldAnalysisRequestHandlerTest, HdfsLockFactoryTest, OverseerTest, 
BinaryUpdateRequestHandlerTest, DebugComponentTest, 
DistributedExpandComponentTest, DateMathParserTest, AutoCommitTest, 
BasicDistributedZk2Test, TestDynamicFieldResource, 
TestLeaderInitiatedRecoveryThread, TestPostingsSolrHighlighter, 
SolrCloudExampleTest, PluginInfoTest, DirectUpdateHandlerOptimizeTest, 
CurrencyFieldXmlFileTest, SolrTestCaseJ4Test, TestSchemaManager, 
ExitableDirectoryReaderTest, FieldMutatingUpdateProcessorTest, 
TestReversedWildcardFilterFactory, FacetPivotSmallTest, 
TestSweetSpotSimilarityFactory, TestJmxMonitoredMap, 
HdfsChaosMonkeyNothingIsSafeTest, TestDFISimilarityFactory, TestSmileRequest, 
DirectUpdateHandlerTest, TestFilteredDocIdSet, TestAnalyzeInfixSuggestions, 
TestDownShardTolerantSearch, SecurityConfHandlerTest, TestZkChroot, 
TestSha256AuthenticationProvider, DocValuesMissingTest, 
BigEndianAscendingWordSerializerTest, TestSuggestSpellingConverter, 
TestBlobHandler, FullSolrCloudDistribCmdsTest, TestSolrDynamicMBean, 
TestRecovery, TestFreeTextSuggestions, 
StatelessScriptUpdateProcessorFactoryTest, TestJmxIntegration, 
NoCacheHeaderTest, BasicDistributedZkTest, ChaosMonkeySafeLeaderTest, 
UnloadDistributedZkTest, LeaderElectionIntegrationTest, ShardRoutingTest, 
BasicZkTest, RecoveryZkTest, TestReplicationHandler, TestSystemIdResolver, 
RAMDirectoryFactoryTest, TestRTGBase, DistributedIntervalFacetingTest, 
AsyncMigrateRouteKeyTest, CdcrReplicationHandlerTest, CdcrRequestHandlerTest, 
CollectionReloadTest, CollectionsAPISolrJTest, DeleteInactiveReplicaTest, 
DeleteLastCustomShardedReplicaTest, DeleteReplicaTest, DeleteStatusTest, 
DistribDocExpirationUpdateProcessorTest, LeaderFailoverAfterPartitionTest, 
OutOfBoxZkACLAndCredentialsProvidersTest, 
OverriddenZkACLAndCredentialsProvidersTest, 
OverseerCollectionConfigSetProcessorTest, OverseerTaskQueueTest, 
SSLMigrationTest, SaslZkACLProviderTest, ShardSplitTest, 
HdfsUnloadDistributedZkTest]
   [junit4] Completed [480/579 (4!)] on J2 in 148.72s, 1 test, 1 error <<< 
FAILURES!

[...truncated 332 lines...]
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/build.xml:747: 
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/build.xml:684: 
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/build.xml:59: 
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build.xml:233:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/common-build.xml:524:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/lucene/common-build.xml:1457:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/lucene/common-build.xml:1014:
 There were test failures: 579 suites (10 ignored), 2314 tests, 1 suite-level 
error, 2 errors, 1 failure, 32 ignored (16 assumptions) [seed: 4834DFA17696430D]

Total time: 213 minutes 15 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