Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Linux/970/
Java: 32bit/jdk1.8.0_144 -server -XX:+UseG1GC

2 tests failed.
FAILED:  org.apache.solr.cloud.ShardSplitTest.test

Error Message:
Timeout occured while waiting response from server at: 
http://127.0.0.1:35779/y_/ze

Stack Trace:
org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting 
response from server at: http://127.0.0.1:35779/y_/ze
        at 
__randomizedtesting.SeedInfo.seed([1BADD93D903B8A13:93F9E6E73EC7E7EB]:0)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:654)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:255)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:244)
        at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219)
        at 
org.apache.solr.cloud.ShardSplitTest.splitShard(ShardSplitTest.java:928)
        at 
org.apache.solr.cloud.ShardSplitTest.splitByRouteFieldTest(ShardSplitTest.java:715)
        at org.apache.solr.cloud.ShardSplitTest.test(ShardSplitTest.java:101)
        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:1737)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:993)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:968)
        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:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
        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:368)
        at java.lang.Thread.run(Thread.java:748)
Caused by: java.net.SocketTimeoutException: Read timed out
        at java.net.SocketInputStream.socketRead0(Native Method)
        at java.net.SocketInputStream.socketRead(SocketInputStream.java:116)
        at java.net.SocketInputStream.read(SocketInputStream.java:171)
        at java.net.SocketInputStream.read(SocketInputStream.java:141)
        at 
org.apache.http.impl.io.SessionInputBufferImpl.streamRead(SessionInputBufferImpl.java:137)
        at 
org.apache.http.impl.io.SessionInputBufferImpl.fillBuffer(SessionInputBufferImpl.java:153)
        at 
org.apache.http.impl.io.SessionInputBufferImpl.readLine(SessionInputBufferImpl.java:282)
        at 
org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:138)
        at 
org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:56)
        at 
org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:259)
        at 
org.apache.http.impl.DefaultBHttpClientConnection.receiveResponseHeader(DefaultBHttpClientConnection.java:163)
        at 
org.apache.http.impl.conn.CPoolProxy.receiveResponseHeader(CPoolProxy.java:165)
        at 
org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:273)
        at 
org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:125)
        at 
org.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:272)
        at 
org.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:185)
        at org.apache.http.impl.execchain.RetryExec.execute(RetryExec.java:89)
        at 
org.apache.http.impl.execchain.RedirectExec.execute(RedirectExec.java:111)
        at 
org.apache.http.impl.client.InternalHttpClient.doExecute(InternalHttpClient.java:185)
        at 
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:83)
        at 
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:56)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:542)
        ... 47 more


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

Error Message:
Error from server at http://127.0.0.1:39201/m/vy: Could not fully create 
collection: collection1

Stack Trace:
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error 
from server at http://127.0.0.1:39201/m/vy: Could not fully create collection: 
collection1
        at 
__randomizedtesting.SeedInfo.seed([1BADD93D903B8A13:93F9E6E73EC7E7EB]:0)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:643)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:255)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:244)
        at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:483)
        at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:413)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1103)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:883)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:816)
        at 
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:194)
        at 
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:211)
        at 
org.apache.solr.cloud.AbstractFullDistribZkTestBase.createJettys(AbstractFullDistribZkTestBase.java:384)
        at 
org.apache.solr.cloud.AbstractFullDistribZkTestBase.createServers(AbstractFullDistribZkTestBase.java:333)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:991)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:968)
        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:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
        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:368)
        at java.lang.Thread.run(Thread.java:748)




Build Log:
[...truncated 11812 lines...]
   [junit4] Suite: org.apache.solr.cloud.TestRequestStatusCollectionAPI
   [junit4]   2> Creating dataDir: 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestRequestStatusCollectionAPI_1BADD93D903B8A13-001/init-core-data-001
   [junit4]   2> 267376 WARN  
