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

3 tests failed.
FAILED:  
org.apache.solr.cloud.CdcrReplicationHandlerTest.testReplicationWithBufferedUpdates

Error Message:
Timeout while trying to assert number of documents @ source_collection

Stack Trace:
java.lang.AssertionError: Timeout while trying to assert number of documents @ 
source_collection
        at 
__randomizedtesting.SeedInfo.seed([C6DB3996DDD59445:15D26988984608D2]:0)
        at 
org.apache.solr.cloud.BaseCdcrDistributedZkTest.assertNumDocs(BaseCdcrDistributedZkTest.java:266)
        at 
org.apache.solr.cloud.CdcrReplicationHandlerTest.testReplicationWithBufferedUpdates(CdcrReplicationHandlerTest.java:233)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        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:992)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:967)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at java.lang.Thread.run(Thread.java:745)
Caused by: java.lang.AssertionError: expected:<410> but was:<420>
        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.cloud.BaseCdcrDistributedZkTest.assertNumDocs(BaseCdcrDistributedZkTest.java:257)
        ... 42 more


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

Error Message:


Stack Trace:
java.lang.AssertionError
        at 
__randomizedtesting.SeedInfo.seed([C6DB3996DDD59445:4E8F064C7329F9BD]:0)
        at org.junit.Assert.fail(Assert.java:92)
        at org.junit.Assert.assertTrue(Assert.java:43)
        at org.junit.Assert.assertTrue(Assert.java:54)
        at 
org.apache.solr.cloud.SharedFSAutoReplicaFailoverTest.testBasics(SharedFSAutoReplicaFailoverTest.java:226)
        at 
org.apache.solr.cloud.SharedFSAutoReplicaFailoverTest.test(SharedFSAutoReplicaFailoverTest.java:107)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        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:992)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:967)
        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.handler.TestReqParamsAPI.test

Error Message:
Could not get expected value  'CY val modified' for path 'response/params/y/c' 
full output: {   "responseHeader":{     "status":0,     "QTime":0},   
"response":{     "znodeVersion":0,     "params":{"x":{         "a":"A val",     
    "b":"B val",         "":{"v":0}}}}}

Stack Trace:
java.lang.AssertionError: Could not get expected value  'CY val modified' for 
path 'response/params/y/c' full output: {
  "responseHeader":{
    "status":0,
    "QTime":0},
  "response":{
    "znodeVersion":0,
    "params":{"x":{
        "a":"A val",
        "b":"B val",
        "":{"v":0}}}}}
        at 
__randomizedtesting.SeedInfo.seed([C6DB3996DDD59445:4E8F064C7329F9BD]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.assertTrue(Assert.java:43)
        at 
org.apache.solr.core.TestSolrConfigHandler.testForResponseElement(TestSolrConfigHandler.java:458)
        at 
org.apache.solr.handler.TestReqParamsAPI.testReqParams(TestReqParamsAPI.java:200)
        at 
org.apache.solr.handler.TestReqParamsAPI.test(TestReqParamsAPI.java:67)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        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:992)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:967)
        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)




Build Log:
[...truncated 11785 lines...]
   [junit4] Suite: org.apache.solr.handler.TestReqParamsAPI
   [junit4]   2> Creating dataDir: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_C6DB3996DDD59445-001/init-core-data-001
   [junit4]   2> 2190765 INFO  
(SUITE-TestReqParamsAPI-seed#[C6DB3996DDD59445]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false)
   [junit4]   2> 2190765 INFO  
(SUITE-TestReqParamsAPI-seed#[C6DB3996DDD59445]-worker) [    ] 
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /
   [junit4]   2> 2190777 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 2190779 INFO  (Thread-30614) [    ] o.a.s.c.ZkTestServer 
client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 2190779 INFO  (Thread-30614) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 2191024 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.ZkTestServer start zk server on port:54070
   [junit4]   2> 2191025 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 2191043 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2191055 INFO  (zkCallback-1941-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@45a39152 
name:ZooKeeperConnection Watcher:127.0.0.1:54070 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2191055 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2191055 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 2191055 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 2191069 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 2191079 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2191111 INFO  (zkCallback-1942-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@3c9b061a 
name:ZooKeeperConnection Watcher:127.0.0.1:54070/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2191111 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2191111 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 2191111 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/collection1
   [junit4]   2> 2191151 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/collection1/shards
   [junit4]   2> 2191167 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection
   [junit4]   2> 2191168 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/shards
   [junit4]   2> 2191168 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
 to /configs/conf1/solrconfig.xml
   [junit4]   2> 2191168 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.xml
   [junit4]   2> 2191169 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/schema.xml
 to /configs/conf1/schema.xml
   [junit4]   2> 2191169 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/schema.xml
   [junit4]   2> 2191170 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
 to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 2191170 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.c.SolrZkClient makePath: 
/configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 2191171 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
 to /configs/conf1/stopwords.txt
   [junit4]   2> 2191171 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/stopwords.txt
   [junit4]   2> 2191176 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/protwords.txt
 to /configs/conf1/protwords.txt
   [junit4]   2> 2191176 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/protwords.txt
   [junit4]   2> 2191176 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/currency.xml
 to /configs/conf1/currency.xml
   [junit4]   2> 2191176 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/currency.xml
   [junit4]   2> 2191177 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
 to /configs/conf1/enumsConfig.xml
   [junit4]   2> 2191177 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/enumsConfig.xml
   [junit4]   2> 2191178 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
 to /configs/conf1/open-exchange-rates.json
   [junit4]   2> 2191178 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/open-exchange-rates.json
   [junit4]   2> 2191187 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
 to /configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 2191187 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 2191188 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
 to /configs/conf1/old_synonyms.txt
   [junit4]   2> 2191188 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/old_synonyms.txt
   [junit4]   2> 2191189 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
 to /configs/conf1/synonyms.txt
   [junit4]   2> 2191189 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/synonyms.txt
   [junit4]   2> 2191265 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_C6DB3996DDD59445-001/control-001/cores/collection1
   [junit4]   2> 2191266 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] o.e.j.s.Server 
jetty-9.3.8.v20160314
   [junit4]   2> 2191269 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@4a58f3a4{/,null,AVAILABLE}
   [junit4]   2> 2191271 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.e.j.s.ServerConnector Started 
ServerConnector@4ab4befb{HTTP/1.1,[http/1.1]}{127.0.0.1:33317}
   [junit4]   2> 2191271 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] o.e.j.s.Server 
Started @2196719ms
   [junit4]   2> 2191271 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_C6DB3996DDD59445-001/tempDir-001/control/data,
 hostContext=/, hostPort=33317, 
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_C6DB3996DDD59445-001/control-001/cores}
   [junit4]   2> 2191271 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): 
