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

3 tests failed.
REGRESSION:  org.apache.solr.cloud.FullSolrCloudDistribCmdsTest.test

Error Message:
Captured an uncaught exception in thread: Thread[id=68790, name=Thread-63232, 
state=RUNNABLE, group=TGRP-FullSolrCloudDistribCmdsTest]

Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught 
exception in thread: Thread[id=68790, name=Thread-63232, state=RUNNABLE, 
group=TGRP-FullSolrCloudDistribCmdsTest]
Caused by: java.lang.RuntimeException: 
org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting 
response from server at: http://127.0.0.1:60564/c/collection1
        at __randomizedtesting.SeedInfo.seed([DBFD227F892BB030]:0)
        at 
org.apache.solr.cloud.FullSolrCloudDistribCmdsTest$1IndexThread.run(FullSolrCloudDistribCmdsTest.java:645)
Caused by: org.apache.solr.client.solrj.SolrServerException: Timeout occured 
while waiting response from server at: http://127.0.0.1:60564/c/collection1
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:587)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:241)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:230)
        at 
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:150)
        at 
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:167)
        at 
org.apache.solr.cloud.FullSolrCloudDistribCmdsTest$1IndexThread.run(FullSolrCloudDistribCmdsTest.java:643)
Caused by: java.net.SocketTimeoutException: Read timed out
        at java.net.SocketInputStream.socketRead0(Native Method)
        at java.net.SocketInputStream.socketRead(SocketInputStream.java:116)
        at java.net.SocketInputStream.read(SocketInputStream.java:170)
        at java.net.SocketInputStream.read(SocketInputStream.java:141)
        at 
org.apache.http.impl.io.AbstractSessionInputBuffer.fillBuffer(AbstractSessionInputBuffer.java:160)
        at 
org.apache.http.impl.io.SocketInputBuffer.fillBuffer(SocketInputBuffer.java:84)
        at 
org.apache.http.impl.io.AbstractSessionInputBuffer.readLine(AbstractSessionInputBuffer.java:273)
        at 
org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:140)
        at 
org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:57)
        at 
org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:261)
        at 
org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:283)
        at 
org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:251)
        at 
org.apache.http.impl.conn.ManagedClientConnectionImpl.receiveResponseHeader(ManagedClientConnectionImpl.java:197)
        at 
org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:272)
        at 
org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:124)
        at 
org.apache.http.impl.client.DefaultRequestDirector.tryExecute(DefaultRequestDirector.java:685)
        at 
org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:487)
        at 
org.apache.http.impl.client.AbstractHttpClient.doExecute(AbstractHttpClient.java:882)
        at 
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82)
        at 
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:107)
        at 
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:55)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:480)
        ... 5 more


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

Error Message:
KeeperErrorCode = Session expired for /clusterstate.json

Stack Trace:
org.apache.zookeeper.KeeperException$SessionExpiredException: KeeperErrorCode = 
Session expired for /clusterstate.json
        at org.apache.zookeeper.KeeperException.create(KeeperException.java:127)
        at org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
        at org.apache.zookeeper.ZooKeeper.getData(ZooKeeper.java:1155)
        at 
org.apache.solr.common.cloud.SolrZkClient$7.execute(SolrZkClient.java:353)
        at 
org.apache.solr.common.cloud.SolrZkClient$7.execute(SolrZkClient.java:350)
        at 
org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:61)
        at 
org.apache.solr.common.cloud.SolrZkClient.getData(SolrZkClient.java:350)
        at 
org.apache.solr.common.cloud.ZkStateReader.refreshLegacyClusterState(ZkStateReader.java:472)
        at 
org.apache.solr.common.cloud.ZkStateReader.updateClusterState(ZkStateReader.java:256)
        at 
org.apache.solr.cloud.AbstractDistribZkTestBase.waitForCollectionToDisappear(AbstractDistribZkTestBase.java:196)
        at 
org.apache.solr.cloud.AbstractFullDistribZkTestBase.assertCollectionNotExists(AbstractFullDistribZkTestBase.java:1772)
        at 
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.deletePartiallyCreatedCollection(CollectionsAPIDistributedZkTest.java:234)
        at 
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.test(CollectionsAPIDistributedZkTest.java:171)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:497)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1665)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:864)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:900)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:914)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:963)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:938)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:873)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:775)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:809)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:820)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at java.lang.Thread.run(Thread.java:745)


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

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

Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught 
exception in thread: Thread[id=39325, name=collection2, state=RUNNABLE, 
group=TGRP-HdfsCollectionsAPIDistributedZkTest]
Caused by: 
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error 
from server at http://127.0.0.1:33064/xsssc/og: Could not find collection : 
awholynewstresscollection_collection2_0
        at __randomizedtesting.SeedInfo.seed([DBFD227F892BB030]:0)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:575)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:241)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:230)
        at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:372)
        at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:325)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1099)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:870)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:806)
        at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1220)
        at 
org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:895)




Build Log:
[...truncated 10253 lines...]
   [junit4] Suite: 
org.apache.solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest
   [junit4]   2> Creating dataDir: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_DBFD227F892BB030-001/init-core-data-001
   [junit4]   2> 1012549 INFO  
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[DBFD227F892BB030]-worker) [    
] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false)
   [junit4]   2> 1012549 INFO  
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[DBFD227F892BB030]-worker) [    
] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: 
/xsssc/og
   [junit4]   1> Formatting using clusterid: testClusterID
   [junit4]   2> 1012603 WARN  
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[DBFD227F892BB030]-worker) [    
] o.a.h.m.i.MetricsConfig Cannot locate configuration: tried 
hadoop-metrics2-namenode.properties,hadoop-metrics2.properties
   [junit4]   2> 1012608 WARN  
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[DBFD227F892BB030]-worker) [    
] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
   [junit4]   2> 1012611 INFO  
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[DBFD227F892BB030]-worker) [    
] o.m.log jetty-6.1.26
   [junit4]   2> 1012624 INFO  
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[DBFD227F892BB030]-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_41499_hdfs____.fb23rz/webapp
   [junit4]   2> 1012731 INFO  
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[DBFD227F892BB030]-worker) [    
] o.m.log NO JSP Support for /, did not find 
org.apache.jasper.servlet.JspServlet
   [junit4]   2> 1014378 INFO  
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[DBFD227F892BB030]-worker) [    
] o.m.log Started 
HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:41499
   [junit4]   2> 1014449 WARN  
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[DBFD227F892BB030]-worker) [    
] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
   [junit4]   2> 1014451 INFO  
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[DBFD227F892BB030]-worker) [    
] o.m.log jetty-6.1.26
   [junit4]   2> 1014467 INFO  
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[DBFD227F892BB030]-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_41772_datanode____.v2lmg4/webapp
   [junit4]   2> 1014601 INFO  
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[DBFD227F892BB030]-worker) [    
] o.m.log NO JSP Support for /, did not find 
org.apache.jasper.servlet.JspServlet
   [junit4]   2> 1015978 INFO  
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[DBFD227F892BB030]-worker) [    
] o.m.log Started 
HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:41772
   [junit4]   2> 1016061 WARN  
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[DBFD227F892BB030]-worker) [    
] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
   [junit4]   2> 1016062 INFO  
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[DBFD227F892BB030]-worker) [    
] o.m.log jetty-6.1.26
   [junit4]   2> 1016089 INFO  
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[DBFD227F892BB030]-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_49941_datanode____.ithdc8/webapp
   [junit4]   2> 1016245 INFO  (IPC Server handler 2 on 53240) [    ] 
