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

3 tests failed.
FAILED:  org.apache.solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest.test

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

Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught 
exception in thread: Thread[id=14113, name=collection5, state=RUNNABLE, 
group=TGRP-HdfsCollectionsAPIDistributedZkTest]
Caused by: 
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error 
from server at http://127.0.0.1:34052: collection already exists: 
awholynewstresscollection_collection5_2
        at __randomizedtesting.SeedInfo.seed([F9068B6B918E120E]:0)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:590)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:259)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:248)
        at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:403)
        at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:356)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1228)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:998)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:934)
        at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219)
        at 
org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1599)
        at 
org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1620)
        at 
org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:987)


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

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

Stack Trace:
java.lang.AssertionError: ObjectTracker found 8 object(s) that were not 
released!!! [NRTCachingDirectory, NRTCachingDirectory, NRTCachingDirectory, 
NRTCachingDirectory, NRTCachingDirectory, NRTCachingDirectory, 
NRTCachingDirectory, NRTCachingDirectory]
        at __randomizedtesting.SeedInfo.seed([F9068B6B918E120E]: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.teardownTestCases(SolrTestCaseJ4.java:257)
        at sun.reflect.GeneratedMethodAccessor24.invoke(Unknown Source)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        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.cloud.CollectionsAPIDistributedZkTest.test

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

Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught 
exception in thread: Thread[id=179996, name=collection1, state=RUNNABLE, 
group=TGRP-CollectionsAPIDistributedZkTest]
Caused by: 
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error 
from server at https://127.0.0.1:51555: collection already exists: 
awholynewstresscollection_collection1_0
        at __randomizedtesting.SeedInfo.seed([F9068B6B918E120E]:0)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:590)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:259)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:248)
        at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:403)
        at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:356)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1228)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:998)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:934)
        at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219)
        at 
org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1599)
        at 
org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1620)
        at 
org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:987)




Build Log:
[...truncated 11590 lines...]
   [junit4] Suite: 
org.apache.solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest
   [junit4]   2> Creating dataDir: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_F9068B6B918E120E-001/init-core-data-001
   [junit4]   2> 1007598 INFO  
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[F9068B6B918E120E]-worker) [    
] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via: 
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
   [junit4]   2> 1007598 INFO  
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[F9068B6B918E120E]-worker) [    
] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /
   [junit4]   1> Formatting using clusterid: testClusterID
   [junit4]   2> 1007633 WARN  
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[F9068B6B918E120E]-worker) [    
] o.a.h.m.i.MetricsConfig Cannot locate configuration: tried 
hadoop-metrics2-namenode.properties,hadoop-metrics2.properties
   [junit4]   2> 1007640 WARN  
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[F9068B6B918E120E]-worker) [    
] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
   [junit4]   2> 1007655 INFO  
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[F9068B6B918E120E]-worker) [    
] o.m.log jetty-6.1.26
   [junit4]   2> 1007666 INFO  
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[F9068B6B918E120E]-worker) [    
] o.m.log Extract 
jar:file:/x1/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.6.0-tests.jar!/webapps/hdfs
 to ./temp/Jetty_localhost_51210_hdfs____.kulach/webapp
   [junit4]   2> 1007754 INFO  
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[F9068B6B918E120E]-worker) [    
] o.m.log NO JSP Support for /, did not find 
org.apache.jasper.servlet.JspServlet
   [junit4]   2> 1008058 INFO  
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[F9068B6B918E120E]-worker) [    
] o.m.log Started 
HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:51210
   [junit4]   2> 1008121 WARN  
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[F9068B6B918E120E]-worker) [    
] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
   [junit4]   2> 1008123 INFO  
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[F9068B6B918E120E]-worker) [    
] o.m.log jetty-6.1.26
   [junit4]   2> 1008135 INFO  
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[F9068B6B918E120E]-worker) [    
] o.m.log Extract 
jar:file:/x1/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.6.0-tests.jar!/webapps/datanode
 to ./temp/Jetty_localhost_38803_datanode____.xy6tsz/webapp
   [junit4]   2> 1008212 INFO  
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[F9068B6B918E120E]-worker) [    
] o.m.log NO JSP Support for /, did not find 
org.apache.jasper.servlet.JspServlet
   [junit4]   2> 1008783 INFO  
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[F9068B6B918E120E]-worker) [    
] o.m.log Started 
HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:38803
   [junit4]   2> 1008832 WARN  
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[F9068B6B918E120E]-worker) [    
] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
   [junit4]   2> 1008834 INFO  
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[F9068B6B918E120E]-worker) [    
] o.m.log jetty-6.1.26
   [junit4]   2> 1008844 INFO  
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[F9068B6B918E120E]-worker) [    
] o.m.log Extract 
jar:file:/x1/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.6.0-tests.jar!/webapps/datanode
 to ./temp/Jetty_localhost_51346_datanode____.vpqny8/webapp
   [junit4]   2> 1008921 INFO  (IPC Server handler 3 on 44179) [    ] 
BlockStateChange BLOCK* processReport: from storage 
DS-79e2367f-2a53-4b9c-96ee-99ecc0d2398a node DatanodeRegistration(127.0.0.1, 
datanodeUuid=204bc6ba-1da8-452c-b55e-659193caed04, infoPort=38803, 
ipcPort=45458, storageInfo=lv=-56;cid=testClusterID;nsid=1853110078;c=0), 
blocks: 0, hasStaleStorages: true, processing time: 0 msecs
   [junit4]   2> 1008921 INFO  (IPC Server handler 3 on 44179) [    ] 
BlockStateChange BLOCK* processReport: from storage 
DS-a12fecbe-8977-4da2-b094-f0891fb902c9 node DatanodeRegistration(127.0.0.1, 
datanodeUuid=204bc6ba-1da8-452c-b55e-659193caed04, infoPort=38803, 
ipcPort=45458, storageInfo=lv=-56;cid=testClusterID;nsid=1853110078;c=0), 
blocks: 0, hasStaleStorages: false, processing time: 0 msecs
   [junit4]   2> 1008957 INFO  
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[F9068B6B918E120E]-worker) [    
] o.m.log NO JSP Support for /, did not find 
org.apache.jasper.servlet.JspServlet
   [junit4]   2> 1009220 INFO  
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[F9068B6B918E120E]-worker) [    
] o.m.log Started 
HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:51346
   [junit4]   2> 1009281 INFO  (IPC Server handler 4 on 44179) [    ] 