sun.misc.Launcher$AppClassLoader@73d16e93
   [junit4]   2> 2191271 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_C6DB3996DDD59445-001/control-001'
   [junit4]   2> 2191271 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 2191271 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find 
system property or JNDI)
   [junit4]   2> 2191271 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 2191272 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2191274 INFO  (zkCallback-1943-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@17253d20 
name:ZooKeeperConnection Watcher:127.0.0.1:54070/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2191274 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2191274 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 2191276 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in 
ZooKeeper)
   [junit4]   2> 2191276 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_C6DB3996DDD59445-001/control-001/solr.xml
   [junit4]   2> 2191279 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.CorePropertiesLocator Config-defined core root directory: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_C6DB3996DDD59445-001/control-001/cores
   [junit4]   2> 2191281 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.CoreContainer New CoreContainer 968881988
   [junit4]   2> 2191281 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.CoreContainer Loading cores into CoreContainer 
[instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_C6DB3996DDD59445-001/control-001]
   [junit4]   2> 2191281 WARN  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.CoreContainer Couldn't add files from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_C6DB3996DDD59445-001/control-001/lib
 to classpath: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_C6DB3996DDD59445-001/control-001/lib
   [junit4]   2> 2191281 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
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> 2191283 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 2191283 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] o.a.s.l.LogWatcher 
SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 2191283 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] o.a.s.l.LogWatcher 
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 2191283 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] o.a.s.c.ZkContainer 
Zookeeper client=127.0.0.1:54070/solr
   [junit4]   2> 2191283 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.ZkController zkHost includes chroot
   [junit4]   2> 2191284 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 2191286 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2191286 INFO  (zkCallback-1946-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@75f5c9e7 
name:ZooKeeperConnection Watcher:127.0.0.1:54070 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2191286 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2191287 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 2191291 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [n:127.0.0.1:33317_    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2191292 INFO  
(zkCallback-1947-thread-1-processing-n:127.0.0.1:33317_) [n:127.0.0.1:33317_    
] o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@ca6bffb name:ZooKeeperConnection 
Watcher:127.0.0.1:54070/solr got event WatchedEvent state:SyncConnected 
type:None path:null path:null type:None
   [junit4]   2> 2191292 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [n:127.0.0.1:33317_    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2191293 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [n:127.0.0.1:33317_    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer/queue
   [junit4]   2> 2191303 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [n:127.0.0.1:33317_    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work
   [junit4]   2> 2191304 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [n:127.0.0.1:33317_    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running
   [junit4]   2> 2191305 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [n:127.0.0.1:33317_    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed
   [junit4]   2> 2191311 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [n:127.0.0.1:33317_    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure
   [junit4]   2> 2191312 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [n:127.0.0.1:33317_    ] 
o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 2191313 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [n:127.0.0.1:33317_    ] 
o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 2191313 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [n:127.0.0.1:33317_    ] 
o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 2191314 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [n:127.0.0.1:33317_    ] 
o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 2191314 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [n:127.0.0.1:33317_    ] 
o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 2191314 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [n:127.0.0.1:33317_    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 2191315 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [n:127.0.0.1:33317_    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer_elect
   [junit4]   2> 2191316 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [n:127.0.0.1:33317_    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election
   [junit4]   2> 2191316 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [n:127.0.0.1:33317_    ] 
o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 2191322 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [n:127.0.0.1:33317_    ] 
o.a.s.c.LeaderElector Joined leadership election with path: 
/overseer_elect/election/95724606305140740-127.0.0.1:33317_-n_0000000000
   [junit4]   2> 2191322 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [n:127.0.0.1:33317_    ] 
o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:33317_
   [junit4]   2> 2191322 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [n:127.0.0.1:33317_    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader
   [junit4]   2> 2191323 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [n:127.0.0.1:33317_    ] 
o.a.s.c.Overseer Overseer (id=95724606305140740-127.0.0.1:33317_-n_0000000000) 
starting
   [junit4]   2> 2191324 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [n:127.0.0.1:33317_    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work
   [junit4]   2> 2191326 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [n:127.0.0.1:33317_    ] 
o.a.s.c.OverseerAutoReplicaFailoverThread Starting 
OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 
autoReplicaFailoverWaitAfterExpiration=30000 
autoReplicaFailoverBadNodeExpiration=60000
   [junit4]   2> 2191327 INFO  
(OverseerCollectionConfigSetProcessor-95724606305140740-127.0.0.1:33317_-n_0000000000)
 [n:127.0.0.1:33317_    ] o.a.s.c.OverseerTaskProcessor Process current queue 
of overseer operations
   [junit4]   2> 2191332 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [n:127.0.0.1:33317_    ] 
o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:33317_
   [junit4]   2> 2191332 INFO  
(OverseerStateUpdate-95724606305140740-127.0.0.1:33317_-n_0000000000) 
[n:127.0.0.1:33317_    ] o.a.s.c.Overseer Starting to work on the main queue
   [junit4]   2> 2191339 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [n:127.0.0.1:33317_    ] 
o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:33317_
   [junit4]   2> 2191352 INFO  
(zkCallback-1947-thread-1-processing-n:127.0.0.1:33317_) [n:127.0.0.1:33317_    
] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live 
nodes size: [0])
   [junit4]   2> 2191367 INFO  
(OverseerStateUpdate-95724606305140740-127.0.0.1:33317_-n_0000000000) 
[n:127.0.0.1:33317_    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 2191367 INFO  
(zkCallback-1947-thread-1-processing-n:127.0.0.1:33317_) [n:127.0.0.1:33317_    
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (1)
   [junit4]   2> 2191368 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [n:127.0.0.1:33317_    ] 
o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for 
authorization module.
   [junit4]   2> 2191368 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [n:127.0.0.1:33317_    ] 
o.a.s.c.CoreContainer No authentication plugin used.
   [junit4]   2> 2191369 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [n:127.0.0.1:33317_    ] 
o.a.s.c.CorePropertiesLocator Looking for core definitions underneath 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_C6DB3996DDD59445-001/control-001/cores
   [junit4]   2> 2191369 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [n:127.0.0.1:33317_    ] 
o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection1, 
config=solrconfig.xml, transient=false, schema=schema.xml, loadOnStartup=true, 
configSetProperties=configsetprops.json, collection=control_collection, 
coreNodeName=, dataDir=data/, shard=}
   [junit4]   2> 2191369 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [n:127.0.0.1:33317_    ] 
o.a.s.c.CorePropertiesLocator Found core collection1 in 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_C6DB3996DDD59445-001/control-001/cores/collection1
   [junit4]   2> 2191369 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [n:127.0.0.1:33317_    ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions
   [junit4]   2> 2191388 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ c:control_collection   x:collection1] o.a.s.c.ZkController 
publishing state=down
   [junit4]   2> 2191388 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ c:control_collection   x:collection1] o.a.s.c.ZkController 
numShards not found on descriptor - reading it from system property
   [junit4]   2> 2191389 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ c:control_collection   x:collection1] o.a.s.c.ZkController 
look for our core node name
   [junit4]   2> 2191404 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [n:127.0.0.1:33317_    ] 
o.a.s.s.SolrDispatchFilter 
user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2
   [junit4]   2> 2191404 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [n:127.0.0.1:33317_    ] 
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
   [junit4]   2> 2191411 INFO  
(OverseerStateUpdate-95724606305140740-127.0.0.1:33317_-n_0000000000) 
[n:127.0.0.1:33317_    ] o.a.s.c.Overseer processMessage: queueSize: 1, message 
= {
   [junit4]   2>   "core":"collection1",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"http://127.0.0.1:33317";,
   [junit4]   2>   "node_name":"127.0.0.1:33317_",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":null,
   [junit4]   2>   "collection":"control_collection",
   [junit4]   2>   "operation":"state"} current state version: 0
   [junit4]   2> 2191417 INFO  
(OverseerStateUpdate-95724606305140740-127.0.0.1:33317_-n_0000000000) 
[n:127.0.0.1:33317_    ] o.a.s.c.o.ReplicaMutator Update state numShards=1 
message={
   [junit4]   2>   "core":"collection1",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"http://127.0.0.1:33317";,
   [junit4]   2>   "node_name":"127.0.0.1:33317_",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":null,
   [junit4]   2>   "collection":"control_collection",
   [junit4]   2>   "operation":"state"}
   [junit4]   2> 2191419 INFO  
(OverseerStateUpdate-95724606305140740-127.0.0.1:33317_-n_0000000000) 
[n:127.0.0.1:33317_    ] o.a.s.c.o.ClusterStateMutator building a new cName: 
control_collection
   [junit4]   2> 2191422 INFO  
(OverseerStateUpdate-95724606305140740-127.0.0.1:33317_-n_0000000000) 
[n:127.0.0.1:33317_    ] o.a.s.c.o.ReplicaMutator Assigning new node to shard 
shard=shard1
   [junit4]   2> 2191424 INFO  
(zkCallback-1947-thread-1-processing-n:127.0.0.1:33317_) [n:127.0.0.1:33317_    
] 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> 2192389 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ c:control_collection   x:collection1] o.a.s.c.ZkController 
waiting to find shard id in clusterstate for collection1
   [junit4]   2> 2192389 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ c:control_collection   x:collection1] o.a.s.c.ZkController 
Check for collection zkNode:control_collection
   [junit4]   2> 2192390 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ c:control_collection   x:collection1] o.a.s.c.ZkController 
Collection zkNode exists
   [junit4]   2> 2192390 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ c:control_collection   x:collection1] 
o.a.s.c.c.ZkStateReader Load collection config from: 
[/collections/control_collection]
   [junit4]   2> 2192390 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ c:control_collection   x:collection1] 
o.a.s.c.c.ZkStateReader path=[/collections/control_collection] 
[configName]=[conf1] specified config exists in ZooKeeper
   [junit4]   2> 2192390 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ c:control_collection   x:collection1] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_C6DB3996DDD59445-001/control-001/cores/collection1'
   [junit4]   2> 2192390 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ c:control_collection   x:collection1] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 2192390 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ c:control_collection   x:collection1] 
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find 
system property or JNDI)
   [junit4]   2> 2192391 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ c:control_collection   x:collection1] o.a.s.c.Config loaded 
config solrconfig.xml with version 0 
   [junit4]   2> 2192394 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ c:control_collection   x:collection1] o.a.s.c.SolrConfig 