BlockStateChange BLOCK* processReport: from storage 
DS-646134ea-7799-402f-b769-28f32287ee5b node DatanodeRegistration(127.0.0.1, 
datanodeUuid=094ab855-4a37-47d2-931d-c5c27e4f0d5a, infoPort=41772, 
ipcPort=58431, storageInfo=lv=-56;cid=testClusterID;nsid=1541883535;c=0), 
blocks: 0, hasStaleStorages: true, processing time: 1 msecs
   [junit4]   2> 1016245 INFO  (IPC Server handler 2 on 53240) [    ] 
BlockStateChange BLOCK* processReport: from storage 
DS-e87fa334-e03b-4bb2-bcae-31ade5621723 node DatanodeRegistration(127.0.0.1, 
datanodeUuid=094ab855-4a37-47d2-931d-c5c27e4f0d5a, infoPort=41772, 
ipcPort=58431, storageInfo=lv=-56;cid=testClusterID;nsid=1541883535;c=0), 
blocks: 0, hasStaleStorages: false, processing time: 0 msecs
   [junit4]   2> 1016276 INFO  
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[DBFD227F892BB030]-worker) [    
] o.m.log NO JSP Support for /, did not find 
org.apache.jasper.servlet.JspServlet
   [junit4]   2> 1018073 INFO  
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[DBFD227F892BB030]-worker) [    
] o.m.log Started 
HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:49941
   [junit4]   2> 1018246 INFO  (IPC Server handler 6 on 53240) [    ] 
BlockStateChange BLOCK* processReport: from storage 
DS-3d6c87e0-860b-406b-9e8d-287036aee490 node DatanodeRegistration(127.0.0.1, 
datanodeUuid=77907a3c-bd4a-42ab-99cd-681009015875, infoPort=49941, 
ipcPort=48716, storageInfo=lv=-56;cid=testClusterID;nsid=1541883535;c=0), 
blocks: 0, hasStaleStorages: true, processing time: 1 msecs
   [junit4]   2> 1018247 INFO  (IPC Server handler 6 on 53240) [    ] 
BlockStateChange BLOCK* processReport: from storage 
DS-62c00844-11fb-4547-bf4d-c69deeb82866 node DatanodeRegistration(127.0.0.1, 
datanodeUuid=77907a3c-bd4a-42ab-99cd-681009015875, infoPort=49941, 
ipcPort=48716, storageInfo=lv=-56;cid=testClusterID;nsid=1541883535;c=0), 
blocks: 0, hasStaleStorages: false, processing time: 0 msecs
   [junit4]   2> 1018421 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1018421 INFO  (Thread-35696) [    ] o.a.s.c.ZkTestServer 
