Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-5.5/7/

4 tests failed.
FAILED:  org.apache.solr.TestGroupingSearch.testGroupingGroupedBasedFaceting

Error Message:
mismatch: '1'!='2' @ grouped/value4_i/groups/[0]/groupValue

Stack Trace:
java.lang.RuntimeException: mismatch: '1'!='2' @ 
grouped/value4_i/groups/[0]/groupValue
        at 
__randomizedtesting.SeedInfo.seed([F8645B88D6A72879:303103ABEAD4C615]:0)
        at org.apache.solr.SolrTestCaseJ4.assertJQ(SolrTestCaseJ4.java:842)
        at org.apache.solr.SolrTestCaseJ4.assertJQ(SolrTestCaseJ4.java:789)
        at 
org.apache.solr.TestGroupingSearch.testGroupingGroupedBasedFaceting(TestGroupingSearch.java:349)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:606)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at java.lang.Thread.run(Thread.java:745)


FAILED:  org.apache.solr.index.hdfs.CheckHdfsIndexTest.doTest

Error Message:
Could not find a healthy node to handle the request.

Stack Trace:
org.apache.solr.common.SolrException: Could not find a healthy node to handle 
the request.
        at 
__randomizedtesting.SeedInfo.seed([F8645B88D6A72879:5F20E32CBB1C3BC0]:0)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1094)
        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.SolrRequest.process(SolrRequest.java:149)
        at org.apache.solr.client.solrj.SolrClient.commit(SolrClient.java:482)
        at org.apache.solr.client.solrj.SolrClient.commit(SolrClient.java:463)
        at 
org.apache.solr.cloud.AbstractFullDistribZkTestBase.commit(AbstractFullDistribZkTestBase.java:1506)
        at 
org.apache.solr.index.hdfs.CheckHdfsIndexTest.doTest(CheckHdfsIndexTest.java:100)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:606)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:996)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:971)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at java.lang.Thread.run(Thread.java:745)


FAILED:  org.apache.solr.update.DirectUpdateHandlerTest.testExpungeDeletes

Error Message:
expected:<5> but was:<4>

Stack Trace:
java.lang.AssertionError: expected:<5> but was:<4>
        at 
__randomizedtesting.SeedInfo.seed([F8645B88D6A72879:D41D1F0DA31EE0DC]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.failNotEquals(Assert.java:647)
        at org.junit.Assert.assertEquals(Assert.java:128)
        at org.junit.Assert.assertEquals(Assert.java:472)
        at org.junit.Assert.assertEquals(Assert.java:456)
        at 
org.apache.solr.update.DirectUpdateHandlerTest.testExpungeDeletes(DirectUpdateHandlerTest.java:299)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:606)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at java.lang.Thread.run(Thread.java:745)


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

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

Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught 
exception in thread: Thread[id=34657, name=collection0, state=RUNNABLE, 
group=TGRP-CollectionsAPIDistributedZkTest]
Caused by: 
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error 
from server at https://127.0.0.1:46666: collection already exists: 
awholynewstresscollection_collection0_4
        at __randomizedtesting.SeedInfo.seed([F8645B88D6A72879]:0)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:577)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:241)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:230)
        at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:372)
        at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:325)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1100)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:870)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:806)
        at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219)
        at 
org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1575)
        at 
org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1596)
        at 
org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:984)




Build Log:
[...truncated 12060 lines...]
   [junit4] Suite: org.apache.solr.cloud.CollectionsAPIDistributedZkTest
   [junit4]   2> Creating dataDir: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_F8645B88D6A72879-001/init-core-data-001
   [junit4]   2> 1982170 INFO  
