Build: https://builds.apache.org/job/Lucene-Solr-Tests-7.x/218/

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

Error Message:
org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting 
response from server at: http://127.0.0.1:46787/c8n_1x3_lf_shard1_replica_n2

Stack Trace:
org.apache.solr.client.solrj.SolrServerException: 
org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting 
response from server at: http://127.0.0.1:46787/c8n_1x3_lf_shard1_replica_n2
        at 
__randomizedtesting.SeedInfo.seed([EA9FDB590618BC3B:62CBE483A8E4D1C3]:0)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.directUpdate(CloudSolrClient.java:557)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1008)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:875)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:808)
        at 
org.apache.solr.cloud.AbstractFullDistribZkTestBase.sendDocsWithRetry(AbstractFullDistribZkTestBase.java:796)
        at 
org.apache.solr.cloud.AbstractFullDistribZkTestBase.sendDocsWithRetry(AbstractFullDistribZkTestBase.java:784)
        at 
org.apache.solr.cloud.LeaderFailoverAfterPartitionTest.testRf3WithLeaderFailover(LeaderFailoverAfterPartitionTest.java:177)
        at 
org.apache.solr.cloud.LeaderFailoverAfterPartitionTest.test(LeaderFailoverAfterPartitionTest.java:56)
        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: org.apache.solr.client.solrj.SolrServerException: Timeout occured 
while waiting response from server at: 
http://127.0.0.1:46787/c8n_1x3_lf_shard1_replica_n2
        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.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.directUpdate(CloudSolrClient.java:551)
        ... 48 more
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)
        ... 53 more


FAILED:  org.apache.solr.cloud.autoscaling.TriggerIntegrationTest.testEventQueue

Error Message:
action wasn't interrupted

Stack Trace:
java.lang.AssertionError: action wasn't interrupted
        at 
__randomizedtesting.SeedInfo.seed([EA9FDB590618BC3B:232A99F70F7F7ACE]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.assertTrue(Assert.java:43)
        at 
org.apache.solr.cloud.autoscaling.TriggerIntegrationTest.testEventQueue(TriggerIntegrationTest.java:689)
        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 
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 11793 lines...]
   [junit4] Suite: org.apache.solr.cloud.LeaderFailoverAfterPartitionTest
   [junit4]   2> Creating dataDir: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderFailoverAfterPartitionTest_EA9FDB590618BC3B-001/init-core-data-001
   [junit4]   2> 747967 WARN  
(SUITE-LeaderFailoverAfterPartitionTest-seed#[EA9FDB590618BC3B]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=5 numCloses=5
   [junit4]   2> 747967 INFO  
(SUITE-LeaderFailoverAfterPartitionTest-seed#[EA9FDB590618BC3B]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 747968 INFO  
(SUITE-LeaderFailoverAfterPartitionTest-seed#[EA9FDB590618BC3B]-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> 747968 INFO  
(SUITE-LeaderFailoverAfterPartitionTest-seed#[EA9FDB590618BC3B]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 747968 INFO  
(SUITE-LeaderFailoverAfterPartitionTest-seed#[EA9FDB590618BC3B]-worker) [    ] 
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /
   [junit4]   2> 748039 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 748058 INFO  (Thread-748) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 748058 INFO  (Thread-748) [    ] o.a.s.c.ZkTestServer Starting 
server
   [junit4]   2> 748167 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.c.ZkTestServer start zk server on port:40719
   [junit4]   2> 748176 ERROR (Thread-748) [    ] 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> 748439 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
 to /configs/conf1/solrconfig.xml
   [junit4]   2> 748455 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/conf/schema.xml
 to /configs/conf1/schema.xml
   [junit4]   2> 748473 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
 to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 748474 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
 to /configs/conf1/stopwords.txt
   [junit4]   2> 748474 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/conf/protwords.txt
 to /configs/conf1/protwords.txt
   [junit4]   2> 748475 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/conf/currency.xml
 to /configs/conf1/currency.xml
   [junit4]   2> 748509 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
 to /configs/conf1/enumsConfig.xml
   [junit4]   2> 748510 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
 to /configs/conf1/open-exchange-rates.json
   [junit4]   2> 748511 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
 to /configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 748511 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
 to /configs/conf1/old_synonyms.txt
   [junit4]   2> 748526 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
 to /configs/conf1/synonyms.txt
   [junit4]   2> 748533 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.c.AbstractFullDistribZkTestBase Will use NRT replicas unless explicitly 
asked otherwise
   [junit4]   2> 750336 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 750424 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@7c4ef263{/,null,AVAILABLE}
   [junit4]   2> 750474 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@5c4a62{HTTP/1.1,[http/1.1]}{127.0.0.1:34618}
   [junit4]   2> 750474 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.e.j.s.Server Started @762937ms
   [junit4]   2> 750474 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderFailoverAfterPartitionTest_EA9FDB590618BC3B-001/tempDir-001/control/data,
 hostContext=/, hostPort=45033, 
coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderFailoverAfterPartitionTest_EA9FDB590618BC3B-001/control-001/cores}
   [junit4]   2> 750474 ERROR 
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 750474 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.2.0
   [junit4]   2> 750474 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 750474 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 750475 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-11-04T11:55:03.862Z
   [junit4]   2> 750612 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in 
ZooKeeper)
   [junit4]   2> 750612 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderFailoverAfterPartitionTest_EA9FDB590618BC3B-001/control-001/solr.xml
   [junit4]   2> 750650 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay 
is ignored
   [junit4]   2> 750650 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 756644 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@2d474cb5, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 756751 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:40719/solr
   [junit4]   2> 757596 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) 
[n:127.0.0.1:45033_    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 757608 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) 
[n:127.0.0.1:45033_    ] o.a.s.c.OverseerElectionContext I am going to be the 
leader 127.0.0.1:45033_
   [junit4]   2> 757609 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) 
[n:127.0.0.1:45033_    ] o.a.s.c.Overseer Overseer 
(id=98946023521583108-127.0.0.1:45033_-n_0000000000) starting
   [junit4]   2> 757694 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) 