client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 1018421 INFO  (Thread-35696) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 1018521 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.ZkTestServer start zk server on port:38157
   [junit4]   2> 1018521 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1018523 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1018535 INFO  (zkCallback-347-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@5ca25c25 
name:ZooKeeperConnection Watcher:127.0.0.1:38157 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1018535 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1018535 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1018535 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 1018539 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1018539 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1018540 INFO  (zkCallback-348-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@2317d727 
name:ZooKeeperConnection Watcher:127.0.0.1:38157/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1018541 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1018541 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1018541 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/collection1
   [junit4]   2> 1018544 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/collection1/shards
   [junit4]   2> 1018545 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection
   [junit4]   2> 1018546 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/shards
   [junit4]   2> 1018547 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
 to /configs/conf1/solrconfig.xml
   [junit4]   2> 1018548 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.xml
   [junit4]   2> 1018550 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/schema.xml
 to /configs/conf1/schema.xml
   [junit4]   2> 1018550 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/schema.xml
   [junit4]   2> 1018552 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
 to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 1018552 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.SolrZkClient makePath: 
/configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 1018554 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
 to /configs/conf1/stopwords.txt
   [junit4]   2> 1018554 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/stopwords.txt
   [junit4]   2> 1018556 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/protwords.txt
 to /configs/conf1/protwords.txt
   [junit4]   2> 1018556 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/protwords.txt
   [junit4]   2> 1018558 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/currency.xml
 to /configs/conf1/currency.xml
   [junit4]   2> 1018558 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/currency.xml
   [junit4]   2> 1018563 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
 to /configs/conf1/enumsConfig.xml
   [junit4]   2> 1018563 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/enumsConfig.xml
   [junit4]   2> 1018566 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
 to /configs/conf1/open-exchange-rates.json
   [junit4]   2> 1018566 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/open-exchange-rates.json
   [junit4]   2> 1018568 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
 to /configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 1018569 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 1018570 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
 to /configs/conf1/old_synonyms.txt
   [junit4]   2> 1018570 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/old_synonyms.txt
   [junit4]   2> 1018572 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
 to /configs/conf1/synonyms.txt
   [junit4]   2> 1018572 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/synonyms.txt
   [junit4]   2> 1018574 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1018574 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1018587 INFO  (zkCallback-349-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@74e88e01 
name:ZooKeeperConnection Watcher:127.0.0.1:38157 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1018587 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1018587 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1018587 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 1018589 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1018589 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1018591 INFO  (zkCallback-350-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@5701eebf 
name:ZooKeeperConnection Watcher:127.0.0.1:38157/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1018591 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1018591 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1018592 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
 to /configs/conf2/solrconfig.xml
   [junit4]   2> 1018592 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/solrconfig.xml
   [junit4]   2> 1018594 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/schema.xml
 to /configs/conf2/schema.xml
   [junit4]   2> 1018594 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/schema.xml
   [junit4]   2> 1018595 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
 to /configs/conf2/enumsConfig.xml
   [junit4]   2> 1018595 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/enumsConfig.xml
   [junit4]   2> 1018596 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
 to /configs/conf2/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 1018597 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.SolrZkClient makePath: 
/configs/conf2/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 1018598 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
 to /configs/conf2/stopwords.txt
   [junit4]   2> 1018598 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/stopwords.txt
   [junit4]   2> 1018599 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/protwords.txt
 to /configs/conf2/protwords.txt
   [junit4]   2> 1018599 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/protwords.txt
   [junit4]   2> 1018600 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/currency.xml
 to /configs/conf2/currency.xml
   [junit4]   2> 1018600 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/currency.xml
   [junit4]   2> 1018601 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
 to /configs/conf2/open-exchange-rates.json
   [junit4]   2> 1018601 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/open-exchange-rates.json
   [junit4]   2> 1018603 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
 to /configs/conf2/mapping-ISOLatin1Accent.txt
   [junit4]   2> 1018603 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/mapping-ISOLatin1Accent.txt
   [junit4]   2> 1018604 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
 to /configs/conf2/old_synonyms.txt
   [junit4]   2> 1018604 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/old_synonyms.txt
   [junit4]   2> 1018605 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
 to /configs/conf2/synonyms.txt
   [junit4]   2> 1018605 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/synonyms.txt
   [junit4]   2> 1018606 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/elevate.xml
 to /configs/conf2/elevate.xml
   [junit4]   2> 1018606 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/elevate.xml
   [junit4]   2> 1019104 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_DBFD227F892BB030-001/control-001/cores/collection1
   [junit4]   2> 1019107 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.e.j.s.Server jetty-9.2.13.v20150730
   [junit4]   2> 1019124 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@6f5b7a05{/xsssc/og,null,AVAILABLE}
   [junit4]   2> 1019124 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.e.j.s.ServerConnector Started 
ServerConnector@32ab412a{HTTP/1.1}{127.0.0.1:45519}
   [junit4]   2> 1019124 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.e.j.s.Server Started @1022452ms
   [junit4]   2> 1019124 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=hdfs://localhost:53240/hdfs__localhost_53240__x1_jenkins_jenkins-slave_workspace_Lucene-Solr-NightlyTests-trunk_solr_build_solr-core_test_J2_temp_solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_DBFD227F892BB030-001_tempDir-002_control_data,
 hostContext=/xsssc/og, hostPort=45519, 
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_DBFD227F892BB030-001/control-001/cores}
   [junit4]   2> 1019128 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): 
sun.misc.Launcher$AppClassLoader@4e0e2f2a
   [junit4]   2> 1019128 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_DBFD227F892BB030-001/control-001/'
   [junit4]   2> 1019194 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1019196 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1019199 INFO  (zkCallback-351-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@3150f53d 
name:ZooKeeperConnection Watcher:127.0.0.1:38157/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1019199 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1019199 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1019202 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in 
ZooKeeper)
   [junit4]   2> 1019203 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_DBFD227F892BB030-001/control-001/solr.xml
   [junit4]   2> 1019208 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.CoresLocator Config-defined core root directory: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_DBFD227F892BB030-001/control-001/cores
   [junit4]   2> 1019208 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.CoreContainer New CoreContainer 773035174
   [junit4]   2> 1019208 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.CoreContainer Loading cores into CoreContainer 
[instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_DBFD227F892BB030-001/control-001/]
   [junit4]   2> 1019208 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.CoreContainer loading shared library: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_DBFD227F892BB030-001/control-001/lib
   [junit4]   2> 1019208 WARN  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to 
classloader: lib (resolved as: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_DBFD227F892BB030-001/control-001/lib).
   [junit4]   2> 1019215 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
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> 1019216 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 1019216 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 1019216 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.l.LogWatcher Registering Log Listener [Log4j 
(org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 1019217 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:38157/solr
   [junit4]   2> 1019217 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.ZkController zkHost includes chroot
   [junit4]   2> 1019217 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1019217 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1019219 INFO  (zkCallback-353-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@61801db7 
name:ZooKeeperConnection Watcher:127.0.0.1:38157 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1019220 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1019220 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1019221 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) 
[n:127.0.0.1:45519_xsssc%2Fog    ] o.a.s.c.c.ConnectionManager Waiting for 
client to connect to ZooKeeper
   [junit4]   2> 1019223 INFO  
(zkCallback-354-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog    ] o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@37dacfe4 
name:ZooKeeperConnection Watcher:127.0.0.1:38157/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1019223 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) 
[n:127.0.0.1:45519_xsssc%2Fog    ] o.a.s.c.c.ConnectionManager Client is 
connected to ZooKeeper
   [junit4]   2> 1019224 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) 
[n:127.0.0.1:45519_xsssc%2Fog    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer/queue
   [junit4]   2> 1019225 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) 
[n:127.0.0.1:45519_xsssc%2Fog    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer/collection-queue-work
   [junit4]   2> 1019228 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) 
[n:127.0.0.1:45519_xsssc%2Fog    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer/collection-map-running
   [junit4]   2> 1019229 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) 
[n:127.0.0.1:45519_xsssc%2Fog    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer/collection-map-completed
   [junit4]   2> 1019231 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) 
[n:127.0.0.1:45519_xsssc%2Fog    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer/collection-map-failure
   [junit4]   2> 1019233 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) 
[n:127.0.0.1:45519_xsssc%2Fog    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 1019235 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) 
[n:127.0.0.1:45519_xsssc%2Fog    ] o.a.s.c.c.SolrZkClient makePath: 
/aliases.json
   [junit4]   2> 1019236 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) 
[n:127.0.0.1:45519_xsssc%2Fog    ] o.a.s.c.c.SolrZkClient makePath: 
/clusterstate.json
   [junit4]   2> 1019237 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) 
[n:127.0.0.1:45519_xsssc%2Fog    ] o.a.s.c.c.SolrZkClient makePath: 
/security.json
   [junit4]   2> 1019238 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) 
[n:127.0.0.1:45519_xsssc%2Fog    ] o.a.s.c.ZkController Register node as live 
in ZooKeeper:/live_nodes/127.0.0.1:45519_xsssc%2Fog
   [junit4]   2> 1019239 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) 
[n:127.0.0.1:45519_xsssc%2Fog    ] o.a.s.c.c.SolrZkClient makePath: 
/live_nodes/127.0.0.1:45519_xsssc%2Fog
   [junit4]   2> 1019240 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) 
[n:127.0.0.1:45519_xsssc%2Fog    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer_elect
   [junit4]   2> 1019244 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) 
[n:127.0.0.1:45519_xsssc%2Fog    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer_elect/election
   [junit4]   2> 1019246 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) 
[n:127.0.0.1:45519_xsssc%2Fog    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 1019246 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) 
[n:127.0.0.1:45519_xsssc%2Fog    ] o.a.s.c.LeaderElector Joined leadership 
election with path: 
/overseer_elect/election/94576696037998598-127.0.0.1:45519_xsssc%2Fog-n_0000000000
   [junit4]   2> 1019246 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) 
[n:127.0.0.1:45519_xsssc%2Fog    ] o.a.s.c.OverseerElectionContext I am going 
to be the leader 127.0.0.1:45519_xsssc%2Fog
   [junit4]   2> 1019246 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) 
[n:127.0.0.1:45519_xsssc%2Fog    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer_elect/leader
   [junit4]   2> 1019248 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) 
[n:127.0.0.1:45519_xsssc%2Fog    ] o.a.s.c.Overseer Overseer 
(id=94576696037998598-127.0.0.1:45519_xsssc%2Fog-n_0000000000) starting
   [junit4]   2> 1019249 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) 
[n:127.0.0.1:45519_xsssc%2Fog    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer/queue-work
   [junit4]   2> 1019255 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) 
[n:127.0.0.1:45519_xsssc%2Fog    ] o.a.s.c.OverseerAutoReplicaFailoverThread 
Starting OverseerAutoReplicaFailoverThread 
autoReplicaFailoverWorkLoopDelay=10000 
autoReplicaFailoverWaitAfterExpiration=10000 
autoReplicaFailoverBadNodeExpiration=60000
   [junit4]   2> 1019256 INFO  
(OverseerCollectionConfigSetProcessor-94576696037998598-127.0.0.1:45519_xsssc%2Fog-n_0000000000)
 [n:127.0.0.1:45519_xsssc%2Fog    ] o.a.s.c.OverseerTaskProcessor Process 