(SUITE-CollectionsAPIDistributedZkTest-seed#[F8645B88D6A72879]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false)
   [junit4]   2> 1982170 INFO  
(SUITE-CollectionsAPIDistributedZkTest-seed#[F8645B88D6A72879]-worker) [    ] 
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /
   [junit4]   2> 1982174 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1982174 INFO  (Thread-25230) [    ] o.a.s.c.ZkTestServer 
client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 1982174 INFO  (Thread-25230) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 1982274 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.ZkTestServer start zk server on port:48367
   [junit4]   2> 1982274 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1982274 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1982276 INFO  (zkCallback-2155-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@15afc261 
name:ZooKeeperConnection Watcher:127.0.0.1:48367 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1982276 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1982276 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1982276 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 1982278 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1982279 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1982279 INFO  (zkCallback-2156-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@5cab8480 
name:ZooKeeperConnection Watcher:127.0.0.1:48367/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1982279 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1982280 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1982280 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/collection1
   [junit4]   2> 1982281 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/collection1/shards
   [junit4]   2> 1982283 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection
   [junit4]   2> 1982283 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/shards
   [junit4]   2> 1982285 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
 to /configs/conf1/solrconfig.xml
   [junit4]   2> 1982285 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.xml
   [junit4]   2> 1982288 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1/conf/schema.xml
 to /configs/conf1/schema.xml
   [junit4]   2> 1982288 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/schema.xml
   [junit4]   2> 1982289 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
 to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 1982289 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.SolrZkClient makePath: 
/configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 1982290 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
 to /configs/conf1/stopwords.txt
   [junit4]   2> 1982290 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/stopwords.txt
   [junit4]   2> 1982292 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1/conf/protwords.txt
 to /configs/conf1/protwords.txt
   [junit4]   2> 1982292 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/protwords.txt
   [junit4]   2> 1982293 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1/conf/currency.xml
 to /configs/conf1/currency.xml
   [junit4]   2> 1982293 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/currency.xml
   [junit4]   2> 1982294 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
 to /configs/conf1/enumsConfig.xml
   [junit4]   2> 1982294 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/enumsConfig.xml
   [junit4]   2> 1982296 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
 to /configs/conf1/open-exchange-rates.json
   [junit4]   2> 1982296 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/open-exchange-rates.json
   [junit4]   2> 1982297 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
 to /configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 1982297 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 1982299 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
 to /configs/conf1/old_synonyms.txt
   [junit4]   2> 1982299 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/old_synonyms.txt
   [junit4]   2> 1982300 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
 to /configs/conf1/synonyms.txt
   [junit4]   2> 1982300 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/synonyms.txt
   [junit4]   2> 1982303 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1982303 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1982305 INFO  (zkCallback-2157-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@2c9ee1c6 
name:ZooKeeperConnection Watcher:127.0.0.1:48367/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1982305 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1982305 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1982306 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1982307 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1982307 INFO  (zkCallback-2158-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@38c56927 
name:ZooKeeperConnection Watcher:127.0.0.1:48367 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1982309 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1982309 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1982309 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 1982310 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1982310 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1982311 INFO  (zkCallback-2159-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@75b20210 
name:ZooKeeperConnection Watcher:127.0.0.1:48367/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1982311 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1982311 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1982312 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
 to /configs/conf2/solrconfig.xml
   [junit4]   2> 1982312 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/solrconfig.xml
   [junit4]   2> 1982314 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1/conf/schema.xml
 to /configs/conf2/schema.xml
   [junit4]   2> 1982314 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/schema.xml
   [junit4]   2> 1982315 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
 to /configs/conf2/enumsConfig.xml
   [junit4]   2> 1982315 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/enumsConfig.xml
   [junit4]   2> 1982316 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
 to /configs/conf2/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 1982316 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.SolrZkClient makePath: 
/configs/conf2/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 1982317 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
 to /configs/conf2/stopwords.txt
   [junit4]   2> 1982317 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/stopwords.txt
   [junit4]   2> 1982319 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1/conf/protwords.txt
 to /configs/conf2/protwords.txt
   [junit4]   2> 1982319 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/protwords.txt
   [junit4]   2> 1982320 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1/conf/currency.xml
 to /configs/conf2/currency.xml
   [junit4]   2> 1982320 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/currency.xml
   [junit4]   2> 1982321 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
 to /configs/conf2/open-exchange-rates.json
   [junit4]   2> 1982321 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/open-exchange-rates.json
   [junit4]   2> 1982322 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
 to /configs/conf2/mapping-ISOLatin1Accent.txt
   [junit4]   2> 1982322 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/mapping-ISOLatin1Accent.txt
   [junit4]   2> 1982323 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
 to /configs/conf2/old_synonyms.txt
   [junit4]   2> 1982323 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/old_synonyms.txt
   [junit4]   2> 1982325 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
 to /configs/conf2/synonyms.txt
   [junit4]   2> 1982325 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/synonyms.txt
   [junit4]   2> 1982327 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1/conf/elevate.xml
 to /configs/conf2/elevate.xml
   [junit4]   2> 1982327 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/elevate.xml
   [junit4]   2> 1982381 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_F8645B88D6A72879-001/control-001/cores/collection1
   [junit4]   2> 1982382 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.e.j.s.Server jetty-9.2.13.v20150730
   [junit4]   2> 1982383 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@6952b799{/,null,AVAILABLE}
   [junit4]   2> 1982388 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.e.j.s.ServerConnector Started 
ServerConnector@3593d3d4{SSL-http/1.1}{127.0.0.1:39698}
   [junit4]   2> 1982388 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.e.j.s.Server Started @1984208ms
   [junit4]   2> 1982388 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostPort=39698, hostContext=/, 
solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_F8645B88D6A72879-001/tempDir-001/control/data,
 
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_F8645B88D6A72879-001/control-001/cores}
   [junit4]   2> 1982388 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): 
sun.misc.Launcher$AppClassLoader@4f6de641
   [junit4]   2> 1982388 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_F8645B88D6A72879-001/control-001'
   [junit4]   2> 1982388 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1982388 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find 
system property or JNDI)
   [junit4]   2> 1982389 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1982389 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1982390 INFO  (zkCallback-2160-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@1e0f30de 
name:ZooKeeperConnection Watcher:127.0.0.1:48367/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1982390 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1982390 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1982391 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in 
ZooKeeper)
   [junit4]   2> 1982391 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_F8645B88D6A72879-001/control-001/solr.xml
   [junit4]   2> 1982400 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.CorePropertiesLocator Config-defined core root directory: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_F8645B88D6A72879-001/control-001/cores
   [junit4]   2> 1982400 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.CoreContainer New CoreContainer 27542475
   [junit4]   2> 1982400 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.CoreContainer Loading cores into CoreContainer 
[instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_F8645B88D6A72879-001/control-001]
   [junit4]   2> 1982400 WARN  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.CoreContainer Couldn't add files from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_F8645B88D6A72879-001/control-001/lib
 to classpath: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_F8645B88D6A72879-001/control-001/lib
   [junit4]   2> 1982400 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
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> 1982402 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 1982403 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 1982403 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.l.LogWatcher Registering Log Listener [Log4j 
(org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 1982403 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:48367/solr
   [junit4]   2> 1982403 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.ZkController zkHost includes chroot
   [junit4]   2> 1982403 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1982404 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1982405 INFO  (zkCallback-2163-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@53f13904 
name:ZooKeeperConnection Watcher:127.0.0.1:48367 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1982405 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1982405 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1982406 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) 
[n:127.0.0.1:39698_    ] o.a.s.c.ZkController Added new OnReconnect listener 
org.apache.solr.cloud.ZkController$6@72939392
   [junit4]   2> 1982407 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) 
[n:127.0.0.1:39698_    ] o.a.s.c.c.ConnectionManager Waiting for client to 
connect to ZooKeeper
   [junit4]   2> 1982407 INFO  
(zkCallback-2164-thread-1-processing-n:127.0.0.1:39698_) [n:127.0.0.1:39698_    
] o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@73bb0722 
name:ZooKeeperConnection Watcher:127.0.0.1:48367/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1982407 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) 
[n:127.0.0.1:39698_    ] o.a.s.c.c.ConnectionManager Client is connected to 
ZooKeeper
   [junit4]   2> 1982408 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) 
[n:127.0.0.1:39698_    ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue
   [junit4]   2> 1982409 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) 
[n:127.0.0.1:39698_    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer/collection-queue-work
   [junit4]   2> 1982411 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) 
[n:127.0.0.1:39698_    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer/collection-map-running
   [junit4]   2> 1982412 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) 
[n:127.0.0.1:39698_    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer/collection-map-completed
   [junit4]   2> 1982414 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) 
[n:127.0.0.1:39698_    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer/collection-map-failure
   [junit4]   2> 1982415 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) 
[n:127.0.0.1:39698_    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 1982416 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) 
[n:127.0.0.1:39698_    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 1982417 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) 
[n:127.0.0.1:39698_    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 1982418 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) 
[n:127.0.0.1:39698_    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 1982419 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) 
[n:127.0.0.1:39698_    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:39698_
   [junit4]   2> 1982419 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) 
[n:127.0.0.1:39698_    ] o.a.s.c.c.SolrZkClient makePath: 
/live_nodes/127.0.0.1:39698_
   [junit4]   2> 1982420 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) 
[n:127.0.0.1:39698_    ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect
   [junit4]   2> 1982420 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) 
[n:127.0.0.1:39698_    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer_elect/election
   [junit4]   2> 1982421 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) 
[n:127.0.0.1:39698_    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 1982421 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) 
[n:127.0.0.1:39698_    ] o.a.s.c.LeaderElector Joined leadership election with 
path: /overseer_elect/election/95814731442487303-127.0.0.1:39698_-n_0000000000
   [junit4]   2> 1982422 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) 
[n:127.0.0.1:39698_    ] o.a.s.c.OverseerElectionContext I am going to be the 
leader 127.0.0.1:39698_
   [junit4]   2> 1982422 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) 
