Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/25040/
Java: 64bit/jdk-12.0.1 -XX:+UseCompressedOops -XX:+UseSerialGC

1 tests failed.
FAILED:  org.apache.solr.cloud.LeaderVoteWaitTimeoutTest.basicTest

Error Message:
Timeout occurred while waiting response from server at: 
http://127.0.0.1:37825/solr

Stack Trace:
org.apache.solr.client.solrj.SolrServerException: Timeout occurred while 
waiting response from server at: http://127.0.0.1:37825/solr
        at 
__randomizedtesting.SeedInfo.seed([1008821C32AE4408:E2FC957E760B493B]:0)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:676)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:265)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:248)
        at 
org.apache.solr.client.solrj.impl.LBSolrClient.doRequest(LBSolrClient.java:368)
        at 
org.apache.solr.client.solrj.impl.LBSolrClient.request(LBSolrClient.java:296)
        at 
org.apache.solr.client.solrj.impl.BaseCloudSolrClient.sendRequest(BaseCloudSolrClient.java:1127)
        at 
org.apache.solr.client.solrj.impl.BaseCloudSolrClient.requestWithRetryOnStaleState(BaseCloudSolrClient.java:896)
        at 
org.apache.solr.client.solrj.impl.BaseCloudSolrClient.request(BaseCloudSolrClient.java:828)
        at 
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:207)
        at 
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:224)
        at 
org.apache.solr.cloud.LeaderVoteWaitTimeoutTest.basicTest(LeaderVoteWaitTimeoutTest.java:157)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.base/java.lang.reflect.Method.invoke(Method.java:567)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
        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:947)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
        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 
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.base/java.lang.Thread.run(Thread.java:835)
Caused by: java.net.SocketTimeoutException: Read timed out
        at java.base/java.net.SocketInputStream.socketRead0(Native Method)
        at 
java.base/java.net.SocketInputStream.socketRead(SocketInputStream.java:115)
        at java.base/java.net.SocketInputStream.read(SocketInputStream.java:168)
        at java.base/java.net.SocketInputStream.read(SocketInputStream.java:140)
        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:110)
        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:564)
        ... 48 more




Build Log:
[...truncated 14463 lines...]
   [junit4] Suite: org.apache.solr.cloud.LeaderVoteWaitTimeoutTest
   [junit4]   2> 1251418 INFO  