BlockStateChange BLOCK* processReport: from storage 
DS-687944d0-ad12-4486-ab34-55bc32dd3908 node DatanodeRegistration(127.0.0.1, 
datanodeUuid=f3bc0d61-ed57-4617-81a5-2154be16648e, infoPort=51346, 
ipcPort=43833, storageInfo=lv=-56;cid=testClusterID;nsid=1853110078;c=0), 
blocks: 0, hasStaleStorages: true, processing time: 0 msecs
   [junit4]   2> 1009281 INFO  (IPC Server handler 4 on 44179) [    ] 
BlockStateChange BLOCK* processReport: from storage 
DS-9d1bca52-e9e8-41ad-8920-d5f1dbe930f1 node DatanodeRegistration(127.0.0.1, 
datanodeUuid=f3bc0d61-ed57-4617-81a5-2154be16648e, infoPort=51346, 
ipcPort=43833, storageInfo=lv=-56;cid=testClusterID;nsid=1853110078;c=0), 
blocks: 0, hasStaleStorages: false, processing time: 0 msecs
   [junit4]   2> 1009488 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1009489 INFO  (Thread-7576) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 1009489 INFO  (Thread-7576) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 1009589 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.ZkTestServer start zk server on port:36027
   [junit4]   2> 1009589 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1009590 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1009592 INFO  (zkCallback-1913-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@3f74fd98 
name:ZooKeeperConnection Watcher:127.0.0.1:36027 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1009592 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1009592 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1009592 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 1009594 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1009594 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1009596 INFO  (zkCallback-1914-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@656e50f6 
name:ZooKeeperConnection Watcher:127.0.0.1:36027/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1009596 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1009596 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1009596 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/collection1
   [junit4]   2> 1009598 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/collection1/shards
   [junit4]   2> 1009599 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection
   [junit4]   2> 1009600 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/shards
   [junit4]   2> 1009601 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
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> 1009601 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.xml
   [junit4]   2> 1009602 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
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> 1009603 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/schema.xml
   [junit4]   2> 1009604 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
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> 1009604 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.SolrZkClient makePath: 
/configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 1009605 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
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> 1009605 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/stopwords.txt
   [junit4]   2> 1009607 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
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> 1009607 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/protwords.txt
   [junit4]   2> 1009608 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
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> 1009608 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/currency.xml
   [junit4]   2> 1009609 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
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> 1009609 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/enumsConfig.xml
   [junit4]   2> 1009611 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
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> 1009611 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/open-exchange-rates.json
   [junit4]   2> 1009612 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
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> 1009612 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 1009613 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
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> 1009614 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/old_synonyms.txt
   [junit4]   2> 1009615 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
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> 1009615 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/synonyms.txt
   [junit4]   2> 1009617 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1009617 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1009618 INFO  (zkCallback-1915-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@276ea028 
name:ZooKeeperConnection Watcher:127.0.0.1:36027 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1009618 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1009618 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1009618 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 1009619 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1009620 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1009620 INFO  (zkCallback-1916-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@54c94f2f 
name:ZooKeeperConnection Watcher:127.0.0.1:36027/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1009620 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1009621 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1009621 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
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> 1009621 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/solrconfig.xml
   [junit4]   2> 1009622 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
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> 1009622 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/schema.xml
   [junit4]   2> 1009624 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
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> 1009624 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/enumsConfig.xml
   [junit4]   2> 1009625 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
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> 1009625 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.SolrZkClient makePath: 
/configs/conf2/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 1009626 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
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> 1009626 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/stopwords.txt
   [junit4]   2> 1009627 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
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> 1009627 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/protwords.txt
   [junit4]   2> 1009628 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
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> 1009628 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/currency.xml
   [junit4]   2> 1009629 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
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> 1009629 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/open-exchange-rates.json
   [junit4]   2> 1009630 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
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> 1009630 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/mapping-ISOLatin1Accent.txt
   [junit4]   2> 1009631 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
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> 1009631 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/old_synonyms.txt
   [junit4]   2> 1009632 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
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> 1009632 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/synonyms.txt
   [junit4]   2> 1009633 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
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> 1009633 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/elevate.xml
   [junit4]   2> 1009699 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
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.hdfs.HdfsCollectionsAPIDistributedZkTest_F9068B6B918E120E-001/control-001/cores/collection1
   [junit4]   2> 1009700 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.e.j.s.Server jetty-9.3.8.v20160314
   [junit4]   2> 1009702 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@39975273{/,null,AVAILABLE}
   [junit4]   2> 1009702 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.e.j.s.ServerConnector Started 
ServerConnector@619cb287{HTTP/1.1,[http/1.1]}{127.0.0.1:53619}
   [junit4]   2> 1009702 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.e.j.s.Server Started @1012942ms
   [junit4]   2> 1009702 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=hdfs://localhost:44179/hdfs__localhost_44179__x1_jenkins_jenkins-slave_workspace_Lucene-Solr-NightlyTests-6.x_solr_build_solr-core_test_J1_temp_solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_F9068B6B918E120E-001_tempDir-002_control_data,
 hostContext=/, hostPort=53619, 
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_F9068B6B918E120E-001/control-001/cores}
   [junit4]   2> 1009702 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): 
sun.misc.Launcher$AppClassLoader@73d16e93
   [junit4]   2> 1009702 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
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.hdfs.HdfsCollectionsAPIDistributedZkTest_F9068B6B918E120E-001/control-001'
   [junit4]   2> 1009702 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1009702 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find 
system property or JNDI)
   [junit4]   2> 1009703 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1009703 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1009704 INFO  (zkCallback-1917-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@d939a83 name:ZooKeeperConnection 
Watcher:127.0.0.1:36027/solr got event WatchedEvent state:SyncConnected 
type:None path:null path:null type:None
   [junit4]   2> 1009704 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1009705 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1009705 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in 
ZooKeeper)
   [junit4]   2> 1009705 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
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.hdfs.HdfsCollectionsAPIDistributedZkTest_F9068B6B918E120E-001/control-001/solr.xml
   [junit4]   2> 1009709 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
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.hdfs.HdfsCollectionsAPIDistributedZkTest_F9068B6B918E120E-001/control-001/cores
   [junit4]   2> 1009709 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.CoreContainer New CoreContainer 373200867
   [junit4]   2> 1009709 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
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.hdfs.HdfsCollectionsAPIDistributedZkTest_F9068B6B918E120E-001/control-001]
   [junit4]   2> 1009709 WARN  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
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.hdfs.HdfsCollectionsAPIDistributedZkTest_F9068B6B918E120E-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.hdfs.HdfsCollectionsAPIDistributedZkTest_F9068B6B918E120E-001/control-001/lib
   [junit4]   2> 1009709 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
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> 1009710 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 1009710 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 1009710 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.l.LogWatcher Registering Log Listener [Log4j 
(org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 1009711 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:36027/solr
   [junit4]   2> 1009711 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.ZkController zkHost includes chroot
   [junit4]   2> 1009711 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1009711 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1009713 INFO  (zkCallback-1920-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@14c4424d 
name:ZooKeeperConnection Watcher:127.0.0.1:36027 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1009714 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1009714 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1009715 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) 
[n:127.0.0.1:53619_    ] o.a.s.c.ZkController Added new OnReconnect listener 
org.apache.solr.cloud.ZkController$$Lambda$57/1645707539@dac560f
   [junit4]   2> 1009718 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) 
[n:127.0.0.1:53619_    ] o.a.s.c.c.ConnectionManager Waiting for client to 
connect to ZooKeeper
   [junit4]   2> 1009721 INFO  
(zkCallback-1921-thread-1-processing-n:127.0.0.1:53619_) [n:127.0.0.1:53619_    
] o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@db889ec name:ZooKeeperConnection 
Watcher:127.0.0.1:36027/solr got event WatchedEvent state:SyncConnected 
type:None path:null path:null type:None
   [junit4]   2> 1009721 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) 