[n:127.0.0.1:39698_    ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader
   [junit4]   2> 1982423 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) 
[n:127.0.0.1:39698_    ] o.a.s.c.Overseer Overseer 
(id=95814731442487303-127.0.0.1:39698_-n_0000000000) starting
   [junit4]   2> 1982424 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) 
[n:127.0.0.1:39698_    ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work
   [junit4]   2> 1982428 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) 
[n:127.0.0.1:39698_    ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting 
OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 
autoReplicaFailoverWaitAfterExpiration=10000 
autoReplicaFailoverBadNodeExpiration=60000
   [junit4]   2> 1982429 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) 
[n:127.0.0.1:39698_    ] o.a.s.c.c.ZkStateReader Updating cluster state from 
ZooKeeper... 
   [junit4]   2> 1982429 INFO  
(OverseerStateUpdate-95814731442487303-127.0.0.1:39698_-n_0000000000) 
[n:127.0.0.1:39698_    ] o.a.s.c.Overseer Starting to work on the main queue
   [junit4]   2> 1982429 INFO  
(OverseerCollectionConfigSetProcessor-95814731442487303-127.0.0.1:39698_-n_0000000000)
 [n:127.0.0.1:39698_    ] o.a.s.c.OverseerTaskProcessor Process current queue 
of overseer operations
   [junit4]   2> 1982440 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) 
[n:127.0.0.1:39698_    ] o.a.s.c.CoreContainer Security conf doesn't exist. 
Skipping setup for authorization module.
   [junit4]   2> 1982440 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) 
[n:127.0.0.1:39698_    ] o.a.s.c.CoreContainer No authentication plugin used.
   [junit4]   2> 1982440 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) 
[n:127.0.0.1:39698_    ] o.a.s.c.CorePropertiesLocator Looking for core 
definitions underneath 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_F8645B88D6A72879-001/control-001/cores
   [junit4]   2> 1982441 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) 
[n:127.0.0.1:39698_    ] o.a.s.c.CoreDescriptor Created CoreDescriptor: 
{shard=, name=collection1, dataDir=data/, collection=control_collection, 
transient=false, coreNodeName=, config=solrconfig.xml, 
configSetProperties=configsetprops.json, loadOnStartup=true, schema=schema.xml}
   [junit4]   2> 1982441 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) 
[n:127.0.0.1:39698_    ] o.a.s.c.CorePropertiesLocator Found core collection1 
in 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_F8645B88D6A72879-001/control-001/cores/collection1
   [junit4]   2> 1982441 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) 
[n:127.0.0.1:39698_    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
   [junit4]   2> 1982442 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) 
[n:127.0.0.1:39698_    ] o.a.s.s.SolrDispatchFilter 
user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2
   [junit4]   2> 1982442 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) 
[n:127.0.0.1:39698_    ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() 
done
   [junit4]   2> 1982443 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection   x:collection1] o.a.s.c.ZkController 
publishing state=down
   [junit4]   2> 1982443 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection   x:collection1] o.a.s.c.ZkController 
numShards not found on descriptor - reading it from system property
   [junit4]   2> 1982444 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection   x:collection1] o.a.s.c.ZkController 