current queue of overseer operations
   [junit4]   2> 1019256 INFO  
(OverseerStateUpdate-94576696037998598-127.0.0.1:45519_xsssc%2Fog-n_0000000000) 
[n:127.0.0.1:45519_xsssc%2Fog    ] o.a.s.c.Overseer Starting to work on the 
main queue
   [junit4]   2> 1019256 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) 
[n:127.0.0.1:45519_xsssc%2Fog    ] o.a.s.c.c.ZkStateReader Updating cluster 
state from ZooKeeper... 
   [junit4]   2> 1019270 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) 
[n:127.0.0.1:45519_xsssc%2Fog    ] o.a.s.c.CoreContainer Security conf doesn't 
exist. Skipping setup for authorization module.
   [junit4]   2> 1019270 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) 
[n:127.0.0.1:45519_xsssc%2Fog    ] o.a.s.c.CoreContainer No authentication 
plugin used.
   [junit4]   2> 1019271 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) 
[n:127.0.0.1:45519_xsssc%2Fog    ] o.a.s.c.CoresLocator Looking for core 
definitions underneath 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_DBFD227F892BB030-001/control-001/cores
   [junit4]   2> 1019272 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) 
[n:127.0.0.1:45519_xsssc%2Fog    ] o.a.s.c.SolrCore Created CoreDescriptor: 
{name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml, 
loadOnStartup=true, configSetProperties=configsetprops.json, 
instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_DBFD227F892BB030-001/control-001/cores/collection1,
 collection=control_collection, 
absoluteInstDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_DBFD227F892BB030-001/control-001/cores/collection1/,
 coreNodeName=, dataDir=data/, shard=}
   [junit4]   2> 1019272 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) 
[n:127.0.0.1:45519_xsssc%2Fog    ] o.a.s.c.CoresLocator Found core collection1 
in 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_DBFD227F892BB030-001/control-001/cores/collection1/
   [junit4]   2> 1019272 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) 
[n:127.0.0.1:45519_xsssc%2Fog    ] o.a.s.c.CoresLocator Found 1 core definitions
   [junit4]   2> 1019273 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) 
[n:127.0.0.1:45519_xsssc%2Fog    ] o.a.s.s.SolrDispatchFilter 
user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2
   [junit4]   2> 1019273 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) 
[n:127.0.0.1:45519_xsssc%2Fog    ] o.a.s.s.SolrDispatchFilter 
SolrDispatchFilter.init() done
   [junit4]   2> 1019273 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection   x:collection1] 
o.a.s.c.ZkController publishing state=down
   [junit4]   2> 1019273 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection   x:collection1] 
o.a.s.c.ZkController numShards not found on descriptor - reading it from system 
property
   [junit4]   2> 1019275 INFO  
(OverseerStateUpdate-94576696037998598-127.0.0.1:45519_xsssc%2Fog-n_0000000000) 
[n:127.0.0.1:45519_xsssc%2Fog    ] 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:45519/xsssc/og";,
   [junit4]   2>   "node_name":"127.0.0.1:45519_xsssc%2Fog",
   [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> 1019276 INFO  
(OverseerStateUpdate-94576696037998598-127.0.0.1:45519_xsssc%2Fog-n_0000000000) 
[n:127.0.0.1:45519_xsssc%2Fog    ] 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:45519/xsssc/og";,
   [junit4]   2>   "node_name":"127.0.0.1:45519_xsssc%2Fog",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":null,
   [junit4]   2>   "collection":"control_collection",
   [junit4]   2>   "operation":"state"}
   [junit4]   2> 1019279 INFO  
(OverseerStateUpdate-94576696037998598-127.0.0.1:45519_xsssc%2Fog-n_0000000000) 
[n:127.0.0.1:45519_xsssc%2Fog    ] o.a.s.c.o.ClusterStateMutator building a new 
cName: control_collection
   [junit4]   2> 1019279 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection   x:collection1] 
o.a.s.c.ZkController look for our core node name
   [junit4]   2> 1019280 INFO  
(OverseerStateUpdate-94576696037998598-127.0.0.1:45519_xsssc%2Fog-n_0000000000) 
[n:127.0.0.1:45519_xsssc%2Fog    ] o.a.s.c.o.ReplicaMutator Assigning new node 
to shard shard=shard1
   [junit4]   2> 1019281 INFO  
(zkCallback-354-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog    ] 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> 1020280 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection   x:collection1] 
o.a.s.c.ZkController waiting to find shard id in clusterstate for collection1
   [junit4]   2> 1020280 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection   x:collection1] 
o.a.s.c.ZkController Check for collection zkNode:control_collection
   [junit4]   2> 1020283 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection   x:collection1] 
o.a.s.c.ZkController Collection zkNode exists
   [junit4]   2> 1020283 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection   x:collection1] 
o.a.s.c.c.ZkStateReader Load collection config 
from:/collections/control_collection
   [junit4]   2> 1020283 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection   x:collection1] 
o.a.s.c.c.ZkStateReader path=/collections/control_collection configName=conf1 
specified config exists in ZooKeeper
   [junit4]   2> 1020284 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection   x:collection1] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_DBFD227F892BB030-001/control-001/cores/collection1/'
   [junit4]   2> 1020298 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection   x:collection1] 
o.a.s.c.Config loaded config solrconfig.xml with version 0 
   [junit4]   2> 1020302 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection   x:collection1] 
o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 1020306 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection   x:collection1] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0
   [junit4]   2> 1020314 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection   x:collection1] 
o.a.s.c.Config Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 1020315 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection   x:collection1] 
o.a.s.s.IndexSchema Reading Solr Schema from /configs/conf1/schema.xml
   [junit4]   2> 1020320 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection   x:collection1] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1020429 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection   x:collection1] 
o.a.s.s.OpenExchangeRatesOrgProvider Initialized with 
rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 1020435 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection   x:collection1] 
o.a.s.s.IndexSchema default search field in schema is text
   [junit4]   2> 1020436 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection   x:collection1] 
o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 1020443 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection   x:collection1] 
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 1020445 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection   x:collection1] 
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 1020447 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection   x:collection1] 
o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from 
open-exchange-rates.json
   [junit4]   2> 1020447 WARN  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection   x:collection1] 
o.a.s.s.OpenExchangeRatesOrgProvider Unknown key IMPORTANT NOTE
   [junit4]   2> 1020447 WARN  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection   x:collection1] 
o.a.s.s.OpenExchangeRatesOrgProvider Expected key, got STRING
   [junit4]   2> 1020448 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection   x:collection1] 
o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from 
open-exchange-rates.json
   [junit4]   2> 1020448 WARN  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection   x:collection1] 
o.a.s.s.OpenExchangeRatesOrgProvider Unknown key IMPORTANT NOTE
   [junit4]   2> 1020448 WARN  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection   x:collection1] 
o.a.s.s.OpenExchangeRatesOrgProvider Expected key, got STRING
   [junit4]   2> 1020449 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection   x:collection1] 