[n:127.0.0.1:53619_    ] o.a.s.c.c.ConnectionManager Client is connected to 
ZooKeeper
   [junit4]   2> 1009721 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) 
[n:127.0.0.1:53619_    ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue
   [junit4]   2> 1009722 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) 
[n:127.0.0.1:53619_    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer/collection-queue-work
   [junit4]   2> 1009724 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) 
[n:127.0.0.1:53619_    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer/collection-map-running
   [junit4]   2> 1009724 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) 
[n:127.0.0.1:53619_    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer/collection-map-completed
   [junit4]   2> 1009725 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) 
[n:127.0.0.1:53619_    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer/collection-map-failure
   [junit4]   2> 1009726 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) 
[n:127.0.0.1:53619_    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 1009726 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) 
[n:127.0.0.1:53619_    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 1009727 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) 
[n:127.0.0.1:53619_    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 1009728 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) 
[n:127.0.0.1:53619_    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 1009728 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) 
[n:127.0.0.1:53619_    ] o.a.s.c.c.ZkStateReader Updating cluster state from 
ZooKeeper... 
   [junit4]   2> 1009728 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) 
[n:127.0.0.1:53619_    ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
   [junit4]   2> 1009729 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) 
[n:127.0.0.1:53619_    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (0)
   [junit4]   2> 1009730 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) 
[n:127.0.0.1:53619_    ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect
   [junit4]   2> 1009730 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) 
[n:127.0.0.1:53619_    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer_elect/election
   [junit4]   2> 1009731 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) 
[n:127.0.0.1:53619_    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 1009731 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) 
[n:127.0.0.1:53619_    ] o.a.s.c.LeaderElector Joined leadership election with 
path: /overseer_elect/election/96100236532252678-127.0.0.1:53619_-n_0000000000
   [junit4]   2> 1009731 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) 
[n:127.0.0.1:53619_    ] o.a.s.c.OverseerElectionContext I am going to be the 
leader 127.0.0.1:53619_
   [junit4]   2> 1009731 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) 
[n:127.0.0.1:53619_    ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader
   [junit4]   2> 1009732 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) 
[n:127.0.0.1:53619_    ] o.a.s.c.Overseer Overseer 
(id=96100236532252678-127.0.0.1:53619_-n_0000000000) starting
   [junit4]   2> 1009733 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) 
[n:127.0.0.1:53619_    ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work
   [junit4]   2> 1009737 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) 
[n:127.0.0.1:53619_    ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting 
OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 
autoReplicaFailoverWaitAfterExpiration=10000 
autoReplicaFailoverBadNodeExpiration=60000
   [junit4]   2> 1009737 INFO  
(OverseerStateUpdate-96100236532252678-127.0.0.1:53619_-n_0000000000) 
[n:127.0.0.1:53619_    ] o.a.s.c.Overseer Starting to work on the main queue
   [junit4]   2> 1009749 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) 
[n:127.0.0.1:53619_    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:53619_
   [junit4]   2> 1009750 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) 
[n:127.0.0.1:53619_    ] o.a.s.c.c.SolrZkClient makePath: 
/live_nodes/127.0.0.1:53619_
   [junit4]   2> 1009750 INFO  
(OverseerStateUpdate-96100236532252678-127.0.0.1:53619_-n_0000000000) 
[n:127.0.0.1:53619_    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (0)
   [junit4]   2> 1009751 INFO  
(zkCallback-1921-thread-1-processing-n:127.0.0.1:53619_) [n:127.0.0.1:53619_    
] 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> 1009751 INFO  
(zkCallback-1921-thread-1-processing-n:127.0.0.1:53619_) [n:127.0.0.1:53619_    
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 1009758 INFO  
(OverseerCollectionConfigSetProcessor-96100236532252678-127.0.0.1:53619_-n_0000000000)
 [n:127.0.0.1:53619_    ] o.a.s.c.OverseerTaskProcessor Process current queue 
of overseer operations
   [junit4]   2> 1009759 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) 
[n:127.0.0.1:53619_    ] o.a.s.c.CoreContainer Security conf doesn't exist. 
Skipping setup for authorization module.
   [junit4]   2> 1009759 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) 