Collection control_collection not visible yet, but flagging it so a watch is 
registered when it becomes visible
   [junit4]   2> 1982444 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection   x:collection1] 
o.a.s.c.c.ZkStateReader addZkWatch [control_collection]
   [junit4]   2> 1982445 INFO  
(OverseerStateUpdate-95814731442487303-127.0.0.1:39698_-n_0000000000) 
[n:127.0.0.1:39698_    ] o.a.s.c.Overseer processMessage: queueSize: 1, message 
= {
   [junit4]   2>   "roles":null,
   [junit4]   2>   "collection":"control_collection",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "node_name":"127.0.0.1:39698_",
   [junit4]   2>   "base_url":"https://127.0.0.1:39698";,
   [junit4]   2>   "operation":"state",
   [junit4]   2>   "shard":null,
   [junit4]   2>   "core":"collection1"} current state version: 0
   [junit4]   2> 1982445 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection   x:collection1] 
o.a.s.c.c.ZkStateReader Deleting data for [control_collection]
   [junit4]   2> 1982445 INFO  
(OverseerStateUpdate-95814731442487303-127.0.0.1:39698_-n_0000000000) 
[n:127.0.0.1:39698_    ] o.a.s.c.o.ReplicaMutator Update state numShards=1 
message={
   [junit4]   2>   "roles":null,
   [junit4]   2>   "collection":"control_collection",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "node_name":"127.0.0.1:39698_",
   [junit4]   2>   "base_url":"https://127.0.0.1:39698";,
   [junit4]   2>   "operation":"state",
   [junit4]   2>   "shard":null,
   [junit4]   2>   "core":"collection1"}
   [junit4]   2> 1982445 INFO  
(OverseerStateUpdate-95814731442487303-127.0.0.1:39698_-n_0000000000) 
[n:127.0.0.1:39698_    ] o.a.s.c.o.ClusterStateMutator building a new cName: 
control_collection
   [junit4]   2> 1982446 INFO  
(OverseerStateUpdate-95814731442487303-127.0.0.1:39698_-n_0000000000) 
[n:127.0.0.1:39698_    ] o.a.s.c.o.ReplicaMutator Assigning new node to shard 
shard=shard1
   [junit4]   2> 1982446 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection   x:collection1] o.a.s.c.ZkController 
look for our core node name
   [junit4]   2> 1982447 INFO  
(zkCallback-2164-thread-1-processing-n:127.0.0.1:39698_) [n:127.0.0.1:39698_    
] 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> 1983446 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection   x:collection1] o.a.s.c.ZkController 
waiting to find shard id in clusterstate for collection1
   [junit4]   2> 1983446 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection   x:collection1] o.a.s.c.ZkController 
Check for collection zkNode:control_collection
   [junit4]   2> 1983446 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection   x:collection1] o.a.s.c.ZkController 
Collection zkNode exists
   [junit4]   2> 1983447 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection   x:collection1] 
o.a.s.c.c.ZkStateReader Load collection config from: 
[/collections/control_collection]
   [junit4]   2> 1983447 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection   x:collection1] 
o.a.s.c.c.ZkStateReader path=[/collections/control_collection] 
[configName]=[conf1] specified config exists in ZooKeeper
   [junit4]   2> 1983447 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection   x:collection1] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_F8645B88D6A72879-001/control-001/cores/collection1'
   [junit4]   2> 1983447 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection   x:collection1] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1983447 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection   x:collection1] 
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find 
system property or JNDI)
   [junit4]   2> 1983448 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection   x:collection1] o.a.s.c.Config loaded 
config solrconfig.xml with version 0 
   [junit4]   2> 1983454 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection   x:collection1] o.a.s.c.SolrConfig 
current version of requestparams : -1
   [junit4]   2> 1983463 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection   x:collection1] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 5.5.1
   [junit4]   2> 1983483 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection   x:collection1] o.a.s.c.SolrConfig 
Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 1983487 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection   x:collection1] o.a.s.s.IndexSchema 
[collection1] Schema name=test
   [junit4]   2> 1983678 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection   x:collection1] 
o.a.s.s.OpenExchangeRatesOrgProvider Initialized with 
rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 1983683 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection   x:collection1] o.a.s.s.IndexSchema 
default search field in schema is text
   [junit4]   2> 1983684 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection   x:collection1] o.a.s.s.IndexSchema 
unique key field: id
   [junit4]   2> 1983693 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection   x:collection1] 
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 1983695 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection   x:collection1] 
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 1983697 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection   x:collection1] 
o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from 
open-exchange-rates.json
   [junit4]   2> 1983698 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection   x:collection1] 
o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from 
open-exchange-rates.json
   [junit4]   2> 1983699 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ 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-5.5/solr/build/solr-core/test/J2
   [junit4]   2> 1983699 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection   x:collection1] o.a.s.c.CoreContainer 
Creating SolrCore 'collection1' using configuration from collection 
control_collection
   [junit4]   2> 1983699 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 1983699 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ 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-5.5/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_F8645B88D6A72879-001/control-001/cores/collection1],
 
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_F8645B88D6A72879-001/control-001/cores/collection1/data/]
   [junit4]   2> 1983699 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ 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@fa8de42
   [junit4]   2> 1983700 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.CachingDirectoryFactory return new directory for 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_F8645B88D6A72879-001/control-001/cores/collection1/data
   [junit4]   2> 1983700 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.SolrCore New index directory detected: old=null 