(SUITE-TestRequestStatusCollectionAPI-seed#[1BADD93D903B8A13]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=41 numCloses=41
   [junit4]   2> 267376 INFO  
(SUITE-TestRequestStatusCollectionAPI-seed#[1BADD93D903B8A13]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) 
w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 267378 INFO  
(SUITE-TestRequestStatusCollectionAPI-seed#[1BADD93D903B8A13]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: 
@org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl=https://issues.apache.org/jira/browse/SOLR-5776)
   [junit4]   2> 267378 INFO  
(SUITE-TestRequestStatusCollectionAPI-seed#[1BADD93D903B8A13]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 267378 INFO  
(SUITE-TestRequestStatusCollectionAPI-seed#[1BADD93D903B8A13]-worker) [    ] 
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /m/vy
   [junit4]   2> 267386 INFO  
(TEST-TestRequestStatusCollectionAPI.test-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 267387 INFO  (Thread-449) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 267387 INFO  (Thread-449) [    ] o.a.s.c.ZkTestServer Starting 
server
   [junit4]   2> 267391 ERROR (Thread-449) [    ] o.a.z.s.ZooKeeperServer 
ZKShutdownHandler is not registered, so ZooKeeper server won't take any action 
on ERROR or SHUTDOWN server state changes
   [junit4]   2> 267487 INFO  
(TEST-TestRequestStatusCollectionAPI.test-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.ZkTestServer start zk server on port:33383
   [junit4]   2> 267488 INFO  (zkConnectionManagerCallback-488-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 267489 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn caught end of stream exception
   [junit4]   2> EndOfStreamException: Unable to read additional data from 
client sessionid 0x16041e378820000, likely client has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> 267493 INFO  (zkConnectionManagerCallback-490-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 267495 INFO  
(TEST-TestRequestStatusCollectionAPI.test-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
 to /configs/conf1/solrconfig.xml
   [junit4]   2> 267496 INFO  
(TEST-TestRequestStatusCollectionAPI.test-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/conf/schema15.xml
 to /configs/conf1/schema.xml
   [junit4]   2> 267497 INFO  
(TEST-TestRequestStatusCollectionAPI.test-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
 to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 267497 INFO  
(TEST-TestRequestStatusCollectionAPI.test-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
 to /configs/conf1/stopwords.txt
   [junit4]   2> 267498 INFO  
(TEST-TestRequestStatusCollectionAPI.test-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/conf/protwords.txt
 to /configs/conf1/protwords.txt
   [junit4]   2> 267498 INFO  
(TEST-TestRequestStatusCollectionAPI.test-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/conf/currency.xml
 to /configs/conf1/currency.xml
   [junit4]   2> 267499 INFO  
(TEST-TestRequestStatusCollectionAPI.test-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
 to /configs/conf1/enumsConfig.xml
   [junit4]   2> 267499 INFO  
(TEST-TestRequestStatusCollectionAPI.test-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
 to /configs/conf1/open-exchange-rates.json
   [junit4]   2> 267499 INFO  
(TEST-TestRequestStatusCollectionAPI.test-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
 to /configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 267500 INFO  
(TEST-TestRequestStatusCollectionAPI.test-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
 to /configs/conf1/old_synonyms.txt
   [junit4]   2> 267500 INFO  
(TEST-TestRequestStatusCollectionAPI.test-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
 to /configs/conf1/synonyms.txt
   [junit4]   2> 267501 INFO  
(TEST-TestRequestStatusCollectionAPI.test-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.AbstractFullDistribZkTestBase Will use NRT replicas unless explicitly 
asked otherwise
   [junit4]   2> 267574 INFO  
(TEST-TestRequestStatusCollectionAPI.test-seed#[1BADD93D903B8A13]) [    ] 
o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 267575 INFO  
(TEST-TestRequestStatusCollectionAPI.test-seed#[1BADD93D903B8A13]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@14fa88b{/m/vy,null,AVAILABLE}
   [junit4]   2> 267578 INFO  
(TEST-TestRequestStatusCollectionAPI.test-seed#[1BADD93D903B8A13]) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@6c3019{HTTP/1.1,[http/1.1]}{127.0.0.1:39201}
   [junit4]   2> 267578 INFO  
(TEST-TestRequestStatusCollectionAPI.test-seed#[1BADD93D903B8A13]) [    ] 
o.e.j.s.Server Started @270007ms
   [junit4]   2> 267578 INFO  
(TEST-TestRequestStatusCollectionAPI.test-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestRequestStatusCollectionAPI_1BADD93D903B8A13-001/tempDir-001/control/data,
 replicaType=NRT, hostContext=/m/vy, hostPort=39201, 
coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestRequestStatusCollectionAPI_1BADD93D903B8A13-001/control-001/cores}
   [junit4]   2> 267579 ERROR 
(TEST-TestRequestStatusCollectionAPI.test-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 267579 INFO  
(TEST-TestRequestStatusCollectionAPI.test-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
7.3.0
   [junit4]   2> 267579 INFO  
(TEST-TestRequestStatusCollectionAPI.test-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 267579 INFO  
(TEST-TestRequestStatusCollectionAPI.test-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 267579 INFO  
(TEST-TestRequestStatusCollectionAPI.test-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-12-10T19:25:14.945Z
   [junit4]   2> 267582 INFO  (zkConnectionManagerCallback-492-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 267583 INFO  
(TEST-TestRequestStatusCollectionAPI.test-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in 
ZooKeeper)
   [junit4]   2> 267583 INFO  
(TEST-TestRequestStatusCollectionAPI.test-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestRequestStatusCollectionAPI_1BADD93D903B8A13-001/control-001/solr.xml
   [junit4]   2> 267587 INFO  
(TEST-TestRequestStatusCollectionAPI.test-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay 
is ignored
   [junit4]   2> 267587 INFO  
(TEST-TestRequestStatusCollectionAPI.test-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 267588 INFO  
(TEST-TestRequestStatusCollectionAPI.test-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@d72084, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 267591 INFO  
(TEST-TestRequestStatusCollectionAPI.test-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:33383/solr
   [junit4]   2> 267598 INFO  (zkConnectionManagerCallback-496-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 267600 INFO  
(zkConnectionManagerCallback-498-thread-1-processing-n:127.0.0.1:39201_m%2Fvy) 
[n:127.0.0.1:39201_m%2Fvy    ] o.a.s.c.c.ConnectionManager zkClient has 
connected
   [junit4]   2> 267652 INFO  
(TEST-TestRequestStatusCollectionAPI.test-seed#[1BADD93D903B8A13]) 
[n:127.0.0.1:39201_m%2Fvy    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 267652 INFO  
(TEST-TestRequestStatusCollectionAPI.test-seed#[1BADD93D903B8A13]) 
[n:127.0.0.1:39201_m%2Fvy    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:39201_m%2Fvy
   [junit4]   2> 267652 INFO  
(TEST-TestRequestStatusCollectionAPI.test-seed#[1BADD93D903B8A13]) 
[n:127.0.0.1:39201_m%2Fvy    ] o.a.s.c.Overseer Overseer 
(id=99151637037318148-127.0.0.1:39201_m%2Fvy-n_0000000000) starting
   [junit4]   2> 267667 INFO  
(TEST-TestRequestStatusCollectionAPI.test-seed#[1BADD93D903B8A13]) 
[n:127.0.0.1:39201_m%2Fvy    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:39201_m%2Fvy
   [junit4]   2> 267670 INFO  
(zkCallback-497-thread-1-processing-n:127.0.0.1:39201_m%2Fvy) 
[n:127.0.0.1:39201_m%2Fvy    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 267765 INFO  
(TEST-TestRequestStatusCollectionAPI.test-seed#[1BADD93D903B8A13]) 
[n:127.0.0.1:39201_m%2Fvy    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@d72084
   [junit4]   2> 267775 INFO  
(TEST-TestRequestStatusCollectionAPI.test-seed#[1BADD93D903B8A13]) 
[n:127.0.0.1:39201_m%2Fvy    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@d72084
   [junit4]   2> 267775 INFO  
(TEST-TestRequestStatusCollectionAPI.test-seed#[1BADD93D903B8A13]) 
[n:127.0.0.1:39201_m%2Fvy    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@d72084
   [junit4]   2> 267777 INFO  
(TEST-TestRequestStatusCollectionAPI.test-seed#[1BADD93D903B8A13]) 
[n:127.0.0.1:39201_m%2Fvy    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestRequestStatusCollectionAPI_1BADD93D903B8A13-001/control-001/cores
   [junit4]   2> 267798 INFO  (zkConnectionManagerCallback-504-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 267799 INFO  
(TEST-TestRequestStatusCollectionAPI.test-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 267800 INFO  
(TEST-TestRequestStatusCollectionAPI.test-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:33383/solr ready
   [junit4]   2> 267802 INFO  (qtp29958158-1954) [n:127.0.0.1:39201_m%2Fvy    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
replicationFactor=1&collection.configName=conf1&name=control_collection&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=127.0.0.1:39201_m%252Fvy&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 267803 INFO  
(OverseerThreadFactory-702-thread-1-processing-n:127.0.0.1:39201_m%2Fvy) 
[n:127.0.0.1:39201_m%2Fvy    ] o.a.s.c.CreateCollectionCmd Create collection 
control_collection
   [junit4]   2> 267907 INFO  (qtp29958158-1956) [n:127.0.0.1:39201_m%2Fvy    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=conf1&newCollection=true&name=control_collection_shard1_replica_n1&action=CREATE&numShards=1&collection=control_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 267908 INFO  (qtp29958158-1956) [n:127.0.0.1:39201_m%2Fvy    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 268011 INFO  
(zkCallback-497-thread-1-processing-n:127.0.0.1:39201_m%2Fvy) 
[n:127.0.0.1:39201_m%2Fvy    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/control_collection/state.json] for collection 
[control_collection] has occurred - updating... (live nodes size: [1])
   [junit4]   2> 268933 INFO  (qtp29958158-1956) [n:127.0.0.1:39201_m%2Fvy 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.3.0
   [junit4]   2> 268948 INFO  (qtp29958158-1956) [n:127.0.0.1:39201_m%2Fvy 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.s.IndexSchema [control_collection_shard1_replica_n1] Schema name=test
   [junit4]   2> 269029 INFO  (qtp29958158-1956) [n:127.0.0.1:39201_m%2Fvy 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 269057 INFO  (qtp29958158-1956) [n:127.0.0.1:39201_m%2Fvy 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.c.CoreContainer Creating SolrCore 'control_collection_shard1_replica_n1' 
using configuration from collection control_collection, trusted=true
   [junit4]   2> 269058 INFO  (qtp29958158-1956) [n:127.0.0.1:39201_m%2Fvy 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.core.control_collection.shard1.replica_n1' (registry 
'solr.core.control_collection.shard1.replica_n1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@d72084
   [junit4]   2> 269058 INFO  (qtp29958158-1956) [n:127.0.0.1:39201_m%2Fvy 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 269058 INFO  (qtp29958158-1956) [n:127.0.0.1:39201_m%2Fvy 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.c.SolrCore [[control_collection_shard1_replica_n1] ] Opening new SolrCore 
at 
[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestRequestStatusCollectionAPI_1BADD93D903B8A13-001/control-001/cores/control_collection_shard1_replica_n1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestRequestStatusCollectionAPI_1BADD93D903B8A13-001/control-001/cores/control_collection_shard1_replica_n1/data/]
   [junit4]   2> 269071 INFO  (qtp29958158-1956) [n:127.0.0.1:39201_m%2Fvy 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=26, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.22992821420798526]
   [junit4]   2> 269080 WARN  (qtp29958158-1956) [n:127.0.0.1:39201_m%2Fvy 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = 
requestHandler,name = /dump,class = DumpRequestHandler,attributes = 
{initParams=a, name=/dump, class=DumpRequestHandler},args = 
{defaults={a=A,b=B}}}
   [junit4]   2> 269122 INFO  (qtp29958158-1956) [n:127.0.0.1:39201_m%2Fvy 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 269123 INFO  (qtp29958158-1956) [n:127.0.0.1:39201_m%2Fvy 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 269123 INFO  (qtp29958158-1956) [n:127.0.0.1:39201_m%2Fvy 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 269124 INFO  (qtp29958158-1956) [n:127.0.0.1:39201_m%2Fvy 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 269125 INFO  (qtp29958158-1956) [n:127.0.0.1:39201_m%2Fvy 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=12, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=1.0]
   [junit4]   2> 269125 INFO  (qtp29958158-1956) [n:127.0.0.1:39201_m%2Fvy 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@1cd712[control_collection_shard1_replica_n1] main]
   [junit4]   2> 269126 INFO  (qtp29958158-1956) [n:127.0.0.1:39201_m%2Fvy 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf1
   [junit4]   2> 269126 INFO  (qtp29958158-1956) [n:127.0.0.1:39201_m%2Fvy 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 269126 INFO  (qtp29958158-1956) [n:127.0.0.1:39201_m%2Fvy 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 269127 INFO  (qtp29958158-1956) [n:127.0.0.1:39201_m%2Fvy 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1586426194420563968
   [junit4]   2> 269128 INFO  
(searcherExecutor-705-thread-1-processing-n:127.0.0.1:39201_m%2Fvy 
x:control_collection_shard1_replica_n1 s:shard1 c:control_collection) 
[n:127.0.0.1:39201_m%2Fvy c:control_collection s:shard1  
x:control_collection_shard1_replica_n1] o.a.s.c.SolrCore 
[control_collection_shard1_replica_n1] Registered new searcher 
Searcher@1cd712[control_collection_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 269130 INFO  (qtp29958158-1956) [n:127.0.0.1:39201_m%2Fvy 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 269130 INFO  (qtp29958158-1956) [n:127.0.0.1:39201_m%2Fvy 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 269130 INFO  (qtp29958158-1956) [n:127.0.0.1:39201_m%2Fvy 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.c.SyncStrategy Sync replicas to 
http://127.0.0.1:39201/m/vy/control_collection_shard1_replica_n1/
   [junit4]   2> 269130 INFO  (qtp29958158-1956) [n:127.0.0.1:39201_m%2Fvy 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
   [junit4]   2> 269130 INFO  (qtp29958158-1956) [n:127.0.0.1:39201_m%2Fvy 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.c.SyncStrategy 
http://127.0.0.1:39201/m/vy/control_collection_shard1_replica_n1/ has no 
replicas
   [junit4]   2> 269130 INFO  (qtp29958158-1956) [n:127.0.0.1:39201_m%2Fvy 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in 
election, clear LIR
   [junit4]   2> 269131 INFO  (qtp29958158-1956) [n:127.0.0.1:39201_m%2Fvy 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:39201/m/vy/control_collection_shard1_replica_n1/ shard1
   [junit4]   2> 269232 INFO  
(zkCallback-497-thread-1-processing-n:127.0.0.1:39201_m%2Fvy) 
[n:127.0.0.1:39201_m%2Fvy    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/control_collection/state.json] for collection 
[control_collection] has occurred - updating... (live nodes size: [1])
   [junit4]   2> 269282 INFO  (qtp29958158-1956) [n:127.0.0.1:39201_m%2Fvy 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.c.ZkController I am the leader, no recovery necessary
   [junit4]   2> 269290 INFO  (qtp29958158-1956) [n:127.0.0.1:39201_m%2Fvy 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&collection.configName=conf1&newCollection=true&name=control_collection_shard1_replica_n1&action=CREATE&numShards=1&collection=control_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=1382
   [junit4]   2> 269292 INFO  (qtp29958158-1954) [n:127.0.0.1:39201_m%2Fvy    ] 
o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 
30 seconds. Check all shard replicas
   [junit4]   2> 269805 INFO  
(OverseerCollectionConfigSetProcessor-99151637037318148-127.0.0.1:39201_m%2Fvy-n_0000000000)
 [n:127.0.0.1:39201_m%2Fvy    ] o.a.s.c.OverseerTaskQueue Response ZK path: 
/overseer/collection-queue-work/qnr-0000000000 doesn't exist.  Requestor may 
have disconnected from ZooKeeper
   [junit4]   2> 299298 ERROR (qtp29958158-1954) [n:127.0.0.1:39201_m%2Fvy    ] 
o.a.s.h.a.CollectionsHandler Timed out waiting for new collection's replicas to 
become ACTIVE replica 
http://127.0.0.1:39201/m/vy/control_collection_shard1_replica_n1/ is in state 
of down with timeout=30
   [junit4]   2> 299298 INFO  (qtp29958158-1954) [n:127.0.0.1:39201_m%2Fvy    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={replicationFactor=1&collection.configName=conf1&name=control_collection&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=127.0.0.1:39201_m%252Fvy&wt=javabin&version=2}
 status=0 QTime=31496
   [junit4]   2> 299303 INFO  (zkConnectionManagerCallback-508-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 299304 INFO  
(TEST-TestRequestStatusCollectionAPI.test-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 299304 INFO  
(TEST-TestRequestStatusCollectionAPI.test-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:33383/solr ready
   [junit4]   2> 299306 INFO  
(TEST-TestRequestStatusCollectionAPI.test-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection 
loss:false
   [junit4]   2> 299309 INFO  (qtp29958158-1956) [n:127.0.0.1:39201_m%2Fvy    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
replicationFactor=1&collection.configName=conf1&name=collection1&nrtReplicas=1&action=CREATE&numShards=2&createNodeSet=&stateFormat=2&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 299311 INFO  
(OverseerThreadFactory-702-thread-2-processing-n:127.0.0.1:39201_m%2Fvy) 
[n:127.0.0.1:39201_m%2Fvy    ] o.a.s.c.CreateCollectionCmd Create collection 
collection1
   [junit4]   2> 299311 WARN  
(OverseerThreadFactory-702-thread-2-processing-n:127.0.0.1:39201_m%2Fvy) 
[n:127.0.0.1:39201_m%2Fvy    ] o.a.s.c.CreateCollectionCmd It is unusual to 
create a collection (collection1) without cores.
   [junit4]   2> 329320 ERROR 
(OverseerThreadFactory-702-thread-2-processing-n:127.0.0.1:39201_m%2Fvy) 
[n:127.0.0.1:39201_m%2Fvy    ] o.a.s.c.OverseerCollectionMessageHandler 
Collection: collection1 operation: create 
failed:org.apache.solr.common.SolrException: Could not fully create collection: 
collection1
   [junit4]   2>        at 
org.apache.solr.cloud.CreateCollectionCmd.call(CreateCollectionCmd.java:215)
   [junit4]   2>        at 
org.apache.solr.cloud.OverseerCollectionMessageHandler.processMessage(OverseerCollectionMessageHandler.java:233)
   [junit4]   2>        at 
org.apache.solr.cloud.OverseerTaskProcessor$Runner.run(OverseerTaskProcessor.java:464)
   [junit4]   2>        at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:188)
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> 
   [junit4]   2> 329328 INFO  (qtp29958158-1956) [n:127.0.0.1:39201_m%2Fvy    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={replicationFactor=1&collection.configName=conf1&name=collection1&nrtReplicas=1&action=CREATE&numShards=2&createNodeSet=&stateFormat=2&wt=javabin&version=2}
 status=500 QTime=30019
   [junit4]   2> 329329 ERROR (qtp29958158-1956) [n:127.0.0.1:39201_m%2Fvy    ] 
o.a.s.s.HttpSolrCall null:org.apache.solr.common.SolrException: Could not fully 
create collection: collection1
   [junit4]   2>        at 
org.apache.solr.handler.admin.CollectionsHandler.handleResponse(CollectionsHandler.java:309)
   [junit4]   2>        at 
org.apache.solr.handler.admin.CollectionsHandler.invokeAction(CollectionsHandler.java:246)
   [junit4]   2>        at 
org.apache.solr.handler.admin.CollectionsHandler.handleRequestBody(CollectionsHandler.java:224)
   [junit4]   2>        at 
org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:177)
   [junit4]   2>        at 
org.apache.solr.servlet.HttpSolrCall.handleAdmin(HttpSolrCall.java:735)
   [junit4]   2>        at 
org.apache.solr.servlet.HttpSolrCall.handleAdminRequest(HttpSolrCall.java:716)
   [junit4]   2>        at 
org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:497)
   [junit4]   2>        at 
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:382)
   [junit4]   2>        at 
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:326)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1759)
   [junit4]   2>        at 
org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:139)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1759)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:582)
   [junit4]   2>        at 
org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:224)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512)
   [junit4]   2>        at 
org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:493)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134)
   [junit4]   2>        at 
org.eclipse.jetty.server.Server.handle(Server.java:534)
   [junit4]   2>        at 
org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:320)
   [junit4]   2>        at 
org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251)
   [junit4]   2>        at 
org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:283)
   [junit4]   2>        at 
org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:108)
   [junit4]   2>        at 
org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> 
   [junit4]   2> 329330 INFO  
(TEST-TestRequestStatusCollectionAPI.test-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.ChaosMonkey monkey: stop jetty! 39201
   [junit4]   2> 329330 INFO  
(TEST-TestRequestStatusCollectionAPI.test-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=24581228
   [junit4]   2> 329330 INFO  
(TEST-TestRequestStatusCollectionAPI.test-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 329330 INFO  
(TEST-TestRequestStatusCollectionAPI.test-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@aab42d: rootName = null, 
domain = solr.node, service url = null, agent id = null] for registry solr.node 
/ com.codahale.metrics.MetricRegistry@150772a
   [junit4]   2> 329333 INFO  
(TEST-TestRequestStatusCollectionAPI.test-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 329334 INFO  
(TEST-TestRequestStatusCollectionAPI.test-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@dbfd8b: rootName = null, 
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / 
com.codahale.metrics.MetricRegistry@1efe860
   [junit4]   2> 329336 INFO  
(TEST-TestRequestStatusCollectionAPI.test-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 329336 INFO  
(TEST-TestRequestStatusCollectionAPI.test-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@1445552: rootName = null, 
domain = solr.jetty, service url = null, agent id = null] for registry 
solr.jetty / com.codahale.metrics.MetricRegistry@c62365
   [junit4]   2> 329337 INFO  
(TEST-TestRequestStatusCollectionAPI.test-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.ZkController Remove node as live in 
ZooKeeper:/live_nodes/127.0.0.1:39201_m%2Fvy
   [junit4]   2> 329337 INFO  
(TEST-TestRequestStatusCollectionAPI.test-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, 
tag=null
   [junit4]   2> 329337 INFO  
(zkCallback-497-thread-2-processing-n:127.0.0.1:39201_m%2Fvy) 
[n:127.0.0.1:39201_m%2Fvy    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (0)
   [junit4]   2> 329338 INFO  (coreCloseExecutor-710-thread-1) 
[n:127.0.0.1:39201_m%2Fvy c:control_collection s:shard1 r:core_node2 
x:control_collection_shard1_replica_n1] o.a.s.c.SolrCore 
[control_collection_shard1_replica_n1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@61a8ea
   [junit4]   2> 329338 INFO  (coreCloseExecutor-710-thread-1) 
[n:127.0.0.1:39201_m%2Fvy c:control_collection s:shard1 r:core_node2 
x:control_collection_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing 
metric reporters for registry=solr.core.control_collection.shard1.replica_n1, 
tag=6400234
   [junit4]   2> 329338 INFO  (coreCloseExecutor-710-thread-1) 
[n:127.0.0.1:39201_m%2Fvy c:control_collection s:shard1 r:core_node2 
x:control_collection_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter Closing 
reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1c69473: rootName = 
null, domain = solr.core.control_collection.shard1.replica_n1, service url = 
null, agent id = null] for registry 
solr.core.control_collection.shard1.replica_n1 / 
com.codahale.metrics.MetricRegistry@10fc164
   [junit4]   2> 329343 INFO  (coreCloseExecutor-710-thread-1) 
[n:127.0.0.1:39201_m%2Fvy c:control_collection s:shard1 r:core_node2 
x:control_collection_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing 
metric reporters for registry=solr.collection.control_collection.shard1.leader, 
tag=6400234
   [junit4]   2> 329345 INFO  
(TEST-TestRequestStatusCollectionAPI.test-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.Overseer Overseer 
(id=99151637037318148-127.0.0.1:39201_m%2Fvy-n_0000000000) closing
   [junit4]   2> 329345 INFO  
(OverseerStateUpdate-99151637037318148-127.0.0.1:39201_m%2Fvy-n_0000000000) 
[n:127.0.0.1:39201_m%2Fvy    ] o.a.s.c.Overseer Overseer Loop exiting : 
127.0.0.1:39201_m%2Fvy
   [junit4]   2> 329345 WARN  
(OverseerAutoScalingTriggerThread-99151637037318148-127.0.0.1:39201_m%2Fvy-n_0000000000)
 [n:127.0.0.1:39201_m%2Fvy    ] o.a.s.c.a.OverseerTriggerThread 
OverseerTriggerThread woken up but we are closed, exiting.
   [junit4]   2> 329346 INFO  
(TEST-TestRequestStatusCollectionAPI.test-seed#[1BADD93D903B8A13]) [    ] 
o.e.j.s.AbstractConnector Stopped 
ServerConnector@6c3019{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 329346 INFO  
(TEST-TestRequestStatusCollectionAPI.test-seed#[1BADD93D903B8A13]) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@14fa88b{/m/vy,null,UNAVAILABLE}
   [junit4]   2> 329346 ERROR 
(TEST-TestRequestStatusCollectionAPI.test-seed#[1BADD93D903B8A13]) [    ] 
o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper 
server won't take any action on ERROR or SHUTDOWN server state changes
   [junit4]   2> 329351 INFO  
(TEST-TestRequestStatusCollectionAPI.test-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1:33383 33383
   [junit4]   2> 335054 INFO  (Thread-449) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:33383 33383
   [junit4]   2> 335055 WARN  (Thread-449) [    ] o.a.s.c.ZkTestServer Watch 
limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2>        3       /solr/aliases.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2>        3       /solr/clusterstate.json
   [junit4]   2>        3       /solr/clusterprops.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2>        3       /solr/live_nodes
   [junit4]   2>        3       /solr/collections
   [junit4]   2> 
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=TestRequestStatusCollectionAPI -Dtests.method=test 
-Dtests.seed=1BADD93D903B8A13 -Dtests.multiplier=3 -Dtests.slow=true 
-Dtests.locale=ja-JP -Dtests.timezone=Pacific/Guadalcanal -Dtests.asserts=true 
-Dtests.file.encoding=ISO-8859-1
   [junit4] ERROR   67.7s J0 | TestRequestStatusCollectionAPI.test <<<
   [junit4]    > Throwable #1: 
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error 
from server at http://127.0.0.1:39201/m/vy: Could not fully create collection: 
collection1
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([1BADD93D903B8A13:93F9E6E73EC7E7EB]:0)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:643)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:255)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:244)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:483)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:413)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1103)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:883)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:816)
   [junit4]    >        at 
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:194)
   [junit4]    >        at 
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:211)
   [junit4]    >        at 
org.apache.solr.cloud.AbstractFullDistribZkTestBase.createJettys(AbstractFullDistribZkTestBase.java:384)
   [junit4]    >        at 
org.apache.solr.cloud.AbstractFullDistribZkTestBase.createServers(AbstractFullDistribZkTestBase.java:333)
   [junit4]    >        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:991)
   [junit4]    >        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:968)
   [junit4]    >        at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestRequestStatusCollectionAPI_1BADD93D903B8A13-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70), 
sim=RandomSimilarity(queryNorm=true): {}, locale=ja-JP, 
timezone=Pacific/Guadalcanal
   [junit4]   2> NOTE: Linux 4.10.0-40-generic i386/Oracle Corporation 
1.8.0_144 (32-bit)/cpus=8,threads=1,free=330423360,total=462422016
   [junit4]   2> NOTE: All tests run in this JVM: [TestFoldingMultitermQuery, 
FullHLLTest, TestIBSimilarityFactory, TestZkAclsWithHadoopAuth, 
AutoscalingHistoryHandlerTest, ManagedSchemaRoundRobinCloudTest, 
NodeAddedTriggerTest, TestBulkSchemaAPI, OverseerTaskQueueTest, 
HdfsTlogReplayBufferedWhileIndexingTest, ZkControllerTest, 
UpdateRequestProcessorFactoryTest, TestSortByMinMaxFunction, 
DistributedQueueTest, TestPKIAuthenticationPlugin, TemplateUpdateProcessorTest, 
PeerSyncTest, FastVectorHighlighterTest, TestPullReplicaErrorHandling, 
TestRequestStatusCollectionAPI]
   [junit4] Completed [78/751 (1!)] on J0 in 67.70s, 1 test, 1 error <<< 
FAILURES!

[...truncated 2022 lines...]
   [junit4] Suite: org.apache.solr.cloud.ShardSplitTest
   [junit4]   2> Creating dataDir: 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.ShardSplitTest_1BADD93D903B8A13-001/init-core-data-001
   [junit4]   2> 1687142 WARN  
(SUITE-ShardSplitTest-seed#[1BADD93D903B8A13]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=7 numCloses=7
   [junit4]   2> 1687143 INFO  
(SUITE-ShardSplitTest-seed#[1BADD93D903B8A13]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) 
w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 1687143 INFO  
(SUITE-ShardSplitTest-seed#[1BADD93D903B8A13]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: 
@org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl=https://issues.apache.org/jira/browse/SOLR-5776)
   [junit4]   2> 1687143 INFO  
(SUITE-ShardSplitTest-seed#[1BADD93D903B8A13]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 1687144 INFO  
(SUITE-ShardSplitTest-seed#[1BADD93D903B8A13]-worker) [    ] 
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /y_/ze
   [junit4]   2> 1687145 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1687145 INFO  (Thread-3367) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 1687145 INFO  (Thread-3367) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 1687146 ERROR (Thread-3367) [    ] o.a.z.s.ZooKeeperServer 
ZKShutdownHandler is not registered, so ZooKeeper server won't take any action 
on ERROR or SHUTDOWN server state changes
   [junit4]   2> 1687245 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.ZkTestServer start zk server on port:40707
   [junit4]   2> 1687248 INFO  (zkConnectionManagerCallback-3046-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1687251 INFO  (zkConnectionManagerCallback-3048-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1687256 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
 to /configs/conf1/solrconfig.xml
   [junit4]   2> 1687257 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/conf/schema15.xml
 to /configs/conf1/schema.xml
   [junit4]   2> 1687259 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
 to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 1687260 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
 to /configs/conf1/stopwords.txt
   [junit4]   2> 1687260 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/conf/protwords.txt
 to /configs/conf1/protwords.txt
   [junit4]   2> 1687261 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/conf/currency.xml
 to /configs/conf1/currency.xml
   [junit4]   2> 1687262 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
 to /configs/conf1/enumsConfig.xml
   [junit4]   2> 1687263 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
 to /configs/conf1/open-exchange-rates.json
   [junit4]   2> 1687264 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
 to /configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 1687265 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
 to /configs/conf1/old_synonyms.txt
   [junit4]   2> 1687266 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
 to /configs/conf1/synonyms.txt
   [junit4]   2> 1687267 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.AbstractFullDistribZkTestBase Will use NRT replicas unless explicitly 
asked otherwise
   [junit4]   2> 1687345 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) [    ] 
o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 1687346 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@eae538{/y_/ze,null,AVAILABLE}
   [junit4]   2> 1687346 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@186c7d{HTTP/1.1,[http/1.1]}{127.0.0.1:35073}
   [junit4]   2> 1687346 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) [    ] 
o.e.j.s.Server Started @1689774ms
   [junit4]   2> 1687346 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.ShardSplitTest_1BADD93D903B8A13-001/tempDir-001/control/data,
 replicaType=NRT, hostContext=/y_/ze, hostPort=35073, 
coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.ShardSplitTest_1BADD93D903B8A13-001/control-001/cores}
   [junit4]   2> 1687346 ERROR 
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1687346 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
7.3.0
   [junit4]   2> 1687346 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1687346 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1687346 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-12-10T19:48:54.712Z
   [junit4]   2> 1687347 INFO  (zkConnectionManagerCallback-3050-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1687348 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in 
ZooKeeper)
   [junit4]   2> 1687348 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.ShardSplitTest_1BADD93D903B8A13-001/control-001/solr.xml
   [junit4]   2> 1687350 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay 
is ignored
   [junit4]   2> 1687350 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 1687351 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@d72084, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 1687353 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:40707/solr
   [junit4]   2> 1687354 INFO  (zkConnectionManagerCallback-3054-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1687355 INFO  
(zkConnectionManagerCallback-3056-thread-1-processing-n:127.0.0.1:35073_y_%2Fze)
 [n:127.0.0.1:35073_y_%2Fze    ] o.a.s.c.c.ConnectionManager zkClient has 
connected
   [junit4]   2> 1687379 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) 
[n:127.0.0.1:35073_y_%2Fze    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 1687379 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) 
[n:127.0.0.1:35073_y_%2Fze    ] o.a.s.c.OverseerElectionContext I am going to 
be the leader 127.0.0.1:35073_y_%2Fze
   [junit4]   2> 1687379 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) 
[n:127.0.0.1:35073_y_%2Fze    ] o.a.s.c.Overseer Overseer 
(id=99151730082578436-127.0.0.1:35073_y_%2Fze-n_0000000000) starting
   [junit4]   2> 1687382 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) 
[n:127.0.0.1:35073_y_%2Fze    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:35073_y_%2Fze
   [junit4]   2> 1687383 INFO  
(zkCallback-3055-thread-1-processing-n:127.0.0.1:35073_y_%2Fze) 
[n:127.0.0.1:35073_y_%2Fze    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 1687464 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) 
[n:127.0.0.1:35073_y_%2Fze    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@d72084
   [junit4]   2> 1687471 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) 
[n:127.0.0.1:35073_y_%2Fze    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@d72084
   [junit4]   2> 1687471 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) 
[n:127.0.0.1:35073_y_%2Fze    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@d72084
   [junit4]   2> 1687472 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) 
[n:127.0.0.1:35073_y_%2Fze    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.ShardSplitTest_1BADD93D903B8A13-001/control-001/cores
   [junit4]   2> 1687484 INFO  (zkConnectionManagerCallback-3062-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1687485 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 1687485 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:40707/solr ready
   [junit4]   2> 1687486 INFO  (qtp98694-14942) [n:127.0.0.1:35073_y_%2Fze    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
replicationFactor=1&collection.configName=conf1&name=control_collection&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=127.0.0.1:35073_y_%252Fze&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 1687487 INFO  
(OverseerThreadFactory-7457-thread-1-processing-n:127.0.0.1:35073_y_%2Fze) 
[n:127.0.0.1:35073_y_%2Fze    ] o.a.s.c.CreateCollectionCmd Create collection 
control_collection
   [junit4]   2> 1687592 INFO  (qtp98694-14944) [n:127.0.0.1:35073_y_%2Fze    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=conf1&newCollection=true&name=control_collection_shard1_replica_n1&action=CREATE&numShards=1&collection=control_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1687592 INFO  (qtp98694-14944) [n:127.0.0.1:35073_y_%2Fze    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 1687696 INFO  
(zkCallback-3055-thread-1-processing-n:127.0.0.1:35073_y_%2Fze) 
[n:127.0.0.1:35073_y_%2Fze    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/control_collection/state.json] for collection 
[control_collection] has occurred - updating... (live nodes size: [1])
   [junit4]   2> 1688617 INFO  (qtp98694-14944) [n:127.0.0.1:35073_y_%2Fze 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.3.0
   [junit4]   2> 1688628 INFO  (qtp98694-14944) [n:127.0.0.1:35073_y_%2Fze 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.s.IndexSchema [control_collection_shard1_replica_n1] Schema name=test
   [junit4]   2> 1688697 INFO  (qtp98694-14944) [n:127.0.0.1:35073_y_%2Fze 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 1688704 INFO  (qtp98694-14944) [n:127.0.0.1:35073_y_%2Fze 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.c.CoreContainer Creating SolrCore 'control_collection_shard1_replica_n1' 
using configuration from collection control_collection, trusted=true
   [junit4]   2> 1688704 INFO  (qtp98694-14944) [n:127.0.0.1:35073_y_%2Fze 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.core.control_collection.shard1.replica_n1' (registry 
'solr.core.control_collection.shard1.replica_n1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@d72084
   [junit4]   2> 1688704 INFO  (qtp98694-14944) [n:127.0.0.1:35073_y_%2Fze 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 1688705 INFO  (qtp98694-14944) [n:127.0.0.1:35073_y_%2Fze 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.c.SolrCore [[control_collection_shard1_replica_n1] ] Opening new SolrCore 
at 
[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.ShardSplitTest_1BADD93D903B8A13-001/control-001/cores/control_collection_shard1_replica_n1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.ShardSplitTest_1BADD93D903B8A13-001/control-001/cores/control_collection_shard1_replica_n1/data/]
   [junit4]   2> 1688708 INFO  (qtp98694-14944) [n:127.0.0.1:35073_y_%2Fze 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.MockRandomMergePolicy: 
org.apache.lucene.index.MockRandomMergePolicy@b96845
   [junit4]   2> 1688727 WARN  (qtp98694-14944) [n:127.0.0.1:35073_y_%2Fze 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = 
requestHandler,name = /dump,class = DumpRequestHandler,attributes = 
{initParams=a, name=/dump, class=DumpRequestHandler},args = 
{defaults={a=A,b=B}}}
   [junit4]   2> 1688805 INFO  (qtp98694-14944) [n:127.0.0.1:35073_y_%2Fze 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1688805 INFO  (qtp98694-14944) [n:127.0.0.1:35073_y_%2Fze 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1688806 INFO  (qtp98694-14944) [n:127.0.0.1:35073_y_%2Fze 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1688807 INFO  (qtp98694-14944) [n:127.0.0.1:35073_y_%2Fze 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1688808 INFO  (qtp98694-14944) [n:127.0.0.1:35073_y_%2Fze 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=34, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.48103147855688577]
   [junit4]   2> 1688808 INFO  (qtp98694-14944) [n:127.0.0.1:35073_y_%2Fze 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@7b2b64[control_collection_shard1_replica_n1] main]
   [junit4]   2> 1688809 INFO  (qtp98694-14944) [n:127.0.0.1:35073_y_%2Fze 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf1
   [junit4]   2> 1688809 INFO  (qtp98694-14944) [n:127.0.0.1:35073_y_%2Fze 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 1688810 INFO  (qtp98694-14944) [n:127.0.0.1:35073_y_%2Fze 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 1688811 INFO  
(searcherExecutor-7460-thread-1-processing-n:127.0.0.1:35073_y_%2Fze 
x:control_collection_shard1_replica_n1 s:shard1 c:control_collection) 
[n:127.0.0.1:35073_y_%2Fze c:control_collection s:shard1  
x:control_collection_shard1_replica_n1] o.a.s.c.SolrCore 
[control_collection_shard1_replica_n1] Registered new searcher 
Searcher@7b2b64[control_collection_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1688811 INFO  (qtp98694-14944) [n:127.0.0.1:35073_y_%2Fze 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1586427683067133952
   [junit4]   2> 1688816 INFO  (qtp98694-14944) [n:127.0.0.1:35073_y_%2Fze 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 1688816 INFO  (qtp98694-14944) [n:127.0.0.1:35073_y_%2Fze 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 1688816 INFO  (qtp98694-14944) [n:127.0.0.1:35073_y_%2Fze 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.c.SyncStrategy Sync replicas to 
http://127.0.0.1:35073/y_/ze/control_collection_shard1_replica_n1/
   [junit4]   2> 1688816 INFO  (qtp98694-14944) [n:127.0.0.1:35073_y_%2Fze 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
   [junit4]   2> 1688816 INFO  (qtp98694-14944) [n:127.0.0.1:35073_y_%2Fze 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.c.SyncStrategy 
http://127.0.0.1:35073/y_/ze/control_collection_shard1_replica_n1/ has no 
replicas
   [junit4]   2> 1688816 INFO  (qtp98694-14944) [n:127.0.0.1:35073_y_%2Fze 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in 
election, clear LIR
   [junit4]   2> 1688817 INFO  (qtp98694-14944) [n:127.0.0.1:35073_y_%2Fze 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:35073/y_/ze/control_collection_shard1_replica_n1/ shard1
   [junit4]   2> 1688918 INFO  
(zkCallback-3055-thread-1-processing-n:127.0.0.1:35073_y_%2Fze) 
[n:127.0.0.1:35073_y_%2Fze    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/control_collection/state.json] for collection 
[control_collection] has occurred - updating... (live nodes size: [1])
   [junit4]   2> 1688968 INFO  (qtp98694-14944) [n:127.0.0.1:35073_y_%2Fze 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.c.ZkController I am the leader, no recovery necessary
   [junit4]   2> 1688977 INFO  (qtp98694-14944) [n:127.0.0.1:35073_y_%2Fze 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&collection.configName=conf1&newCollection=true&name=control_collection_shard1_replica_n1&action=CREATE&numShards=1&collection=control_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=1385
   [junit4]   2> 1688979 INFO  (qtp98694-14942) [n:127.0.0.1:35073_y_%2Fze    ] 
o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 
30 seconds. Check all shard replicas
   [junit4]   2> 1689070 INFO  
(zkCallback-3055-thread-1-processing-n:127.0.0.1:35073_y_%2Fze) 
[n:127.0.0.1:35073_y_%2Fze    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/control_collection/state.json] for collection 
[control_collection] has occurred - updating... (live nodes size: [1])
   [junit4]   2> 1689488 INFO  
(OverseerCollectionConfigSetProcessor-99151730082578436-127.0.0.1:35073_y_%2Fze-n_0000000000)
 [n:127.0.0.1:35073_y_%2Fze    ] o.a.s.c.OverseerTaskQueue Response ZK path: 
/overseer/collection-queue-work/qnr-0000000000 doesn't exist.  Requestor may 
have disconnected from ZooKeeper
   [junit4]   2> 1689979 INFO  (qtp98694-14942) [n:127.0.0.1:35073_y_%2Fze    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={replicationFactor=1&collection.configName=conf1&name=control_collection&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=127.0.0.1:35073_y_%252Fze&wt=javabin&version=2}
 status=0 QTime=2493
   [junit4]   2> 1689982 INFO  (zkConnectionManagerCallback-3066-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1689983 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 1689983 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:40707/solr ready
   [junit4]   2> 1689983 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection 
loss:false
   [junit4]   2> 1689984 INFO  (qtp98694-14942) [n:127.0.0.1:35073_y_%2Fze    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
replicationFactor=1&collection.configName=conf1&name=collection1&nrtReplicas=1&action=CREATE&numShards=2&createNodeSet=&stateFormat=1&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 1689984 INFO  
(OverseerThreadFactory-7457-thread-2-processing-n:127.0.0.1:35073_y_%2Fze) 
[n:127.0.0.1:35073_y_%2Fze    ] o.a.s.c.CreateCollectionCmd Create collection 
collection1
   [junit4]   2> 1689985 WARN  
(OverseerThreadFactory-7457-thread-2-processing-n:127.0.0.1:35073_y_%2Fze) 
[n:127.0.0.1:35073_y_%2Fze    ] o.a.s.c.CreateCollectionCmd It is unusual to 
create a collection (collection1) without cores.
   [junit4]   2> 1690187 INFO  (qtp98694-14942) [n:127.0.0.1:35073_y_%2Fze    ] 
o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 
30 seconds. Check all shard replicas
   [junit4]   2> 1690187 INFO  (qtp98694-14942) [n:127.0.0.1:35073_y_%2Fze    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={replicationFactor=1&collection.configName=conf1&name=collection1&nrtReplicas=1&action=CREATE&numShards=2&createNodeSet=&stateFormat=1&wt=javabin&version=2}
 status=0 QTime=203
   [junit4]   2> 1690247 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.ShardSplitTest_1BADD93D903B8A13-001/shard-1-001
 of type NRT
   [junit4]   2> 1690247 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) [    ] 
o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 1690248 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@fd82d9{/y_/ze,null,AVAILABLE}
   [junit4]   2> 1690248 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@17f2af3{HTTP/1.1,[http/1.1]}{127.0.0.1:43763}
   [junit4]   2> 1690248 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) [    ] 
o.e.j.s.Server Started @1692677ms
   [junit4]   2> 1690249 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.ShardSplitTest_1BADD93D903B8A13-001/tempDir-001/jetty1,
 replicaType=NRT, solrconfig=solrconfig.xml, hostContext=/y_/ze, 
hostPort=43763, 
coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.ShardSplitTest_1BADD93D903B8A13-001/shard-1-001/cores}
   [junit4]   2> 1690249 ERROR 
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1690249 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
7.3.0
   [junit4]   2> 1690249 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1690249 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1690249 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-12-10T19:48:57.615Z
   [junit4]   2> 1690250 INFO  (zkConnectionManagerCallback-3068-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1690251 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in 
ZooKeeper)
   [junit4]   2> 1690251 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.ShardSplitTest_1BADD93D903B8A13-001/shard-1-001/solr.xml
   [junit4]   2> 1690253 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay 
is ignored
   [junit4]   2> 1690253 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 1690254 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@d72084, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 1690256 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:40707/solr
   [junit4]   2> 1690257 INFO  (zkConnectionManagerCallback-3072-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1690259 INFO  
(zkConnectionManagerCallback-3074-thread-1-processing-n:127.0.0.1:43763_y_%2Fze)
 [n:127.0.0.1:43763_y_%2Fze    ] o.a.s.c.c.ConnectionManager zkClient has 
connected
   [junit4]   2> 1690261 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) 
[n:127.0.0.1:43763_y_%2Fze    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 1690261 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) 
[n:127.0.0.1:43763_y_%2Fze    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 1690262 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) 
[n:127.0.0.1:43763_y_%2Fze    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:43763_y_%2Fze
   [junit4]   2> 1690262 INFO  
(zkCallback-3055-thread-1-processing-n:127.0.0.1:35073_y_%2Fze) 
[n:127.0.0.1:35073_y_%2Fze    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (2)
   [junit4]   2> 1690262 INFO  (zkCallback-3065-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 1690263 INFO  
(zkCallback-3073-thread-1-processing-n:127.0.0.1:43763_y_%2Fze) 
[n:127.0.0.1:43763_y_%2Fze    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (2)
   [junit4]   2> 1690341 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) 
[n:127.0.0.1:43763_y_%2Fze    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@d72084
   [junit4]   2> 1690348 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) 
[n:127.0.0.1:43763_y_%2Fze    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@d72084
   [junit4]   2> 1690348 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) 
[n:127.0.0.1:43763_y_%2Fze    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@d72084
   [junit4]   2> 1690350 INFO  
(TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[1BADD93D903B8A13]) 
[n:127.0.0.1:43763_y_%2Fze    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.ShardSplitTest_1BADD93D903B8A13-001/shard-1-001/cores
   [junit4]   2> 1690368 INFO  (qtp98694-14943) [n:127.0.0.1:35073_y_%2Fze    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with params 
node=127.0.0.1:43763_y_%252Fze&action=ADDREPLICA&collection=collection1&shard=shard2&type=NRT&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 1690369 INFO  
(OverseerCollectionConfigSetProcessor-99151730082578436-127.0.0.1:35073_y_%2Fze-n_0000000000)
 [n:127.0.0.1:35073_y_%2Fze    ] o.a.s.c.OverseerTaskQueue Response ZK path: 
/overseer/collection-queue-work/qnr-0000000002 doesn't exist.  Requestor may 
have disconnected from ZooKeeper
   [junit4]   2> 1690369 INFO  
(OverseerThreadFactory-7457-thread-3-processing-n:127.0.0.1:35073_y_%2Fze) 
[n:127.0.0.1:35073_y_%2Fze    ] o.a.s.c.AddReplicaCmd Node Identified 
127.0.0.1:43763_y_%2Fze for creating new replica
   [junit4]   2> 1690370 INFO  (qtp23202420-14991) [n:127.0.0.1:43763_y_%2Fze   
 ] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=conf1&name=collection1_shard2_replica_n41&action=CREATE&collection=collection1&shard=shard2&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1690371 INFO  (qtp23202420-14991) [n:127.0.0.1:43763_y_%2Fze   
 ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 1691396 INFO  (qtp23202420-14991) [n:127.0.0.1:43763_y_%2Fze 
c:collection1 s:shard2  x:collection1_shard2_replica_n41] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 7.3.0
   [junit4]   2> 1691413 INFO  (qtp23202420-14991) [n:127.0.0.1:43763_y_%2Fze 
c:collection1 s:shard2  x:collection1_shard2_replica_n41] o.a.s.s.IndexSchema 
[collection1_shard2_replica_n41] Schema name=test
   [junit4]   2> 1691466 INFO  (qtp23202420-14991) [n:127.0.0.1:43763_y_%2Fze 
c:collection1 s:shard2  x:collection1_shard2_replica_n41] o.a.s.s.IndexSchema 
Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 1691473 INFO  (qtp23202420-14991) [n:127.0.0.1:43763_y_%2Fze 
c:collection1 s:shard2  x:collection1_shard2_replica_n41] o.a.s.c.CoreContainer 
Creating SolrCore 'collection1_shard2_replica_n41' using configuration from 
collection collection1, trusted=true
   [junit4]   2> 1691473 INFO  (qtp23202420-14991) [n:127.0.0.1:43763_y_%2Fze 
c:collection1 s:shard2  x:collection1_shard2_replica_n41] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.core.collection1.shard2.replica_n41' (registry 
'solr.core.collection1.shard2.replica_n41') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@d72084
   [junit4]   2> 1691473 INFO  (qtp23202420-14991) [n:127.0.0.1:43763_y_%2Fze 
c:collection1 s:shard2  x:collection1_shard2_replica_n41] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 1691473 INFO  (qtp23202420-14991) [n:127.0.0.1:43763_y_%2Fze 
c:collection1 s:shard2  x:collection1_shard2_replica_n41] o.a.s.c.SolrCore 
[[collection1_shard2_replica_n41] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.ShardSplitTest_1BADD93D903B8A13-001/shard-1-001/cores/collection1_shard2_replica_n41],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.ShardSplitTest_1BADD93D903B8A13-001/shard-1-001/cores/collection1_shard2_replica_n41/data/]
   [junit4]   2> 1691476 INFO  (qtp23202420-14991) [n:127.0.0.1:43763_y_%2Fze 
c:collection1 s:shard2  x:collection1_shard2_replica_n41] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.MockRandomMergePolicy: 
org.apache.lucene.index.MockRandomMergePolicy@743083
   [junit4]   2> 1691493 WARN  (qtp23202420-14991) [n:127.0.0.1:43763_y_%2Fze 
c:collection1 s:shard2  x:collection1_shard2_replica_n41] 
o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = 
requestHandler,name = /dump,class = DumpRequestHandler,attributes = 
{initParams=a, name=/dump, class=DumpRequestHandler},args = 
{defaults={a=A,b=B}}}
   [junit4]   2> 1691517 INFO  (qtp23202420-14991) [n:127.0.0.1:43763_y_%2Fze 
c:collection1 s:shard2  x:collection1_shard2_replica_n41] o.a.s.u.UpdateHandler 
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1691517 INFO  (qtp23202420-14991) [n:127.0.0.1:43763_y_%2Fze 
c:collection1 s:shard2  x:collection1_shard2_replica_n41] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 
maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1691518 INFO  (qtp23202420-14991) [n:127.0.0.1:43763_y_%2Fze 
c:collection1 s:shard2  x:collection1_shard2_replica_n41] o.a.s.u.CommitTracker 
Hard AutoCommit: disabled
   [junit4]   2> 1691518 INFO  (qtp23202420-14991) [n:127.0.0.1:43763_y_%2Fze 
c:collection1 s:shard2  x:collection1_shard2_replica_n41] o.a.s.u.CommitTracker 
Soft AutoCommit: disabled
   [junit4]   2> 1691519 INFO  (qtp23202420-14991) [n:127.0.0.1:43763_y_%2Fze 
c:collection1 s:shard2  x:collection1_shard2_replica_n41] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=167

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

Rule_shard1_0_replica0 s:shard1_0 c:shardSplitWithRule r:core_node10) 
[n:127.0.0.1:35899_y_%2Fze c:shardSplitWithRule s:shard1_0 r:core_node10 
x:shardSplitWithRule_shard1_0_replica0] o.a.s.m.SolrMetricManager Closing 
metric reporters for 
registry=solr.collection.shardSplitWithRule.shard1_0.leader, tag=265288
   [junit4]   2> 2566485 WARN  
(recoveryExecutor-3395-thread-1-processing-n:127.0.0.1:35899_y_%2Fze 
x:shardSplitWithRule_shard1_0_replica0 s:shard1_0 c:shardSplitWithRule 
r:core_node10) [n:127.0.0.1:35899_y_%2Fze c:shardSplitWithRule s:shard1_0 
r:core_node10 x:shardSplitWithRule_shard1_0_replica0] o.a.s.c.RecoveryStrategy 
Stopping recovery for core=[shardSplitWithRule_shard1_0_replica0] 
coreNodeName=[core_node10]
   [junit4]   2> 2566486 WARN  
(updateExecutor-3394-thread-2-processing-n:127.0.0.1:35899_y_%2Fze 
x:shardSplitWithRule_shard1_0_replica0 s:shard1_0 c:shardSplitWithRule 
r:core_node10) [n:127.0.0.1:35899_y_%2Fze c:shardSplitWithRule s:shard1_0 
r:core_node10 x:shardSplitWithRule_shard1_0_replica0] 
o.a.s.u.DefaultSolrCoreState Skipping recovery because Solr is shutdown
   [junit4]   2> 2566486 INFO  
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.Overseer Overseer 
(id=99151785963421714-127.0.0.1:35899_y_%2Fze-n_0000000004) closing
   [junit4]   2> 2566486 WARN  
(OverseerAutoScalingTriggerThread-99151785963421714-127.0.0.1:35899_y_%2Fze-n_0000000004)
 [n:127.0.0.1:35899_y_%2Fze    ] o.a.s.c.a.OverseerTriggerThread 
OverseerTriggerThread woken up but we are closed, exiting.
   [junit4]   2> 2566487 INFO  
(OverseerStateUpdate-99151785963421714-127.0.0.1:35899_y_%2Fze-n_0000000004) 
[n:127.0.0.1:35899_y_%2Fze    ] o.a.s.c.Overseer Overseer Loop exiting : 
127.0.0.1:35899_y_%2Fze
   [junit4]   2> 2566495 INFO  
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[1BADD93D903B8A13]) [    ] 
o.e.j.s.AbstractConnector Stopped 
ServerConnector@10f82a6{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 2566495 INFO  
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[1BADD93D903B8A13]) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@1053ec3{/y_/ze,null,UNAVAILABLE}
   [junit4]   2> 2566496 INFO  
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.ChaosMonkey monkey: stop jetty! 33499
   [junit4]   2> 2566496 ERROR 
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[1BADD93D903B8A13]) [    ] 
o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper 
server won't take any action on ERROR or SHUTDOWN server state changes
   [junit4]   2> 2566497 INFO  
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[1BADD93D903B8A13]) [    ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1:41117 41117
   [junit4]   2> 2571532 INFO  (Thread-3611) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:41117 41117
   [junit4]   2> 2571533 WARN  (Thread-3611) [    ] o.a.s.c.ZkTestServer Watch 
limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2>        7       /solr/aliases.json
   [junit4]   2>        5       /solr/security.json
   [junit4]   2>        5       /solr/configs/conf1
   [junit4]   2>        4       /solr/collections/collection1/state.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2>        47      /solr/collections/shardSplitWithRule/state.json
   [junit4]   2>        7       /solr/clusterprops.json
   [junit4]   2>        7       /solr/clusterstate.json
   [junit4]   2>        3       /solr/autoscaling.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2>        7       /solr/live_nodes
   [junit4]   2>        7       /solr/collections
   [junit4]   2>        3       /solr/overseer/queue
   [junit4]   2>        3       /solr/autoscaling/events/.auto_add_replicas
   [junit4]   2>        3       /solr/overseer/collection-queue-work
   [junit4]   2>        3       /solr/overseer/queue-work
   [junit4]   2> 
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.ShardSplitTest_1BADD93D903B8A13-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): 
{rnd_b=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
 shard_s=PostingsFormat(name=LuceneVarGapFixedInterval), 
n_ti=PostingsFormat(name=LuceneVarGapFixedInterval), 
a_t=PostingsFormat(name=LuceneVarGapFixedInterval), 
a_i=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
 
id=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128)))},
 docValues:{rnd_b=DocValuesFormat(name=Lucene70), 
_version_=DocValuesFormat(name=Asserting), n_ti=DocValuesFormat(name=Direct), 
a_t=DocValuesFormat(name=Direct), a_i=DocValuesFormat(name=Lucene70), 
id=DocValuesFormat(name=Lucene70)}, maxPointsInLeafNode=1005, 
maxMBSortInHeap=6.3848120009761935, sim=RandomSimilarity(queryNorm=true): {}, 
locale=es-BO, timezone=America/Fort_Nelson
   [junit4]   2> NOTE: Linux 4.10.0-40-generic i386/Oracle Corporation 
1.8.0_144 (32-bit)/cpus=8,threads=1,free=162934384,total=536870912
   [junit4]   2> NOTE: All tests run in this JVM: [TestFoldingMultitermQuery, 
FullHLLTest, TestIBSimilarityFactory, TestZkAclsWithHadoopAuth, 
AutoscalingHistoryHandlerTest, ManagedSchemaRoundRobinCloudTest, 
NodeAddedTriggerTest, TestBulkSchemaAPI, OverseerTaskQueueTest, 
HdfsTlogReplayBufferedWhileIndexingTest, ZkControllerTest, 
UpdateRequestProcessorFactoryTest, TestSortByMinMaxFunction, 
DistributedQueueTest, TestPKIAuthenticationPlugin, TemplateUpdateProcessorTest, 
PeerSyncTest, FastVectorHighlighterTest, TestPullReplicaErrorHandling, 
TestRequestStatusCollectionAPI, TestRecovery, TestCorePropertiesReload, 
TestInPlaceUpdatesStandalone, BasicZkTest, TestPostingsSolrHighlighter, 
ForceLeaderTest, NumberUtilsTest, TestReversedWildcardFilterFactory, 
TestSerializedLuceneMatchVersion, TestConfigsApi, TestSolrIndexConfig, 
TestBlendedInfixSuggestions, TestNRTOpen, CleanupOldIndexTest, 
SolrGraphiteReporterTest, UpdateParamsTest, SystemLogListenerTest, 
BasicAuthStandaloneTest, TestDynamicFieldResource, SpatialRPTFieldTypeTest, 
FileUtilsTest, CdcrReplicationDistributedZkTest, HdfsNNFailoverTest, 
AutoAddReplicasPlanActionTest, ConjunctionSolrSpellCheckerTest, 
TestOverriddenPrefixQueryForCustomFieldType, SpatialFilterTest, 
TestManagedSynonymFilterFactory, TestExactStatsCache, ActionThrottleTest, 
TestCloudInspectUtil, TestNumericTokenStream, TestTlogReplica, 
CollectionStateFormat2Test, TestSearcherReuse, ZkStateWriterTest, TestSolrJ, 
TestDocTermOrds, TestSubQueryTransformer, ConnectionManagerTest, 
DistributedExpandComponentTest, JsonLoaderTest, TestSolrDeletionPolicy1, 
BufferStoreTest, BasicFunctionalityTest, SimpleMLTQParserTest, CacheHeaderTest, 
StatsReloadRaceTest, URLClassifyProcessorTest, TestCodecSupport, 
DeleteReplicaTest, ChaosMonkeyNothingIsSafeWithPullReplicasTest, 
TestSweetSpotSimilarityFactory, TestFieldCacheSort, AnalysisErrorHandlingTest, 
RulesTest, DocumentBuilderTest, TestNonDefinedSimilarityFactory, 
RAMDirectoryFactoryTest, TestRandomDVFaceting, CdcrVersionReplicationTest, 
DateFieldTest, TestUseDocValuesAsStored, ResourceLoaderTest, 
TestShortCircuitedRequests, TestPHPSerializedResponseWriter, 
TolerantUpdateProcessorTest, NoCacheHeaderTest, TestQueryUtils, 
TestDelegationWithHadoopAuth, TestFieldCacheWithThreads, TestReqParamsAPI, 
MetricsConfigTest, TestAddFieldRealTimeGet, TestOnReconnectListenerSupport, 
PropertiesRequestHandlerTest, RestartWhileUpdatingTest, SolrPluginUtilsTest, 
AnalyticsQueryTest, TestRebalanceLeaders, TestConfigSetImmutable, 
TestEmbeddedSolrServerSchemaAPI, TestWordDelimiterFilterFactory, 
SolrMetricReporterTest, DirectUpdateHandlerOptimizeTest, 
TestBinaryResponseWriter, TestSQLHandlerNonCloud, TestMacros, 
SaslZkACLProviderTest, ResponseLogComponentTest, TestComponentsName, 
LeaderFailoverAfterPartitionTest, TestImplicitCoreProperties, 
TestSolrCloudSnapshots, StatelessScriptUpdateProcessorFactoryTest, 
TestCloudSchemaless, TestUtilizeNode, DistributedQueryElevationComponentTest, 
BaseCdcrDistributedZkTest, TestReplicationHandler, TestStressVersions, 
TestInitQParser, TestCoreBackup, DeleteInactiveReplicaTest, TestPushWriter, 
TestDistributedGrouping, TestRealTimeGet, TestJoin, SolrCmdDistributorTest, 
ConvertedLegacyTest, TestSort, TestBadConfig, ShowFileRequestHandlerTest, 
TestCoreDiscovery, SuggesterFSTTest, CoreAdminHandlerTest, TestStressLucene, 
TestTrie, TestCSVLoader, PolyFieldTest, SchemaVersionSpecificBehaviorTest, 
SolrCoreCheckLockOnStartupTest, TestPseudoReturnFields, TestUpdate, 
FieldMutatingUpdateProcessorTest, TestRemoteStreaming, SolrInfoBeanTest, 
TestSurroundQueryParser, TestWriterPerf, TestQueryTypes, 
FileBasedSpellCheckerTest, RequestHandlersTest, 
PathHierarchyTokenizerFactoryTest, TestIndexingPerformance, 
IndexSchemaRuntimeFieldTest, TestCSVResponseWriter, MBeansHandlerTest, 
HighlighterConfigTest, SOLR749Test, TestQuerySenderNoQuery, BadComponentTest, 
TestStressRecovery, TestMergePolicyConfig, TestSolrDeletionPolicy2, 
MultiTermTest, SampleTest, TestDocSet, TestBinaryField, NumericFieldsTest, 
MinimalSchemaTest, TestElisionMultitermQuery, TestConfig, OutputWriterTest, 
ExternalFileFieldSortTest, TestSolrCoreProperties, DirectSolrConnectionTest, 
NotRequiredUniqueKeyTest, TestLuceneMatchVersion, TestPhraseSuggestions, 
SpellPossibilityIteratorTest, TestCharFilters, EchoParamsTest, 
TestDFRSimilarityFactory, TestLMDirichletSimilarityFactory, 
TestBM25SimilarityFactory, TestFastWriter, TimeZoneUtilsTest, 
TestFastOutputStream, ScriptEngineTest, OpenExchangeRatesOrgProviderTest, 
PluginInfoTest, DateMathParserTest, ChaosMonkeyNothingIsSafeTest, 
CollectionsAPIAsyncDistributedZkTest, DeleteNodeTest, DeleteShardTest, 
DeleteStatusTest, DistribJoinFromCollectionTest, 
LeaderFailureAfterFreshStartTest, MultiThreadedOCPTest, RemoteQueryErrorTest, 
ReplaceNodeTest, ShardSplitTest]
   [junit4] Completed [668/751 (2!)] on J0 in 884.45s, 5 tests, 1 error <<< 
FAILURES!

[...truncated 43426 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to