[n:127.0.0.1:53619_    ] o.a.s.c.CoreContainer No authentication plugin used.
   [junit4]   2> 1009760 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) 
[n:127.0.0.1:53619_    ] 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.hdfs.HdfsCollectionsAPIDistributedZkTest_F9068B6B918E120E-001/control-001/cores
   [junit4]   2> 1009760 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) 
[n:127.0.0.1:53619_    ] 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> 1009760 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) 
[n:127.0.0.1:53619_    ] 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.hdfs.HdfsCollectionsAPIDistributedZkTest_F9068B6B918E120E-001/control-001/cores/collection1
   [junit4]   2> 1009760 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) 
[n:127.0.0.1:53619_    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
   [junit4]   2> 1009761 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection   x:collection1] o.a.s.c.ZkController 
publishing state=down
   [junit4]   2> 1009761 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection   x:collection1] o.a.s.c.ZkController 
numShards not found on descriptor - reading it from system property
   [junit4]   2> 1009761 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) 
[n:127.0.0.1:53619_    ] 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> 1009761 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) 
[n:127.0.0.1:53619_    ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() 
done
   [junit4]   2> 1009761 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection   x:collection1] o.a.s.c.ZkController 
Collection control_collection not visible yet, but flagging it so a watch is 
registered when it becomes visible
   [junit4]   2> 1009762 INFO  
(OverseerStateUpdate-96100236532252678-127.0.0.1:53619_-n_0000000000) 
[n:127.0.0.1:53619_    ] 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:53619";,
   [junit4]   2>   "node_name":"127.0.0.1:53619_",
   [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> 1009762 INFO  
(OverseerStateUpdate-96100236532252678-127.0.0.1:53619_-n_0000000000) 
[n:127.0.0.1:53619_    ] 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:53619";,
   [junit4]   2>   "node_name":"127.0.0.1:53619_",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":null,
   [junit4]   2>   "collection":"control_collection",
   [junit4]   2>   "operation":"state"}
   [junit4]   2> 1009762 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection   x:collection1] 
o.a.s.c.c.ZkStateReader Deleting data for [control_collection]
   [junit4]   2> 1009762 INFO  
(OverseerStateUpdate-96100236532252678-127.0.0.1:53619_-n_0000000000) 
[n:127.0.0.1:53619_    ] o.a.s.c.o.ClusterStateMutator building a new cName: 
control_collection
   [junit4]   2> 1009762 INFO  
(OverseerStateUpdate-96100236532252678-127.0.0.1:53619_-n_0000000000) 
[n:127.0.0.1:53619_    ] o.a.s.c.o.ReplicaMutator Assigning new node to shard 
shard=shard1
   [junit4]   2> 1009763 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection   x:collection1] o.a.s.c.ZkController 
look for our core node name
   [junit4]   2> 1009763 INFO  
(zkCallback-1921-thread-1-processing-n:127.0.0.1:53619_) [n:127.0.0.1:53619_    
] 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> 1010763 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection   x:collection1] o.a.s.c.ZkController 
waiting to find shard id in clusterstate for collection1
   [junit4]   2> 1010763 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection   x:collection1] o.a.s.c.ZkController 
Check for collection zkNode:control_collection
   [junit4]   2> 1010764 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection   x:collection1] o.a.s.c.ZkController 
Collection zkNode exists
   [junit4]   2> 1010764 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection   x:collection1] 
o.a.s.c.c.ZkStateReader Load collection config from: 
[/collections/control_collection]
   [junit4]   2> 1010764 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection   x:collection1] 
o.a.s.c.c.ZkStateReader path=[/collections/control_collection] 
[configName]=[conf1] specified config exists in ZooKeeper
   [junit4]   2> 1010764 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ 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.hdfs.HdfsCollectionsAPIDistributedZkTest_F9068B6B918E120E-001/control-001/cores/collection1'
   [junit4]   2> 1010764 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection   x:collection1] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1010764 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection   x:collection1] 
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find 
system property or JNDI)
   [junit4]   2> 1010765 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection   x:collection1] o.a.s.c.Config loaded 
config solrconfig.xml with version 0 
   [junit4]   2> 1010769 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection   x:collection1] o.a.s.c.SolrConfig 
current version of requestparams : -1
   [junit4]   2> 1010771 WARN  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection   x:collection1] o.a.s.c.Config 
Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> 
instead.
   [junit4]   2> 1010772 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection   x:collection1] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 6.2.0
   [junit4]   2> 1010778 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection   x:collection1] o.a.s.c.SolrConfig 
Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 1010782 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection   x:collection1] o.a.s.s.IndexSchema 
[collection1] Schema name=test
   [junit4]   2> 1010859 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection   x:collection1] 
o.a.s.s.OpenExchangeRatesOrgProvider Initialized with 
rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 1010863 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection   x:collection1] o.a.s.s.IndexSchema 
default search field in schema is text
   [junit4]   2> 1010864 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection   x:collection1] o.a.s.s.IndexSchema 
unique key field: id
   [junit4]   2> 1010869 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection   x:collection1] 
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 1010871 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection   x:collection1] 
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 1010872 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection   x:collection1] 
o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from 
open-exchange-rates.json
   [junit4]   2> 1010872 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection   x:collection1] 
o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from 
open-exchange-rates.json
   [junit4]   2> 1010873 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ 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> 1010873 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection   x:collection1] o.a.s.c.CoreContainer 
Creating SolrCore 'collection1' using configuration from collection 
control_collection
   [junit4]   2> 1010873 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.SolrCore org.apache.solr.core.HdfsDirectoryFactory
   [junit4]   2> 1010873 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.HdfsDirectoryFactory 