(SUITE-LeaderVoteWaitTimeoutTest-seed#[1008821C32AE4408]-worker) [     ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 1251418 INFO  
(SUITE-LeaderVoteWaitTimeoutTest-seed#[1008821C32AE4408]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Created dataDir: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderVoteWaitTimeoutTest_1008821C32AE4408-001/data-dir-180-001
   [junit4]   2> 1251418 WARN  
(SUITE-LeaderVoteWaitTimeoutTest-seed#[1008821C32AE4408]-worker) [     ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=49 numCloses=49
   [junit4]   2> 1251418 INFO  
(SUITE-LeaderVoteWaitTimeoutTest-seed#[1008821C32AE4408]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 1251419 INFO  
(SUITE-LeaderVoteWaitTimeoutTest-seed#[1008821C32AE4408]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via: 
@org.apache.solr.util.RandomizeSSL(reason="", value=0.0/0.0, ssl=0.0/0.0, 
clientAuth=0.0/0.0)
   [junit4]   2> 1251421 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.SolrTestCaseJ4 ###Starting testMostInSyncReplicasCanWinElection
   [junit4]   2> 1251421 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderVoteWaitTimeoutTest_1008821C32AE4408-001/tempDir-001
   [junit4]   2> 1251421 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1251421 INFO  (ZkTestServer Run Thread) [     ] 
o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 1251421 INFO  (ZkTestServer Run Thread) [     ] 
o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 1251521 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.ZkTestServer start zk server on port:45173
   [junit4]   2> 1251521 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:45173
   [junit4]   2> 1251521 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:45173
   [junit4]   2> 1251521 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 45173
   [junit4]   2> 1251523 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1251524 INFO  (zkConnectionManagerCallback-7129-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1251524 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1251526 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1251526 INFO  (zkConnectionManagerCallback-7131-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1251526 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1251527 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1251528 INFO  (zkConnectionManagerCallback-7133-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1251528 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1251631 WARN  (jetty-launcher-7134-thread-3) [     ] 
o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
   [junit4]   2> 1251631 WARN  (jetty-launcher-7134-thread-1) [     ] 
o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
   [junit4]   2> 1251631 WARN  (jetty-launcher-7134-thread-2) [     ] 
o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
   [junit4]   2> 1251631 WARN  (jetty-launcher-7134-thread-4) [     ] 
o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
   [junit4]   2> 1251632 INFO  (jetty-launcher-7134-thread-1) [     ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 1251632 INFO  (jetty-launcher-7134-thread-4) [     ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 1251632 INFO  (jetty-launcher-7134-thread-1) [     ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 1251632 INFO  (jetty-launcher-7134-thread-2) [     ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 1251632 INFO  (jetty-launcher-7134-thread-3) [     ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 1251632 INFO  (jetty-launcher-7134-thread-4) [     ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 1251632 INFO  (jetty-launcher-7134-thread-3) [     ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 1251632 INFO  (jetty-launcher-7134-thread-2) [     ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 1251632 INFO  (jetty-launcher-7134-thread-1) [     ] 
o.e.j.s.Server jetty-9.4.19.v20190610; built: 2019-06-10T16:30:51.723Z; git: 
afcf563148970e98786327af5e07c261fda175d3; jvm 12.0.1+12
   [junit4]   2> 1251632 INFO  (jetty-launcher-7134-thread-3) [     ] 
o.e.j.s.Server jetty-9.4.19.v20190610; built: 2019-06-10T16:30:51.723Z; git: 
afcf563148970e98786327af5e07c261fda175d3; jvm 12.0.1+12
   [junit4]   2> 1251632 INFO  (jetty-launcher-7134-thread-2) [     ] 
o.e.j.s.Server jetty-9.4.19.v20190610; built: 2019-06-10T16:30:51.723Z; git: 
afcf563148970e98786327af5e07c261fda175d3; jvm 12.0.1+12
   [junit4]   2> 1251632 INFO  (jetty-launcher-7134-thread-4) [     ] 
o.e.j.s.Server jetty-9.4.19.v20190610; built: 2019-06-10T16:30:51.723Z; git: 
afcf563148970e98786327af5e07c261fda175d3; jvm 12.0.1+12
   [junit4]   2> 1251633 INFO  (jetty-launcher-7134-thread-4) [     ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1251633 INFO  (jetty-launcher-7134-thread-4) [     ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1251633 INFO  (jetty-launcher-7134-thread-4) [     ] 
o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 1251633 INFO  (jetty-launcher-7134-thread-4) [     ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@18fbacaa{/solr,null,AVAILABLE}
   [junit4]   2> 1251633 INFO  (jetty-launcher-7134-thread-4) [     ] 
o.e.j.s.AbstractConnector Started ServerConnector@6a7e29a3{HTTP/1.1,[http/1.1, 
h2c]}{127.0.0.1:42493}
   [junit4]   2> 1251633 INFO  (jetty-launcher-7134-thread-3) [     ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1251634 INFO  (jetty-launcher-7134-thread-3) [     ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1251634 INFO  (jetty-launcher-7134-thread-4) [     ] 
o.e.j.s.Server Started @1251645ms
   [junit4]   2> 1251634 INFO  (jetty-launcher-7134-thread-3) [     ] 
o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 1251634 INFO  (jetty-launcher-7134-thread-4) [     ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=42493}
   [junit4]   2> 1251634 INFO  (jetty-launcher-7134-thread-3) [     ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@3ff1260b{/solr,null,AVAILABLE}
   [junit4]   2> 1251634 ERROR (jetty-launcher-7134-thread-4) [     ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1251634 INFO  (jetty-launcher-7134-thread-4) [     ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1251634 INFO  (jetty-launcher-7134-thread-1) [     ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1251634 INFO  (jetty-launcher-7134-thread-1) [     ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1251634 INFO  (jetty-launcher-7134-thread-1) [     ] 
o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 1251634 INFO  (jetty-launcher-7134-thread-4) [     ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
9.0.0
   [junit4]   2> 1251634 INFO  (jetty-launcher-7134-thread-4) [     ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1251634 INFO  (jetty-launcher-7134-thread-4) [     ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1251634 INFO  (jetty-launcher-7134-thread-4) [     ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2019-11-18T23:31:16.953324Z
   [junit4]   2> 1251634 INFO  (jetty-launcher-7134-thread-3) [     ] 
o.e.j.s.AbstractConnector Started ServerConnector@36f2a6b{HTTP/1.1,[http/1.1, 
h2c]}{127.0.0.1:36989}
   [junit4]   2> 1251634 INFO  (jetty-launcher-7134-thread-3) [     ] 
o.e.j.s.Server Started @1251645ms
   [junit4]   2> 1251634 INFO  (jetty-launcher-7134-thread-1) [     ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@1c44d3e7{/solr,null,AVAILABLE}
   [junit4]   2> 1251634 INFO  (jetty-launcher-7134-thread-3) [     ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=36989}
   [junit4]   2> 1251634 INFO  (jetty-launcher-7134-thread-2) [     ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1251634 INFO  (jetty-launcher-7134-thread-2) [     ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1251634 INFO  (jetty-launcher-7134-thread-2) [     ] 
o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 1251634 ERROR (jetty-launcher-7134-thread-3) [     ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1251634 INFO  (jetty-launcher-7134-thread-3) [     ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1251634 INFO  (jetty-launcher-7134-thread-3) [     ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
9.0.0
   [junit4]   2> 1251634 INFO  (jetty-launcher-7134-thread-3) [     ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1251634 INFO  (jetty-launcher-7134-thread-3) [     ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1251634 INFO  (jetty-launcher-7134-thread-3) [     ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2019-11-18T23:31:16.953587Z
   [junit4]   2> 1251634 INFO  (jetty-launcher-7134-thread-1) [     ] 
o.e.j.s.AbstractConnector Started ServerConnector@69af897b{HTTP/1.1,[http/1.1, 
h2c]}{127.0.0.1:46417}
   [junit4]   2> 1251634 INFO  (jetty-launcher-7134-thread-1) [     ] 
o.e.j.s.Server Started @1251645ms
   [junit4]   2> 1251634 INFO  (jetty-launcher-7134-thread-1) [     ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=46417}
   [junit4]   2> 1251635 INFO  (jetty-launcher-7134-thread-2) [     ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@6a5bbb39{/solr,null,AVAILABLE}
   [junit4]   2> 1251635 ERROR (jetty-launcher-7134-thread-1) [     ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1251635 INFO  (jetty-launcher-7134-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1251635 INFO  (jetty-launcher-7134-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
9.0.0
   [junit4]   2> 1251635 INFO  (jetty-launcher-7134-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1251635 INFO  (jetty-launcher-7134-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1251635 INFO  (jetty-launcher-7134-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2019-11-18T23:31:16.954658Z
   [junit4]   2> 1251635 INFO  (jetty-launcher-7134-thread-2) [     ] 
o.e.j.s.AbstractConnector Started ServerConnector@188424fe{HTTP/1.1,[http/1.1, 
h2c]}{127.0.0.1:40757}
   [junit4]   2> 1251635 INFO  (jetty-launcher-7134-thread-2) [     ] 
o.e.j.s.Server Started @1251646ms
   [junit4]   2> 1251635 INFO  (jetty-launcher-7134-thread-2) [     ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=40757}
   [junit4]   2> 1251635 ERROR (jetty-launcher-7134-thread-2) [     ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1251635 INFO  (jetty-launcher-7134-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1251635 INFO  (jetty-launcher-7134-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
9.0.0
   [junit4]   2> 1251636 INFO  (jetty-launcher-7134-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1251636 INFO  (jetty-launcher-7134-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1251636 INFO  (jetty-launcher-7134-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2019-11-18T23:31:16.955024Z
   [junit4]   2> 1251636 INFO  (jetty-launcher-7134-thread-4) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1251636 INFO  (jetty-launcher-7134-thread-3) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1251636 INFO  (jetty-launcher-7134-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1251636 INFO  (zkConnectionManagerCallback-7138-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1251636 INFO  (jetty-launcher-7134-thread-3) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1251636 INFO  (zkConnectionManagerCallback-7136-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1251636 INFO  (jetty-launcher-7134-thread-4) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1251636 INFO  (zkConnectionManagerCallback-7140-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1251636 INFO  (jetty-launcher-7134-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1251637 INFO  (jetty-launcher-7134-thread-2) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1251637 INFO  (jetty-launcher-7134-thread-3) [     ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1251637 INFO  (jetty-launcher-7134-thread-4) [     ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1251637 INFO  (zkConnectionManagerCallback-7142-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1251637 INFO  (jetty-launcher-7134-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1251637 INFO  (jetty-launcher-7134-thread-2) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1251637 INFO  (jetty-launcher-7134-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1251794 INFO  (jetty-launcher-7134-thread-2) [     ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 1251794 WARN  (jetty-launcher-7134-thread-2) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@b2540c9[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1251794 WARN  (jetty-launcher-7134-thread-2) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@b2540c9[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1251796 WARN  (jetty-launcher-7134-thread-2) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@6f6b1267[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1251796 WARN  (jetty-launcher-7134-thread-2) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@6f6b1267[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1251797 INFO  (jetty-launcher-7134-thread-2) [     ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:45173/solr
   [junit4]   2> 1251798 INFO  (jetty-launcher-7134-thread-2) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1251798 INFO  (zkConnectionManagerCallback-7149-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1251798 INFO  (jetty-launcher-7134-thread-2) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1251905 INFO  (jetty-launcher-7134-thread-3) [     ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 1251905 WARN  (jetty-launcher-7134-thread-3) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@225329e8[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1251905 WARN  (jetty-launcher-7134-thread-3) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@225329e8[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1251907 WARN  (jetty-launcher-7134-thread-3) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@5f4a815a[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1251907 WARN  (jetty-launcher-7134-thread-3) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@5f4a815a[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1251907 INFO  (jetty-launcher-7134-thread-3) [     ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:45173/solr
   [junit4]   2> 1251908 INFO  (jetty-launcher-7134-thread-3) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1251909 INFO  (zkConnectionManagerCallback-7156-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1251909 INFO  (jetty-launcher-7134-thread-3) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1252010 INFO  (jetty-launcher-7134-thread-4) [     ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 1252010 WARN  (jetty-launcher-7134-thread-4) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@241c84ac[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1252010 WARN  (jetty-launcher-7134-thread-4) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@241c84ac[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1252012 WARN  (jetty-launcher-7134-thread-4) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@95160ac[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1252012 WARN  (jetty-launcher-7134-thread-4) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@95160ac[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1252013 INFO  (jetty-launcher-7134-thread-4) [     ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:45173/solr
   [junit4]   2> 1252014 INFO  (jetty-launcher-7134-thread-4) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1252014 INFO  (zkConnectionManagerCallback-7163-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1252014 INFO  (jetty-launcher-7134-thread-4) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1252085 INFO  (jetty-launcher-7134-thread-1) [     ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 1252086 WARN  (jetty-launcher-7134-thread-1) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@39b522d2[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1252086 WARN  (jetty-launcher-7134-thread-1) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@39b522d2[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1252087 WARN  (jetty-launcher-7134-thread-1) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@23291578[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1252087 WARN  (jetty-launcher-7134-thread-1) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@23291578[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1252088 INFO  (jetty-launcher-7134-thread-1) [     ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:45173/solr
   [junit4]   2> 1252089 INFO  (jetty-launcher-7134-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1252090 INFO  (zkConnectionManagerCallback-7170-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1252090 INFO  (jetty-launcher-7134-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1252149 INFO  (jetty-launcher-7134-thread-4) 
[n:127.0.0.1:42493_solr     ] o.a.s.c.c.ConnectionManager Waiting for client to 
connect to ZooKeeper
   [junit4]   2> 1252150 INFO  (zkConnectionManagerCallback-7172-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1252150 INFO  (jetty-launcher-7134-thread-4) 
[n:127.0.0.1:42493_solr     ] o.a.s.c.c.ConnectionManager Client is connected 
to ZooKeeper
   [junit4]   2> 1252185 INFO  (jetty-launcher-7134-thread-4) 
[n:127.0.0.1:42493_solr     ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:42493_solr
   [junit4]   2> 1252185 INFO  (jetty-launcher-7134-thread-4) 
[n:127.0.0.1:42493_solr     ] o.a.s.c.Overseer Overseer 
(id=72082115872358411-127.0.0.1:42493_solr-n_0000000000) starting
   [junit4]   2> 1252187 INFO  
(OverseerStateUpdate-72082115872358411-127.0.0.1:42493_solr-n_0000000000) 
[n:127.0.0.1:42493_solr     ] o.a.s.c.Overseer Starting to work on the main 
queue : 127.0.0.1:42493_solr
   [junit4]   2> 1252187 INFO  (jetty-launcher-7134-thread-4) 
[n:127.0.0.1:42493_solr     ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:42493_solr
   [junit4]   2> 1252188 INFO  (zkCallback-7171-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 1252196 INFO  (jetty-launcher-7134-thread-4) 
[n:127.0.0.1:42493_solr     ] o.a.s.h.a.MetricsHistoryHandler No .system 
collection, keeping metrics history in memory.
   [junit4]   2> 1252207 INFO  (jetty-launcher-7134-thread-4) 
[n:127.0.0.1:42493_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_42493.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@6fd9a883
   [junit4]   2> 1252212 INFO  (jetty-launcher-7134-thread-4) 
[n:127.0.0.1:42493_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_42493.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@6fd9a883
   [junit4]   2> 1252212 INFO  (jetty-launcher-7134-thread-4) 
[n:127.0.0.1:42493_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_42493.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@6fd9a883
   [junit4]   2> 1252214 INFO  (jetty-launcher-7134-thread-4) 
[n:127.0.0.1:42493_solr     ] o.a.s.p.PackageLoader /packages.json updated to 
version -1
   [junit4]   2> 1252214 INFO  (jetty-launcher-7134-thread-4) 
[n:127.0.0.1:42493_solr     ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderVoteWaitTimeoutTest_1008821C32AE4408-001/tempDir-001/node4/.
   [junit4]   2> 1252249 INFO  (jetty-launcher-7134-thread-3) 
[n:127.0.0.1:36989_solr     ] o.a.s.c.c.ConnectionManager Waiting for client to 
connect to ZooKeeper
   [junit4]   2> 1252250 INFO  (zkConnectionManagerCallback-7178-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1252250 INFO  (jetty-launcher-7134-thread-3) 
[n:127.0.0.1:36989_solr     ] o.a.s.c.c.ConnectionManager Client is connected 
to ZooKeeper
   [junit4]   2> 1252254 INFO  (jetty-launcher-7134-thread-3) 
[n:127.0.0.1:36989_solr     ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 1252256 INFO  (jetty-launcher-7134-thread-3) 
[n:127.0.0.1:36989_solr     ] o.a.s.c.ZkController Publish 
node=127.0.0.1:36989_solr as DOWN
   [junit4]   2> 1252256 INFO  (jetty-launcher-7134-thread-3) 
[n:127.0.0.1:36989_solr     ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient cache for 2147483647 transient cores
   [junit4]   2> 1252256 INFO  (jetty-launcher-7134-thread-3) 
[n:127.0.0.1:36989_solr     ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:36989_solr
   [junit4]   2> 1252256 INFO  (zkCallback-7171-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 1252257 INFO  (zkCallback-7177-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 1252264 INFO  (jetty-launcher-7134-thread-3) 
[n:127.0.0.1:36989_solr     ] o.a.s.h.a.MetricsHistoryHandler No .system 
collection, keeping metrics history in memory.
   [junit4]   2> 1252274 INFO  (jetty-launcher-7134-thread-3) 
[n:127.0.0.1:36989_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_36989.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@6fd9a883
   [junit4]   2> 1252280 INFO  (jetty-launcher-7134-thread-3) 
[n:127.0.0.1:36989_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_36989.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@6fd9a883
   [junit4]   2> 1252280 INFO  (jetty-launcher-7134-thread-3) 
[n:127.0.0.1:36989_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_36989.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@6fd9a883
   [junit4]   2> 1252281 INFO  (jetty-launcher-7134-thread-3) 
[n:127.0.0.1:36989_solr     ] o.a.s.p.PackageLoader /packages.json updated to 
version -1
   [junit4]   2> 1252281 INFO  (jetty-launcher-7134-thread-3) 
[n:127.0.0.1:36989_solr     ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderVoteWaitTimeoutTest_1008821C32AE4408-001/tempDir-001/node3/.
   [junit4]   2> 1252350 INFO  (jetty-launcher-7134-thread-2) 
[n:127.0.0.1:40757_solr     ] o.a.s.c.c.ConnectionManager Waiting for client to 
connect to ZooKeeper
   [junit4]   2> 1252351 INFO  (zkConnectionManagerCallback-7184-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1252351 INFO  (jetty-launcher-7134-thread-2) 
[n:127.0.0.1:40757_solr     ] o.a.s.c.c.ConnectionManager Client is connected 
to ZooKeeper
   [junit4]   2> 1252354 INFO  (jetty-launcher-7134-thread-2) 
[n:127.0.0.1:40757_solr     ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (2)
   [junit4]   2> 1252357 INFO  (jetty-launcher-7134-thread-2) 
[n:127.0.0.1:40757_solr     ] o.a.s.c.ZkController Publish 
node=127.0.0.1:40757_solr as DOWN
   [junit4]   2> 1252358 INFO  (jetty-launcher-7134-thread-2) 
[n:127.0.0.1:40757_solr     ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient cache for 2147483647 transient cores
   [junit4]   2> 1252358 INFO  (jetty-launcher-7134-thread-2) 
[n:127.0.0.1:40757_solr     ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:40757_solr
   [junit4]   2> 1252358 INFO  (zkCallback-7171-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 1252358 INFO  (zkCallback-7177-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 1252358 INFO  (zkCallback-7183-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 1252375 INFO  (jetty-launcher-7134-thread-2) 
[n:127.0.0.1:40757_solr     ] o.a.s.h.a.MetricsHistoryHandler No .system 
collection, keeping metrics history in memory.
   [junit4]   2> 1252386 INFO  (jetty-launcher-7134-thread-2) 
[n:127.0.0.1:40757_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_40757.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@6fd9a883
   [junit4]   2> 1252392 INFO  (jetty-launcher-7134-thread-2) 
[n:127.0.0.1:40757_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_40757.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@6fd9a883
   [junit4]   2> 1252392 INFO  (jetty-launcher-7134-thread-2) 
[n:127.0.0.1:40757_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_40757.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@6fd9a883
   [junit4]   2> 1252393 INFO  (jetty-launcher-7134-thread-2) 
[n:127.0.0.1:40757_solr     ] o.a.s.p.PackageLoader /packages.json updated to 
version -1
   [junit4]   2> 1252394 INFO  (jetty-launcher-7134-thread-2) 
[n:127.0.0.1:40757_solr     ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderVoteWaitTimeoutTest_1008821C32AE4408-001/tempDir-001/node2/.
   [junit4]   2> 1252450 INFO  (jetty-launcher-7134-thread-1) 
[n:127.0.0.1:46417_solr     ] o.a.s.c.c.ConnectionManager Waiting for client to 
connect to ZooKeeper
   [junit4]   2> 1252451 INFO  (zkConnectionManagerCallback-7190-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1252451 INFO  (jetty-launcher-7134-thread-1) 
[n:127.0.0.1:46417_solr     ] o.a.s.c.c.ConnectionManager Client is connected 
to ZooKeeper
   [junit4]   2> 1252455 INFO  (jetty-launcher-7134-thread-1) 
[n:127.0.0.1:46417_solr     ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (3)
   [junit4]   2> 1252457 INFO  (jetty-launcher-7134-thread-1) 
[n:127.0.0.1:46417_solr     ] o.a.s.c.ZkController Publish 
node=127.0.0.1:46417_solr as DOWN
   [junit4]   2> 1252458 INFO  (jetty-launcher-7134-thread-1) 
[n:127.0.0.1:46417_solr     ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient cache for 2147483647 transient cores
   [junit4]   2> 1252458 INFO  (jetty-launcher-7134-thread-1) 
[n:127.0.0.1:46417_solr     ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:46417_solr
   [junit4]   2> 1252458 INFO  (zkCallback-7171-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 1252458 INFO  (zkCallback-7183-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 1252458 INFO  (zkCallback-7177-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 1252458 INFO  (zkCallback-7189-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 1252466 INFO  (jetty-launcher-7134-thread-1) 
[n:127.0.0.1:46417_solr     ] o.a.s.h.a.MetricsHistoryHandler No .system 
collection, keeping metrics history in memory.
   [junit4]   2> 1252475 INFO  (jetty-launcher-7134-thread-1) 
[n:127.0.0.1:46417_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_46417.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@6fd9a883
   [junit4]   2> 1252481 INFO  (jetty-launcher-7134-thread-1) 
[n:127.0.0.1:46417_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_46417.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@6fd9a883
   [junit4]   2> 1252481 INFO  (jetty-launcher-7134-thread-1) 
[n:127.0.0.1:46417_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_46417.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@6fd9a883
   [junit4]   2> 1252482 INFO  (jetty-launcher-7134-thread-1) 
[n:127.0.0.1:46417_solr     ] o.a.s.p.PackageLoader /packages.json updated to 
version -1
   [junit4]   2> 1252483 INFO  (jetty-launcher-7134-thread-1) 
[n:127.0.0.1:46417_solr     ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderVoteWaitTimeoutTest_1008821C32AE4408-001/tempDir-001/node1/.
   [junit4]   2> 1252507 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=4
   [junit4]   2> 1252508 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1252509 INFO  (zkConnectionManagerCallback-7199-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1252509 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1252510 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
   [junit4]   2> 1252511 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 
127.0.0.1:45173/solr ready
   [junit4]   2> 1252513 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=601645481
   [junit4]   2> 1252513 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.ZkController Remove node as live in 
ZooKeeper:/live_nodes/127.0.0.1:42493_solr
   [junit4]   2> 1252514 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.ZkController Publish this node as DOWN...
   [junit4]   2> 1252514 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.ZkController Publish node=127.0.0.1:42493_solr as DOWN
   [junit4]   2> 1252515 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 
2147483647 transient cores
   [junit4]   2> 1252515 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.node, tag=null
   [junit4]   2> 1252515 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@6752fcbb: rootName = 
solr_42493, domain = solr.node, service url = null, agent id = null] for 
registry solr.node / com.codahale.metrics.MetricRegistry@2345b7e2
   [junit4]   2> 1252519 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.jvm, tag=null
   [junit4]   2> 1252519 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@11e64a0f: rootName = 
solr_42493, domain = solr.jvm, service url = null, agent id = null] for 
registry solr.jvm / com.codahale.metrics.MetricRegistry@27fe2b7e
   [junit4]   2> 1252522 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.jetty, tag=null
   [junit4]   2> 1252522 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@34456d2d: rootName = 
solr_42493, domain = solr.jetty, service url = null, agent id = null] for 
registry solr.jetty / com.codahale.metrics.MetricRegistry@306279b1
   [junit4]   2> 1252522 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.cluster, tag=null
   [junit4]   2> 1252523 INFO  (closeThreadPool-7203-thread-1) [     ] 
o.a.s.c.Overseer Overseer 
(id=72082115872358411-127.0.0.1:42493_solr-n_0000000000) closing
   [junit4]   2> 1252523 INFO  
(OverseerStateUpdate-72082115872358411-127.0.0.1:42493_solr-n_0000000000) 
[n:127.0.0.1:42493_solr     ] o.a.s.c.Overseer Overseer Loop exiting : 
127.0.0.1:42493_solr
   [junit4]   2> 1252523 INFO  
(OverseerAutoScalingTriggerThread-72082115872358411-127.0.0.1:42493_solr-n_0000000000)
 [     ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we 
are closed, exiting.
   [junit4]   2> 1252524 INFO  (closeThreadPool-7203-thread-2) [     ] 
o.a.s.c.Overseer Overseer 
(id=72082115872358411-127.0.0.1:42493_solr-n_0000000000) closing
   [junit4]   2> 1252525 INFO  (zkCallback-7189-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
   [junit4]   2> 1252525 INFO  (zkCallback-7183-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
   [junit4]   2> 1252525 INFO  (zkCallback-7177-thread-1) [     ] 
o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:36989_solr
   [junit4]   2> 1252625 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.Overseer Overseer 
(id=72082115872358411-127.0.0.1:42493_solr-n_0000000000) closing
   [junit4]   2> 1252625 INFO  (zkCallback-7198-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
   [junit4]   2> 1252625 INFO  (zkCallback-7177-thread-2) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
   [junit4]   2> 1252626 INFO  (zkCallback-7177-thread-1) 
[n:127.0.0.1:36989_solr     ] o.a.s.c.Overseer Overseer 
(id=72082115872358412-127.0.0.1:36989_solr-n_0000000001) starting
   [junit4]   2> 1252626 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.e.j.s.AbstractConnector Stopped 
ServerConnector@6a7e29a3{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:0}
   [junit4]   2> 1252626 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@18fbacaa{/solr,null,UNAVAILABLE}
   [junit4]   2> 1252626 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 1252626 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding 
port=0)
   [junit4]   2> 1252626 WARN  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
   [junit4]   2> 1252627 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 
1 ...
   [junit4]   2> 1252627 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.e.j.s.Server jetty-9.4.19.v20190610; built: 
2019-06-10T16:30:51.723Z; git: afcf563148970e98786327af5e07c261fda175d3; jvm 
12.0.1+12
   [junit4]   2> 1252628 INFO  
(OverseerStateUpdate-72082115872358412-127.0.0.1:36989_solr-n_0000000001) 
[n:127.0.0.1:36989_solr     ] o.a.s.c.Overseer Starting to work on the main 
queue : 127.0.0.1:36989_solr
   [junit4]   2> 1252631 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1252632 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1252632 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 1252632 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@5cef0fa4{/solr,null,AVAILABLE}
   [junit4]   2> 1252632 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.e.j.s.AbstractConnector Started 
ServerConnector@27095ba8{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:37639}
   [junit4]   2> 1252632 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.e.j.s.Server Started @1252643ms
   [junit4]   2> 1252632 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=45933}
   [junit4]   2> 1252632 ERROR 
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging 
may be missing or incomplete.
   [junit4]   2> 1252632 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1252632 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? 
version 9.0.0
   [junit4]   2> 1252632 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on 
port null
   [junit4]   2> 1252632 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1252632 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2019-11-18T23:31:17.951794Z
   [junit4]   2> 1252637 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1252637 INFO  (zkConnectionManagerCallback-7205-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1252637 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1252638 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1252906 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 1252907 WARN  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.e.j.u.s.S.config Trusting all certificates configured for 
Client@514a480a[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1252907 WARN  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm 
configured for Client@514a480a[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1252908 WARN  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.e.j.u.s.S.config Trusting all certificates configured for 
Client@1dce072b[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1252908 WARN  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm 
configured for Client@1dce072b[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1252909 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:45173/solr
   [junit4]   2> 1252910 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1252911 INFO  (zkConnectionManagerCallback-7212-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1252911 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1253013 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [n:127.0.0.1:45933_solr     ] o.a.s.c.c.ConnectionManager Waiting for client 
to connect to ZooKeeper
   [junit4]   2> 1253014 INFO  (zkConnectionManagerCallback-7214-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1253014 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [n:127.0.0.1:45933_solr     ] o.a.s.c.c.ConnectionManager Client is connected 
to ZooKeeper
   [junit4]   2> 1253018 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [n:127.0.0.1:45933_solr     ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (3)
   [junit4]   2> 1253020 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [n:127.0.0.1:45933_solr     ] o.a.s.c.ZkController Publish 
node=127.0.0.1:45933_solr as DOWN
   [junit4]   2> 1253020 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [n:127.0.0.1:45933_solr     ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient cache for 2147483647 transient cores
   [junit4]   2> 1253020 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [n:127.0.0.1:45933_solr     ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:45933_solr
   [junit4]   2> 1253020 INFO  (zkCallback-7189-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 1253020 INFO  (zkCallback-7198-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 1253021 INFO  (zkCallback-7183-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 1253021 INFO  (zkCallback-7177-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 1253021 INFO  (zkCallback-7213-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 1253029 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [n:127.0.0.1:45933_solr     ] o.a.s.h.a.MetricsHistoryHandler No .system 
collection, keeping metrics history in memory.
   [junit4]   2> 1253040 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [n:127.0.0.1:45933_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_45933.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@6fd9a883
   [junit4]   2> 1253048 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [n:127.0.0.1:45933_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_45933.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@6fd9a883
   [junit4]   2> 1253048 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [n:127.0.0.1:45933_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_45933.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@6fd9a883
   [junit4]   2> 1253049 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [n:127.0.0.1:45933_solr     ] o.a.s.p.PackageLoader /packages.json updated to 
version -1
   [junit4]   2> 1253050 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [n:127.0.0.1:45933_solr     ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderVoteWaitTimeoutTest_1008821C32AE4408-001/tempDir-001/node4/.
   [junit4]   2> 1253082 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.LeaderVoteWaitTimeoutTest Adding proxy for URL: 
http://127.0.0.1:37639/solr. Proxy: http://127.0.0.1:45933/solr
   [junit4]   2> 1253082 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=124933012
   [junit4]   2> 1253082 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.ZkController Remove node as live in 
ZooKeeper:/live_nodes/127.0.0.1:36989_solr
   [junit4]   2> 1253083 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.ZkController Publish this node as DOWN...
   [junit4]   2> 1253083 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.ZkController Publish node=127.0.0.1:36989_solr as DOWN
   [junit4]   2> 1253085 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.node, tag=null
   [junit4]   2> 1253085 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@ccc4e03: rootName = 
solr_36989, domain = solr.node, service url = null, agent id = null] for 
registry solr.node / com.codahale.metrics.MetricRegistry@316b9231
   [junit4]   2> 1253089 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.jvm, tag=null
   [junit4]   2> 1253089 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@1d62d88d: rootName = 
solr_36989, domain = solr.jvm, service url = null, agent id = null] for 
registry solr.jvm / com.codahale.metrics.MetricRegistry@27fe2b7e
   [junit4]   2> 1253092 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.jetty, tag=null
   [junit4]   2> 1253092 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@31c98c71: rootName = 
solr_36989, domain = solr.jetty, service url = null, agent id = null] for 
registry solr.jetty / com.codahale.metrics.MetricRegistry@306279b1
   [junit4]   2> 1253092 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.cluster, tag=null
   [junit4]   2> 1253092 INFO  (closeThreadPool-7222-thread-2) [     ] 
o.a.s.c.Overseer Overseer 
(id=72082115872358412-127.0.0.1:36989_solr-n_0000000001) closing
   [junit4]   2> 1253092 INFO  
(OverseerStateUpdate-72082115872358412-127.0.0.1:36989_solr-n_0000000001) 
[n:127.0.0.1:36989_solr     ] o.a.s.c.Overseer Overseer Loop exiting : 
127.0.0.1:36989_solr
   [junit4]   2> 1253093 INFO  
(OverseerAutoScalingTriggerThread-72082115872358412-127.0.0.1:36989_solr-n_0000000001)
 [     ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we 
are closed, exiting.
   [junit4]   2> 1253094 INFO  (closeThreadPool-7222-thread-1) [     ] 
o.a.s.c.Overseer Overseer 
(id=72082115872358412-127.0.0.1:36989_solr-n_0000000001) closing
   [junit4]   2> 1253094 INFO  (zkCallback-7183-thread-1) [     ] 
o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:40757_solr
   [junit4]   2> 1253094 INFO  (zkCallback-7213-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
   [junit4]   2> 1253094 INFO  (zkCallback-7189-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
   [junit4]   2> 1253094 INFO  (zkCallback-7198-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
   [junit4]   2> 1253094 INFO  (zkCallback-7183-thread-2) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
   [junit4]   2> 1253095 INFO  (zkCallback-7183-thread-1) 
[n:127.0.0.1:40757_solr     ] o.a.s.c.Overseer Overseer 
(id=72082115872358413-127.0.0.1:40757_solr-n_0000000002) starting
   [junit4]   2> 1253096 INFO  
(OverseerStateUpdate-72082115872358413-127.0.0.1:40757_solr-n_0000000002) 
[n:127.0.0.1:40757_solr     ] o.a.s.c.Overseer Starting to work on the main 
queue : 127.0.0.1:40757_solr
   [junit4]   2> 1253195 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.Overseer Overseer 
(id=72082115872358412-127.0.0.1:36989_solr-n_0000000001) closing
   [junit4]   2> 1253195 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.e.j.s.AbstractConnector Stopped 
ServerConnector@36f2a6b{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:0}
   [junit4]   2> 1253196 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@3ff1260b{/solr,null,UNAVAILABLE}
   [junit4]   2> 1253196 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 1253196 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding 
port=0)
   [junit4]   2> 1253196 WARN  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
   [junit4]   2> 1253196 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 
1 ...
   [junit4]   2> 1253196 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.e.j.s.Server jetty-9.4.19.v20190610; built: 
2019-06-10T16:30:51.723Z; git: afcf563148970e98786327af5e07c261fda175d3; jvm 
12.0.1+12
   [junit4]   2> 1253197 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1253197 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1253197 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 1253197 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@2bdd358e{/solr,null,AVAILABLE}
   [junit4]   2> 1253197 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.e.j.s.AbstractConnector Started 
ServerConnector@757407fc{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:43607}
   [junit4]   2> 1253198 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.e.j.s.Server Started @1253209ms
   [junit4]   2> 1253198 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=36325}
   [junit4]   2> 1253198 ERROR 
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging 
may be missing or incomplete.
   [junit4]   2> 1253198 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1253198 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? 
version 9.0.0
   [junit4]   2> 1253198 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on 
port null
   [junit4]   2> 1253198 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1253198 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2019-11-18T23:31:18.517244Z
   [junit4]   2> 1253198 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1253199 INFO  (zkConnectionManagerCallback-7224-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1253199 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1253199 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1253474 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 1253475 WARN  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.e.j.u.s.S.config Trusting all certificates configured for 
Client@5c5bd933[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1253475 WARN  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm 
configured for Client@5c5bd933[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1253477 WARN  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.e.j.u.s.S.config Trusting all certificates configured for 
Client@e85a842[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1253477 WARN  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm 
configured for Client@e85a842[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1253478 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:45173/solr
   [junit4]   2> 1253478 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1253479 INFO  (zkConnectionManagerCallback-7231-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1253479 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1253581 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1253582 INFO  (zkConnectionManagerCallback-7233-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1253582 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1253586 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
   [junit4]   2> 1253588 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.ZkController Publish node=127.0.0.1:36325_solr as DOWN
   [junit4]   2> 1253588 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 
2147483647 transient cores
   [junit4]   2> 1253588 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:36325_solr
   [junit4]   2> 1253589 INFO  (zkCallback-7198-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 1253589 INFO  (zkCallback-7183-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 1253589 INFO  (zkCallback-7189-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 1253589 INFO  (zkCallback-7213-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 1253589 INFO  (zkCallback-7232-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 1253597 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics 
history in memory.
   [junit4]   2> 1253608 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_36325.solr.node' 
(registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@6fd9a883
   [junit4]   2> 1253616 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_36325.solr.jvm' 
(registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@6fd9a883
   [junit4]   2> 1253616 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_36325.solr.jetty' 
(registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@6fd9a883
   [junit4]   2> 1253617 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.p.PackageLoader /packages.json updated to version -1
   [junit4]   2> 1253617 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderVoteWaitTimeoutTest_1008821C32AE4408-001/tempDir-001/node3/.
   [junit4]   2> 1253649 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.LeaderVoteWaitTimeoutTest Adding proxy for URL: 
http://127.0.0.1:43607/solr. Proxy: http://127.0.0.1:36325/solr
   [junit4]   2> 1253649 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=615667240
   [junit4]   2> 1253649 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.ZkController Remove node as live in 
ZooKeeper:/live_nodes/127.0.0.1:40757_solr
   [junit4]   2> 1253650 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.ZkController Publish this node as DOWN...
   [junit4]   2> 1253650 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.ZkController Publish node=127.0.0.1:40757_solr as DOWN
   [junit4]   2> 1253651 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.node, tag=null
   [junit4]   2> 1253651 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@700a3307: rootName = 
solr_40757, domain = solr.node, service url = null, agent id = null] for 
registry solr.node / com.codahale.metrics.MetricRegistry@3d56d2cd
   [junit4]   2> 1253656 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.jvm, tag=null
   [junit4]   2> 1253656 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@4d87e250: rootName = 
solr_40757, domain = solr.jvm, service url = null, agent id = null] for 
registry solr.jvm / com.codahale.metrics.MetricRegistry@27fe2b7e
   [junit4]   2> 1253658 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.jetty, tag=null
   [junit4]   2> 1253658 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@6d2b187a: rootName = 
solr_40757, domain = solr.jetty, service url = null, agent id = null] for 
registry solr.jetty / com.codahale.metrics.MetricRegistry@306279b1
   [junit4]   2> 1253658 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.cluster, tag=null
   [junit4]   2> 1253659 INFO  (closeThreadPool-7241-thread-2) [     ] 
o.a.s.c.Overseer Overseer 
(id=72082115872358413-127.0.0.1:40757_solr-n_0000000002) closing
   [junit4]   2> 1253659 INFO  
(OverseerStateUpdate-72082115872358413-127.0.0.1:40757_solr-n_0000000002) 
[n:127.0.0.1:40757_solr     ] o.a.s.c.Overseer Overseer Loop exiting : 
127.0.0.1:40757_solr
   [junit4]   2> 1253660 INFO  
(OverseerAutoScalingTriggerThread-72082115872358413-127.0.0.1:40757_solr-n_0000000002)
 [     ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we 
are closed, exiting.
   [junit4]   2> 1253660 INFO  (zkCallback-7189-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
   [junit4]   2> 1253660 INFO  (zkCallback-7232-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
   [junit4]   2> 1253660 INFO  (zkCallback-7213-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
   [junit4]   2> 1253660 INFO  (zkCallback-7198-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
   [junit4]   2> 1253661 INFO  (zkCallback-7189-thread-2) [     ] 
o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:46417_solr
   [junit4]   2> 1253661 INFO  (closeThreadPool-7241-thread-1) [     ] 
o.a.s.c.Overseer Overseer 
(id=72082115872358413-127.0.0.1:40757_solr-n_0000000002) closing
   [junit4]   2> 1253661 INFO  (zkCallback-7189-thread-2) 
[n:127.0.0.1:46417_solr     ] o.a.s.c.Overseer Overseer 
(id=72082115872358414-127.0.0.1:46417_solr-n_0000000003) starting
   [junit4]   2> 1253663 INFO  
(OverseerStateUpdate-72082115872358414-127.0.0.1:46417_solr-n_0000000003) 
[n:127.0.0.1:46417_solr     ] o.a.s.c.Overseer Starting to work on the main 
queue : 127.0.0.1:46417_solr
   [junit4]   2> 1253760 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.Overseer Overseer 
(id=72082115872358413-127.0.0.1:40757_solr-n_0000000002) closing
   [junit4]   2> 1253761 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.e.j.s.AbstractConnector Stopped 
ServerConnector@188424fe{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:0}
   [junit4]   2> 1253761 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@6a5bbb39{/solr,null,UNAVAILABLE}
   [junit4]   2> 1253761 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 1253762 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding 
port=0)
   [junit4]   2> 1253762 WARN  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
   [junit4]   2> 1253762 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 
1 ...
   [junit4]   2> 1253762 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.e.j.s.Server jetty-9.4.19.v20190610; built: 
2019-06-10T16:30:51.723Z; git: afcf563148970e98786327af5e07c261fda175d3; jvm 
12.0.1+12
   [junit4]   2> 1253763 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1253763 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1253763 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 1253763 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@1f7d79d9{/solr,null,AVAILABLE}
   [junit4]   2> 1253763 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.e.j.s.AbstractConnector Started 
ServerConnector@448d1199{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:36867}
   [junit4]   2> 1253763 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.e.j.s.Server Started @1253774ms
   [junit4]   2> 1253763 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=42803}
   [junit4]   2> 1253763 ERROR 
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging 
may be missing or incomplete.
   [junit4]   2> 1253763 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1253763 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? 
version 9.0.0
   [junit4]   2> 1253763 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on 
port null
   [junit4]   2> 1253763 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1253763 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2019-11-18T23:31:19.082959Z
   [junit4]   2> 1253765 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1253765 INFO  (zkConnectionManagerCallback-7243-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1253765 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1253765 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1253983 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 1253983 WARN  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.e.j.u.s.S.config Trusting all certificates configured for 
Client@445121cd[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1253983 WARN  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm 
configured for Client@445121cd[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1253985 WARN  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.e.j.u.s.S.config Trusting all certificates configured for 
Client@752fa2cb[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1253985 WARN  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm 
configured for Client@752fa2cb[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1253986 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:45173/solr
   [junit4]   2> 1253986 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1253987 INFO  (zkConnectionManagerCallback-7250-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1253987 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1254089 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1254090 INFO  (zkConnectionManagerCallback-7252-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1254090 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1254093 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
   [junit4]   2> 1254095 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.ZkController Publish node=127.0.0.1:42803_solr as DOWN
   [junit4]   2> 1254095 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 
2147483647 transient cores
   [junit4]   2> 1254095 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:42803_solr
   [junit4]   2> 1254096 INFO  (zkCallback-7198-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 1254096 INFO  (zkCallback-7189-thread-2) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 1254096 INFO  (zkCallback-7232-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 1254096 INFO  (zkCallback-7213-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 1254096 INFO  (zkCallback-7251-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 1254104 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics 
history in memory.
   [junit4]   2> 1254115 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_42803.solr.node' 
(registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@6fd9a883
   [junit4]   2> 1254122 INFO  
(TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[1008821C32AE4408])
 [     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_42803.solr.jvm' 
(registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBean

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

.LBSolrClient.request(LBSolrClient.java:296)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.BaseCloudSolrClient.sendRequest(BaseCloudSolrClient.java:1127)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.BaseCloudSolrClient.requestWithRetryOnStaleState(BaseCloudSolrClient.java:896)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.BaseCloudSolrClient.request(BaseCloudSolrClient.java:828)
   [junit4]    >        at 
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:207)
   [junit4]    >        at 
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:224)
   [junit4]    >        at 
org.apache.solr.cloud.LeaderVoteWaitTimeoutTest.basicTest(LeaderVoteWaitTimeoutTest.java:157)
   [junit4]    >        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   [junit4]    >        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
   [junit4]    >        at 
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   [junit4]    >        at 
java.base/java.lang.reflect.Method.invoke(Method.java:567)
   [junit4]    >        at java.base/java.lang.Thread.run(Thread.java:835)
   [junit4]    > Caused by: java.net.SocketTimeoutException: Read timed out
   [junit4]    >        at 
java.base/java.net.SocketInputStream.socketRead0(Native Method)
   [junit4]    >        at 
java.base/java.net.SocketInputStream.socketRead(SocketInputStream.java:115)
   [junit4]    >        at 
java.base/java.net.SocketInputStream.read(SocketInputStream.java:168)
   [junit4]    >        at 
java.base/java.net.SocketInputStream.read(SocketInputStream.java:140)
   [junit4]    >        at 
org.apache.http.impl.io.SessionInputBufferImpl.streamRead(SessionInputBufferImpl.java:137)
   [junit4]    >        at 
org.apache.http.impl.io.SessionInputBufferImpl.fillBuffer(SessionInputBufferImpl.java:153)
   [junit4]    >        at 
org.apache.http.impl.io.SessionInputBufferImpl.readLine(SessionInputBufferImpl.java:282)
   [junit4]    >        at 
org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:138)
   [junit4]    >        at 
org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:56)
   [junit4]    >        at 
org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:259)
   [junit4]    >        at 
org.apache.http.impl.DefaultBHttpClientConnection.receiveResponseHeader(DefaultBHttpClientConnection.java:163)
   [junit4]    >        at 
org.apache.http.impl.conn.CPoolProxy.receiveResponseHeader(CPoolProxy.java:165)
   [junit4]    >        at 
org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:273)
   [junit4]    >        at 
org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:125)
   [junit4]    >        at 
org.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:272)
   [junit4]    >        at 
org.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:185)
   [junit4]    >        at 
org.apache.http.impl.execchain.RetryExec.execute(RetryExec.java:89)
   [junit4]    >        at 
org.apache.http.impl.execchain.RedirectExec.execute(RedirectExec.java:110)
   [junit4]    >        at 
org.apache.http.impl.client.InternalHttpClient.doExecute(InternalHttpClient.java:185)
   [junit4]    >        at 
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:83)
   [junit4]    >        at 
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:56)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:564)
   [junit4]    >        ... 48 more
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderVoteWaitTimeoutTest_1008821C32AE4408-001
   [junit4]   2> Nov 18, 2019 11:33:14 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=CheapBastard, 
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@5f1f421b),
 locale=kok, timezone=Pacific/Kosrae
   [junit4]   2> NOTE: Linux 5.0.0-36-generic amd64/AdoptOpenJDK 12.0.1 
(64-bit)/cpus=8,threads=1,free=53730168,total=518979584
   [junit4]   2> NOTE: All tests run in this JVM: [DateMathParserTest, 
DeleteShardTest, BaseCdcrDistributedZkTest, TestCloudSchemaless, 
IndexBasedSpellCheckerTest, TestCloudRecovery2, AddBlockUpdateTest, 
BJQFilterAccessibleTest, NumberUtilsTest, OpenExchangeRatesOrgProviderTest, 
SuggestComponentTest, DisMaxRequestHandlerTest, DocValuesMultiTest, 
TestConfigSetsAPI, ReplaceNodeNoTargetTest, SuggesterTest, TestInitParams, 
TestDirectoryFactory, OverseerCollectionConfigSetProcessorTest, 
TestEmbeddedSolrServerAdminHandler, TestManagedStopFilterFactory, 
TestCryptoKeys, ConcurrentCreateRoutedAliasTest, 
TestDynamicFieldCollectionResource, DistributedSpellCheckComponentTest, 
TestCloudPivotFacet, CollectionPropsTest, TestHighlightDedupGrouping, 
SpatialFilterTest, TestFieldCacheReopen, LukeRequestHandlerTest, 
ScriptEngineTest, HdfsBasicDistributedZk2Test, TestNumericTerms32, 
TestSolrDeletionPolicy2, CollectionReloadTest, TestFilteredDocIdSet, 
TestAnalyzedSuggestions, RecoveryZkTest, TestStressRecovery, 
TestFieldCacheVsDocValues, TestRequestStatusCollectionAPI, FullHLLTest, 
TestRandomFaceting, SimplePostToolTest, DistributedFacetPivotSmallTest, 
CloudExitableDirectoryReaderTest, DataDrivenBlockJoinTest, QueryEqualityTest, 
NoCacheHeaderTest, AlternateDirectoryTest, LeaderFailoverAfterPartitionTest, 
SolrInfoBeanTest, TestBackupRepositoryFactory, TestDocTermOrds, TestStreamBody, 
ZkSolrClientTest, SolrRrdBackendFactoryTest, HdfsThreadLeakTest, 
BigEndianAscendingWordSerializerTest, MaxSizeAutoCommitTest, SimpleFacetsTest, 
SpellPossibilityIteratorTest, ConjunctionSolrSpellCheckerTest, 
TestJettySolrRunner, ZkFailoverTest, MetricsHistoryWithAuthIntegrationTest, 
PeerSyncWithIndexFingerprintCachingTest, ForceLeaderWithTlogReplicasTest, 
ChaosMonkeyNothingIsSafeTest, TestSweetSpotSimilarityFactory, 
ManagedSchemaRoundRobinCloudTest, ReturnFieldsTest, ExternalFileFieldSortTest, 
PackageManagerCLITest, TestFaceting, BasicDistributedZk2Test, AuthToolTest, 
TestRuleBasedAuthorizationPlugin, TestDistributedSearch, 
TestCustomDocTransformer, OverseerStatusTest, JvmMetricsTest, 
TestSimNodeAddedTrigger, TestMinHashQParser, TestRecovery, 
FieldMutatingUpdateProcessorTest, DateFieldTest, SmileWriterTest, 
TestHdfsBackupRestoreCore, JsonLoaderTest, ByteBuffersDirectoryFactoryTest, 
MultiSolrCloudTestCaseTest, TestUtils, TestLMDirichletSimilarityFactory, 
TestManagedSchemaThreadSafety, TestLegacyTerms, BadCopyFieldTest, 
TestRawResponseWriter, SolrSlf4jReporterTest, PreAnalyzedUpdateProcessorTest, 
TestSizeLimitedDistributedMap, ClassificationUpdateProcessorTest, 
TestReloadDeadlock, TestSolrQueryResponse, TestQuerySenderNoQuery, 
ShardRoutingTest, MinimalSchemaTest, TestNestedDocsSort, 
ChaosMonkeySafeLeaderWithPullReplicasTest, TestSSLRandomization, 
TestDynamicURP, TestNamedUpdateProcessors, AtomicUpdateProcessorFactoryTest, 
SpellCheckComponentTest, PathHierarchyTokenizerFactoryTest, 
BlockJoinFacetSimpleTest, UpdateParamsTest, HttpPartitionOnCommitTest, 
ImplicitSnitchTest, TestReplicationHandlerDiskOverFlow, 
MoveReplicaHDFSFailoverTest, TestBinaryField, TestCoreDiscovery, 
AnalyticsMergeStrategyTest, TestTolerantUpdateProcessorCloud, 
ScheduledTriggerIntegrationTest, TestSimpleTextCodec, TestNumericRangeQuery64, 
DistributedFacetSimpleRefinementLongTailTest, DistributedFacetPivotLargeTest, 
TestConfigSetProperties, DimensionalRoutedAliasUpdateProcessorTest, 
CoreSorterTest, JWTVerificationkeyResolverTest, TestCoreAdminApis, 
TestWordDelimiterFilterFactory, LeaderElectionContextKeyTest, 
CreateCollectionCleanupTest, V2ApiIntegrationTest, TestQueryUtils, 
CdcrOpsAndBoundariesTest, DistributedQueryComponentCustomSortTest, 
MetricTriggerIntegrationTest, WordBreakSolrSpellCheckerTest, 
TestStressInPlaceUpdates, AnalysisAfterCoreReloadTest, BasicFunctionalityTest, 
ConvertedLegacyTest, TestCrossCoreJoin, TestCursorMarkWithoutUniqueKey, 
TestDistributedGrouping, TestSolrCoreProperties, TestSolrTestCaseJ4, 
TestTolerantSearch, TestCharFilters, TestDeprecatedFilters, 
TestLuceneMatchVersion, ActionThrottleTest, AddReplicaTest, 
AliasIntegrationTest, DeleteInactiveReplicaTest, 
DeleteLastCustomShardedReplicaTest, DeleteNodeTest, DistribCursorPagingTest, 
DistribDocExpirationUpdateProcessorTest, DistribJoinFromCollectionTest, 
DistributedQueueTest, DistributedVersionInfoTest, DocValuesNotIndexedTest, 
LeaderTragicEventTest, LeaderVoteWaitTimeoutTest]
   [junit4] Completed [466/888 (1!)] on J1 in 118.56s, 2 tests, 1 error <<< 
FAILURES!

[...truncated 46319 lines...]
[repro] Jenkins log URL: 
https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/25040/consoleText

[repro] Revision: 51b1c5a023e587646f4d01ee38dfa3848faac91c

[repro] Ant options: "-Dargs=-XX:+UseCompressedOops -XX:+UseSerialGC"
[repro] Repro line:  ant test  -Dtestcase=LeaderVoteWaitTimeoutTest 
-Dtests.method=basicTest -Dtests.seed=1008821C32AE4408 -Dtests.multiplier=3 
-Dtests.slow=true -Dtests.locale=kok -Dtests.timezone=Pacific/Kosrae 
-Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1

[repro] ant clean

[...truncated 6 lines...]
[repro] Test suites by module:
[repro]    solr/core
[repro]       LeaderVoteWaitTimeoutTest
[repro] ant compile-test

[...truncated 3333 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5 
-Dtests.class="*.LeaderVoteWaitTimeoutTest" -Dtests.showOutput=onerror 
"-Dargs=-XX:+UseCompressedOops -XX:+UseSerialGC" -Dtests.seed=1008821C32AE4408 
-Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=kok 
-Dtests.timezone=Pacific/Kosrae -Dtests.asserts=true 
-Dtests.file.encoding=ISO-8859-1

[...truncated 80 lines...]
[repro] Failures:
[repro]   0/5 failed: org.apache.solr.cloud.LeaderVoteWaitTimeoutTest
[repro] Exiting with code 0

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

Reply via email to