o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default 
properties: Can't find resource 'configsetprops.json' in classpath or 
'/configs/conf1', 
cwd=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2
   [junit4]   2> 1020449 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection   x:collection1] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from 
collection control_collection
   [junit4]   2> 1020450 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.SolrCore org.apache.solr.core.HdfsDirectoryFactory
   [junit4]   2> 1020450 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.HdfsDirectoryFactory 
solr.hdfs.home=hdfs://localhost:53240/solr_hdfs_home
   [junit4]   2> 1020450 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.HdfsDirectoryFactory Solr Kerberos Authentication 
disabled
   [junit4]   2> 1020450 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_DBFD227F892BB030-001/control-001/cores/collection1/],
 dataDir=[null]
   [junit4]   2> 1020450 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog 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@5423aea8
   [junit4]   2> 1020455 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.HdfsDirectoryFactory creating directory factory for path 
hdfs://localhost:53240/solr_hdfs_home/control_collection/core_node1/data
   [junit4]   2> 1020474 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.s.h.HdfsLocalityReporter Registering direcotry 
hdfs://localhost:53240/solr_hdfs_home/control_collection/core_node1/data for 
locality metrics.
   [junit4]   2> 1020475 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for 
hdfs://localhost:53240/solr_hdfs_home/control_collection/core_node1/data
   [junit4]   2> 1020476 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.SolrCore New index directory detected: old=null 
new=hdfs://localhost:53240/solr_hdfs_home/control_collection/core_node1/data/index/
   [junit4]   2> 1020487 WARN  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory 
'hdfs:/localhost:53240/solr_hdfs_home/control_collection/core_node1/data/index' 
doesn't exist. Creating new index...
   [junit4]   2> 1020487 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.HdfsDirectoryFactory creating directory factory for path 
hdfs://localhost:53240/solr_hdfs_home/control_collection/core_node1/data/index
   [junit4]   2> 1020498 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.s.h.HdfsLocalityReporter Registering direcotry 
hdfs://localhost:53240/solr_hdfs_home/control_collection/core_node1/data/index 
for locality metrics.
   [junit4]   2> 1020498 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for 
hdfs://localhost:53240/solr_hdfs_home/control_collection/core_node1/data/index
   [junit4]   2> 1020498 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=11, maxMergeAtOnceExplicit=14, maxMergedSegmentMB=61.6328125, 
floorSegmentMB=0.9677734375, forceMergeDeletesPctAllowed=22.374332611284107, 
segmentsPerTier=46.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 1020520 INFO  (IPC Server handler 2 on 53240) [    ] 
BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:58665 is 
added to blk_1073741825_1001{blockUCState=UNDER_CONSTRUCTION, 
primaryNodeIndex=-1, 
replicas=[ReplicaUnderConstruction[[DISK]DS-62c00844-11fb-4547-bf4d-c69deeb82866:NORMAL:127.0.0.1:40022|RBW],
 
ReplicaUnderConstruction[[DISK]DS-e87fa334-e03b-4bb2-bcae-31ade5621723:NORMAL:127.0.0.1:58665|RBW]]}
 size 0
   [junit4]   2> 1020522 INFO  (IPC Server handler 7 on 53240) [    ] 
BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:40022 is 
added to blk_1073741825_1001{blockUCState=UNDER_CONSTRUCTION, 
primaryNodeIndex=-1, 
replicas=[ReplicaUnderConstruction[[DISK]DS-e87fa334-e03b-4bb2-bcae-31ade5621723:NORMAL:127.0.0.1:58665|RBW],
 
ReplicaUnderConstruction[[DISK]DS-3d6c87e0-860b-406b-9e8d-287036aee490:NORMAL:127.0.0.1:40022|FINALIZED]]}
 size 0
   [junit4]   2> 1020526 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>        commit{dir=NRTCachingDirectory(HdfsDirectory@b858a38e 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@49e85f50; 
maxCacheMB=192.0 maxMergeSizeMB=16.0),segFN=segments_1,generation=1}
   [junit4]   2> 1020527 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.SolrCore newest commit generation = 1
   [junit4]   2> 1020531 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating 
updateRequestProcessorChain "nodistrib"
   [junit4]   2> 1020531 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating 
updateRequestProcessorChain "dedupe"
   [junit4]   2> 1020531 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 1020531 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating 
updateRequestProcessorChain "stored_sig"
   [junit4]   2> 1020531 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 1020531 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog 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> 1020531 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog 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> 1020531 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog 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> 1020532 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog 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> 1020533 INFO  