solr.hdfs.home=hdfs://localhost:44179/solr_hdfs_home
   [junit4]   2> 1010873 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.HdfsDirectoryFactory Solr Kerberos Authentication disabled
   [junit4]   2> 1010873 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ 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.hdfs.HdfsCollectionsAPIDistributedZkTest_F9068B6B918E120E-001/control-001/cores/collection1],
 
dataDir=[hdfs://localhost:44179/solr_hdfs_home/control_collection/core_node1/data/]
   [junit4]   2> 1010874 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ 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@6b111841
   [junit4]   2> 1010874 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.HdfsDirectoryFactory creating directory factory for path 
hdfs://localhost:44179/solr_hdfs_home/control_collection/core_node1/data
   [junit4]   2> 1010885 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.CachingDirectoryFactory return new directory for 
hdfs://localhost:44179/solr_hdfs_home/control_collection/core_node1/data
   [junit4]   2> 1010889 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.SolrCore New index directory detected: old=null 
new=hdfs://localhost:44179/solr_hdfs_home/control_collection/core_node1/data/index/
   [junit4]   2> 1010895 WARN  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.SolrCore [collection1] Solr index directory 
'hdfs:/localhost:44179/solr_hdfs_home/control_collection/core_node1/data/index' 
doesn't exist. Creating new index...
   [junit4]   2> 1010895 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.HdfsDirectoryFactory creating directory factory for path 
hdfs://localhost:44179/solr_hdfs_home/control_collection/core_node1/data/index
   [junit4]   2> 1010913 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.CachingDirectoryFactory return new directory for 
hdfs://localhost:44179/solr_hdfs_home/control_collection/core_node1/data/index
   [junit4]   2> 1010913 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: 
minMergeSize=0, mergeFactor=10, maxMergeSize=1414583399, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.1]
   [junit4]   2> 1011089 INFO  (IPC Server handler 5 on 44179) [    ] 
BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:35424 is 
added to blk_1073741825_1001{blockUCState=COMMITTED, primaryNodeIndex=-1, 
replicas=[ReplicaUnderConstruction[[DISK]DS-a12fecbe-8977-4da2-b094-f0891fb902c9:NORMAL:127.0.0.1:48408|RBW],
 
ReplicaUnderConstruction[[DISK]DS-687944d0-ad12-4486-ab34-55bc32dd3908:NORMAL:127.0.0.1:35424|RBW]]}
 size 71
   [junit4]   2> 1011093 INFO  (IPC Server handler 8 on 44179) [    ] 
BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:48408 is 
added to blk_1073741825_1001 size 71
   [junit4]   2> 1011481 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>        
commit{dir=NRTCachingDirectory(HdfsDirectory@hdfs://localhost:44179/solr_hdfs_home/control_collection/core_node1/data/index
 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@79f00f1d; 
maxCacheMB=192.0 maxMergeSizeMB=16.0),segFN=segments_1,generation=1}
   [junit4]   2> 1011481 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 1011482 INFO  
(OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:53619_ 
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 
hdfs://localhost:44179/solr_hdfs_home/control_collection/core_node1/data/
   [junit4]   2> 1011484 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain 
"nodistrib"
   [junit4]   2> 1011484 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain 
"dedupe"
   [junit4]   2> 1011484 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.p.UpdateRequestProcessorChain inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 1011484 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain 
"stored_sig"
   [junit4]   2> 1011484 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.p.UpdateRequestProcessorChain inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 1011484 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ 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> 1011484 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ 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> 1011484 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ 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> 1011484 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ 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> 1011484 WARN  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ 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> 1011485 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1011486 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1011487 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1011487 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1011489 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.RequestHandlers Registered paths: 
/admin/mbeans,standard,/update/json/docs,/admin/luke,/export,/get,/admin/properties,/update/json,/admin/threads,/dump,/update/csv,/sql,/graph,/admin/segments,/admin/system,/replication,/config,/stream,/schema,/admin/plugins,/admin/logging,/admin/ping,/update,/admin/file
   [junit4]   2> 1011489 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ 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> 1011489 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.HdfsUpdateLog
   [junit4]   2> 1011489 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ 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> 1011489 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.HdfsUpdateLog Initializing HdfsUpdateLog: tlogDfsReplication=2
   [junit4]   2> 1011501 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1011501 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1011502 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ 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=40, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.5831232526589275]
   [junit4]   2> 1011506 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>        
commit{dir=NRTCachingDirectory(HdfsDirectory@hdfs://localhost:44179/solr_hdfs_home/control_collection/core_node1/data/index
 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@79f00f1d; 
maxCacheMB=192.0 maxMergeSizeMB=16.0),segFN=segments_1,generation=1}
   [junit4]   2> 1011506 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 1011506 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@336dced2[collection1] main]
   [junit4]   2> 1011506 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ 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> 1011507 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ 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> 1011507 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ 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> 1011507 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf1
   [junit4]   2> 1011507 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.r.RestManager Initializing RestManager with initArgs: {}
   [junit4]   2> 1011507 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ 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> 1011508 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ 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> 1011508 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ 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> 1011508 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.r.RestManager Initializing 0 registered ManagedResources
   [junit4]   2> 1011508 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1011509 INFO  