current version of requestparams : -1
   [junit4]   2> 2192397 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ c:control_collection   x:collection1] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 6.1.0
   [junit4]   2> 2192404 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ c:control_collection   x:collection1] o.a.s.c.SolrConfig 
Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 2192408 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ c:control_collection   x:collection1] o.a.s.s.IndexSchema 
[collection1] Schema name=test
   [junit4]   2> 2192613 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ c:control_collection   x:collection1] 
o.a.s.s.OpenExchangeRatesOrgProvider Initialized with 
rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 2192617 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ c:control_collection   x:collection1] o.a.s.s.IndexSchema 
default search field in schema is text
   [junit4]   2> 2192618 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ c:control_collection   x:collection1] o.a.s.s.IndexSchema 
unique key field: id
   [junit4]   2> 2192623 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ c:control_collection   x:collection1] 
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 2192625 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ c:control_collection   x:collection1] 
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 2192626 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ c:control_collection   x:collection1] 
o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from 
open-exchange-rates.json
   [junit4]   2> 2192626 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ c:control_collection   x:collection1] 
o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from 
open-exchange-rates.json
   [junit4]   2> 2192627 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ c:control_collection   x:collection1] 
o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default 
properties: Can't find resource 'configsetprops.json' in classpath or 
'/configs/conf1', 
cwd=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2
   [junit4]   2> 2192627 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ c:control_collection   x:collection1] o.a.s.c.CoreContainer 