[n:127.0.0.1:45033_    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:45033_
   [junit4]   2> 757767 INFO  
(OverseerStateUpdate-98946023521583108-127.0.0.1:45033_-n_0000000000) 
[n:127.0.0.1:45033_    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 758032 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) 
[n:127.0.0.1:45033_    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@2d474cb5
   [junit4]   2> 758069 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) 
[n:127.0.0.1:45033_    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@2d474cb5
   [junit4]   2> 758069 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) 
[n:127.0.0.1:45033_    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@2d474cb5
   [junit4]   2> 758070 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) 
[n:127.0.0.1:45033_    ] o.a.s.c.CorePropertiesLocator Found 0 core definitions 
underneath 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderFailoverAfterPartitionTest_EA9FDB590618BC3B-001/control-001/cores
   [junit4]   2> 758455 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 758455 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:40719/solr ready
   [junit4]   2> 758471 INFO  (SocketProxy-Acceptor-45033) [    ] 
o.a.s.c.SocketProxy accepted 
Socket[addr=/127.0.0.1,port=57728,localport=45033], receiveBufferSize:531000
   [junit4]   2> 758528 INFO  (SocketProxy-Acceptor-45033) [    ] 
o.a.s.c.SocketProxy proxy connection 
Socket[addr=/127.0.0.1,port=34618,localport=59186], receiveBufferSize=530904
   [junit4]   2> 758545 INFO  (qtp1073813646-2126) [n:127.0.0.1:45033_    ] 
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:45033_&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 758638 INFO  
(OverseerThreadFactory-1071-thread-1-processing-n:127.0.0.1:45033_) 
[n:127.0.0.1:45033_    ] o.a.s.c.CreateCollectionCmd Create collection 
control_collection
   [junit4]   2> 758749 INFO  (SocketProxy-Acceptor-45033) [    ] 
o.a.s.c.SocketProxy accepted 
Socket[addr=/127.0.0.1,port=57732,localport=45033], receiveBufferSize:531000
   [junit4]   2> 758750 INFO  (SocketProxy-Acceptor-45033) [    ] 
o.a.s.c.SocketProxy proxy connection 
Socket[addr=/127.0.0.1,port=34618,localport=59190], receiveBufferSize=530904
   [junit4]   2> 758776 INFO  (qtp1073813646-2124) [n:127.0.0.1:45033_    ] 
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> 758776 INFO  (qtp1073813646-2124) [n:127.0.0.1:45033_    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 759069 INFO  
(zkCallback-247-thread-1-processing-n:127.0.0.1:45033_) [n:127.0.0.1:45033_    
] 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> 760174 INFO  (qtp1073813646-2124) [n:127.0.0.1:45033_ 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.2.0
   [junit4]   2> 760283 INFO  (qtp1073813646-2124) [n:127.0.0.1:45033_ 
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> 764972 INFO  (qtp1073813646-2124) [n:127.0.0.1:45033_ 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 765082 INFO  (qtp1073813646-2124) [n:127.0.0.1:45033_ 
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> 765082 INFO  (qtp1073813646-2124) [n:127.0.0.1:45033_ 
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@2d474cb5
   [junit4]   2> 765083 INFO  (qtp1073813646-2124) [n:127.0.0.1:45033_ 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 765116 INFO  (qtp1073813646-2124) [n:127.0.0.1:45033_ 
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/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderFailoverAfterPartitionTest_EA9FDB590618BC3B-001/control-001/cores/control_collection_shard1_replica_n1],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderFailoverAfterPartitionTest_EA9FDB590618BC3B-001/control-001/cores/control_collection_shard1_replica_n1/data/]
   [junit4]   2> 765119 INFO  (qtp1073813646-2124) [n:127.0.0.1:45033_ 
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=40, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.2779659765120155]
   [junit4]   2> 765135 WARN  (qtp1073813646-2124) [n:127.0.0.1:45033_ 
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> 765482 INFO  (qtp1073813646-2124) [n:127.0.0.1:45033_ 
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> 765482 INFO  (qtp1073813646-2124) [n:127.0.0.1:45033_ 
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> 765483 INFO  (qtp1073813646-2124) [n:127.0.0.1:45033_ 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 765483 INFO  (qtp1073813646-2124) [n:127.0.0.1:45033_ 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 765484 INFO  (qtp1073813646-2124) [n:127.0.0.1:45033_ 
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=32, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.8985562952811531]
   [junit4]   2> 765485 INFO  (qtp1073813646-2124) [n:127.0.0.1:45033_ 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@216acc6f[control_collection_shard1_replica_n1] main]
   [junit4]   2> 765499 INFO  (qtp1073813646-2124) [n:127.0.0.1:45033_ 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf1
   [junit4]   2> 765499 INFO  (qtp1073813646-2124) [n:127.0.0.1:45033_ 
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> 765500 INFO  (qtp1073813646-2124) [n:127.0.0.1:45033_ 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 765516 INFO  
(searcherExecutor-1074-thread-1-processing-n:127.0.0.1:45033_ 
x:control_collection_shard1_replica_n1 s:shard1 c:control_collection) 
[n:127.0.0.1:45033_ 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@216acc6f[control_collection_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 765519 INFO  (qtp1073813646-2124) [n:127.0.0.1:45033_ 
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 1583136394608377856
   [junit4]   2> 765522 INFO  (qtp1073813646-2124) [n:127.0.0.1:45033_ 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 765522 INFO  (qtp1073813646-2124) [n:127.0.0.1:45033_ 
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> 765522 INFO  (qtp1073813646-2124) [n:127.0.0.1:45033_ 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.c.SyncStrategy Sync replicas to 
http://127.0.0.1:45033/control_collection_shard1_replica_n1/
   [junit4]   2> 765522 INFO  (qtp1073813646-2124) [n:127.0.0.1:45033_ 
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> 765522 INFO  (qtp1073813646-2124) [n:127.0.0.1:45033_ 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1] 
o.a.s.c.SyncStrategy 
http://127.0.0.1:45033/control_collection_shard1_replica_n1/ has no replicas
   [junit4]   2> 765522 INFO  (qtp1073813646-2124) [n:127.0.0.1:45033_ 
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> 765572 INFO  (qtp1073813646-2124) [n:127.0.0.1:45033_ 
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:45033/control_collection_shard1_replica_n1/ shard1
   [junit4]   2> 765653 INFO  
(zkCallback-247-thread-2-processing-n:127.0.0.1:45033_) [n:127.0.0.1:45033_    
] 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> 765682 INFO  (qtp1073813646-2124) [n:127.0.0.1:45033_ 
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> 765683 INFO  (qtp1073813646-2124) [n:127.0.0.1:45033_ 
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=6907
   [junit4]   2> 765760 INFO  (qtp1073813646-2126) [n:127.0.0.1:45033_    ] 
o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 
30 seconds. Check all shard replicas
   [junit4]   2> 765889 INFO  
(zkCallback-247-thread-1-processing-n:127.0.0.1:45033_) [n:127.0.0.1:45033_    
] 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> 766564 INFO  
(OverseerCollectionConfigSetProcessor-98946023521583108-127.0.0.1:45033_-n_0000000000)
 [n:127.0.0.1:45033_    ] 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> 766763 INFO  (qtp1073813646-2126) [n:127.0.0.1:45033_    ] 
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:45033_&wt=javabin&version=2}
 status=0 QTime=8218
   [junit4]   2> 766803 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 766804 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:40719/solr ready
   [junit4]   2> 766804 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection 
loss:false
   [junit4]   2> 766837 INFO  (SocketProxy-Acceptor-45033) [    ] 
o.a.s.c.SocketProxy accepted 
Socket[addr=/127.0.0.1,port=57740,localport=45033], receiveBufferSize:531000
   [junit4]   2> 766857 INFO  (SocketProxy-Acceptor-45033) [    ] 
o.a.s.c.SocketProxy proxy connection 
Socket[addr=/127.0.0.1,port=34618,localport=59198], receiveBufferSize=530904
   [junit4]   2> 766858 INFO  (qtp1073813646-2127) [n:127.0.0.1:45033_    ] 
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> 766930 INFO  
(OverseerThreadFactory-1071-thread-2-processing-n:127.0.0.1:45033_) 
[n:127.0.0.1:45033_    ] o.a.s.c.CreateCollectionCmd Create collection 
collection1
   [junit4]   2> 766983 WARN  
(OverseerThreadFactory-1071-thread-2-processing-n:127.0.0.1:45033_) 
[n:127.0.0.1:45033_    ] o.a.s.c.CreateCollectionCmd It is unusual to create a 
collection (collection1) without cores.
   [junit4]   2> 767264 INFO  (qtp1073813646-2127) [n:127.0.0.1:45033_    ] 
o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 
30 seconds. Check all shard replicas
   [junit4]   2> 767264 INFO  (qtp1073813646-2127) [n:127.0.0.1:45033_    ] 
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=406
   [junit4]   2> 768947 INFO  
(OverseerCollectionConfigSetProcessor-98946023521583108-127.0.0.1:45033_-n_0000000000)
 [n:127.0.0.1:45033_    ] 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> 769090 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderFailoverAfterPartitionTest_EA9FDB590618BC3B-001/shard-1-001
 of type NRT
   [junit4]   2> 769091 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 769166 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@65d2427a{/,null,AVAILABLE}
   [junit4]   2> 769166 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@2710ac7b{HTTP/1.1,[http/1.1]}{127.0.0.1:34949}
   [junit4]   2> 769166 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.e.j.s.Server Started @781629ms
   [junit4]   2> 769166 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderFailoverAfterPartitionTest_EA9FDB590618BC3B-001/tempDir-001/jetty1,
 solrconfig=solrconfig.xml, hostContext=/, hostPort=46787, 
coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderFailoverAfterPartitionTest_EA9FDB590618BC3B-001/shard-1-001/cores}
   [junit4]   2> 769166 ERROR 
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 769166 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.2.0
   [junit4]   2> 769216 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 769216 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 769216 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-11-04T11:55:22.603Z
   [junit4]   2> 769391 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in 
ZooKeeper)
   [junit4]   2> 769391 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderFailoverAfterPartitionTest_EA9FDB590618BC3B-001/shard-1-001/solr.xml
   [junit4]   2> 769437 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay 
is ignored
   [junit4]   2> 769437 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 769438 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@2d474cb5, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 769494 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:40719/solr
   [junit4]   2> 769731 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) 
[n:127.0.0.1:46787_    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 769749 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) 
[n:127.0.0.1:46787_    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 769750 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) 
[n:127.0.0.1:46787_    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:46787_
   [junit4]   2> 769751 INFO  (zkCallback-255-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 769858 INFO  
(zkCallback-247-thread-2-processing-n:127.0.0.1:45033_) [n:127.0.0.1:45033_    
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 769932 INFO  
(zkCallback-260-thread-1-processing-n:127.0.0.1:46787_) [n:127.0.0.1:46787_    
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 770556 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) 
[n:127.0.0.1:46787_    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@2d474cb5
   [junit4]   2> 770608 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) 
[n:127.0.0.1:46787_    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@2d474cb5
   [junit4]   2> 770609 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) 
[n:127.0.0.1:46787_    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@2d474cb5
   [junit4]   2> 770627 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) 
[n:127.0.0.1:46787_    ] o.a.s.c.CorePropertiesLocator Found 0 core definitions 
underneath 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderFailoverAfterPartitionTest_EA9FDB590618BC3B-001/shard-1-001/cores
   [junit4]   2> 776725 WARN  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]-SendThread(127.0.0.1:40719))
 [    ] o.a.z.ClientCnxn Client session timed out, have not heard from server 
in 6974ms for sessionid 0x15f86e257f10006
   [junit4]   2> 776742 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 0x15f86e257f10006, 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> 776833 INFO  (qtp1073813646-2123) [n:127.0.0.1:45033_    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with params 
node=127.0.0.1:46787_&action=ADDREPLICA&collection=collection1&shard=shard2&type=NRT&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 776835 INFO  
(OverseerThreadFactory-1071-thread-3-processing-n:127.0.0.1:45033_) 
[n:127.0.0.1:45033_    ] o.a.s.c.AddReplicaCmd Node Identified 127.0.0.1:46787_ 
for creating new replica
   [junit4]   2> 776869 WARN  (zkCallback-255-thread-3) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@7c094b8c name: 
ZooKeeperConnection Watcher:127.0.0.1:40719/solr got event WatchedEvent 
state:Disconnected type:None path:null path: null type: None
   [junit4]   2> 776869 WARN  (zkCallback-255-thread-3) [    ] 
o.a.s.c.c.ConnectionManager zkClient has disconnected
   [junit4]   2> 776877 INFO  (SocketProxy-Acceptor-46787) [    ] 
o.a.s.c.SocketProxy accepted 
Socket[addr=/127.0.0.1,port=44554,localport=46787], receiveBufferSize:531000
   [junit4]   2> 776922 INFO  (SocketProxy-Acceptor-46787) [    ] 
o.a.s.c.SocketProxy proxy connection 
Socket[addr=/127.0.0.1,port=34949,localport=48596], receiveBufferSize=530904
   [junit4]   2> 776959 INFO  (qtp1317127777-2180) [n:127.0.0.1:46787_    ] 
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> 776960 INFO  (qtp1317127777-2180) [n:127.0.0.1:46787_    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 778096 INFO  (qtp1317127777-2180) [n:127.0.0.1:46787_ 
c:collection1 s:shard2  x:collection1_shard2_replica_n41] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 7.2.0
   [junit4]   2> 778281 INFO  (qtp1317127777-2180) [n:127.0.0.1:46787_ 
c:collection1 s:shard2  x:collection1_shard2_replica_n41] o.a.s.s.IndexSchema 
[collection1_shard2_replica_n41] Schema name=test
   [junit4]   2> 785103 INFO  (qtp1317127777-2180) [n:127.0.0.1:46787_ 
c:collection1 s:shard2  x:collection1_shard2_replica_n41] o.a.s.s.IndexSchema 
Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 785199 INFO  (qtp1317127777-2180) [n:127.0.0.1:46787_ 
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> 785212 INFO  (qtp1317127777-2180) [n:127.0.0.1:46787_ 
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@2d474cb5
   [junit4]   2> 785212 INFO  (qtp1317127777-2180) [n:127.0.0.1:46787_ 
c:collection1 s:shard2  x:collection1_shard2_replica_n41] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 785212 INFO  (qtp1317127777-2180) [n:127.0.0.1:46787_ 
c:collection1 s:shard2  x:collection1_shard2_replica_n41] o.a.s.c.SolrCore 
[[collection1_shard2_replica_n41] ] Opening new SolrCore at 
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderFailoverAfterPartitionTest_EA9FDB590618BC3B-001/shard-1-001/cores/collection1_shard2_replica_n41],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderFailoverAfterPartitionTest_EA9FDB590618BC3B-001/shard-1-001/cores/collection1_shard2_replica_n41/data/]
   [junit4]   2> 785232 INFO  (qtp1317127777-2180) [n:127.0.0.1:46787_ 
c:collection1 s:shard2  x:collection1_shard2_replica_n41] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=40, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.2779659765120155]
   [junit4]   2> 785270 WARN  (qtp1317127777-2180) [n:127.0.0.1:46787_ 
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> 785631 INFO  (qtp1317127777-2180) [n:127.0.0.1:46787_ 
c:collection1 s:shard2  x:collection1_shard2_replica_n41] o.a.s.u.UpdateHandler 
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 785631 INFO  (qtp1317127777-2180) [n:127.0.0.1:46787_ 
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> 785632 INFO  (qtp1317127777-2180) [n:127.0.0.1:46787_ 
c:collection1 s:shard2  x:collection1_shard2_replica_n41] o.a.s.u.CommitTracker 
Hard AutoCommit: disabled
   [junit4]   2> 785632 INFO  (qtp1317127777-2180) [n:127.0.0.1:46787_ 
c:collection1 s:shard2  x:collection1_shard2_replica_n41] o.a.s.u.CommitTracker 
Soft AutoCommit: disabled
   [junit4]   2> 785633 INFO  (qtp1317127777-2180) [n:127.0.0.1:46787_ 
c:collection1 s:shard2  x:collection1_shard2_replica_n41] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=32, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.8985562952811531]
   [junit4]   2> 785633 INFO  (qtp1317127777-2180) [n:127.0.0.1:46787_ 
c:collection1 s:shard2  x:collection1_shard2_replica_n41] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@1d3cdb50[collection1_shard2_replica_n41] main]
   [junit4]   2> 785643 INFO  (qtp1317127777-2180) [n:127.0.0.1:46787_ 
c:collection1 s:shard2  x:collection1_shard2_replica_n41] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf1
   [junit4]   2> 785644 INFO  (qtp1317127777-2180) [n:127.0.0.1:46787_ 
c:collection1 s:shard2  x:collection1_shard2_replica_n41] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 785644 INFO  (qtp1317127777-2180) [n:127.0.0.1:46787_ 
c:collection1 s:shard2  x:collection1_shard2_replica_n41] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 785644 INFO  (qtp1317127777-2180) [n:127.0.0.1:46787_ 
c:collection1 s:shard2  x:collection1_shard2_replica_n41] o.a.s.u.UpdateLog 
Could not find max version in index or recent updates, using new clock 
1583136415710969856
   [junit4]   2> 785717 INFO  (qtp1317127777-2180) [n:127.0.0.1:46787_ 
c:collection1 s:shard2  x:collection1_shard2_replica_n41] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 785717 INFO  (qtp1317127777-2180) [n:127.0.0.1:46787_ 
c:collection1 s:shard2  x:collection1_shard2_replica_n41] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 785717 INFO  (qtp1317127777-2180) [n:127.0.0.1:46787_ 
c:collection1 s:shard2  x:collection1_shard2_replica_n41] o.a.s.c.SyncStrategy 
Sync replicas to http://127.0.0.1:46787/collection1_shard2_replica_n41/
   [junit4]   2> 785717 INFO  (qtp1317127777-2180) [n:127.0.0.1:46787_ 
c:collection1 s:shard2  x:collection1_shard2_replica_n41] o.a.s.c.SyncStrategy 
Sync Success - now sync replicas to me
   [junit4]   2> 785718 INFO  (qtp1317127777-2180) [n:127.0.0.1:46787_ 
c:collection1 s:shard2  x:collection1_shard2_replica_n41] o.a.s.c.SyncStrategy 
http://127.0.0.1:46787/collection1_shard2_replica_n41/ has no replicas
   [junit4]   2> 785718 INFO  (qtp1317127777-2180) [n:127.0.0.1:46787_ 
c:collection1 s:shard2  x:collection1_shard2_replica_n41] 
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in 
election, clear LIR
   [junit4]   2> 785720 INFO  (qtp1317127777-2180) [n:127.0.0.1:46787_ 
c:collection1 s:shard2  x:collection1_shard2_replica_n41] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:46787/collection1_shard2_replica_n41/ shard2
   [junit4]   2> 785725 INFO  
(searcherExecutor-1085-thread-1-processing-n:127.0.0.1:46787_ 
x:collection1_shard2_replica_n41 s:shard2 c:collection1) [n:127.0.0.1:46787_ 
c:collection1 s:shard2  x:collection1_shard2_replica_n41] o.a.s.c.SolrCore 
[collection1_shard2_replica_n41] Registered new searcher 
Searcher@1d3cdb50[collection1_shard2_replica_n41] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 785826 INFO  (qtp1317127777-2180) [n:127.0.0.1:46787_ 
c:collection1 s:shard2  x:collection1_shard2_replica_n41] o.a.s.c.ZkController 
I am the leader, no recovery necessary
   [junit4]   2> 785827 INFO  (qtp1317127777-2180) [n:127.0.0.1:46787_ 
c:collection1 s:shard2  x:collection1_shard2_replica_n41] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&collection.configName=conf1&name=collection1_shard2_replica_n41&action=CREATE&collection=collection1&shard=shard2&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=8867
   [junit4]   2> 785844 INFO  (qtp1073813646-2123) [n:127.0.0.1:45033_    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={node=127.0.0.1:46787_&action=ADDREPLICA&collection=collection1&shard=shard2&type=NRT&wt=javabin&version=2}
 status=0 QTime=9011
   [junit4]   2> 786810 INFO  
(OverseerCollectionConfigSetProcessor-98946023521583108-127.0.0.1:45033_-n_0000000000)
 [n:127.0.0.1:45033_    ] o.a.s.c.OverseerTaskQueue Response ZK path: 
/overseer/collection-queue-work/qnr-0000000004 doesn't exist.  Requestor may 
have disconnected from ZooKeeper
   [junit4]   2> 787030 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.c.AbstractFullDistribZkTestBase create jetty 2 in directory 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderFailoverAfterPartitionTest_EA9FDB590618BC3B-001/shard-2-001
 of type NRT
   [junit4]   2> 787031 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 787140 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@2d81f8c{/,null,AVAILABLE}
   [junit4]   2> 787140 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@7575dc2c{HTTP/1.1,[http/1.1]}{127.0.0.1:39497}
   [junit4]   2> 787140 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.e.j.s.Server Started @799603ms
   [junit4]   2> 787140 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderFailoverAfterPartitionTest_EA9FDB590618BC3B-001/tempDir-001/jetty2,
 solrconfig=solrconfig.xml, hostContext=/, hostPort=44329, 
coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderFailoverAfterPartitionTest_EA9FDB590618BC3B-001/shard-2-001/cores}
   [junit4]   2> 787140 ERROR 
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 787141 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.2.0
   [junit4]   2> 787141 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 787141 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 787141 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-11-04T11:55:40.528Z
   [junit4]   2> 787162 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in 
ZooKeeper)
   [junit4]   2> 787162 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderFailoverAfterPartitionTest_EA9FDB590618BC3B-001/shard-2-001/solr.xml
   [junit4]   2> 787198 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay 
is ignored
   [junit4]   2> 787198 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 787199 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@2d474cb5, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 787334 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:40719/solr
   [junit4]   2> 787445 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) 
[n:127.0.0.1:44329_    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (2)
   [junit4]   2> 787447 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) 
[n:127.0.0.1:44329_    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 787481 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) 
[n:127.0.0.1:44329_    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:44329_
   [junit4]   2> 787482 INFO  (zkCallback-255-thread-3) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 787482 INFO  
(zkCallback-260-thread-1-processing-n:127.0.0.1:46787_) [n:127.0.0.1:46787_    
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 787517 INFO  
(zkCallback-247-thread-1-processing-n:127.0.0.1:45033_) [n:127.0.0.1:45033_    
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 787517 INFO  
(zkCallback-266-thread-1-processing-n:127.0.0.1:44329_) [n:127.0.0.1:44329_    
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 787958 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) 
[n:127.0.0.1:44329_    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@2d474cb5
   [junit4]   2> 788067 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) 
[n:127.0.0.1:44329_    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@2d474cb5
   [junit4]   2> 788067 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) 
[n:127.0.0.1:44329_    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@2d474cb5
   [junit4]   2> 788102 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) 
[n:127.0.0.1:44329_    ] o.a.s.c.CorePropertiesLocator Found 0 core definitions 
underneath 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderFailoverAfterPartitionTest_EA9FDB590618BC3B-001/shard-2-001/cores
   [junit4]   2> 788557 INFO  (SocketProxy-Acceptor-44329) [    ] 
o.a.s.c.SocketProxy accepted 
Socket[addr=/127.0.0.1,port=50102,localport=44329], receiveBufferSize:531000
   [junit4]   2> 788595 INFO  (SocketProxy-Acceptor-44329) [    ] 
o.a.s.c.SocketProxy proxy connection 
Socket[addr=/127.0.0.1,port=39497,localport=49152], receiveBufferSize=530904
   [junit4]   2> 788631 INFO  (qtp1640265028-2217) [n:127.0.0.1:44329_    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with params 
node=127.0.0.1:44329_&action=ADDREPLICA&collection=collection1&shard=shard1&type=NRT&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 788704 INFO  
(OverseerThreadFactory-1071-thread-4-processing-n:127.0.0.1:45033_) 
[n:127.0.0.1:45033_    ] o.a.s.c.AddReplicaCmd Node Identified 127.0.0.1:44329_ 
for creating new replica
   [junit4]   2> 788705 INFO  (SocketProxy-Acceptor-44329) [    ] 
o.a.s.c.SocketProxy accepted 
Socket[addr=/127.0.0.1,port=50106,localport=44329], receiveBufferSize:531000
   [junit4]   2> 788706 INFO  (SocketProxy-Acceptor-44329) [    ] 
o.a.s.c.SocketProxy proxy connection 
Socket[addr=/127.0.0.1,port=39497,localport=49156], receiveBufferSize=530904
   [junit4]   2> 788814 INFO  (qtp1640265028-2215) [n:127.0.0.1:44329_    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=conf1&name=collection1_shard1_replica_n43&action=CREATE&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 788814 INFO  (qtp1640265028-2215) [n:127.0.0.1:44329_    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 788997 INFO  (qtp1640265028-2215) [n:127.0.0.1:44329_ 
c:collection1 s:shard1  x:collection1_shard1_replica_n43] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 7.2.0
   [junit4]   2> 789362 INFO  (qtp1640265028-2215) [n:127.0.0.1:44329_ 
c:collection1 s:shard1  x:collection1_shard1_replica_n43] o.a.s.s.IndexSchema 
[collection1_shard1_replica_n43] Schema name=test
   [junit4]   2> 803780 INFO  (qtp1640265028-2215) [n:127.0.0.1:44329_ 
c:collection1 s:shard1  x:collection1_shard1_replica_n43] o.a.s.s.IndexSchema 
Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 803779 WARN  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]-SendThread(127.0.0.1:40719))
 [n:127.0.0.1:44329_    ] o.a.z.ClientCnxn Client session timed out, have not 
heard from server in 13832ms for sessionid 0x15f86e257f1000c
   [junit4]   2> 803801 WARN  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]-SendThread(127.0.0.1:40719))
 [n:127.0.0.1:45033_    ] o.a.z.ClientCnxn Client session timed out, have not 
heard from server in 14862ms for sessionid 0x15f86e257f10004
   [junit4]   2> 803801 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 0x15f86e257f1000c, 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> 803801 WARN  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]-SendThread(127.0.0.1:40719))
 [    ] o.a.z.ClientCnxn Client session timed out, have not heard from server 
in 14971ms for sessionid 0x15f86e257f10006
   [junit4]   2> 803801 WARN  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]-SendThread(127.0.0.1:40719))
 [n:127.0.0.1:46787_    ] o.a.z.ClientCnxn Client session timed out, have not 
heard from server in 14971ms for sessionid 0x15f86e257f10009
   [junit4]   2> 803966 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 0x15f86e257f10009, 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> 803966 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 0x15f86e257f10004, 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> 803959 WARN  
(zkCallback-266-thread-2-processing-n:127.0.0.1:44329_) [n:127.0.0.1:44329_    
] o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@1d14d0fc name: 
ZooKeeperConnection Watcher:127.0.0.1:40719/solr got event WatchedEvent 
state:Disconnected type:None path:null path: null type: None
   [junit4]   2> 803976 WARN  
(zkCallback-266-thread-2-processing-n:127.0.0.1:44329_) [n:127.0.0.1:44329_    
] o.a.s.c.c.ConnectionManager zkClient has disconnected
   [junit4]   2> 804008 WARN  
(zkCallback-247-thread-3-processing-n:127.0.0.1:45033_) [n:127.0.0.1:45033_    
] o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@1d1dd0e9 name: 
ZooKeeperConnection Watcher:127.0.0.1:40719/solr got event WatchedEvent 
state:Disconnected type:None path:null path: null type: None
   [junit4]   2> 804008 WARN  
(zkCallback-247-thread-3-processing-n:127.0.0.1:45033_) [n:127.0.0.1:45033_    
] o.a.s.c.c.ConnectionManager zkClient has disconnected
   [junit4]   2> 804020 WARN  
(zkCallback-260-thread-1-processing-n:127.0.0.1:46787_) [n:127.0.0.1:46787_    
] o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@1b6013a7 name: 
ZooKeeperConnection Watcher:127.0.0.1:40719/solr got event WatchedEvent 
state:Disconnected type:None path:null path: null type: None
   [junit4]   2> 804020 WARN  
(zkCallback-260-thread-1-processing-n:127.0.0.1:46787_) [n:127.0.0.1:46787_    
] o.a.s.c.c.ConnectionManager zkClient has disconnected
   [junit4]   2> 804037 WARN  (zkCallback-255-thread-2) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@7c094b8c name: 
ZooKeeperConnection Watcher:127.0.0.1:40719/solr got event WatchedEvent 
state:Disconnected type:None path:null path: null type: None
   [junit4]   2> 804037 WARN  (zkCallback-255-thread-2) [    ] 
o.a.s.c.c.ConnectionManager zkClient has disconnected
   [junit4]   2> 805695 INFO  (qtp1640265028-2215) [n:127.0.0.1:44329_ 
c:collection1 s:shard1  x:collection1_shard1_replica_n43] o.a.s.c.CoreContainer 
Creating SolrCore 'collection1_shard1_replica_n43' using configuration from 
collection collection1, trusted=true
   [junit4]   2> 805731 WARN  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]-SendThread(127.0.0.1:40719))
 [    ] o.a.z.ClientCnxn Unable to reconnect to ZooKeeper service, session 
0x15f86e257f10006 has expired
   [junit4]   2> 805731 INFO  (qtp1640265028-2215) [n:127.0.0.1:44329_ 
c:collection1 s:shard1  x:collection1_shard1_replica_n43] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.core.collection1.shard1.replica_n43' (registry 
'solr.core.collection1.shard1.replica_n43') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@2d474cb5
   [junit4]   2> 805731 INFO  (qtp1640265028-2215) [n:127.0.0.1:44329_ 
c:collection1 s:shard1  x:collection1_shard1_replica_n43] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 805732 INFO  (qtp1640265028-2215) [n:127.0.0.1:44329_ 
c:collection1 s:shard1  x:collection1_shard1_replica_n43] o.a.s.c.SolrCore 
[[collection1_shard1_replica_n43] ] Opening new SolrCore at 
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderFailoverAfterPartitionTest_EA9FDB590618BC3B-001/shard-2-001/cores/collection1_shard1_replica_n43],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderFailoverAfterPartitionTest_EA9FDB590618BC3B-001/shard-2-001/cores/collection1_shard1_replica_n43/data/]
   [junit4]   2> 805741 WARN  (zkCallback-255-thread-3) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@7c094b8c name: 
ZooKeeperConnection Watcher:127.0.0.1:40719/solr got event WatchedEvent 
state:Expired type:None path:null path: null type: None
   [junit4]   2> 805741 WARN  (zkCallback-255-thread-3) [    ] 
o.a.s.c.c.ConnectionManager Our previous ZooKeeper session was expired. 
Attempting to reconnect to recover relationship with ZooKeeper...
   [junit4]   2> 805741 WARN  (zkCallback-255-thread-3) [    ] 
o.a.s.c.c.DefaultConnectionStrategy Connection expired - starting a new one...
   [junit4]   2> 805824 INFO  (qtp1640265028-2215) [n:127.0.0.1:44329_ 
c:collection1 s:shard1  x:collection1_shard1_replica_n43] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=40, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.2779659765120155]
   [junit4]   2> 805840 WARN  (qtp1640265028-2215) [n:127.0.0.1:44329_ 
c:collection1 s:shard1  x:collection1_shard1_replica_n43] 
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> 805866 INFO  (zkCallback-255-thread-3) [    ] 
o.a.s.c.c.ConnectionManager Connection with ZooKeeper reestablished.
   [junit4]   2> 805943 INFO  (zkCallback-255-thread-3) [    ] 
o.a.s.c.c.DefaultConnectionStrategy Reconnected to ZooKeeper
   [junit4]   2> 805943 INFO  (zkCallback-255-thread-3) [    ] 
o.a.s.c.c.ConnectionManager Connected:true
   [junit4]   2> 806270 INFO  (qtp1640265028-2215) [n:127.0.0.1:44329_ 
c:collection1 s:shard1  x:collection1_shard1_replica_n43] o.a.s.u.UpdateHandler 
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 806270 INFO  (qtp1640265028-2215) [n:127.0.0.1:44329_ 
c:collection1 s:shard1  x:collection1_shard1_replica_n43] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 
maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 806271 INFO  (qtp1640265028-2215) [n:127.0.0.1:44329_ 
c:collection1 s:shard1  x:collection1_shard1_replica_n43] o.a.s.u.CommitTracker 
Hard AutoCommit: disabled
   [junit4]   2> 806271 INFO  (qtp1640265028-2215) [n:127.0.0.1:44329_ 
c:collection1 s:shard1  x:collection1_shard1_replica_n43] o.a.s.u.CommitTracker 
Soft AutoCommit: disabled
   [junit4]   2> 806290 INFO  (qtp1640265028-2215) [n:127.0.0.1:44329_ 
c:collection1 s:shard1  x:collection1_shard1_replica_n43] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=32, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.8985562952811531]
   [junit4]   2> 806290 INFO  (qtp1640265028-2215) [n:127.0.0.1:44329_ 
c:collection1 s:shard1  x:collection1_shard1_replica_n43] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@3d582fb2[collection1_shard1_replica_n43] main]
   [junit4]   2> 806363 INFO  (qtp1640265028-2215) [n:127.0.0.1:44329_ 
c:collection1 s:shard1  x:collection1_shard1_replica_n43] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf1
   [junit4]   2> 806363 INFO  (qtp1640265028-2215) [n:127.0.0.1:44329_ 
c:collection1 s:shard1  x:collection1_shard1_replica_n43] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 806364 INFO  (qtp1640265028-2215) [n:127.0.0.1:44329_ 
c:collection1 s:shard1  x:collection1_shard1_replica_n43] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 806364 INFO  (qtp1640265028-2215) [n:127.0.0.1:44329_ 
c:collection1 s:shard1  x:collection1_shard1_replica_n43] o.a.s.u.UpdateLog 
Could not find max version in index or recent updates, using new clock 
1583136437437464576
   [junit4]   2> 806367 INFO  
(searcherExecutor-1096-thread-1-processing-n:127.0.0.1:44329_ 
x:collection1_shard1_replica_n43 s:shard1 c:collection1) [n:127.0.0.1:44329_ 
c:collection1 s:shard1  x:collection1_shard1_replica_n43] o.a.s.c.SolrCore 
[collection1_shard1_replica_n43] Registered new searcher 
Searcher@3d582fb2[collection1_shard1_replica_n43] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 806401 INFO  (qtp1640265028-2215) [n:127.0.0.1:44329_ 
c:collection1 s:shard1  x:collection1_shard1_replica_n43] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 806401 INFO  (qtp1640265028-2215) [n:127.0.0.1:44329_ 
c:collection1 s:shard1  x:collection1_shard1_replica_n43] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 806401 INFO  (qtp1640265028-2215) [n:127.0.0.1:44329_ 
c:collection1 s:shard1  x:collection1_shard1_replica_n43] o.a.s.c.SyncStrategy 
Sync replicas to http://127.0.0.1:44329/collection1_shard1_replica_n43/
   [junit4]   2> 806401 INFO  (qtp1640265028-2215) [n:127.0.0.1:44329_ 
c:collection1 s:shard1  x:collection1_shard1_replica_n43] o.a.s.c.SyncStrategy 
Sync Success - now sync replicas to me
   [junit4]   2> 806401 INFO  (qtp1640265028-2215) [n:127.0.0.1:44329_ 
c:collection1 s:shard1  x:collection1_shard1_replica_n43] o.a.s.c.SyncStrategy 
http://127.0.0.1:44329/collection1_shard1_replica_n43/ has no replicas
   [junit4]   2> 806401 INFO  (qtp1640265028-2215) [n:127.0.0.1:44329_ 
c:collection1 s:shard1  x:collection1_shard1_replica_n43] 
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in 
election, clear LIR
   [junit4]   2> 806436 INFO  (qtp1640265028-2215) [n:127.0.0.1:44329_ 
c:collection1 s:shard1  x:collection1_shard1_replica_n43] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:44329/collection1_shard1_replica_n43/ shard1
   [junit4]   2> 806509 INFO  (qtp1640265028-2215) [n:127.0.0.1:44329_ 
c:collection1 s:shard1  x:collection1_shard1_replica_n43] o.a.s.c.ZkController 
I am the leader, no recovery necessary
   [junit4]   2> 806511 INFO  (qtp1640265028-2215) [n:127.0.0.1:44329_ 
c:collection1 s:shard1  x:collection1_shard1_replica_n43] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&collection.configName=conf1&name=collection1_shard1_replica_n43&action=CREATE&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=17697
   [junit4]   2> 806588 INFO  (qtp1640265028-2217) [n:127.0.0.1:44329_    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={node=127.0.0.1:44329_&action=ADDREPLICA&collection=collection1&shard=shard1&type=NRT&wt=javabin&version=2}
 status=0 QTime=17956
   [junit4]   2> 807424 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.c.AbstractFullDistribZkTestBase create jetty 3 in directory 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderFailoverAfterPartitionTest_EA9FDB590618BC3B-001/shard-3-001
 of type NRT
   [junit4]   2> 807424 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 807541 INFO  
(OverseerCollectionConfigSetProcessor-98946023521583108-127.0.0.1:45033_-n_0000000000)
 [n:127.0.0.1:45033_    ] o.a.s.c.OverseerTaskQueue Response ZK path: 
/overseer/collection-queue-work/qnr-0000000006 doesn't exist.  Requestor may 
have disconnected from ZooKeeper
   [junit4]   2> 807643 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@57de6972{/,null,AVAILABLE}
   [junit4]   2> 807643 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@7c1a98d8{HTTP/1.1,[http/1.1]}{127.0.0.1:38308}
   [junit4]   2> 807643 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.e.j.s.Server Started @820105ms
   [junit4]   2> 807643 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderFailoverAfterPartitionTest_EA9FDB590618BC3B-001/tempDir-001/jetty3,
 replicaType=NRT, solrconfig=solrconfig.xml, hostContext=/, hostPort=34505, 
coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderFailoverAfterPartitionTest_EA9FDB590618BC3B-001/shard-3-001/cores}
   [junit4]   2> 807643 ERROR 
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 807643 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.2.0
   [junit4]   2> 807643 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 807643 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 807643 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-11-04T11:56:01.030Z
   [junit4]   2> 807754 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in 
ZooKeeper)
   [junit4]   2> 807754 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderFailoverAfterPartitionTest_EA9FDB590618BC3B-001/shard-3-001/solr.xml
   [junit4]   2> 807811 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay 
is ignored
   [junit4]   2> 807811 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 807812 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@2d474cb5, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 807898 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:40719/solr
   [junit4]   2> 808193 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) 
[n:127.0.0.1:34505_    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (3)
   [junit4]   2> 808212 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) 
[n:127.0.0.1:34505_    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 808213 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) 
[n:127.0.0.1:34505_    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:34505_
   [junit4]   2> 808214 INFO  
(zkCallback-260-thread-4-processing-n:127.0.0.1:46787_) [n:127.0.0.1:46787_    
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 808248 INFO  (zkCallback-255-thread-3) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 808264 INFO  
(zkCallback-266-thread-5-processing-n:127.0.0.1:44329_) [n:127.0.0.1:44329_    
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 808284 INFO  
(zkCallback-247-thread-6-processing-n:127.0.0.1:45033_) [n:127.0.0.1:45033_    
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 808301 INFO  
(zkCallback-272-thread-1-processing-n:127.0.0.1:34505_) [n:127.0.0.1:34505_    
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 808996 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) 
[n:127.0.0.1:34505_    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@2d474cb5
   [junit4]   2> 809144 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) 
[n:127.0.0.1:34505_    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@2d474cb5
   [junit4]   2> 809144 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) 
[n:127.0.0.1:34505_    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@2d474cb5
   [junit4]   2> 809214 INFO  
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[EA9FDB590618BC3B]) 
[n:127.0.0.1:34505_    ] o.a.s.c.CorePropertiesLocator Found 0 core definitions 
underneath 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderFailoverAfterPartitionTest_EA9FDB590618BC3B-001/shard-3-001/cores
   [junit4]   2> 809763 INFO  (SocketProxy-Acceptor-34505) [    ] 
o.a.s.c.SocketProxy accepted 
Socket[addr=/127.0.0.1,port=39450,localport=34505], receiveBufferSize:531000
   [junit4]   2> 809820 INFO  (SocketProxy-Acceptor-34505) [    ] 
o.a.s.c.SocketProxy proxy connection 
Socket[addr=/127.0.0.1,port=38308,localport=47456], receiveBufferSize=530904
   [junit4]   2> 809896 INFO  (qtp1054789277-2270) [n:127.0.0.1:34505_    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with params 
node=127.0.0.1:34505_&action=ADDREPLICA&collection=collection1&shard=shard2&type=NRT&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 809966 INFO  
(OverseerThreadFactory-1071-thread-5-processing-n:127.0.0.1:45033_) 
[n:127.0.0.1:45033_    ] o.a.s.c.AddReplicaCmd Node Identified 127.0.0.1:34505_ 
for creating new replica
   [junit4]   2> 809968 INFO  (SocketProxy-Acceptor-34505) [    ] 
o.a.s.c.SocketProxy accepted 
Socket[addr=/127.0.0.1,port=39454,localport=34505], receiveBufferSize:531000
   [junit4]   2> 810006 INFO  (SocketProxy-Acceptor-34505) [    ] 
o.a.s.c.SocketProxy proxy connection 
Socket[addr=/127.0.0.1,port=38308,localport=47460], receiveBufferSize=530904
   [junit4]   2> 810056 INFO  (qtp1054789277-2268) [n:127.0.0.1:34505_    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=conf1&name=collection1_shard2_replica_n45&action=CREATE&collection=collection1&shard=shard2&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 810057 INFO  (qtp1054789277-2268) [n:127.0.0.1:34505_    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 811184 INFO  (qtp1054789277-2268) [n:127.0.0.1:34505_ 
c:collection1 s:shard2  x:collection1_shard2_replica_n45] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 7.2.0
   [junit4]   2> 811345 INFO  (qtp1054789277-2268) [n:127.0.0.1:34505_ 
c:collection1 s:shard2  x:collection1_shard2_replica_n45] o.a.s.s.IndexSchema 
[collection1_shard2_replica_n45] Schema name=test
   [junit4]   2> 812929 INFO  (qtp1054789277-2268) [n:127.0.0.1:34505_ 
c:collection1 s:shard2  x:collection1_shard2_replica_n45] o.a.s.s.IndexSchema 
Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 813308 INFO  (qtp1054789277-2268) [n:127.0.0.1:34505_ 
c:collection1 s:shard2  x:collection1_shard2_replica_n45] o.a.s.c.CoreContainer 
Creating SolrCore 'collection1_shard2_replica_n45' using configuration from 
collection collection1, trusted=true
   [junit4]   2> 813310 INFO  (qtp1054789277-2268) [n:127.0.0.1:34505_ 
c:collection1 s:shard2  x:collection1_shard2_replica_n45] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.core.collection1.shard2.replica_n45' (registry 
'solr.core.collection1.shard2.replica_n45') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@2d474cb5
   [junit4]   2> 813310 INFO  (qtp1054789277-2268) [n:127.0.0.1:34505_ 
c:collection1 s:shard2  x:collection1_shard2_replica_n45] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 813311 INFO  (qtp1054789277-2268) [n:127.0.0.1:34505_ 
c:collection1 s:shard2  x:collection1_shard2_replica_n45] o.a.s.c.SolrCore 
[[collection1_shard2_replica_n45] ] Opening new SolrCore at 
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderFailoverAfterPartitionTest_EA9FDB590618BC3B-001/shard-3-001/cores/collection1_shard2_replica_n45],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderFailoverAfterPartitionTest_EA9FDB590618BC3B-001/shard-3-001/cores/collection1_shard2_replica_n45/data/]
   [junit4]   2> 813362 INFO  (qtp1054789277-2268) [n:127.0.0.1:34505_ 
c:collection1 s:shard2  x:collection1_shard2_replica_n45] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=40, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.2779659765120155]
   [junit4]   2> 813435 WARN  (qtp1054789277-2268) [n:127.0.0.1:34505_ 
c:collection1 s:shard2  x:collection1_shard2_replica_n45] 
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> 814132 INFO  (qtp1054789277-2268) [n:127.0.0.1:34505_ 
c:collection1 s:shard2  x:collection1_shard2_replica_n45] o.a.s.u.UpdateHandler 
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 814132 INFO  (qtp1054789277-2268) [n:127.0.0.1:34505_ 
c:collection1 s:shard2  x:collection1_shard2_replica_n45] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 
maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 814268 INFO  (qtp1054789277-2268) [n:127.0.0.1:34505_ 
c:collection1 s:shard2  x:collection1_shard2_replica_n45] o.a.s.u.CommitTracker 
Hard AutoCommit: disabled
   [junit4]   2> 814268 INFO  (qtp1054789277-2268) [n:127.0.0.1:34505_ 
c:collection1 s:shard2  x:collection1_shard2_replica_n45] o.a.s.u.CommitTracker 
Soft AutoCommit: disabled
   [junit4]   2> 814304 INFO  (qtp1054789277-2268) [n:127.0.0.1:34505_ 
c:collection1 s:shard2  x:collection1_shard2_replica_n45] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=32, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFS

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

or registry=solr.cluster, tag=null
   [junit4]   2> 5940188 INFO  (jetty-closer-2728-thread-3) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 5940151 INFO  (jetty-closer-2728-thread-4) [    ] 
o.a.s.c.ZkController Remove node as live in 
ZooKeeper:/live_nodes/127.0.0.1:37216_solr
   [junit4]   2> 5940151 INFO  
(zkCallback-2870-thread-1-processing-n:127.0.0.1:42998_solr) 
[n:127.0.0.1:42998_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (5) -> (4)
   [junit4]   2> 5940187 INFO  (jetty-closer-2728-thread-8) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 5940189 INFO  (jetty-closer-2728-thread-4) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, 
tag=null
   [junit4]   2> 5940189 INFO  (jetty-closer-2728-thread-4) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 5940190 INFO  
(zkCallback-2802-thread-2-processing-n:127.0.0.1:46045_solr) 
[n:127.0.0.1:46045_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (0)
   [junit4]   2> 5940171 INFO  
(zkCallback-2906-thread-2-processing-n:127.0.0.1:44846_solr) 
[n:127.0.0.1:44846_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (5) -> (1)
   [junit4]   2> 5940171 INFO  (jetty-closer-2728-thread-5) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@2ba4523e{/solr,null,UNAVAILABLE}
   [junit4]   2> 5940168 DEBUG (jetty-closer-2728-thread-1) [    ] 
o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread has been closed explicitly
   [junit4]   2> 5940208 INFO  
(zkCallback-2846-thread-2-processing-n:127.0.0.1:37216_solr) 
[n:127.0.0.1:37216_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (0)
   [junit4]   2> 5940240 INFO  (jetty-closer-2728-thread-8) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@9227b75{/solr,null,UNAVAILABLE}
   [junit4]   2> 5940260 INFO  (jetty-closer-2728-thread-6) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@14202a47{/solr,null,UNAVAILABLE}
   [junit4]   2> 5940261 INFO  (jetty-closer-2728-thread-3) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@40c489d0{/solr,null,UNAVAILABLE}
   [junit4]   2> 5940281 INFO  (jetty-closer-2728-thread-1) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@6e51fecb{/solr,null,UNAVAILABLE}
   [junit4]   2> 5941776 INFO  (jetty-closer-2728-thread-4) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@671aacbd{/solr,null,UNAVAILABLE}
   [junit4]   2> 5941777 ERROR 
(SUITE-TriggerIntegrationTest-seed#[EA9FDB590618BC3B]-worker) [    ] 
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> 5941777 INFO  
(SUITE-TriggerIntegrationTest-seed#[EA9FDB590618BC3B]-worker) [    ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1:39714 39714
   [junit4]   2> 5941845 INFO  (Thread-4279) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:39714 39714
   [junit4]   2> 5941845 WARN  (Thread-4279) [    ] o.a.s.c.ZkTestServer Watch 
limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2>        41      /solr/aliases.json
   [junit4]   2>        41      /solr/clusterprops.json
   [junit4]   2>        16      /solr/security.json
   [junit4]   2>        2       /solr/configs/conf
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2>        41      /solr/clusterstate.json
   [junit4]   2>        17      /solr/collections/collection1/state.json
   [junit4]   2>        6       /solr/autoscaling.json
   [junit4]   2>        4       
/solr/overseer_elect/election/98946354673549343-127.0.0.1:46045_solr-n_0000000006
   [junit4]   2>        3       
/solr/overseer_elect/election/98946354673549371-127.0.0.1:42998_solr-n_0000000012
   [junit4]   2>        2       
/solr/overseer_elect/election/98946354673549334-127.0.0.1:35919_solr-n_0000000004
   [junit4]   2>        2       
/solr/overseer_elect/election/98946354673549361-127.0.0.1:37216_solr-n_0000000010
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2>        41      /solr/live_nodes
   [junit4]   2>        41      /solr/collections
   [junit4]   2>        6       /solr/autoscaling/events/.auto_add_replicas
   [junit4]   2>        6       /solr/overseer/queue
   [junit4]   2>        6       /solr/overseer/collection-queue-work
   [junit4]   2>        6       /solr/overseer/queue-work
   [junit4]   2>        3       /solr/autoscaling/events/node_added_trigger
   [junit4]   2>        2       /solr/autoscaling/events/node_lost_trigger
   [junit4]   2>        2       /solr/autoscaling/events/node_added_trigger1
   [junit4]   2> 
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.TriggerIntegrationTest_EA9FDB590618BC3B-001
   [junit4]   2> Nov 04, 2017 1:21:35 PM 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 1 leaked 
thread(s).
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): {}, 
docValues:{}, maxPointsInLeafNode=1572, maxMBSortInHeap=6.535209798759785, 
sim=RandomSimilarity(queryNorm=false): {}, locale=sr-Latn-ME, timezone=GB
   [junit4]   2> NOTE: Linux 4.4.0-83-generic amd64/Oracle Corporation 
1.8.0_152 (64-bit)/cpus=4,threads=1,free=242977104,total=520617984
   [junit4]   2> NOTE: All tests run in this JVM: [DocumentBuilderTest, 
TestFastOutputStream, TestSystemCollAutoCreate, TestCloudInspectUtil, 
TestReplicationHandler, TestExceedMaxTermLength, 
TestMultiValuedNumericRangeQuery, BitVectorTest, TestInitQParser, 
TestManagedSynonymFilterFactory, StatsReloadRaceTest, TestRandomFaceting, 
TestConfigReload, CollectionStateFormat2Test, RAMDirectoryFactoryTest, 
LeaderFailoverAfterPartitionTest, TestFieldTypeCollectionResource, 
AssignBackwardCompatibilityTest, FileUtilsTest, TestFilteredDocIdSet, 
CursorPagingTest, TestUtils, ZkControllerTest, TestMergePolicyConfig, 
JsonLoaderTest, TestCloudNestedDocsSort, TestNumericTerms64, TestCSVLoader, 
TestDynamicFieldResource, TestOverriddenPrefixQueryForCustomFieldType, 
TestPointFields, TestDelegationWithHadoopAuth, TestXmlQParser, 
URLClassifyProcessorTest, MinimalSchemaTest, 
OutOfBoxZkACLAndCredentialsProvidersTest, TestConfigsApi, TestExactStatsCache, 
SolrGraphiteReporterTest, TestMissingGroups, TestStressVersions, 
TestPostingsSolrHighlighter, TestFieldCacheWithThreads, 
ConjunctionSolrSpellCheckerTest, TestComponentsName, ForceLeaderTest, 
MetricsConfigTest, SliceStateTest, RestartWhileUpdatingTest, 
TestIndexingPerformance, CacheHeaderTest, TestSolrIndexConfig, 
SuggestComponentContextFilterQueryTest, CollectionsAPISolrJTest, 
ExternalFileFieldSortTest, TestInitParams, TestJsonFacets, TestBulkSchemaAPI, 
TestMaxTokenLenTokenizer, TestScoreJoinQPScore, SolrXmlInZkTest, 
RemoteQueryErrorTest, TestTrackingShardHandlerFactory, DocValuesTest, 
TermsComponentTest, TestSolrJ, TestUnifiedSolrHighlighter, UpdateParamsTest, 
TestSweetSpotSimilarityFactory, SimpleCollectionCreateDeleteTest, TestMacros, 
TestInPlaceUpdatesStandalone, TestReRankQParserPlugin, 
TestOnReconnectListenerSupport, DateFieldTest, 
TestSerializedLuceneMatchVersion, TestSuggestSpellingConverter, 
StatelessScriptUpdateProcessorFactoryTest, DateRangeFieldTest, 
TestSolrDeletionPolicy1, TermVectorComponentTest, TestSolrCLIRunExample, 
MergeStrategyTest, RuleEngineTest, TestCrossCoreJoin, TestBadConfig, 
TestClusterProperties, BasicAuthStandaloneTest, TestConfig, 
TestPKIAuthenticationPlugin, SyncSliceTest, HdfsThreadLeakTest, 
RegexBytesRefFilterTest, BasicZkTest, TestLegacyFieldReuse, 
TestRequestStatusCollectionAPI, TestHighFrequencyDictionaryFactory, 
TemplateUpdateProcessorTest, MoveReplicaTest, SolrCoreTest, 
TestReversedWildcardFilterFactory, DirectUpdateHandlerOptimizeTest, 
TestPHPSerializedResponseWriter, SaslZkACLProviderTest, SearchHandlerTest, 
TestBlendedInfixSuggestions, DistributedQueryElevationComponentTest, 
TestManagedResource, DistributedMLTComponentTest, HdfsRecoveryZkTest, 
TestConfigSetsAPI, TestUpdate, TestConfigOverlay, 
AutoscalingHistoryHandlerTest, NodeLostTriggerTest, CleanupOldIndexTest, 
TestWordDelimiterFilterFactory, CoreSorterTest, TestGeoJSONResponseWriter, 
TestIntervalFaceting, DistributedQueueTest, TestSolr4Spatial2, TestFaceting, 
TestRecovery, TestHashPartitioner, TestJoin, StatsComponentTest, 
SoftAutoCommitTest, SOLR749Test, TestQuerySenderNoQuery, 
ResponseLogComponentTest, MultiTermTest, SampleTest, TestBinaryField, 
TestSearchPerf, DirectSolrConnectionTest, NotRequiredUniqueKeyTest, 
TestPhraseSuggestions, TestXIncludeConfig, EchoParamsTest, 
TestDFRSimilarityFactory, TestPerFieldSimilarity, 
TestLMDirichletSimilarityFactory, TimeZoneUtilsTest, ResourceLoaderTest, 
ScriptEngineTest, PreAnalyzedFieldTest, DistributedIntervalFacetingTest, 
TestEmbeddedSolrServerAdminHandler, TestEmbeddedSolrServerSchemaAPI, 
TestJettySolrRunner, ActionThrottleTest, AliasIntegrationTest, 
CdcrReplicationHandlerTest, CdcrRequestHandlerTest, 
ChaosMonkeyNothingIsSafeWithPullReplicasTest, 
ConcurrentDeleteAndCreateCollectionTest, ConfigSetsAPITest, 
ConnectionManagerTest, CustomCollectionTest, DeleteShardTest, 
DistribCursorPagingTest, LeaderElectionContextKeyTest, 
LeaderFailureAfterFreshStartTest, MissingSegmentRecoveryTest, 
MoveReplicaHDFSTest, NodeMutatorTest, 
OverriddenZkACLAndCredentialsProvidersTest, OverseerModifyCollectionTest, 
OverseerTaskQueueTest, ShardSplitTest, TestTolerantUpdateProcessorCloud, 
TlogReplayBufferedWhileIndexingTest, VMParamsZkACLAndCredentialsProvidersTest, 
ZkFailoverTest, ComputePlanActionTest, SystemLogListenerTest, 
TriggerIntegrationTest]
   [junit4] Completed [590/747 (2!)] on J0 in 141.82s, 12 tests, 1 failure <<< 
FAILURES!

[...truncated 47764 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org

Reply via email to