(searcherExecutor-2596-thread-1-processing-n:127.0.0.1:53619_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:53619_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore 
[collection1] Registered new searcher Searcher@336dced2[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1011509 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ 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> 1011509 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ 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> 1011509 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ 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> 1011509 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ 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 1537603786633117696
   [junit4]   2> 1011511 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.UpdateLog Took 1.0ms to seed version buckets with highest version 
1537603786633117696
   [junit4]   2> 1011511 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.ZkController watch zkdir /configs/conf1
   [junit4]   2> 1011511 INFO  
(coreLoadExecutor-2595-thread-1-processing-n:127.0.0.1:53619_) 
[n:127.0.0.1:53619_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.CoreContainer registering core: collection1
   [junit4]   2> 1011511 INFO  
(coreZkRegister-2589-thread-1-processing-n:127.0.0.1:53619_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:53619_ 
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:53619 
collection:control_collection shard:shard1
   [junit4]   2> 1011512 INFO  
(coreZkRegister-2589-thread-1-processing-n:127.0.0.1:53619_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:53619_ 
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> 1011514 INFO  
(coreZkRegister-2589-thread-1-processing-n:127.0.0.1:53619_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:53619_ 
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/96100236532252678-core_node1-n_0000000000
   [junit4]   2> 1011514 INFO  
(coreZkRegister-2589-thread-1-processing-n:127.0.0.1:53619_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:53619_ 
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> 1011515 INFO  
(coreZkRegister-2589-thread-1-processing-n:127.0.0.1:53619_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:53619_ 
c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 1011515 INFO  
(coreZkRegister-2589-thread-1-processing-n:127.0.0.1:53619_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:53619_ 
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> 1011515 INFO  
(coreZkRegister-2589-thread-1-processing-n:127.0.0.1:53619_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:53619_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy 
Sync replicas to http://127.0.0.1:53619/collection1/
   [junit4]   2> 1011515 INFO  
(coreZkRegister-2589-thread-1-processing-n:127.0.0.1:53619_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:53619_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy 
Sync Success - now sync replicas to me
   [junit4]   2> 1011515 INFO  
(coreZkRegister-2589-thread-1-processing-n:127.0.0.1:53619_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:53619_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy 
http://127.0.0.1:53619/collection1/ has no replicas
   [junit4]   2> 1011515 INFO  
(OverseerStateUpdate-96100236532252678-127.0.0.1:53619_-n_0000000000) 
[n:127.0.0.1:53619_    ] 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> 1011516 INFO  
(coreZkRegister-2589-thread-1-processing-n:127.0.0.1:53619_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:53619_ 
c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/leaders/shard1
   [junit4]   2> 1011516 INFO  
(zkCallback-1921-thread-1-processing-n:127.0.0.1:53619_) [n:127.0.0.1:53619_    
] 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> 1011517 INFO  
(coreZkRegister-2589-thread-1-processing-n:127.0.0.1:53619_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:53619_ 
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/96100236532252678-core_node1-n_0000000000
   [junit4]   2> 1011518 INFO  
(coreZkRegister-2589-thread-1-processing-n:127.0.0.1:53619_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:53619_ 
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:53619/collection1/ shard1
   [junit4]   2> 1011518 INFO  
(OverseerStateUpdate-96100236532252678-127.0.0.1:53619_-n_0000000000) 
[n:127.0.0.1:53619_    ] 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:53619";,
   [junit4]   2>   "core":"collection1",
   [junit4]   2>   "state":"active"} current state version: 2
   [junit4]   2> 1011620 INFO  
(zkCallback-1921-thread-1-processing-n:127.0.0.1:53619_) [n:127.0.0.1:53619_    
] 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> 1011669 INFO  
(coreZkRegister-2589-thread-1-processing-n:127.0.0.1:53619_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:53619_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController 
We are http://127.0.0.1:53619/collection1/ and leader is 
http://127.0.0.1:53619/collection1/
   [junit4]   2> 1011669 INFO  
(coreZkRegister-2589-thread-1-processing-n:127.0.0.1:53619_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:53619_ 
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:53619
   [junit4]   2> 1011669 INFO  
(coreZkRegister-2589-thread-1-processing-n:127.0.0.1:53619_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:53619_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController 
I am the leader, no recovery necessary
   [junit4]   2> 1011669 INFO  
(coreZkRegister-2589-thread-1-processing-n:127.0.0.1:53619_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:53619_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController 
publishing state=active
   [junit4]   2> 1011669 INFO  
(coreZkRegister-2589-thread-1-processing-n:127.0.0.1:53619_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:53619_ 
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> 1011671 INFO  
(OverseerStateUpdate-96100236532252678-127.0.0.1:53619_-n_0000000000) 
[n:127.0.0.1:53619_    ] o.a.s.c.Overseer processMessage: queueSize: 1, message 
= {
   [junit4]   2>   "core":"collection1",
   [junit4]   2>   "core_node_name":"core_node1",
   [junit4]   2>   
"dataDir":"hdfs://localhost:44179/solr_hdfs_home/control_collection/core_node1/data/",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"http://127.0.0.1:53619";,
   [junit4]   2>   "node_name":"127.0.0.1:53619_",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"control_collection",
   [junit4]   2>   "operation":"state",
   [junit4]   2>   
"ulogDir":"hdfs://localhost:44179/solr_hdfs_home/control_collection/core_node1/data/tlog"}
 current state version: 3
   [junit4]   2> 1011671 INFO  
(OverseerStateUpdate-96100236532252678-127.0.0.1:53619_-n_0000000000) 
[n:127.0.0.1:53619_    ] o.a.s.c.o.ReplicaMutator Update state numShards=1 
message={
   [junit4]   2>   "core":"collection1",
   [junit4]   2>   "core_node_name":"core_node1",
   [junit4]   2>   
"dataDir":"hdfs://localhost:44179/solr_hdfs_home/control_collection/core_node1/data/",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"http://127.0.0.1:53619";,
   [junit4]   2>   "node_name":"127.0.0.1:53619_",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"control_collection",
   [junit4]   2>   "operation":"state",
   [junit4]   2>   
"ulogDir":"hdfs://localhost:44179/solr_hdfs_home/control_collection/core_node1/data/tlog"}
   [junit4]   2> 1011767 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1011767 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1011768 INFO  (zkCallback-1925-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@7fa8b143 
name:ZooKeeperConnection Watcher:127.0.0.1:36027/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1011768 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1011769 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1011769 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 1011769 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.ZkStateReader Loaded empty cluster properties
   [junit4]   2> 1011770 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 1011771 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection 
loss:false
   [junit4]   2> 1011771 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.AbstractFullDistribZkTestBase Creating collection1 with stateFormat=2
   [junit4]   2> 1011771 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1011772 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1011772 INFO  (zkCallback-1926-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@2f4ae3c7 
name:ZooKeeperConnection Watcher:127.0.0.1:36027/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1011773 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1011773 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1011778 INFO  (zkCallback-1925-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred 
- updating... (live nodes size: [1])
   [junit4]   2> 1011778 INFO  
(zkCallback-1921-thread-1-processing-n:127.0.0.1:53619_) [n:127.0.0.1:53619_    
] 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> 1011780 INFO  
(OverseerStateUpdate-96100236532252678-127.0.0.1:53619_-n_0000000000) 
[n:127.0.0.1:53619_    ] 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: 4
   [junit4]   2> 1011781 INFO  
(OverseerStateUpdate-96100236532252678-127.0.0.1:53619_-n_0000000000) 
[n:127.0.0.1:53619_    ] o.a.s.c.o.ClusterStateMutator building a new cName: 
collection1
   [junit4]   2> 1011834 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
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.hdfs.HdfsCollectionsAPIDistributedZkTest_F9068B6B918E120E-001/shard-1-001/cores/collection1
   [junit4]   2> 1011835 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
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.hdfs.HdfsCollectionsAPIDistributedZkTest_F9068B6B918E120E-001/shard-1-001
   [junit4]   2> 1011835 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.e.j.s.Server jetty-9.3.8.v20160314
   [junit4]   2> 1011836 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@75029db{/,null,AVAILABLE}
   [junit4]   2> 1011836 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.e.j.s.ServerConnector Started 
ServerConnector@32da63bd{HTTP/1.1,[http/1.1]}{127.0.0.1:52086}
   [junit4]   2> 1011837 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.e.j.s.Server Started @1015077ms
   [junit4]   2> 1011837 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=hdfs://localhost:44179/hdfs__localhost_44179__x1_jenkins_jenkins-slave_workspace_Lucene-Solr-NightlyTests-6.x_solr_build_solr-core_test_J1_temp_solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_F9068B6B918E120E-001_tempDir-002_jetty1,
 solrconfig=solrconfig.xml, hostContext=/, hostPort=52086, 
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_F9068B6B918E120E-001/shard-1-001/cores}
   [junit4]   2> 1011837 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): 
sun.misc.Launcher$AppClassLoader@73d16e93
   [junit4]   2> 1011837 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
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.hdfs.HdfsCollectionsAPIDistributedZkTest_F9068B6B918E120E-001/shard-1-001'
   [junit4]   2> 1011837 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1011837 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find 
system property or JNDI)
   [junit4]   2> 1011837 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1011837 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1011839 INFO  (zkCallback-1927-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@545d2be1 
name:ZooKeeperConnection Watcher:127.0.0.1:36027/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1011839 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1011839 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1011840 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in 
ZooKeeper)
   [junit4]   2> 1011840 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
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.hdfs.HdfsCollectionsAPIDistributedZkTest_F9068B6B918E120E-001/shard-1-001/solr.xml
   [junit4]   2> 1011843 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
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.hdfs.HdfsCollectionsAPIDistributedZkTest_F9068B6B918E120E-001/shard-1-001/cores
   [junit4]   2> 1011843 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.CoreContainer New CoreContainer 1481041463
   [junit4]   2> 1011843 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[F9068B6B918E120E]) [    ] 
o.a.s.c.CoreContainer Loading cores into CoreContainer [in

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

s://127.0.0.1:33961, https://127.0.0.1:51555, https://127.0.0.1:50449, 
https://127.0.0.1:40823, https://127.0.0.1:43691]
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:383)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1228)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:998)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:934)
   [junit4]    >        at 
org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219)
   [junit4]    >        at 
org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1599)
   [junit4]    >        at 
org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1620)
   [junit4]    >        at 
org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:987)
   [junit4]    > Caused by: org.apache.solr.client.solrj.SolrServerException: 
Timeout occured while waiting response from server at: https://127.0.0.1:50449
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:601)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:259)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:248)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:403)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:356)
   [junit4]    >        ... 7 more
   [junit4]    > Caused by: java.net.SocketTimeoutException: Read timed out
   [junit4]    >        at java.net.SocketInputStream.socketRead0(Native Method)
   [junit4]    >        at 
java.net.SocketInputStream.socketRead(SocketInputStream.java:116)
   [junit4]    >        at 
java.net.SocketInputStream.read(SocketInputStream.java:170)
   [junit4]    >        at 
java.net.SocketInputStream.read(SocketInputStream.java:141)
   [junit4]    >        at 
sun.security.ssl.InputRecord.readFully(InputRecord.java:465)
   [junit4]    >        at 
sun.security.ssl.InputRecord.read(InputRecord.java:503)
   [junit4]    >        at 
sun.security.ssl.SSLSocketImpl.readRecord(SSLSocketImpl.java:973)
   [junit4]    >        at 
sun.security.ssl.SSLSocketImpl.readDataRecord(SSLSocketImpl.java:930)
   [junit4]    >        at 
sun.security.ssl.AppInputStream.read(AppInputStream.java:105)
   [junit4]    >        at 
org.apache.http.impl.io.AbstractSessionInputBuffer.fillBuffer(AbstractSessionInputBuffer.java:160)
   [junit4]    >        at 
org.apache.http.impl.io.SocketInputBuffer.fillBuffer(SocketInputBuffer.java:84)
   [junit4]    >        at 
org.apache.http.impl.io.AbstractSessionInputBuffer.readLine(AbstractSessionInputBuffer.java:273)
   [junit4]    >        at 
org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:140)
   [junit4]    >        at 
org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:57)
   [junit4]    >        at 
org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:261)
   [junit4]    >        at 
org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:283)
   [junit4]    >        at 
org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:251)
   [junit4]    >        at 
org.apache.http.impl.conn.ManagedClientConnectionImpl.receiveResponseHeader(ManagedClientConnectionImpl.java:197)
   [junit4]    >        at 
org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:272)
   [junit4]    >        at 