new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_F8645B88D6A72879-001/control-001/cores/collection1/data/index/
   [junit4]   2> 1983700 WARN  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.SolrCore [collection1] Solr index directory 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_F8645B88D6A72879-001/control-001/cores/collection1/data/index'
 doesn't exist. Creating new index...
   [junit4]   2> 1983700 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.CachingDirectoryFactory return new directory for 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_F8645B88D6A72879-001/control-001/cores/collection1/data/index
   [junit4]   2> 1983700 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ 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=5, maxMergeAtOnceExplicit=5, maxMergedSegmentMB=56.392578125, 
floorSegmentMB=1.0556640625, forceMergeDeletesPctAllowed=19.796399583025394, 
segmentsPerTier=17.0, maxCFSSegmentSizeMB=1.1064453125, 
noCFSRatio=0.29039190655464586
   [junit4]   2> 1983701 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>        
commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@6f459e64 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@43a1f04e; 
maxCacheMB=0.6865234375 
maxMergeSizeMB=0.0283203125)),segFN=segments_1,generation=1}
   [junit4]   2> 1983701 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 1983701 INFO  
(OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:39698_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore 
Looking for old index directories to cleanup for core collection1 in 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_F8645B88D6A72879-001/control-001/cores/collection1/data/
   [junit4]   2> 1983702 WARN  
(OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:39698_ 
c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.DirectoryFactory 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_F8645B88D6A72879-001/control-001/cores/collection1/data/
 does not point to a valid data directory; skipping clean-up of old index 
directories.
   [junit4]   2> 1983704 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain 
"nodistrib"
   [junit4]   2> 1983704 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain 
"dedupe"
   [junit4]   2> 1983704 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.p.UpdateRequestProcessorChain inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 1983704 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain 
"stored_sig"
   [junit4]   2> 1983705 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.p.UpdateRequestProcessorChain inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 1983705 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ 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> 1983705 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ 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> 1983705 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ 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> 1983705 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ 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> 1983705 WARN  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = 
requestHandler,name = /dump,class = DumpRequestHandler,args = 
{defaults={a=A,b=B}}}
   [junit4]   2> 1983707 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1983708 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1983708 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1983709 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1983712 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.RequestHandlers Registered paths: 
/admin/file,/admin/system,/replication,/config,/admin/properties,/admin/luke,standard,/dump,/admin/logging,/admin/ping,/update/json/docs,/admin/plugins,/schema,/update/csv,/admin/segments,/admin/mbeans,/admin/threads,/update/json,/update,/get
   [junit4]   2> 1983712 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ 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> 1983713 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1983713 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1983713 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1983713 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1983714 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=26, maxMergeAtOnceExplicit=32, maxMergedSegmentMB=68.947265625, 
floorSegmentMB=1.5048828125, forceMergeDeletesPctAllowed=26.098676377846555, 
segmentsPerTier=12.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 1983714 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>        
commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@6f459e64 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@43a1f04e; 
maxCacheMB=0.6865234375 
maxMergeSizeMB=0.0283203125)),segFN=segments_1,generation=1}
   [junit4]   2> 1983714 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 1983714 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.s.SolrIndexSearcher Opening Searcher@684575eb[collection1] main
   [junit4]   2> 1983714 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ 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> 1983715 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ 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> 1983715 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ 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> 1983715 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf1
   [junit4]   2> 1983715 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.r.RestManager Initializing RestManager with initArgs: {}
   [junit4]   2> 1983715 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ 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> 1983715 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ 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> 1983716 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ 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> 1983716 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.r.RestManager Initializing 0 registered ManagedResources
   [junit4]   2> 1983716 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1983716 INFO  