Creating SolrCore 'collection1' using configuration from collection 
control_collection
   [junit4]   2> 2192627 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 2192628 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_C6DB3996DDD59445-001/control-001/cores/collection1],
 
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_C6DB3996DDD59445-001/control-001/cores/collection1/data/]
   [junit4]   2> 2192628 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ 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@68b56580
   [junit4]   2> 2192628 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.CachingDirectoryFactory return new directory for 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_C6DB3996DDD59445-001/control-001/cores/collection1/data
   [junit4]   2> 2192628 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.SolrCore New index directory detected: old=null 
new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_C6DB3996DDD59445-001/control-001/cores/collection1/data/index/
   [junit4]   2> 2192628 WARN  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.SolrCore [collection1] Solr index directory 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_C6DB3996DDD59445-001/control-001/cores/collection1/data/index'
 doesn't exist. Creating new index...
   [junit4]   2> 2192628 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.CachingDirectoryFactory return new directory for 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_C6DB3996DDD59445-001/control-001/cores/collection1/data/index
   [junit4]   2> 2192629 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.MockRandomMergePolicy: 
org.apache.lucene.index.MockRandomMergePolicy@3277bb8c
   [junit4]   2> 2192629 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@69213e2a 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@445ca31),segFN=segments_1,generation=1}
   [junit4]   2> 2192629 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 2192631 INFO  
(OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:33317_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore 
Looking for old index directories to cleanup for core collection1 in 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_C6DB3996DDD59445-001/control-001/cores/collection1/data/
   [junit4]   2> 2192631 WARN  
(OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:33317_ 
c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.DirectoryFactory 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_C6DB3996DDD59445-001/control-001/cores/collection1/data/
 does not point to a valid data directory; skipping clean-up of old index 
directories.
   [junit4]   2> 2192635 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain 
"nodistrib"
   [junit4]   2> 2192635 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain 
"dedupe"
   [junit4]   2> 2192636 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.p.UpdateRequestProcessorChain inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 2192636 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain 
"stored_sig"
   [junit4]   2> 2192636 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.p.UpdateRequestProcessorChain inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 2192636 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ 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> 2192636 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ 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> 2192636 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ 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> 2192636 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ 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> 2192636 WARN  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ 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> 2192637 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 2192638 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 2192638 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 2192644 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 2192649 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.RequestHandlers Registered paths: 
/admin/mbeans,standard,/dump,/update/csv,/sql,/update/json/docs,/admin/luke,/export,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/stream,/schema,/admin/plugins,/admin/logging,/update/json,/admin/ping,/admin/threads,/update,/admin/file
   [junit4]   2> 2192649 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ 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> 2192650 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ 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> 2192650 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ 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> 2192650 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2192650 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2192651 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=32, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=0.392578125, noCFSRatio=1.0]
   [junit4]   2> 2192651 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@69213e2a 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@445ca31),segFN=segments_1,generation=1}
   [junit4]   2> 2192651 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 2192651 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@2ec8d268[collection1] main]
   [junit4]   2> 2192651 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ 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> 2192652 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ 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> 2192652 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ 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> 2192652 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf1
   [junit4]   2> 2192652 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.r.RestManager Initializing RestManager with initArgs: {}
   [junit4]   2> 2192652 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ 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> 2192652 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ 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> 2192653 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ 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> 2192653 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.r.RestManager Initializing 0 registered ManagedResources
   [junit4]   2> 2192653 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 2192653 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ 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> 2192653 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ 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> 2192653 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ 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> 2192653 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ 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 1531593702843088896
   [junit4]   2> 2192655 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ 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 
1531593702843088896
   [junit4]   2> 2192655 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.ZkController watch zkdir /configs/conf1
   [junit4]   2> 2192655 INFO  