org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:124)
   [junit4]    >        at 
org.apache.http.impl.client.DefaultRequestDirector.tryExecute(DefaultRequestDirector.java:685)
   [junit4]    >        at 
org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:487)
   [junit4]    >        at 
org.apache.http.impl.client.AbstractHttpClient.doExecute(AbstractHttpClient.java:882)
   [junit4]    >        at 
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82)
   [junit4]    >        at 
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:107)
   [junit4]    >        at 
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:55)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:495)
   [junit4]    >        ... 11 more
   [junit4]   2> 3286320 INFO  
(SUITE-CollectionsAPIDistributedZkTest-seed#[F9068B6B918E120E]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene62): 
{other_tl1=PostingsFormat(name=MockRandom), 
range_facet_l_dv=PostingsFormat(name=LuceneVarGapDocFreqInterval), 
_version_=PostingsFormat(name=MockRandom), 
multiDefault=PostingsFormat(name=Memory doPackFST= true), 
a_t=PostingsFormat(name=Memory doPackFST= true), 
intDefault=PostingsFormat(name=MockRandom), a_i1=PostingsFormat(name=Memory 
doPackFST= true), id=PostingsFormat(name=LuceneVarGapDocFreqInterval), 
range_facet_i_dv=PostingsFormat(name=Memory doPackFST= true), 
text=PostingsFormat(name=Memory doPackFST= false), 
range_facet_l=PostingsFormat(name=Memory doPackFST= true), 
timestamp=PostingsFormat(name=Memory doPackFST= true)}, 
docValues:{range_facet_l_dv=DocValuesFormat(name=Lucene54), 
range_facet_i_dv=DocValuesFormat(name=Memory), 
timestamp=DocValuesFormat(name=Memory)}, maxPointsInLeafNode=1818, 
maxMBSortInHeap=6.728991094923747, 
sim=RandomSimilarity(queryNorm=true,coord=yes): {}, locale=ar-LB, 
timezone=Europe/Vilnius
   [junit4]   2> NOTE: Linux 3.13.0-85-generic amd64/Oracle Corporation 
1.8.0_74 (64-bit)/cpus=4,threads=1,free=257798728,total=486014976
   [junit4]   2> NOTE: All tests run in this JVM: [TestPseudoReturnFields, 
BlockDirectoryTest, PeerSyncTest, TestPerFieldSimilarityWithDefaultOverride, 
TestBulkSchemaConcurrent, JavabinLoaderTest, SortSpecParsingTest, 
DeleteStatusTest, SolrRequestParserTest, TestDistribIDF, CursorPagingTest, 
DefaultValueUpdateProcessorTest, TestCSVLoader, TestConfigSetsAPIExclusivity, 
TlogReplayBufferedWhileIndexingTest, SuggestComponentContextFilterQueryTest, 
HdfsBasicDistributedZk2Test, TestLegacyFieldCache, 
LeaderInitiatedRecoveryOnCommitTest, TestReRankQParserPlugin, TestMacros, 
TestJsonFacets, TestStressLiveNodes, SSLMigrationTest, TestFreeTextSuggestions, 
TestBulkSchemaAPI, CacheHeaderTest, HdfsChaosMonkeySafeLeaderTest, 
TestSolr4Spatial, HLLSerializationTest, DistributedFacetPivotWhiteBoxTest, 
TestManagedResource, ZkNodePropsTest, TestQueryWrapperFilter, 
MultiThreadedOCPTest, TestSolr4Spatial2, TestFastOutputStream, 
CoreAdminCreateDiscoverTest, TestLuceneMatchVersion, EchoParamsTest, 
TestFieldCollectionResource, TestNRTOpen, TestMiniSolrCloudClusterSSL, 
ResourceLoaderTest, TestSearcherReuse, TestDocSet, 
AsyncCallRequestStatusResponseTest, SharedFSAutoReplicaFailoverTest, 
UUIDFieldTest, TestExpandComponent, LeaderElectionIntegrationTest, 
CurrencyFieldOpenExchangeTest, BooleanFieldTest, PreAnalyzedFieldTest, 
TestImplicitCoreProperties, TestSortByMinMaxFunction, TestScoreJoinQPNoScore, 
TestManagedSchemaAPI, TestObjectReleaseTracker, TestBadConfig, 
OverseerCollectionConfigSetProcessorTest, QueryElevationComponentTest, 
TestRemoteStreaming, TestLeaderElectionZkExpiry, TolerantUpdateProcessorTest, 
TestClusterStateMutator, TestRTGBase, TestDistributedSearch, 
TestSubQueryTransformer, DistributedSpellCheckComponentTest, 
ConnectionReuseTest, BlockJoinFacetRandomTest, TestFieldCacheSortRandom, 
BlobRepositoryCloudTest, TestUninvertingReader, CdcrUpdateLogTest, 
TestOmitPositions, TestSolrQueryParserDefaultOperatorResource, 
TestLMDirichletSimilarityFactory, TestMiniSolrCloudCluster, TestLRUCache, 
WrapperMergePolicyFactoryTest, PolyFieldTest, SynonymTokenizerTest, 
TestReplicationHandler, TestRebalanceLeaders, TestConfigSetProperties, 
TestDFISimilarityFactory, AddSchemaFieldsUpdateProcessorFactoryTest, 
SystemInfoHandlerTest, JSONWriterTest, TestUseDocValuesAsStored2, 
HdfsLockFactoryTest, DistributedQueryElevationComponentTest, 
TestRequestStatusCollectionAPI, SOLR749Test, TestSchemaSimilarityResource, 
TestJoin, SyncSliceTest, TestFunctionQuery, 
SignatureUpdateProcessorFactoryTest, CollectionsAPIDistributedZkTest]
   [junit4] Completed [288/615 (3!)] on J0 in 522.52s, 1 test, 1 error <<< 
FAILURES!

[...truncated 1009 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:531:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/lucene/common-build.xml:1427:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/lucene/common-build.xml:984:
 There were test failures: 615 suites (10 ignored), 2591 tests, 1 suite-level 
error, 2 errors, 33 ignored (18 assumptions) [seed: F9068B6B918E120E]

Total time: 255 minutes 59 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