(searcherExecutor-4941-thread-1-processing-r:core_node1 c:control_collection 
n:127.0.0.1:39698_ s:shard1 x:collection1) [n:127.0.0.1:39698_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore 
[collection1] Registered new searcher Searcher@684575eb[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1983716 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ 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> 1983716 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.VersionInfo Refreshing highest value of _version_ for 65536 version 
buckets from index
   [junit4]   2> 1983716 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ 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> 1983716 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ 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 1533035704695652352
   [junit4]   2> 1983718 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.UpdateLog Took 1.0ms to seed version buckets with highest version 
1533035704695652352
   [junit4]   2> 1983718 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.ZkController watch zkdir /configs/conf1
   [junit4]   2> 1983719 INFO  
(coreLoadExecutor-4940-thread-1-processing-n:127.0.0.1:39698_) 
[n:127.0.0.1:39698_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.CoreContainer registering core: collection1
   [junit4]   2> 1983719 INFO  
(coreZkRegister-4934-thread-1-processing-r:core_node1 c:control_collection 
n:127.0.0.1:39698_ s:shard1 x:collection1) [n:127.0.0.1:39698_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController 
Register replica - core:collection1 address:https://127.0.0.1:39698 
collection:control_collection shard:shard1
   [junit4]   2> 1983720 INFO  
(coreZkRegister-4934-thread-1-processing-r:core_node1 c:control_collection 
n:127.0.0.1:39698_ s:shard1 x:collection1) [n:127.0.0.1:39698_ 
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> 1983722 INFO  
(coreZkRegister-4934-thread-1-processing-r:core_node1 c:control_collection 
n:127.0.0.1:39698_ s:shard1 x:collection1) [n:127.0.0.1:39698_ 
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/95814731442487303-core_node1-n_0000000000
   [junit4]   2> 1983722 INFO  
(coreZkRegister-4934-thread-1-processing-r:core_node1 c:control_collection 
n:127.0.0.1:39698_ s:shard1 x:collection1) [n:127.0.0.1:39698_ 
c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.ShardLeaderElectionContext Running the leader process for shard=shard1 
and weAreReplacement=false and leaderVoteWait=180000
   [junit4]   2> 1983723 INFO  
(coreZkRegister-4934-thread-1-processing-r:core_node1 c:control_collection 
n:127.0.0.1:39698_ s:shard1 x:collection1) [n:127.0.0.1:39698_ 
c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 1983723 INFO  
(coreZkRegister-4934-thread-1-processing-r:core_node1 c:control_collection 
n:127.0.0.1:39698_ s:shard1 x:collection1) [n:127.0.0.1:39698_ 
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> 1983723 INFO  
(coreZkRegister-4934-thread-1-processing-r:core_node1 c:control_collection 
n:127.0.0.1:39698_ s:shard1 x:collection1) [n:127.0.0.1:39698_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy 
Sync replicas to https://127.0.0.1:39698/collection1/
   [junit4]   2> 1983724 INFO  
(OverseerStateUpdate-95814731442487303-127.0.0.1:39698_-n_0000000000) 
[n:127.0.0.1:39698_    ] 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> 1983724 INFO  
(coreZkRegister-4934-thread-1-processing-r:core_node1 c:control_collection 
n:127.0.0.1:39698_ s:shard1 x:collection1) [n:127.0.0.1:39698_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy 
Sync Success - now sync replicas to me
   [junit4]   2> 1983724 INFO  
(coreZkRegister-4934-thread-1-processing-r:core_node1 c:control_collection 
n:127.0.0.1:39698_ s:shard1 x:collection1) [n:127.0.0.1:39698_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy 
https://127.0.0.1:39698/collection1/ has no replicas
   [junit4]   2> 1983724 INFO  
(coreZkRegister-4934-thread-1-processing-r:core_node1 c:control_collection 
n:127.0.0.1:39698_ s:shard1 x:collection1) [n:127.0.0.1:39698_ 
c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/leaders/shard1
   [junit4]   2> 1983727 INFO  
(coreZkRegister-4934-thread-1-processing-r:core_node1 c:control_collection 
n:127.0.0.1:39698_ s:shard1 x:collection1) [n:127.0.0.1:39698_ 
c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node 
/collections/control_collection/leaders/shard1/leader after winning as 
/collections/control_collection/leader_elect/shard1/election/95814731442487303-core_node1-n_0000000000
   [junit4]   2> 1983728 INFO  
(coreZkRegister-4934-thread-1-processing-r:core_node1 c:control_collection 
n:127.0.0.1:39698_ s:shard1 x:collection1) [n:127.0.0.1:39698_ 
c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
https://127.0.0.1:39698/collection1/ shard1
   [junit4]   2> 1983728 INFO  
(OverseerStateUpdate-95814731442487303-127.0.0.1:39698_-n_0000000000) 
[n:127.0.0.1:39698_    ] 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":"https://127.0.0.1:39698";,
   [junit4]   2>   "core":"collection1",
   [junit4]   2>   "state":"active"} current state version: 1
   [junit4]   2> 1983832 INFO  
(zkCallback-2164-thread-1-processing-n:127.0.0.1:39698_) [n:127.0.0.1:39698_    
] 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> 1983879 INFO  
(coreZkRegister-4934-thread-1-processing-r:core_node1 c:control_collection 
n:127.0.0.1:39698_ s:shard1 x:collection1) [n:127.0.0.1:39698_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController 
We are https://127.0.0.1:39698/collection1/ and leader is 
https://127.0.0.1:39698/collection1/
   [junit4]   2> 1983879 INFO  
(coreZkRegister-4934-thread-1-processing-r:core_node1 c:control_collection 
n:127.0.0.1:39698_ s:shard1 x:collection1) [n:127.0.0.1:39698_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController 
No LogReplay needed for core=collection1 baseURL=https://127.0.0.1:39698
   [junit4]   2> 1983879 INFO  
(coreZkRegister-4934-thread-1-processing-r:core_node1 c:control_collection 
n:127.0.0.1:39698_ s:shard1 x:collection1) [n:127.0.0.1:39698_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController 
I am the leader, no recovery necessary
   [junit4]   2> 1983879 INFO  
(coreZkRegister-4934-thread-1-processing-r:core_node1 c:control_collection 
n:127.0.0.1:39698_ s:shard1 x:collection1) [n:127.0.0.1:39698_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController 
publishing state=active
   [junit4]   2> 1983879 INFO  
(coreZkRegister-4934-thread-1-processing-r:core_node1 c:control_collection 
n:127.0.0.1:39698_ s:shard1 x:collection1) [n:127.0.0.1:39698_ 
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> 1983880 INFO  
(OverseerStateUpdate-95814731442487303-127.0.0.1:39698_-n_0000000000) 
[n:127.0.0.1:39698_    ] o.a.s.c.Overseer processMessage: queueSize: 1, message 
= {
   [junit4]   2>   "roles":null,
   [junit4]   2>   "collection":"control_collection",
   [junit4]   2>   "core_node_name":"core_node1",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "node_name":"127.0.0.1:39698_",
   [junit4]   2>   "base_url":"https://127.0.0.1:39698";,
   [junit4]   2>   "operation":"state",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"collection1"} current state version: 2
   [junit4]   2> 1983881 INFO  
(OverseerStateUpdate-95814731442487303-127.0.0.1:39698_-n_0000000000) 
[n:127.0.0.1:39698_    ] o.a.s.c.o.ReplicaMutator Update state numShards=1 
message={
   [junit4]   2>   "roles":null,
   [junit4]   2>   "collection":"control_collection",
   [junit4]   2>   "core_node_name":"core_node1",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "node_name":"127.0.0.1:39698_",
   [junit4]   2>   "base_url":"https://127.0.0.1:39698";,
   [junit4]   2>   "operation":"state",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"collection1"}
   [junit4]   2> 1983944 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1983945 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1983946 INFO  (zkCallback-2166-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@789d6cd name:ZooKeeperConnection 
Watcher:127.0.0.1:48367/solr got event WatchedEvent state:SyncConnected 
type:None path:null path:null type:None
   [junit4]   2> 1983946 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1983947 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1983947 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 1983948 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection 
loss:false
   [junit4]   2> 1983948 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.AbstractFullDistribZkTestBase Creating collection1 with stateFormat=2
   [junit4]   2> 1983948 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1983949 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1983950 INFO  (zkCallback-2167-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@1e0d2741 
name:ZooKeeperConnection Watcher:127.0.0.1:48367/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1983950 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1983950 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1983952 INFO  
(OverseerStateUpdate-95814731442487303-127.0.0.1:39698_-n_0000000000) 
[n:127.0.0.1:39698_    ] 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> 1983952 INFO  
(OverseerStateUpdate-95814731442487303-127.0.0.1:39698_-n_0000000000) 
[n:127.0.0.1:39698_    ] o.a.s.c.o.ClusterStateMutator building a new cName: 
collection1
   [junit4]   2> 1983953 INFO  
(zkCallback-2164-thread-1-processing-n:127.0.0.1:39698_) [n:127.0.0.1:39698_    
] 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> 1983963 INFO  (zkCallback-2166-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> 1984014 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_F8645B88D6A72879-001/shard-1-001/cores/collection1
   [junit4]   2> 1984015 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_F8645B88D6A72879-001/shard-1-001
   [junit4]   2> 1984015 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.e.j.s.Server jetty-9.2.13.v20150730
   [junit4]   2> 1984016 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@850cbe8{/,null,AVAILABLE}
   [junit4]   2> 1984020 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.e.j.s.ServerConnector Started 
ServerConnector@174a89ce{SSL-http/1.1}{127.0.0.1:46666}
   [junit4]   2> 1984020 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.e.j.s.Server Started @1985840ms
   [junit4]   2> 1984020 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, 
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_F8645B88D6A72879-001/shard-1-001/cores,
 solrconfig=solrconfig.xml, hostPort=46666, 
solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_F8645B88D6A72879-001/tempDir-001/jetty1}
   [junit4]   2> 1984020 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): 
sun.misc.Launcher$AppClassLoader@4f6de641
   [junit4]   2> 1984020 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_F8645B88D6A72879-001/shard-1-001'
   [junit4]   2> 1984020 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1984020 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[F8645B88D6A72879]) [    ] 
o.a.s.c.SolrResourceLoader s

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

csSourceAdapter.java:227)
   [junit4]   2>        at 
org.apache.hadoop.metrics2.impl.MetricsSourceAdapter.stop(MetricsSourceAdapter.java:212)
   [junit4]   2>        at 
org.apache.hadoop.metrics2.impl.MetricsSystemImpl.stopSources(MetricsSystemImpl.java:461)
   [junit4]   2>        at 
org.apache.hadoop.metrics2.impl.MetricsSystemImpl.stop(MetricsSystemImpl.java:212)
   [junit4]   2>        at 
org.apache.hadoop.metrics2.impl.MetricsSystemImpl.shutdown(MetricsSystemImpl.java:592)
   [junit4]   2>        at 
org.apache.hadoop.metrics2.lib.DefaultMetricsSystem.shutdownInstance(DefaultMetricsSystem.java:72)
   [junit4]   2>        at 
org.apache.hadoop.metrics2.lib.DefaultMetricsSystem.shutdown(DefaultMetricsSystem.java:68)
   [junit4]   2>        at 
org.apache.hadoop.hdfs.server.namenode.metrics.NameNodeMetrics.shutdown(NameNodeMetrics.java:145)
   [junit4]   2>        at 
org.apache.hadoop.hdfs.server.namenode.NameNode.stop(NameNode.java:822)
   [junit4]   2>        at 
org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:1720)
   [junit4]   2>        at 
org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:1699)
   [junit4]   2>        at 
org.apache.solr.cloud.hdfs.HdfsTestUtil.teardownClass(HdfsTestUtil.java:198)
   [junit4]   2>        at 
org.apache.solr.index.hdfs.CheckHdfsIndexTest.teardownClass(CheckHdfsIndexTest.java:69)
   [junit4]   2>        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native 
Method)
   [junit4]   2>        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
   [junit4]   2>        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   [junit4]   2>        at java.lang.reflect.Method.invoke(Method.java:606)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:834)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
   [junit4]   2>        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> Caused by: java.lang.NullPointerException
   [junit4]   2>        at 
org.apache.hadoop.hdfs.server.blockmanagement.BlocksMap.size(BlocksMap.java:198)
   [junit4]   2>        at 
org.apache.hadoop.hdfs.server.blockmanagement.BlockManager.getTotalBlocks(BlockManager.java:3291)
   [junit4]   2>        at 
org.apache.hadoop.hdfs.server.namenode.FSNamesystem.getBlocksTotal(FSNamesystem.java:6223)
   [junit4]   2>        ... 54 more
   [junit4]   2> 3738814 INFO  
(SUITE-CheckHdfsIndexTest-seed#[F8645B88D6A72879]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J1/temp/solr.index.hdfs.CheckHdfsIndexTest_F8645B88D6A72879-001
   [junit4]   2> Apr 30, 2016 12:15:32 PM 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 3 leaked 
thread(s).
   [junit4]   2> NOTE: test params are: 
codec=HighCompressionCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=HIGH_COMPRESSION,
 chunkSize=11203, maxDocsPerChunk=916, blockSize=9), 
termVectorsFormat=CompressingTermVectorsFormat(compressionMode=HIGH_COMPRESSION,
 chunkSize=11203, blockSize=9)), sim=DefaultSimilarity, locale=sr-Latn, 
timezone=Africa/Bissau
   [junit4]   2> NOTE: Linux 3.13.0-85-generic amd64/Oracle Corporation 
1.7.0_80 (64-bit)/cpus=4,threads=2,free=221256744,total=514326528
   [junit4]   2> NOTE: All tests run in this JVM: [CSVRequestHandlerTest, 
DistanceFunctionTest, OpenCloseCoreStressTest, 
BigEndianAscendingWordSerializerTest, SpellCheckComponentTest, 
TestSolrConfigHandlerCloud, TestFileDictionaryLookup, TestHashPartitioner, 
FullHLLTest, LoggingHandlerTest, DistribJoinFromCollectionTest, 
FacetPivotSmallTest, TestReplicationHandlerBackup, SSLMigrationTest, 
NumericFieldsTest, UniqFieldsUpdateProcessorFactoryTest, 
TestNonDefinedSimilarityFactory, FastVectorHighlighterTest, 
HdfsRestartWhileUpdatingTest, RequestLoggingTest, SoftAutoCommitTest, 
TestQuerySenderNoQuery, HdfsUnloadDistributedZkTest, 
TestSolrQueryParserResource, TestSmileRequest, ShardRoutingTest, 
SchemaVersionSpecificBehaviorTest, CreateCollectionCleanupTest, RankQueryTest, 
TestWordDelimiterFilterFactory, TestDefaultStatsCache, TestClusterStateMutator, 
VMParamsZkACLAndCredentialsProvidersTest, TestSimpleTrackingShardHandler, 
TestDynamicFieldResource, TestReloadDeadlock, TestSolrConfigHandler, 
TestLeaderInitiatedRecoveryThread, TestLMJelinekMercerSimilarityFactory, 
ConvertedLegacyTest, TestCustomSort, DeleteStatusTest, RuleEngineTest, 
TestScoreJoinQPScore, TestConfigSetsAPIZkFailure, DateRangeFieldTest, 
PreAnalyzedUpdateProcessorTest, TestFiltering, TestDistributedGrouping, 
TestNRTOpen, TestCloudManagedSchemaConcurrent, ChaosMonkeyNothingIsSafeTest, 
AsyncMigrateRouteKeyTest, ZkCLITest, DocumentBuilderTest, 
SpellPossibilityIteratorTest, FileUtilsTest, DistributedExpandComponentTest, 
TestExceedMaxTermLength, DistributedFacetPivotSmallAdvancedTest, 
BlockJoinFacetRandomTest, TestSolrCloudWithKerberosAlt, 
TestCursorMarkWithoutUniqueKey, TermVectorComponentTest, MultiTermTest, 
TestQueryTypes, DocExpirationUpdateProcessorFactoryTest, 
AnalysisErrorHandlingTest, TestSchemaVersionResource, 
TestCopyFieldCollectionResource, TestManagedSynonymFilterFactory, 
DirectSolrSpellCheckerTest, ZkSolrClientTest, AliasIntegrationTest, 
TestQueryUtils, TestExactStatsCache, TestNoOpRegenerator, TestSystemIdResolver, 
TestRawResponseWriter, ConcurrentDeleteAndCreateCollectionTest, 
IndexBasedSpellCheckerTest, TestSurroundQueryParser, NotRequiredUniqueKeyTest, 
TestSortByMinMaxFunction, TimeZoneUtilsTest, DistributedMLTComponentTest, 
DistanceUnitsTest, SolrInfoMBeanTest, SharedFSAutoReplicaFailoverTest, 
TestSchemaNameResource, TestRandomRequestDistribution, 
DistributedQueryComponentCustomSortTest, HighlighterMaxOffsetTest, DOMUtilTest, 
LeaderElectionIntegrationTest, BasicZkTest, RecoveryZkTest, 
FullSolrCloudDistribCmdsTest, TestReplicationHandler, 
CloudExitableDirectoryReaderTest, CollectionTooManyReplicasTest, 
DeleteShardTest, ForceLeaderTest, LeaderInitiatedRecoveryOnShardRestartTest, 
OutOfBoxZkACLAndCredentialsProvidersTest, 
OverriddenZkACLAndCredentialsProvidersTest, 
OverseerCollectionConfigSetProcessorTest, OverseerRolesTest, 
SolrCloudExampleTest, TestAuthenticationFramework, 
TestExclusionRuleCollectionAccess, TestRebalanceLeaders, TestStressLiveNodes, 
HdfsChaosMonkeyNothingIsSafeTest, StressHdfsTest, SuggestComponentTest, 
TestExpandComponent, TestPivotHelperCode, TestTrackingShardHandlerFactory, 
CheckHdfsIndexTest]
   [junit4] Completed [517/572 (4!)] on J1 in 43.41s, 6 tests, 1 error, 1 
skipped <<< FAILURES!

[...truncated 194 lines...]
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/build.xml:757: 
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/build.xml:694: 
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/build.xml:59: 
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build.xml:233:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/common-build.xml:534:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/lucene/common-build.xml:1477:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/lucene/common-build.xml:1033:
 There were test failures: 572 suites (7 ignored), 2293 tests, 3 errors, 1 
failure, 34 ignored (18 assumptions) [seed: F8645B88D6A72879]

Total time: 401 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 - Any
Sending email for trigger: Failure - Any



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

Reply via email to