(searcherExecutor-4698-thread-1-processing-n:127.0.0.1:33317_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:33317_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore 
[collection1] Registered new searcher Searcher@2ec8d268[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2192656 INFO  
(coreLoadExecutor-4697-thread-1-processing-n:127.0.0.1:33317_) 
[n:127.0.0.1:33317_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.CoreContainer registering core: collection1
   [junit4]   2> 2192657 INFO  
(coreZkRegister-4691-thread-1-processing-n:127.0.0.1:33317_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:33317_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController 
Register replica - core:collection1 address:http://127.0.0.1:33317 
collection:control_collection shard:shard1
   [junit4]   2> 2192657 INFO  
(coreZkRegister-4691-thread-1-processing-n:127.0.0.1:33317_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:33317_ 
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> 2192659 INFO  
(coreZkRegister-4691-thread-1-processing-n:127.0.0.1:33317_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:33317_ 
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/95724606305140740-core_node1-n_0000000000
   [junit4]   2> 2192659 INFO  
(coreZkRegister-4691-thread-1-processing-n:127.0.0.1:33317_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:33317_ 
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=10000
   [junit4]   2> 2192660 INFO  
(coreZkRegister-4691-thread-1-processing-n:127.0.0.1:33317_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:33317_ 
c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 2192660 INFO  
(coreZkRegister-4691-thread-1-processing-n:127.0.0.1:33317_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:33317_ 
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> 2192660 INFO  
(coreZkRegister-4691-thread-1-processing-n:127.0.0.1:33317_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:33317_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy 
Sync replicas to http://127.0.0.1:33317/collection1/
   [junit4]   2> 2192660 INFO  
(coreZkRegister-4691-thread-1-processing-n:127.0.0.1:33317_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:33317_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy 
Sync Success - now sync replicas to me
   [junit4]   2> 2192660 INFO  
(coreZkRegister-4691-thread-1-processing-n:127.0.0.1:33317_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:33317_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy 
http://127.0.0.1:33317/collection1/ has no replicas
   [junit4]   2> 2192661 INFO  
(coreZkRegister-4691-thread-1-processing-n:127.0.0.1:33317_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:33317_ 
c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/leaders/shard1
   [junit4]   2> 2192662 INFO  
(coreZkRegister-4691-thread-1-processing-n:127.0.0.1:33317_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:33317_ 
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/95724606305140740-core_node1-n_0000000000
   [junit4]   2> 2192668 INFO  
(coreZkRegister-4691-thread-1-processing-n:127.0.0.1:33317_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:33317_ 
c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:33317/collection1/ shard1
   [junit4]   2> 2192670 INFO  
(OverseerStateUpdate-95724606305140740-127.0.0.1:33317_-n_0000000000) 
[n:127.0.0.1:33317_    ] 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> 2192676 INFO  
(OverseerStateUpdate-95724606305140740-127.0.0.1:33317_-n_0000000000) 
[n:127.0.0.1:33317_    ] o.a.s.c.Overseer processMessage: queueSize: 1, message 
= {
   [junit4]   2>   "operation":"leader",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"control_collection",
   [junit4]   2>   "base_url":"http://127.0.0.1:33317";,
   [junit4]   2>   "core":"collection1",
   [junit4]   2>   "state":"active"} current state version: 1
   [junit4]   2> 2192779 INFO  
(zkCallback-1947-thread-1-processing-n:127.0.0.1:33317_) [n:127.0.0.1:33317_    
] 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> 2192821 INFO  
(coreZkRegister-4691-thread-1-processing-n:127.0.0.1:33317_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:33317_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController 
We are http://127.0.0.1:33317/collection1/ and leader is 
http://127.0.0.1:33317/collection1/
   [junit4]   2> 2192821 INFO  
(coreZkRegister-4691-thread-1-processing-n:127.0.0.1:33317_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:33317_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController 
No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:33317
   [junit4]   2> 2192821 INFO  
(coreZkRegister-4691-thread-1-processing-n:127.0.0.1:33317_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:33317_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController 
I am the leader, no recovery necessary
   [junit4]   2> 2192821 INFO  
(coreZkRegister-4691-thread-1-processing-n:127.0.0.1:33317_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:33317_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController 
publishing state=active
   [junit4]   2> 2192821 INFO  
(coreZkRegister-4691-thread-1-processing-n:127.0.0.1:33317_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:33317_ 
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> 2192822 INFO  
(OverseerStateUpdate-95724606305140740-127.0.0.1:33317_-n_0000000000) 
[n:127.0.0.1:33317_    ] o.a.s.c.Overseer processMessage: queueSize: 1, message 
= {
   [junit4]   2>   "core":"collection1",
   [junit4]   2>   "core_node_name":"core_node1",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"http://127.0.0.1:33317";,
   [junit4]   2>   "node_name":"127.0.0.1:33317_",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"control_collection",
   [junit4]   2>   "operation":"state"} current state version: 2
   [junit4]   2> 2192822 INFO  
(OverseerStateUpdate-95724606305140740-127.0.0.1:33317_-n_0000000000) 
[n:127.0.0.1:33317_    ] o.a.s.c.o.ReplicaMutator Update state numShards=1 
message={
   [junit4]   2>   "core":"collection1",
   [junit4]   2>   "core_node_name":"core_node1",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"http://127.0.0.1:33317";,
   [junit4]   2>   "node_name":"127.0.0.1:33317_",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"control_collection",
   [junit4]   2>   "operation":"state"}
   [junit4]   2> 2192908 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 2192919 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2192920 INFO  (zkCallback-1949-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@6380e913 
name:ZooKeeperConnection Watcher:127.0.0.1:54070/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2192920 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2192921 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 2192921 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 2192921 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 2192922 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] o.a.s.c.ChaosMonkey 
monkey: init - expire sessions:false cause connection loss:false
   [junit4]   2> 2192922 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.AbstractFullDistribZkTestBase Creating collection1 with stateFormat=2
   [junit4]   2> 2192922 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 2192923 INFO  
(zkCallback-1947-thread-1-processing-n:127.0.0.1:33317_) [n:127.0.0.1:33317_    
] 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> 2192927 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2192935 INFO  (zkCallback-1950-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@64a082ab 
name:ZooKeeperConnection Watcher:127.0.0.1:54070/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2192935 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2192935 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 2192935 INFO  (zkCallback-1949-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> 2192951 INFO  
(OverseerStateUpdate-95724606305140740-127.0.0.1:33317_-n_0000000000) 
[n:127.0.0.1:33317_    ] o.a.s.c.Overseer processMessage: queueSize: 1, message 
= {
   [junit4]   2>   "operation":"create",
   [junit4]   2>   "name":"collection1",
   [junit4]   2>   "numShards":"2",
   [junit4]   2>   "stateFormat":"2"} current state version: 3
   [junit4]   2> 2192951 INFO  
(OverseerStateUpdate-95724606305140740-127.0.0.1:33317_-n_0000000000) 
[n:127.0.0.1:33317_    ] o.a.s.c.o.ClusterStateMutator building a new cName: 
collection1
   [junit4]   2> 2193066 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_C6DB3996DDD59445-001/shard-1-001/cores/collection1
   [junit4]   2> 2193066 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_C6DB3996DDD59445-001/shard-1-001
   [junit4]   2> 2193067 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] o.e.j.s.Server 
jetty-9.3.8.v20160314
   [junit4]   2> 2193068 INFO  
(OverseerStateUpdate-95724606305140740-127.0.0.1:33317_-n_0000000000) 
[n:127.0.0.1:33317_    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/collection1/state.json
   [junit4]   2> 2193068 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@226f491d{/,null,AVAILABLE}
   [junit4]   2> 2193068 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.e.j.s.ServerConnector Started 
ServerConnector@60a37698{HTTP/1.1,[http/1.1]}{127.0.0.1:49587}
   [junit4]   2> 2193068 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] o.e.j.s.Server 
Started @2198516ms
   [junit4]   2> 2193069 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_C6DB3996DDD59445-001/tempDir-001/jetty1,
 solrconfig=solrconfig.xml, hostContext=/, hostPort=49587, 
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_C6DB3996DDD59445-001/shard-1-001/cores}
   [junit4]   2> 2193069 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): 
sun.misc.Launcher$AppClassLoader@73d16e93
   [junit4]   2> 2193069 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_C6DB3996DDD59445-001/shard-1-001'
   [junit4]   2> 2193069 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 2193069 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find 
system property or JNDI)
   [junit4]   2> 2193069 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 2193070 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2193071 INFO  (zkCallback-1951-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@54238b69 
name:ZooKeeperConnection Watcher:127.0.0.1:54070/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2193071 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2193071 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 2193072 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in 
ZooKeeper)
   [junit4]   2> 2193072 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_C6DB3996DDD59445-001/shard-1-001/solr.xml
   [junit4]   2> 2193086 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.CorePropertiesLocator Config-defined core root directory: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_C6DB3996DDD59445-001/shard-1-001/cores
   [junit4]   2> 2193086 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.CoreContainer New CoreContainer 1584516323
   [junit4]   2> 2193086 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.CoreContainer Loading cores into CoreContainer 
[instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_C6DB3996DDD59445-001/shard-1-001]
   [junit4]   2> 2193086 WARN  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.CoreContainer Couldn't add files from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_C6DB3996DDD59445-001/shard-1-001/lib
 to classpath: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_C6DB3996DDD59445-001/shard-1-001/lib
   [junit4]   2> 2193087 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
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> 2193089 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 2193089 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] o.a.s.l.LogWatcher 
SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 2193089 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] o.a.s.l.LogWatcher 
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 2193089 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] o.a.s.c.ZkContainer 
Zookeeper client=127.0.0.1:54070/solr
   [junit4]   2> 2193090 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.ZkController zkHost includes chroot
   [junit4]   2> 2193090 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 2193090 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2193091 INFO  (zkCallback-1954-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@47ff0db3 
name:ZooKeeperConnection Watcher:127.0.0.1:54070 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2193091 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2193091 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 2193094 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [n:127.0.0.1:49587_    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2193095 INFO  
(zkCallback-1955-thread-1-processing-n:127.0.0.1:49587_) [n:127.0.0.1:49587_    
] o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@369f5279 
name:ZooKeeperConnection Watcher:127.0.0.1:54070/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2193095 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [n:127.0.0.1:49587_    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2193098 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [n:127.0.0.1:49587_    ] 
o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 2193099 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [n:127.0.0.1:49587_    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 2193100 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [n:127.0.0.1:49587_    ] 
o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 2193101 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [n:127.0.0.1:49587_    ] 
o.a.s.c.LeaderElector Joined leadership election with path: 
/overseer_elect/election/95724606305140745-127.0.0.1:49587_-n_0000000001
   [junit4]   2> 2193101 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [n:127.0.0.1:49587_    ] 
o.a.s.c.LeaderElector Watching path 
/overseer_elect/election/95724606305140740-127.0.0.1:33317_-n_0000000000 to 
know if I could be the leader
   [junit4]   2> 2193101 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [n:127.0.0.1:49587_    ] 
o.a.s.c.ZkController Publish node=127.0.0.1:49587_ as DOWN
   [junit4]   2> 2193102 INFO  
(OverseerStateUpdate-95724606305140740-127.0.0.1:33317_-n_0000000000) 
[n:127.0.0.1:33317_    ] o.a.s.c.Overseer processMessage: queueSize: 1, message 
= {
   [junit4]   2>   "operation":"downnode",
   [junit4]   2>   "node_name":"127.0.0.1:49587_"} current state version: 3
   [junit4]   2> 2193102 INFO  
(OverseerStateUpdate-95724606305140740-127.0.0.1:33317_-n_0000000000) 
[n:127.0.0.1:33317_    ] o.a.s.c.o.NodeMutator DownNode state invoked for node: 
127.0.0.1:49587_
   [junit4]   2> 2193103 INFO  
(OverseerStateUpdate-95724606305140740-127.0.0.1:33317_-n_0000000000) 
[n:127.0.0.1:33317_    ] o.a.s.c.o.ZkStateWriter going to update_collection 
/collections/collection1/state.json version: 0
   [junit4]   2> 2193208 INFO  
(zkCallback-1947-thread-1-processing-n:127.0.0.1:33317_) [n:127.0.0.1:33317_    
] 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> 2193209 INFO  (zkCallback-1949-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> 2193211 INFO  
(zkCallback-1955-thread-1-processing-n:127.0.0.1:49587_) [n:127.0.0.1:49587_    
] 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> 2194105 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [n:127.0.0.1:49587_    ] 
o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:49587_
   [junit4]   2> 2194115 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [n:127.0.0.1:49587_    ] 
o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:49587_
   [junit4]   2> 2194139 INFO  
(zkCallback-1947-thread-1-processing-n:127.0.0.1:33317_) [n:127.0.0.1:33317_    
] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live 
nodes size: [1])
   [junit4]   2> 2194139 INFO  (zkCallback-1949-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live 
nodes size: [1])
   [junit4]   2> 2194139 INFO  
(zkCallback-1955-thread-1-processing-n:127.0.0.1:49587_) [n:127.0.0.1:49587_    
] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live 
nodes size: [1])
   [junit4]   2> 2194147 INFO  
(zkCallback-1947-thread-1-processing-n:127.0.0.1:33317_) [n:127.0.0.1:33317_    
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 2194149 INFO  (zkCallback-1949-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 2194159 INFO  
(zkCallback-1955-thread-1-processing-n:127.0.0.1:49587_) [n:127.0.0.1:49587_    
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 2194160 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [n:127.0.0.1:49587_    ] 
o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for 
authorization module.
   [junit4]   2> 2194160 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [n:127.0.0.1:49587_    ] 
o.a.s.c.CoreContainer No authentication plugin used.
   [junit4]   2> 2194161 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [n:127.0.0.1:49587_    ] 
o.a.s.c.CorePropertiesLocator Looking for core definitions underneath 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_C6DB3996DDD59445-001/shard-1-001/cores
   [junit4]   2> 2194162 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [n:127.0.0.1:49587_    ] 
o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection1, 
config=solrconfig.xml, transient=false, schema=schema.xml, loadOnStartup=true, 
configSetProperties=configsetprops.json, collection=collection1, coreNodeName=, 
dataDir=data/, shard=}
   [junit4]   2> 2194162 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [n:127.0.0.1:49587_    ] 
o.a.s.c.CorePropertiesLocator Found core collection1 in 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_C6DB3996DDD59445-001/shard-1-001/cores/collection1
   [junit4]   2> 2194162 INFO  
(TEST-TestReqParamsAPI.test-seed#[C6DB3996DDD59445]) [n:127.0.0.1:49587_    ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions
   [junit4]   2> 2194184 INFO  
(coreLoadExecutor-4708-thread-1-processing-n:127.0.0.1:49587_) 
[n:127.0.0.1:49587_ c:collection1   x:collection1] o.a.s.c.ZkController 
publishing state=down
   [junit4]   2> 2194184 INFO  
(coreLoadExecutor-4708-thread-1-processing-n:127.0.0.1:49587_) 
[n:127.0.0.1:49587_ c:collection1   x:collection1] o.a.s.c.ZkController 
numShards not found on descriptor - reading it from system property
   [junit4]   2> 2194185 INFO  
(coreLoadExecutor-4708-thread-1-processing-n:127.0.0.1:49587_) 
[n:127.0.0.1:49587_ c:collection1   x:collection1] o.a.s.c.ZkController 
Registering watch for collection collection1
   [junit4]   2> 2194185 INFO  
(coreLoadExecutor-4708-thread-1-processing-n:127.0.0.1:49587_) 
[n:127.0.0.1:49587_ c:collection1   x:collection1] o.a.s.c.c.ZkStateReader 
addZkWatch [collection1]
   [junit4]   2> 2194185 INFO  
(coreLoadExecutor-4708-thread-1-processing-n:127.0.0.1:49587_) 
[n:127.0.0.1:49587_ c:collection1   x:collection1] o.a.s.c.c.ZkStateReader Add 
data for [collection1] ver [1]
   [junit4]   2> 2194185 INFO  
(coreLoadExecutor-4708-thread-1-processing-n:127.0.0.1:49587_) [n:127.0.0.

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

72)
   [junit4]   2>        at 
org.apache.hadoop.metrics2.lib.DefaultMetricsSystem.shutdown(DefaultMetricsSystem.java:68)
   [junit4]   2>        at 
org.apache.hadoop.hdfs.server.namenode.metrics.NameNodeMetrics.shutdown(NameNodeMetrics.java:145)
   [junit4]   2>        at 
org.apache.hadoop.hdfs.server.namenode.NameNode.stop(NameNode.java:822)
   [junit4]   2>        at 
org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:1720)
   [junit4]   2>        at 
org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:1699)
   [junit4]   2>        at 
org.apache.solr.cloud.hdfs.HdfsTestUtil.teardownClass(HdfsTestUtil.java:198)
   [junit4]   2>        at 
org.apache.solr.cloud.SharedFSAutoReplicaFailoverTest.hdfsFailoverAfterClass(SharedFSAutoReplicaFailoverTest.java:82)
   [junit4]   2>        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native 
Method)
   [junit4]   2>        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
   [junit4]   2>        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   [junit4]   2>        at java.lang.reflect.Method.invoke(Method.java:498)
   [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> 5530464 INFO  
(SUITE-SharedFSAutoReplicaFailoverTest-seed#[C6DB3996DDD59445]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.SharedFSAutoReplicaFailoverTest_C6DB3996DDD59445-001
   [junit4]   2> Apr 14, 2016 2:41:55 PM 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 2 leaked 
thread(s).
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene60), 
sim=ClassicSimilarity, locale=ar-LB, timezone=Antarctica/Macquarie
   [junit4]   2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation 
1.8.0_74 (64-bit)/cpus=4,threads=1,free=130663280,total=504889344
   [junit4]   2> NOTE: All tests run in this JVM: [DocValuesMultiTest, 
TestIndexSearcher, ReplicationFactorTest, CollectionStateFormat2Test, 
TestCollapseQParserPlugin, TestCloudDeleteByQuery, SimpleMLTQParserTest, 
XmlUpdateRequestHandlerTest, SuggesterTSTTest, 
VMParamsZkACLAndCredentialsProvidersTest, TestNoOpRegenerator, 
TestPHPSerializedResponseWriter, HdfsChaosMonkeyNothingIsSafeTest, TestReload, 
BadIndexSchemaTest, TestBlobHandler, HdfsTlogReplayBufferedWhileIndexingTest, 
OverseerCollectionConfigSetProcessorTest, TestConfigSets, NoCacheHeaderTest, 
OverseerTaskQueueTest, TestSolrConfigHandlerCloud, 
BinaryUpdateRequestHandlerTest, TestSuggestSpellingConverter, 
ConnectionManagerTest, FullSolrCloudDistribCmdsTest, CircularListTest, 
TestSimpleQParserPlugin, BaseCdcrDistributedZkTest, CleanupOldIndexTest, 
TestExtendedDismaxParser, SolrCoreCheckLockOnStartupTest, TestWriterPerf, 
DebugComponentTest, SimpleFacetsTest, UUIDUpdateProcessorFallbackTest, 
TestSolrCloudWithKerberosAlt, BigEndianAscendingWordDeserializerTest, 
FieldAnalysisRequestHandlerTest, TestInitQParser, TestTrieFacet, 
TestManagedResourceStorage, DistributedFacetPivotSmallAdvancedTest, 
TestExactSharedStatsCache, TestSolrFieldCacheMBean, ForceLeaderTest, 
LeaderInitiatedRecoveryOnCommitTest, SolrTestCaseJ4Test, CoreAdminHandlerTest, 
PreAnalyzedUpdateProcessorTest, CursorMarkTest, TestManagedSchema, 
ExitableDirectoryReaderTest, TestSolrJ, TestFuzzyAnalyzedSuggestions, 
BasicAuthIntegrationTest, SSLMigrationTest, TestMacros, TestRTimerTree, 
TestCoreDiscovery, ZkStateWriterTest, SolrCloudExampleTest, RulesTest, 
TestLeaderInitiatedRecoveryThread, TestRecoveryHdfs, FacetPivotSmallTest, 
TestCSVResponseWriter, TestScoreJoinQPScore, 
TestTolerantUpdateProcessorRandomCloud, TestFastWriter, AssignTest, 
TestSweetSpotSimilarityFactory, TestTolerantSearch, CoreAdminRequestStatusTest, 
DataDrivenBlockJoinTest, TestSchemaVersionResource, BlockJoinFacetSimpleTest, 
HighlighterConfigTest, ScriptEngineTest, ExplicitHLLTest, 
PrimitiveFieldTypeTest, TestConfigSetsAPIZkFailure, AtomicUpdatesTest, 
TestHighFrequencyDictionaryFactory, CurrencyFieldXmlFileTest, TestSearchPerf, 
TestStressReorder, StressHdfsTest, TestSolrDynamicMBean, TestReqParamsAPI, 
BJQParserTest, TestManagedSynonymFilterFactory, 
DocExpirationUpdateProcessorFactoryTest, DistribJoinFromCollectionTest, 
TestFieldSortValues, TestCollectionAPI, BasicDistributedZkTest, 
ChaosMonkeySafeLeaderTest, BasicDistributedZk2Test, UnloadDistributedZkTest, 
CollectionsAPIDistributedZkTest, OpenCloseCoreStressTest, OverseerTest, 
BasicZkTest, RecoveryZkTest, TestRandomFaceting, AutoCommitTest, 
TestDistributedGrouping, TestRealTimeGet, HardAutoCommitTest, 
DistributedTermsComponentTest, StatsComponentTest, SolrCmdDistributorTest, 
QueryElevationComponentTest, TestSort, ShowFileRequestHandlerTest, 
SolrIndexSplitterTest, SpellCheckCollatorTest, TestFoldingMultitermQuery, 
SuggesterTest, SpatialFilterTest, PolyFieldTest, WordBreakSolrSpellCheckerTest, 
TestPseudoReturnFields, TestWordDelimiterFilterFactory, 
DirectUpdateHandlerOptimizeTest, StatelessScriptUpdateProcessorFactoryTest, 
TestSurroundQueryParser, TestQueryUtils, DirectSolrSpellCheckerTest, 
TestReversedWildcardFilterFactory, TestQueryTypes, TermsComponentTest, 
TestValueSourceCache, TermVectorComponentTest, RequiredFieldsTest, 
FastVectorHighlighterTest, RegexBoostProcessorTest, TestJmxIntegration, 
ReturnFieldsTest, QueryParsingTest, UniqFieldsUpdateProcessorFactoryTest, 
PingRequestHandlerTest, SOLR749Test, TestQuerySenderListener, UpdateParamsTest, 
AlternateDirectoryTest, TestSolrIndexConfig, ResponseLogComponentTest, 
SolrIndexConfigTest, BadComponentTest, TestStressRecovery, 
TestCursorMarkWithoutUniqueKey, TestDistributedMissingSort, 
ConnectionReuseTest, CdcrReplicationHandlerTest, CustomCollectionTest, 
DistributedVersionInfoTest, LeaderFailoverAfterPartitionTest, 
MultiThreadedOCPTest, SaslZkACLProviderTest, SharedFSAutoReplicaFailoverTest]
   [junit4] Completed [440/586 (3!)] on J2 in 176.76s, 1 test, 1 failure <<< 
FAILURES!

[...truncated 469 lines...]
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/build.xml:747: 
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/build.xml:684: 
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/build.xml:59: 
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build.xml:233:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/common-build.xml:529:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/lucene/common-build.xml:1457:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/lucene/common-build.xml:1014:
 There were test failures: 586 suites (10 ignored), 2364 tests, 3 failures, 31 
ignored (16 assumptions) [seed: C6DB3996DDD59445]

Total time: 312 minutes 49 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