(OldIndexDirectoryCleanupThreadForCore-collection1) 
[n:127.0.0.1:45519_xsssc%2Fog 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:53240/solr_hdfs_home/control_collection/core_node1/data/
   [junit4]   2> 1020534 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1020535 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1020535 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1020536 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1020539 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.RequestHandlers Registered paths: 
/admin/mbeans,standard,/update/csv,/update/json/docs,/admin/luke,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/schema,/admin/plugins,/admin/logging,/update/json,/admin/threads,/admin/ping,/update,/admin/file
   [junit4]   2> 1020539 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog 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> 1020540 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog 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> 1020540 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.UpdateLog Initializing HdfsUpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
tlogDfsReplication=2
   [junit4]   2> 1020549 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.SolrCore Hard AutoCommit: disabled
   [junit4]   2> 1020549 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.SolrCore Soft AutoCommit: disabled
   [junit4]   2> 1020550 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=13, maxMergeAtOnceExplicit=21, maxMergedSegmentMB=31.6259765625, 
floorSegmentMB=0.326171875, forceMergeDeletesPctAllowed=21.50979184994877, 
segmentsPerTier=45.0, maxCFSSegmentSizeMB=1.7470703125, 
noCFSRatio=0.35721170780540257
   [junit4]   2> 1020556 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>        commit{dir=NRTCachingDirectory(HdfsDirectory@b858a38e 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@49e85f50; 
maxCacheMB=192.0 maxMergeSizeMB=16.0),segFN=segments_1,generation=1}
   [junit4]   2> 1020556 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.SolrCore newest commit generation = 1
   [junit4]   2> 1020557 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@2371b951[collection1] 
main
   [junit4]   2> 1020557 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog 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> 1020558 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog 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> 1020558 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog 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> 1020558 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO 
with znodeBase: /configs/conf1
   [junit4]   2> 1020558 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {}
   [junit4]   2> 1020558 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog 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> 1020559 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog 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> 1020559 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog 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> 1020559 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
   [junit4]   2> 1020559 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1020560 INFO  
(searcherExecutor-1435-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog 
x:collection1 s:shard1 c:control_collection r:core_node1) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@2371b951[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1020562 WARN  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.s.h.HdfsLocalityReporter Could not retrieve locality 
information for hdfs://localhost:45967/solr3 due to exception: 
java.net.ConnectException: Call From lucene1-us-west/10.41.0.5 to 
localhost:45967 failed on connection exception: java.net.ConnectException: 
Connection refused; For more details see:  
http://wiki.apache.org/hadoop/ConnectionRefused
   [junit4]   2> 1020562 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog 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> 1020562 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.VersionInfo Refreshing highest value of _version_ for 
256 version buckets from index
   [junit4]   2> 1020562 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog 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> 1020562 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog 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 1513227138850881536
   [junit4]   2> 1020562 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.UpdateLog Took 0.0ms to seed version buckets with 
highest version 1513227138850881536
   [junit4]   2> 1020562 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.ZkController watch zkdir /configs/conf1
   [junit4]   2> 1020563 INFO  
(coreLoadExecutor-1434-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.CoreContainer registering core: collection1
   [junit4]   2> 1020563 INFO  
(coreZkRegister-1428-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog 
x:collection1 s:shard1 c:control_collection r:core_node1) 
[n:127.0.0.1:45519_xsssc%2Fog 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:45519/xsssc/og collection:control_collection 
shard:shard1
   [junit4]   2> 1020564 INFO  
(coreZkRegister-1428-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog 
x:collection1 s:shard1 c:control_collection r:core_node1) 
[n:127.0.0.1:45519_xsssc%2Fog 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> 1020567 INFO  
(coreZkRegister-1428-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog 
x:collection1 s:shard1 c:control_collection r:core_node1) 
[n:127.0.0.1:45519_xsssc%2Fog 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/94576696037998598-core_node1-n_0000000000
   [junit4]   2> 1020567 INFO  
(coreZkRegister-1428-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog 
x:collection1 s:shard1 c:control_collection r:core_node1) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.ShardLeaderElectionContext Running the leader process 
for shard shard1
   [junit4]   2> 1020569 INFO  
(coreZkRegister-1428-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog 
x:collection1 s:shard1 c:control_collection r:core_node1) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to 
continue.
   [junit4]   2> 1020569 INFO  
(coreZkRegister-1428-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog 
x:collection1 s:shard1 c:control_collection r:core_node1) 
[n:127.0.0.1:45519_xsssc%2Fog 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> 1020569 INFO  
(coreZkRegister-1428-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog 
x:collection1 s:shard1 c:control_collection r:core_node1) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.SyncStrategy Sync replicas to 
http://127.0.0.1:45519/xsssc/og/collection1/
   [junit4]   2> 1020569 INFO  
(coreZkRegister-1428-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog 
x:collection1 s:shard1 c:control_collection r:core_node1) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
   [junit4]   2> 1020569 INFO  
(coreZkRegister-1428-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog 
x:collection1 s:shard1 c:control_collection r:core_node1) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.SyncStrategy 
http://127.0.0.1:45519/xsssc/og/collection1/ has no replicas
   [junit4]   2> 1020569 INFO  
(OverseerStateUpdate-94576696037998598-127.0.0.1:45519_xsssc%2Fog-n_0000000000) 
[n:127.0.0.1:45519_xsssc%2Fog    ] 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> 1020569 INFO  
(coreZkRegister-1428-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog 
x:collection1 s:shard1 c:control_collection r:core_node1) 
[n:127.0.0.1:45519_xsssc%2Fog 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:45519/xsssc/og/collection1/ shard1
   [junit4]   2> 1020570 INFO  
(coreZkRegister-1428-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog 
x:collection1 s:shard1 c:control_collection r:core_node1) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.c.SolrZkClient makePath: 
/collections/control_collection/leaders/shard1
   [junit4]   2> 1020572 INFO  
(coreZkRegister-1428-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog 
x:collection1 s:shard1 c:control_collection r:core_node1) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.ShardLeaderElectionContextBase Creating leader 
registration node
   [junit4]   2> 1020574 INFO  
(OverseerStateUpdate-94576696037998598-127.0.0.1:45519_xsssc%2Fog-n_0000000000) 
[n:127.0.0.1:45519_xsssc%2Fog    ] 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:45519/xsssc/og";,
   [junit4]   2>   "core":"collection1",
   [junit4]   2>   "state":"active"} current state version: 1
   [junit4]   2> 1020676 INFO  
(zkCallback-354-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog    ] 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> 1020724 INFO  
(coreZkRegister-1428-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog 
x:collection1 s:shard1 c:control_collection r:core_node1) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.ZkController We are 
http://127.0.0.1:45519/xsssc/og/collection1/ and leader is 
http://127.0.0.1:45519/xsssc/og/collection1/
   [junit4]   2> 1020725 INFO  
(coreZkRegister-1428-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog 
x:collection1 s:shard1 c:control_collection r:core_node1) 
[n:127.0.0.1:45519_xsssc%2Fog 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:45519/xsssc/og
   [junit4]   2> 1020725 INFO  
(coreZkRegister-1428-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog 
x:collection1 s:shard1 c:control_collection r:core_node1) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.ZkController I am the leader, no recovery necessary
   [junit4]   2> 1020725 INFO  
(coreZkRegister-1428-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog 
x:collection1 s:shard1 c:control_collection r:core_node1) 
[n:127.0.0.1:45519_xsssc%2Fog c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.ZkController publishing state=active
   [junit4]   2> 1020725 INFO  
(coreZkRegister-1428-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog 
x:collection1 s:shard1 c:control_collection r:core_node1) 
[n:127.0.0.1:45519_xsssc%2Fog 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> 1020726 INFO  
(OverseerStateUpdate-94576696037998598-127.0.0.1:45519_xsssc%2Fog-n_0000000000) 
[n:127.0.0.1:45519_xsssc%2Fog    ] o.a.s.c.Overseer processMessage: queueSize: 
1, message = {
   [junit4]   2>   "core":"collection1",
   [junit4]   2>   "core_node_name":"core_node1",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"http://127.0.0.1:45519/xsssc/og";,
   [junit4]   2>   "node_name":"127.0.0.1:45519_xsssc%2Fog",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"control_collection",
   [junit4]   2>   "operation":"state"} current state version: 2
   [junit4]   2> 1020727 INFO  
(OverseerStateUpdate-94576696037998598-127.0.0.1:45519_xsssc%2Fog-n_0000000000) 
[n:127.0.0.1:45519_xsssc%2Fog    ] o.a.s.c.o.ReplicaMutator Update state 
numShards=1 message={
   [junit4]   2>   "core":"collection1",
   [junit4]   2>   "core_node_name":"core_node1",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"http://127.0.0.1:45519/xsssc/og";,
   [junit4]   2>   "node_name":"127.0.0.1:45519_xsssc%2Fog",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"control_collection",
   [junit4]   2>   "operation":"state"}
   [junit4]   2> 1020775 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1020776 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1020777 INFO  (zkCallback-356-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@cad36d5 name:ZooKeeperConnection 
Watcher:127.0.0.1:38157/solr got event WatchedEvent state:SyncConnected 
type:None path:null path:null type:None
   [junit4]   2> 1020777 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1020778 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1020778 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 1020780 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection 
loss:false
   [junit4]   2> 1020780 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.AbstractFullDistribZkTestBase Creating collection1 with stateFormat=2
   [junit4]   2> 1020780 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1020781 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1020782 INFO  (zkCallback-357-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@11d83f6a 
name:ZooKeeperConnection Watcher:127.0.0.1:38157/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1020782 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1020782 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1020784 INFO  
(OverseerStateUpdate-94576696037998598-127.0.0.1:45519_xsssc%2Fog-n_0000000000) 
[n:127.0.0.1:45519_xsssc%2Fog    ] o.a.s.c.Overseer processMessage: queueSize: 
1, message = {
   [junit4]   2>   "operation":"create",
   [junit4]   2>   "name":"collection1",
   [junit4]   2>   "numShards":"2",
   [junit4]   2>   "stateFormat":"2"} current state version: 2
   [junit4]   2> 1020784 INFO  
(OverseerStateUpdate-94576696037998598-127.0.0.1:45519_xsssc%2Fog-n_0000000000) 
[n:127.0.0.1:45519_xsssc%2Fog    ] o.a.s.c.o.ClusterStateMutator building a new 
cName: collection1
   [junit4]   2> 1020784 INFO  
(zkCallback-354-thread-1-processing-n:127.0.0.1:45519_xsssc%2Fog) 
[n:127.0.0.1:45519_xsssc%2Fog    ] 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> 1020784 INFO  (zkCallback-356-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> 1020894 INFO  
(OverseerStateUpdate-94576696037998598-127.0.0.1:45519_xsssc%2Fog-n_0000000000) 
[n:127.0.0.1:45519_xsssc%2Fog    ] o.a.s.c.o.ZkStateWriter going to 
create_collection /collections/collection1/state.json
   [junit4]   2> 1021106 INFO  
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[DBFD227F892BB030]) [    ] 
o.a.s.SolrTestCaseJ4 W

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

 5grand3_s=PostingsFormat(name=LuceneFixedGap), 
1parent_f1_s=PostingsFormat(name=Memory doPackFST= false), 
13parent_f1_s=Lucene50(blocksize=128), 23parent_f1_s=FSTOrd50, 
6child1_s=PostingsFormat(name=Memory doPackFST= false), 
_root_=Lucene50(blocksize=128), 5child2_s=FSTOrd50, 29parent_f1_s=FSTOrd50, 
33parent_f1_s=PostingsFormat(name=LuceneFixedGap), 
39parent_f1_s=Lucene50(blocksize=128), 3child0_s=PostingsFormat(name=Memory 
doPackFST= false), 4child3_s=PostingsFormat(name=Memory doPackFST= false), 
12parent_f1_s=FSTOrd50, 22parent_f1_s=PostingsFormat(name=LuceneFixedGap), 
1grand0_s=PostingsFormat(name=Memory doPackFST= false), 
11grand2_s=Lucene50(blocksize=128), 11grand6_s=Lucene50(blocksize=128), 
10grand7_s=Lucene50(blocksize=128), 7parent_f1_s=FSTOrd50, 2child1_s=FSTOrd50, 
3parent_f2_s=Lucene50(blocksize=128), 32parent_f1_s=PostingsFormat(name=Memory 
doPackFST= false), 10grand3_s=Lucene50(blocksize=128), 
6grand3_s=PostingsFormat(name=Memory doPackFST= false), 31parent_f2_s=FSTOrd50, 
5grand2_s=PostingsFormat(name=Memory doPackFST= false), 
10grand9_s=PostingsFormat(name=LuceneFixedGap), 
4grand1_s=PostingsFormat(name=Memory doPackFST= false), 
11parent_f2_s=PostingsFormat(name=Memory doPackFST= false), 
21parent_f2_s=Lucene50(blocksize=128), 7grand4_s=PostingsFormat(name=Memory 
doPackFST= false), 3grand0_s=PostingsFormat(name=Memory doPackFST= false), 
9grand6_s=FSTOrd50, 8grand1_s=PostingsFormat(name=Memory doPackFST= false), 
9grand2_s=FSTOrd50, 8grand5_s=PostingsFormat(name=Memory doPackFST= false), 
9parent_f1_s=PostingsFormat(name=Memory doPackFST= false), 
30parent_f1_s=FSTOrd50, 14parent_f2_s=Lucene50(blocksize=128), 
20parent_f1_s=Lucene50(blocksize=128), 
1parent_f2_s=PostingsFormat(name=LuceneFixedGap), 6child3_s=FSTOrd50, 
7grand0_s=PostingsFormat(name=Memory doPackFST= false), 
text_t=Lucene50(blocksize=128), 24parent_f2_s=FSTOrd50, 
34parent_f2_s=PostingsFormat(name=LuceneFixedGap), 13parent_f2_s=FSTOrd50, 
type_s=Lucene50(blocksize=128), 
23parent_f2_s=PostingsFormat(name=LuceneFixedGap), 
5child1_s=Lucene50(blocksize=128), 10parent_f1_s=PostingsFormat(name=Memory 
doPackFST= false), 33parent_f2_s=PostingsFormat(name=Memory doPackFST= false), 
11grand1_s=PostingsFormat(name=Memory doPackFST= false), 
22parent_f2_s=PostingsFormat(name=Memory doPackFST= false), 
10grand0_s=PostingsFormat(name=Memory doPackFST= false), 
4child0_s=PostingsFormat(name=LuceneFixedGap), 
11grand5_s=PostingsFormat(name=Memory doPackFST= false), 
12parent_f2_s=PostingsFormat(name=LuceneFixedGap), 
10grand8_s=PostingsFormat(name=Memory doPackFST= false), 
10grand4_s=PostingsFormat(name=Memory doPackFST= false), 
32parent_f2_s=Lucene50(blocksize=128), 31parent_f1_s=Lucene50(blocksize=128), 
5grand1_s=Lucene50(blocksize=128), 6grand4_s=Lucene50(blocksize=128), 
11parent_f1_s=PostingsFormat(name=LuceneFixedGap), 
4grand2_s=Lucene50(blocksize=128), 21parent_f1_s=PostingsFormat(name=Memory 
doPackFST= false), 7grand3_s=Lucene50(blocksize=128), 
11grand9_s=PostingsFormat(name=Memory doPackFST= false), 
8grand2_s=Lucene50(blocksize=128), 9grand5_s=Lucene50(blocksize=128), 
8grand6_s=Lucene50(blocksize=128), 9grand1_s=Lucene50(blocksize=128), 
37parent_f1_s=PostingsFormat(name=LuceneFixedGap), 
14parent_f1_s=PostingsFormat(name=Memory doPackFST= false), 
20parent_f2_s=FSTOrd50, 34parent_f1_s=FSTOrd50, 
6child4_s=Lucene50(blocksize=128), 24parent_f1_s=Lucene50(blocksize=128), 
30parent_f2_s=PostingsFormat(name=LuceneFixedGap), 
5parent_f1_s=PostingsFormat(name=Memory doPackFST= false), 
6grand0_s=Lucene50(blocksize=128), 10parent_f2_s=Lucene50(blocksize=128), 
5child0_s=PostingsFormat(name=Memory doPackFST= false), 
8parent_f1_s=PostingsFormat(name=LuceneFixedGap), 
27parent_f2_s=PostingsFormat(name=LuceneFixedGap), 
2parent_f2_s=PostingsFormat(name=Memory doPackFST= false), 
11grand0_s=PostingsFormat(name=LuceneFixedGap), 4child1_s=FSTOrd50, 
2grand1_s=PostingsFormat(name=Memory doPackFST= false), 
11grand4_s=PostingsFormat(name=LuceneFixedGap), 
17parent_f2_s=PostingsFormat(name=Memory doPackFST= false), 3child2_s=FSTOrd50, 
16parent_f2_s=PostingsFormat(name=LuceneFixedGap), 
10grand5_s=PostingsFormat(name=LuceneFixedGap), 
26parent_f2_s=PostingsFormat(name=Memory doPackFST= false), 1child0_s=FSTOrd50, 
36parent_f2_s=Lucene50(blocksize=128), 
10grand1_s=PostingsFormat(name=LuceneFixedGap), 7grand6_s=FSTOrd50, 
5grand0_s=FSTOrd50, 18parent_f1_s=FSTOrd50, 
28parent_f1_s=Lucene50(blocksize=128), 6grand5_s=FSTOrd50, 7grand2_s=FSTOrd50, 
4grand3_s=FSTOrd50, 9grand8_s=PostingsFormat(name=Memory doPackFST= false), 
15parent_f1_s=PostingsFormat(name=LuceneFixedGap), 
11grand8_s=PostingsFormat(name=LuceneFixedGap), 8grand3_s=FSTOrd50, 
6parent_f1_s=Lucene50(blocksize=128), 9grand4_s=PostingsFormat(name=Memory 
doPackFST= false), 25parent_f1_s=PostingsFormat(name=Memory doPackFST= false), 
8grand7_s=FSTOrd50, 0parent_f1_s=PostingsFormat(name=LuceneFixedGap), 
3grand2_s=FSTOrd50, 9grand0_s=PostingsFormat(name=Memory doPackFST= false), 
35parent_f1_s=Lucene50(blocksize=128), 4parent_f2_s=FSTOrd50, 
19parent_f2_s=FSTOrd50, 37parent_f2_s=PostingsFormat(name=Memory doPackFST= 
false), 5child4_s=PostingsFormat(name=Memory doPackFST= false), 
6child5_s=PostingsFormat(name=Memory doPackFST= false), 5grand4_s=FSTOrd50, 
38parent_f1_s=FSTOrd50, 6grand1_s=FSTOrd50, 
5parent_f2_s=PostingsFormat(name=LuceneFixedGap), 
6child0_s=Lucene50(blocksize=128), 16parent_f1_s=PostingsFormat(name=Memory 
doPackFST= false), 8parent_f2_s=FSTOrd50, 39parent_f2_s=FSTOrd50, 
29parent_f2_s=Lucene50(blocksize=128), 2parent_f1_s=Lucene50(blocksize=128), 
4child2_s=Lucene50(blocksize=128), rnd_b=FSTOrd50, 11grand3_s=FSTOrd50, 
27parent_f1_s=FSTOrd50, 17parent_f1_s=Lucene50(blocksize=128), 
_version_=Lucene50(blocksize=128), 2grand0_s=Lucene50(blocksize=128), 
11grand7_s=FSTOrd50, 3child1_s=PostingsFormat(name=LuceneFixedGap), 
10grand6_s=FSTOrd50, 7parent_f2_s=Lucene50(blocksize=128), 
26parent_f1_s=PostingsFormat(name=LuceneFixedGap), 10grand2_s=FSTOrd50, 
2child0_s=Lucene50(blocksize=128), 3parent_f1_s=FSTOrd50, 
36parent_f1_s=PostingsFormat(name=Memory doPackFST= false)}, docValues:{}, 
sim=ClassicSimilarity, locale=fr, timezone=CET
   [junit4]   2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation 
1.8.0_45 (64-bit)/cpus=4,threads=1,free=212911968,total=527433728
   [junit4]   2> NOTE: All tests run in this JVM: [HdfsDirectoryFactoryTest, 
SearchHandlerTest, TestSolrCLIRunExample, SolrXmlInZkTest, 
CollectionReloadTest, HardAutoCommitTest, TestSolrXml, CdcrUpdateLogTest, 
TestSolrCloudWithKerberosAlt, TestSweetSpotSimilarityFactory, 
ResponseHeaderTest, StatsComponentTest, HdfsBasicDistributedZkTest, 
SegmentsInfoRequestHandlerTest, MultiThreadedOCPTest, TestMissingGroups, 
SuggesterWFSTTest, TestGroupingSearch, TestWriterPerf, HdfsDirectoryTest, 
TestSolrIndexConfig, TestFieldResource, TestReRankQParserPlugin, 
TestBulkSchemaAPI, AutoCommitTest, AsyncMigrateRouteKeyTest, 
TestConfigSetProperties, AssignTest, TestDefaultSearchFieldResource, 
TestCSVResponseWriter, TestFastWriter, DistributedFacetPivotSmallTest, 
BasicAuthIntegrationTest, TestSolrDynamicMBean, TestIndexingPerformance, 
TestDistributedStatsComponentCardinality, UUIDFieldTest, RecoveryZkTest, 
HdfsCollectionsAPIDistributedZkTest, TestCharFilters, TestSystemIdResolver, 
TestLRUCache, TestDefaultStatsCache, TestMinMaxOnMultiValuedField, 
TestXIncludeConfig, TestSolrConfigHandler, TestRTimerTree, 
TermVectorComponentDistributedTest, TestStressReorder, DocValuesMultiTest, 
RAMDirectoryFactoryTest, UpdateParamsTest, TestAuthorizationFramework, 
TestManagedResourceStorage, FieldAnalysisRequestHandlerTest, 
TestBulkSchemaConcurrent, TestDefaultSimilarityFactory, 
TestFieldCollectionResource, BadComponentTest, TestPerFieldSimilarity, 
TestHighFrequencyDictionaryFactory, TestSolrDeletionPolicy1, SuggesterTSTTest, 
DirectUpdateHandlerTest, TestExpandComponent, 
TestLeaderInitiatedRecoveryThread, CoreAdminHandlerTest, 
TestManagedStopFilterFactory, TestCollationField, CursorMarkTest, 
TestPHPSerializedResponseWriter, SimpleFacetsTest, TestCollapseQParserPlugin, 
TestExtendedDismaxParser, TestTrieFacet, TestClassNameShortening, 
LeaderElectionTest, XmlUpdateRequestHandlerTest, RegexBoostProcessorTest, 
CloudExitableDirectoryReaderTest, RecoveryAfterSoftCommitTest, 
ShowFileRequestHandlerTest, SecurityConfHandlerTest, 
TestFuzzyAnalyzedSuggestions, TestSolr4Spatial2, HdfsThreadLeakTest, 
OverseerTaskQueueTest, TestSmileRequest, SharedFSAutoReplicaFailoverUtilsTest, 
PrimitiveFieldTypeTest, OverseerTest, LeaderElectionIntegrationTest, 
BasicZkTest, FullSolrCloudDistribCmdsTest]
   [junit4] Completed [292/546] on J2 in 406.85s, 1 test, 1 error <<< FAILURES!

[...truncated 817 lines...]
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:782:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:719:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:59:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build.xml:233:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/common-build.xml:514:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/lucene/common-build.xml:1432:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/lucene/common-build.xml:987:
 There were test failures: 546 suites (8 ignored), 2145 tests, 3 errors, 29 
ignored (17 assumptions) [seed: DBFD227F892BB030]

Total time: 182 minutes 44 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
No prior successful build to compare, so performing full copy of artifacts
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure


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

Reply via email to