Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/23875/ Java: 32bit/jdk1.8.0_172 -client -XX:+UseG1GC
1 tests failed. FAILED: org.apache.solr.cloud.LeaderVoteWaitTimeoutTest.basicTest Error Message: Timeout occurred while waiting response from server at: https://127.0.0.1:32979/solr Stack Trace: org.apache.solr.client.solrj.SolrServerException: Timeout occurred while waiting response from server at: https://127.0.0.1:32979/solr at __randomizedtesting.SeedInfo.seed([8D66CBF2891768D4:7F92DC90CDB265E7]:0) at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:660) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:255) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:244) at org.apache.solr.client.solrj.impl.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:1055) at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.requestWithRetryOnStaleState(BaseCloudSolrClient.java:830) at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.request(BaseCloudSolrClient.java:763) 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:155) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java: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 com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at java.lang.Thread.run(Thread.java:748) Caused by: java.net.SocketTimeoutException: Read timed out at java.net.SocketInputStream.socketRead0(Native Method) at java.net.SocketInputStream.socketRead(SocketInputStream.java:116) at java.net.SocketInputStream.read(SocketInputStream.java:171) at java.net.SocketInputStream.read(SocketInputStream.java:141) at sun.security.ssl.InputRecord.readFully(InputRecord.java:465) at sun.security.ssl.InputRecord.read(InputRecord.java:503) at sun.security.ssl.SSLSocketImpl.readRecord(SSLSocketImpl.java:983) at sun.security.ssl.SSLSocketImpl.readDataRecord(SSLSocketImpl.java:940) at sun.security.ssl.AppInputStream.read(AppInputStream.java:105) 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:548) ... 49 more Build Log: [...truncated 14435 lines...] [junit4] Suite: org.apache.solr.cloud.LeaderVoteWaitTimeoutTest [junit4] 2> 2328283 INFO (SUITE-LeaderVoteWaitTimeoutTest-seed#[8D66CBF2891768D4]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom [junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderVoteWaitTimeoutTest_8D66CBF2891768D4-001/init-core-data-001 [junit4] 2> 2328284 WARN (SUITE-LeaderVoteWaitTimeoutTest-seed#[8D66CBF2891768D4]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=39 numCloses=39 [junit4] 2> 2328284 INFO (SUITE-LeaderVoteWaitTimeoutTest-seed#[8D66CBF2891768D4]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false [junit4] 2> 2328286 INFO (SUITE-LeaderVoteWaitTimeoutTest-seed#[8D66CBF2891768D4]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN) [junit4] 2> 2328290 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testMostInSyncReplicasCanWinElection [junit4] 2> 2328291 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderVoteWaitTimeoutTest_8D66CBF2891768D4-001/tempDir-001 [junit4] 2> 2328291 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 2328292 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 2328292 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 2328392 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.c.ZkTestServer start zk server on port:36111 [junit4] 2> 2328392 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:36111 [junit4] 2> 2328392 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 36111 [junit4] 2> 2328395 INFO (zkConnectionManagerCallback-9535-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2328397 INFO (zkConnectionManagerCallback-9537-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2328401 INFO (zkConnectionManagerCallback-9539-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2328407 WARN (jetty-launcher-9540-thread-1) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 2328407 INFO (jetty-launcher-9540-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0) [junit4] 2> 2328407 INFO (jetty-launcher-9540-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 2328407 INFO (jetty-launcher-9540-thread-1) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_172-b11 [junit4] 2> 2328410 WARN (jetty-launcher-9540-thread-3) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 2328410 WARN (jetty-launcher-9540-thread-2) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 2328411 INFO (jetty-launcher-9540-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0) [junit4] 2> 2328411 INFO (jetty-launcher-9540-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0) [junit4] 2> 2328411 INFO (jetty-launcher-9540-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 2328411 INFO (jetty-launcher-9540-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 2328411 INFO (jetty-launcher-9540-thread-3) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_172-b11 [junit4] 2> 2328411 INFO (jetty-launcher-9540-thread-2) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_172-b11 [junit4] 2> 2328418 WARN (jetty-launcher-9540-thread-4) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 2328419 INFO (jetty-launcher-9540-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0) [junit4] 2> 2328419 INFO (jetty-launcher-9540-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 2328419 INFO (jetty-launcher-9540-thread-4) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_172-b11 [junit4] 2> 2328440 INFO (jetty-launcher-9540-thread-3) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 2328440 INFO (jetty-launcher-9540-thread-3) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 2328440 INFO (jetty-launcher-9540-thread-3) [ ] o.e.j.s.session node0 Scavenging every 600000ms [junit4] 2> 2328441 INFO (jetty-launcher-9540-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 2328441 INFO (jetty-launcher-9540-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 2328441 INFO (jetty-launcher-9540-thread-1) [ ] o.e.j.s.session node0 Scavenging every 660000ms [junit4] 2> 2328445 INFO (jetty-launcher-9540-thread-2) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 2328445 INFO (jetty-launcher-9540-thread-2) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 2328445 INFO (jetty-launcher-9540-thread-2) [ ] o.e.j.s.session node0 Scavenging every 660000ms [junit4] 2> 2328446 INFO (jetty-launcher-9540-thread-3) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@17e0ca4{/solr,null,AVAILABLE} [junit4] 2> 2328447 WARN (jetty-launcher-9540-thread-3) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@5cf441[provider=null,keyStore=null,trustStore=null] [junit4] 2> 2328447 INFO (jetty-launcher-9540-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@6741de{/solr,null,AVAILABLE} [junit4] 2> 2328447 INFO (jetty-launcher-9540-thread-4) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 2328447 INFO (jetty-launcher-9540-thread-4) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 2328447 INFO (jetty-launcher-9540-thread-4) [ ] o.e.j.s.session node0 Scavenging every 660000ms [junit4] 2> 2328448 INFO (jetty-launcher-9540-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@55c3d9{/solr,null,AVAILABLE} [junit4] 2> 2328448 WARN (jetty-launcher-9540-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@ca0356[provider=null,keyStore=null,trustStore=null] [junit4] 2> 2328448 WARN (jetty-launcher-9540-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@1dcbf8c[provider=null,keyStore=null,trustStore=null] [junit4] 2> 2328450 INFO (jetty-launcher-9540-thread-3) [ ] o.e.j.s.AbstractConnector Started ServerConnector@4bd7c2{SSL,[ssl, http/1.1]}{127.0.0.1:34933} [junit4] 2> 2328450 INFO (jetty-launcher-9540-thread-4) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1a0e836{/solr,null,AVAILABLE} [junit4] 2> 2328450 INFO (jetty-launcher-9540-thread-3) [ ] o.e.j.s.Server Started @2328550ms [junit4] 2> 2328450 INFO (jetty-launcher-9540-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=34933} [junit4] 2> 2328450 ERROR (jetty-launcher-9540-thread-3) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 2328450 INFO (jetty-launcher-9540-thread-3) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 2328450 INFO (jetty-launcher-9540-thread-3) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 9.0.0 [junit4] 2> 2328450 WARN (jetty-launcher-9540-thread-4) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@ee58aa[provider=null,keyStore=null,trustStore=null] [junit4] 2> 2328450 INFO (jetty-launcher-9540-thread-3) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 2328450 INFO (jetty-launcher-9540-thread-3) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 2328450 INFO (jetty-launcher-9540-thread-3) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-04-06T15:03:50.503Z [junit4] 2> 2328450 INFO (jetty-launcher-9540-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@1c8b23e{SSL,[ssl, http/1.1]}{127.0.0.1:41957} [junit4] 2> 2328450 INFO (jetty-launcher-9540-thread-1) [ ] o.e.j.s.Server Started @2328550ms [junit4] 2> 2328450 INFO (jetty-launcher-9540-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=41957} [junit4] 2> 2328451 ERROR (jetty-launcher-9540-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 2328451 INFO (jetty-launcher-9540-thread-1) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 2328451 INFO (jetty-launcher-9540-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 9.0.0 [junit4] 2> 2328451 INFO (jetty-launcher-9540-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 2328451 INFO (jetty-launcher-9540-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 2328451 INFO (jetty-launcher-9540-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-04-06T15:03:50.504Z [junit4] 2> 2328457 INFO (jetty-launcher-9540-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@178273b{SSL,[ssl, http/1.1]}{127.0.0.1:37905} [junit4] 2> 2328458 INFO (jetty-launcher-9540-thread-2) [ ] o.e.j.s.Server Started @2328558ms [junit4] 2> 2328458 INFO (jetty-launcher-9540-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=37905} [junit4] 2> 2328458 INFO (zkConnectionManagerCallback-9542-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2328458 ERROR (jetty-launcher-9540-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 2328458 INFO (jetty-launcher-9540-thread-2) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 2328458 INFO (jetty-launcher-9540-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 9.0.0 [junit4] 2> 2328458 INFO (jetty-launcher-9540-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 2328458 INFO (jetty-launcher-9540-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 2328458 INFO (jetty-launcher-9540-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-04-06T15:03:50.511Z [junit4] 2> 2328458 INFO (jetty-launcher-9540-thread-3) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 2328470 INFO (jetty-launcher-9540-thread-4) [ ] o.e.j.s.AbstractConnector Started ServerConnector@1ebb7d0{SSL,[ssl, http/1.1]}{127.0.0.1:43549} [junit4] 2> 2328470 INFO (jetty-launcher-9540-thread-4) [ ] o.e.j.s.Server Started @2328570ms [junit4] 2> 2328470 INFO (jetty-launcher-9540-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=43549} [junit4] 2> 2328470 ERROR (jetty-launcher-9540-thread-4) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 2328470 INFO (jetty-launcher-9540-thread-4) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 2328470 INFO (jetty-launcher-9540-thread-4) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 9.0.0 [junit4] 2> 2328470 INFO (jetty-launcher-9540-thread-4) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 2328470 INFO (jetty-launcher-9540-thread-4) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 2328470 INFO (jetty-launcher-9540-thread-4) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-04-06T15:03:50.523Z [junit4] 2> 2328473 INFO (zkConnectionManagerCallback-9544-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2328474 INFO (zkConnectionManagerCallback-9546-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2328474 INFO (jetty-launcher-9540-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 2328474 INFO (jetty-launcher-9540-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 2328487 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 0x100f69ee26f0005, likely client has closed socket [junit4] 2> 2328497 INFO (zkConnectionManagerCallback-9548-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2328498 INFO (jetty-launcher-9540-thread-4) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 2329545 INFO (jetty-launcher-9540-thread-2) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true] [junit4] 2> 2329546 WARN (jetty-launcher-9540-thread-2) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2 [junit4] 2> 2329553 WARN (jetty-launcher-9540-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@1467b25[provider=null,keyStore=null,trustStore=null] [junit4] 2> 2329571 WARN (jetty-launcher-9540-thread-2) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2 [junit4] 2> 2329592 WARN (jetty-launcher-9540-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@a42a00[provider=null,keyStore=null,trustStore=null] [junit4] 2> 2329594 INFO (jetty-launcher-9540-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:36111/solr [junit4] 2> 2329630 INFO (zkConnectionManagerCallback-9558-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2329685 INFO (zkConnectionManagerCallback-9560-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2329787 INFO (jetty-launcher-9540-thread-2) [n:127.0.0.1:37905_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:37905_solr [junit4] 2> 2329788 INFO (jetty-launcher-9540-thread-2) [n:127.0.0.1:37905_solr ] o.a.s.c.Overseer Overseer (id=72328756302118920-127.0.0.1:37905_solr-n_0000000000) starting [junit4] 2> 2329817 INFO (zkConnectionManagerCallback-9567-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2329833 INFO (jetty-launcher-9540-thread-2) [n:127.0.0.1:37905_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:36111/solr ready [junit4] 2> 2329850 INFO (OverseerStateUpdate-72328756302118920-127.0.0.1:37905_solr-n_0000000000) [n:127.0.0.1:37905_solr ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:37905_solr [junit4] 2> 2329871 INFO (jetty-launcher-9540-thread-2) [n:127.0.0.1:37905_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:37905_solr [junit4] 2> 2329882 INFO (zkCallback-9559-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 2329918 INFO (zkCallback-9566-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 2329987 INFO (jetty-launcher-9540-thread-2) [n:127.0.0.1:37905_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 2330022 INFO (jetty-launcher-9540-thread-2) [n:127.0.0.1:37905_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_37905.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ac0645 [junit4] 2> 2330034 INFO (jetty-launcher-9540-thread-2) [n:127.0.0.1:37905_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_37905.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ac0645 [junit4] 2> 2330034 INFO (jetty-launcher-9540-thread-2) [n:127.0.0.1:37905_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_37905.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ac0645 [junit4] 2> 2330037 INFO (jetty-launcher-9540-thread-2) [n:127.0.0.1:37905_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderVoteWaitTimeoutTest_8D66CBF2891768D4-001/tempDir-001/node2/. [junit4] 2> 2330606 INFO (jetty-launcher-9540-thread-1) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true] [junit4] 2> 2330608 WARN (jetty-launcher-9540-thread-1) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2 [junit4] 2> 2330610 WARN (jetty-launcher-9540-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@389c78[provider=null,keyStore=null,trustStore=null] [junit4] 2> 2330639 WARN (jetty-launcher-9540-thread-1) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2 [junit4] 2> 2330662 WARN (jetty-launcher-9540-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@eea927[provider=null,keyStore=null,trustStore=null] [junit4] 2> 2330664 INFO (jetty-launcher-9540-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:36111/solr [junit4] 2> 2330720 INFO (zkConnectionManagerCallback-9574-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2330753 INFO (zkConnectionManagerCallback-9576-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2330756 INFO (jetty-launcher-9540-thread-1) [n:127.0.0.1:41957_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 2330759 INFO (jetty-launcher-9540-thread-1) [n:127.0.0.1:41957_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:41957_solr as DOWN [junit4] 2> 2330759 INFO (jetty-launcher-9540-thread-1) [n:127.0.0.1:41957_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 2330759 INFO (jetty-launcher-9540-thread-1) [n:127.0.0.1:41957_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:41957_solr [junit4] 2> 2330764 INFO (zkCallback-9559-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 2330764 INFO (zkCallback-9566-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 2330780 INFO (zkCallback-9575-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 2330839 INFO (zkConnectionManagerCallback-9583-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2330842 INFO (jetty-launcher-9540-thread-1) [n:127.0.0.1:41957_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2) [junit4] 2> 2330843 INFO (jetty-launcher-9540-thread-1) [n:127.0.0.1:41957_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:36111/solr ready [junit4] 2> 2330889 INFO (jetty-launcher-9540-thread-1) [n:127.0.0.1:41957_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 2330936 INFO (jetty-launcher-9540-thread-1) [n:127.0.0.1:41957_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_41957.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ac0645 [junit4] 2> 2330973 INFO (jetty-launcher-9540-thread-1) [n:127.0.0.1:41957_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_41957.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ac0645 [junit4] 2> 2330973 INFO (jetty-launcher-9540-thread-1) [n:127.0.0.1:41957_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_41957.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ac0645 [junit4] 2> 2330977 INFO (jetty-launcher-9540-thread-1) [n:127.0.0.1:41957_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderVoteWaitTimeoutTest_8D66CBF2891768D4-001/tempDir-001/node1/. [junit4] 2> 2331344 INFO (jetty-launcher-9540-thread-4) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true] [junit4] 2> 2331345 WARN (jetty-launcher-9540-thread-4) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2 [junit4] 2> 2331345 WARN (jetty-launcher-9540-thread-4) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@19dbf6d[provider=null,keyStore=null,trustStore=null] [junit4] 2> 2331350 WARN (jetty-launcher-9540-thread-4) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2 [junit4] 2> 2331358 WARN (jetty-launcher-9540-thread-4) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@18babe1[provider=null,keyStore=null,trustStore=null] [junit4] 2> 2331360 INFO (jetty-launcher-9540-thread-4) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:36111/solr [junit4] 2> 2331381 INFO (zkConnectionManagerCallback-9590-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2331390 INFO (zkConnectionManagerCallback-9592-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2331393 INFO (jetty-launcher-9540-thread-4) [n:127.0.0.1:43549_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2) [junit4] 2> 2331396 INFO (jetty-launcher-9540-thread-4) [n:127.0.0.1:43549_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:43549_solr as DOWN [junit4] 2> 2331396 INFO (jetty-launcher-9540-thread-4) [n:127.0.0.1:43549_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 2331396 INFO (jetty-launcher-9540-thread-4) [n:127.0.0.1:43549_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:43549_solr [junit4] 2> 2331397 INFO (zkCallback-9566-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 2331398 INFO (zkCallback-9559-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 2331398 INFO (zkCallback-9575-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 2331399 INFO (zkCallback-9582-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 2331418 INFO (zkCallback-9591-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 2331432 INFO (zkConnectionManagerCallback-9599-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2331433 INFO (jetty-launcher-9540-thread-4) [n:127.0.0.1:43549_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3) [junit4] 2> 2331434 INFO (jetty-launcher-9540-thread-4) [n:127.0.0.1:43549_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:36111/solr ready [junit4] 2> 2331437 INFO (jetty-launcher-9540-thread-4) [n:127.0.0.1:43549_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 2331462 INFO (jetty-launcher-9540-thread-4) [n:127.0.0.1:43549_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_43549.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ac0645 [junit4] 2> 2331479 INFO (jetty-launcher-9540-thread-4) [n:127.0.0.1:43549_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_43549.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ac0645 [junit4] 2> 2331479 INFO (jetty-launcher-9540-thread-4) [n:127.0.0.1:43549_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_43549.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ac0645 [junit4] 2> 2331480 INFO (jetty-launcher-9540-thread-4) [n:127.0.0.1:43549_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderVoteWaitTimeoutTest_8D66CBF2891768D4-001/tempDir-001/node4/. [junit4] 2> 2332643 INFO (jetty-launcher-9540-thread-3) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true] [junit4] 2> 2332644 WARN (jetty-launcher-9540-thread-3) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2 [junit4] 2> 2332646 WARN (jetty-launcher-9540-thread-3) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@1a21b81[provider=null,keyStore=null,trustStore=null] [junit4] 2> 2332649 WARN (jetty-launcher-9540-thread-3) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2 [junit4] 2> 2332654 WARN (jetty-launcher-9540-thread-3) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@a3e974[provider=null,keyStore=null,trustStore=null] [junit4] 2> 2332655 INFO (jetty-launcher-9540-thread-3) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:36111/solr [junit4] 2> 2332660 INFO (zkConnectionManagerCallback-9606-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2332661 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 0x100f69ee26f0010, likely client has closed socket [junit4] 2> 2332665 INFO (zkConnectionManagerCallback-9608-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2332668 INFO (jetty-launcher-9540-thread-3) [n:127.0.0.1:34933_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3) [junit4] 2> 2332672 INFO (jetty-launcher-9540-thread-3) [n:127.0.0.1:34933_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:34933_solr as DOWN [junit4] 2> 2332673 INFO (jetty-launcher-9540-thread-3) [n:127.0.0.1:34933_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 2332673 INFO (jetty-launcher-9540-thread-3) [n:127.0.0.1:34933_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:34933_solr [junit4] 2> 2332674 INFO (zkCallback-9591-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2332674 INFO (zkCallback-9566-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2332674 INFO (zkCallback-9575-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2332674 INFO (zkCallback-9559-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2332678 INFO (zkCallback-9582-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2332678 INFO (zkCallback-9607-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2332678 INFO (zkCallback-9598-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2332696 INFO (zkConnectionManagerCallback-9615-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2332697 INFO (jetty-launcher-9540-thread-3) [n:127.0.0.1:34933_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4) [junit4] 2> 2332698 INFO (jetty-launcher-9540-thread-3) [n:127.0.0.1:34933_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:36111/solr ready [junit4] 2> 2332701 INFO (jetty-launcher-9540-thread-3) [n:127.0.0.1:34933_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 2332725 INFO (jetty-launcher-9540-thread-3) [n:127.0.0.1:34933_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_34933.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ac0645 [junit4] 2> 2332741 INFO (jetty-launcher-9540-thread-3) [n:127.0.0.1:34933_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_34933.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ac0645 [junit4] 2> 2332741 INFO (jetty-launcher-9540-thread-3) [n:127.0.0.1:34933_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_34933.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ac0645 [junit4] 2> 2332742 INFO (jetty-launcher-9540-thread-3) [n:127.0.0.1:34933_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderVoteWaitTimeoutTest_8D66CBF2891768D4-001/tempDir-001/node3/. [junit4] 2> 2332819 INFO (zkConnectionManagerCallback-9621-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2332820 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4) [junit4] 2> 2332821 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:36111/solr ready [junit4] 2> 2332823 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=12760334 [junit4] 2> 2332823 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:37905_solr [junit4] 2> 2332824 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.c.CoreContainer Publish this node as DOWN... [junit4] 2> 2332824 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.c.ZkController Publish node=127.0.0.1:37905_solr as DOWN [junit4] 2> 2332826 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 2332826 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 2332826 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@cbf51d: rootName = solr_37905, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@c3a214 [junit4] 2> 2332835 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null [junit4] 2> 2332835 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@3d9495: rootName = solr_37905, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@1d352e8 [junit4] 2> 2332841 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null [junit4] 2> 2332842 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@9e895: rootName = solr_37905, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@2a43fc [junit4] 2> 2332842 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null [junit4] 2> 2332846 INFO (closeThreadPool-9624-thread-1) [ ] o.a.s.c.Overseer Overseer (id=72328756302118920-127.0.0.1:37905_solr-n_0000000000) closing [junit4] 2> 2332850 INFO (OverseerStateUpdate-72328756302118920-127.0.0.1:37905_solr-n_0000000000) [n:127.0.0.1:37905_solr ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:37905_solr [junit4] 2> 2332850 INFO (OverseerAutoScalingTriggerThread-72328756302118920-127.0.0.1:37905_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we are closed, exiting. [junit4] 2> 2332863 INFO (closeThreadPool-9624-thread-2) [ ] o.a.s.c.Overseer Overseer (id=72328756302118920-127.0.0.1:37905_solr-n_0000000000) closing [junit4] 2> 2332864 INFO (zkCallback-9575-thread-1) [ ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:41957_solr [junit4] 2> 2332864 INFO (zkCallback-9591-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 2332864 INFO (zkCallback-9582-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 2332864 INFO (zkCallback-9575-thread-1) [n:127.0.0.1:41957_solr ] o.a.s.c.Overseer Overseer (id=72328756302118923-127.0.0.1:41957_solr-n_0000000001) starting [junit4] 2> 2332867 INFO (zkCallback-9607-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 2332867 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.c.Overseer Overseer (id=72328756302118920-127.0.0.1:37905_solr-n_0000000000) closing [junit4] 2> 2332870 INFO (zkCallback-9620-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 2332874 INFO (zkCallback-9598-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 2332874 INFO (zkCallback-9614-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 2332874 INFO (zkCallback-9575-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 2332878 INFO (OverseerStateUpdate-72328756302118923-127.0.0.1:41957_solr-n_0000000001) [n:127.0.0.1:41957_solr ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:41957_solr [junit4] 2> 2332887 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@178273b{SSL,[ssl, http/1.1]}{127.0.0.1:0} [junit4] 2> 2332887 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@55c3d9{/solr,null,UNAVAILABLE} [junit4] 2> 2332890 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.e.j.s.session node0 Stopped scavenging [junit4] 2> 2332890 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0) [junit4] 2> 2332891 WARN (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 2332893 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 2332893 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_172-b11 [junit4] 2> 2332913 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 2332913 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 2332914 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.e.j.s.session node0 Scavenging every 660000ms [junit4] 2> 2332915 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@64b51f{/solr,null,AVAILABLE} [junit4] 2> 2332916 WARN (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@290d9f[provider=null,keyStore=null,trustStore=null] [junit4] 2> 2332919 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@1999d8d{SSL,[ssl, http/1.1]}{127.0.0.1:42197} [junit4] 2> 2332919 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.e.j.s.Server Started @2333019ms [junit4] 2> 2332919 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=41295} [junit4] 2> 2332920 ERROR (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 2332920 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 2332920 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 9.0.0 [junit4] 2> 2332920 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 2332920 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 2332920 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-04-06T15:03:54.973Z [junit4] 2> 2332930 INFO (zkConnectionManagerCallback-9626-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2332931 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 2333778 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true] [junit4] 2> 2333779 WARN (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2 [junit4] 2> 2333780 WARN (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@9e70d1[provider=null,keyStore=null,trustStore=null] [junit4] 2> 2333791 WARN (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2 [junit4] 2> 2333793 WARN (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@1bfc2b1[provider=null,keyStore=null,trustStore=null] [junit4] 2> 2333794 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:36111/solr [junit4] 2> 2333802 INFO (zkConnectionManagerCallback-9633-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2333814 INFO (zkConnectionManagerCallback-9635-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2333816 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [n:127.0.0.1:41295_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3) [junit4] 2> 2333819 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [n:127.0.0.1:41295_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:41295_solr as DOWN [junit4] 2> 2333820 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [n:127.0.0.1:41295_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 2333820 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [n:127.0.0.1:41295_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:41295_solr [junit4] 2> 2333822 INFO (zkCallback-9614-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2333822 INFO (zkCallback-9607-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2333822 INFO (zkCallback-9620-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2333822 INFO (zkCallback-9582-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2333822 INFO (zkCallback-9598-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2333823 INFO (zkCallback-9591-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2333823 INFO (zkCallback-9575-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2333830 INFO (zkCallback-9634-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2333842 INFO (zkConnectionManagerCallback-9642-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2333844 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [n:127.0.0.1:41295_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4) [junit4] 2> 2333845 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [n:127.0.0.1:41295_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:36111/solr ready [junit4] 2> 2333850 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [n:127.0.0.1:41295_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 2333878 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [n:127.0.0.1:41295_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_41295.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ac0645 [junit4] 2> 2333896 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [n:127.0.0.1:41295_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_41295.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ac0645 [junit4] 2> 2333897 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [n:127.0.0.1:41295_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_41295.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ac0645 [junit4] 2> 2333898 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [n:127.0.0.1:41295_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderVoteWaitTimeoutTest_8D66CBF2891768D4-001/tempDir-001/node2/. [junit4] 2> 2333981 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.c.LeaderVoteWaitTimeoutTest Adding proxy for URL: https://127.0.0.1:42197/solr. Proxy: https://127.0.0.1:41295/solr [junit4] 2> 2333981 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=5964260 [junit4] 2> 2333981 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:41957_solr [junit4] 2> 2333981 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.c.CoreContainer Publish this node as DOWN... [junit4] 2> 2333981 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.c.ZkController Publish node=127.0.0.1:41957_solr as DOWN [junit4] 2> 2333984 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 2333984 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1778903: rootName = solr_41957, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@1548458 [junit4] 2> 2333993 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null [junit4] 2> 2333993 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@12ff348: rootName = solr_41957, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@1d352e8 [junit4] 2> 2334013 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null [junit4] 2> 2334013 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@69e15f: rootName = solr_41957, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@2a43fc [junit4] 2> 2334013 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null [junit4] 2> 2334022 INFO (closeThreadPool-9646-thread-1) [ ] o.a.s.c.Overseer Overseer (id=72328756302118923-127.0.0.1:41957_solr-n_0000000001) closing [junit4] 2> 2334036 INFO (OverseerStateUpdate-72328756302118923-127.0.0.1:41957_solr-n_0000000001) [n:127.0.0.1:41957_solr ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:41957_solr [junit4] 2> 2334036 INFO (OverseerAutoScalingTriggerThread-72328756302118923-127.0.0.1:41957_solr-n_0000000001) [ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we are closed, exiting. [junit4] 2> 2334038 INFO (closeThreadPool-9646-thread-2) [ ] o.a.s.c.Overseer Overseer (id=72328756302118923-127.0.0.1:41957_solr-n_0000000001) closing [junit4] 2> 2334038 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.c.Overseer Overseer (id=72328756302118923-127.0.0.1:41957_solr-n_0000000001) closing [junit4] 2> 2334039 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 0x100f69ee26f000b, likely client has closed socket [junit4] 2> 2334039 INFO (zkCallback-9598-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 2334039 INFO (zkCallback-9620-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 2334039 INFO (zkCallback-9614-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 2334039 INFO (zkCallback-9634-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 2334039 INFO (zkCallback-9591-thread-1) [ ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:43549_solr [junit4] 2> 2334039 INFO (zkCallback-9607-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 2334041 INFO (zkCallback-9591-thread-1) [n:127.0.0.1:43549_solr ] o.a.s.c.Overseer Overseer (id=72328756302118926-127.0.0.1:43549_solr-n_0000000002) starting [junit4] 2> 2334042 INFO (zkCallback-9641-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 2334047 INFO (zkCallback-9591-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 2334047 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@1c8b23e{SSL,[ssl, http/1.1]}{127.0.0.1:0} [junit4] 2> 2334050 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@6741de{/solr,null,UNAVAILABLE} [junit4] 2> 2334054 INFO (OverseerStateUpdate-72328756302118926-127.0.0.1:43549_solr-n_0000000002) [n:127.0.0.1:43549_solr ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:43549_solr [junit4] 2> 2334062 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.e.j.s.session node0 Stopped scavenging [junit4] 2> 2334062 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0) [junit4] 2> 2334063 WARN (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 2334064 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 2334064 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_172-b11 [junit4] 2> 2334083 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 2334083 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 2334083 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.e.j.s.session node0 Scavenging every 660000ms [junit4] 2> 2334083 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@30e3b{/solr,null,AVAILABLE} [junit4] 2> 2334084 WARN (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@7412f6[provider=null,keyStore=null,trustStore=null] [junit4] 2> 2334085 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@194fe0e{SSL,[ssl, http/1.1]}{127.0.0.1:40163} [junit4] 2> 2334085 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.e.j.s.Server Started @2334185ms [junit4] 2> 2334085 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=36857} [junit4] 2> 2334085 ERROR (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 2334085 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 2334086 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 9.0.0 [junit4] 2> 2334086 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 2334086 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 2334086 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-04-06T15:03:56.139Z [junit4] 2> 2334091 INFO (zkConnectionManagerCallback-9648-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2334092 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 2335589 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true] [junit4] 2> 2335589 WARN (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2 [junit4] 2> 2335590 WARN (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@984c0d[provider=null,keyStore=null,trustStore=null] [junit4] 2> 2335594 WARN (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2 [junit4] 2> 2335598 WARN (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@130547[provider=null,keyStore=null,trustStore=null] [junit4] 2> 2335599 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:36111/solr [junit4] 2> 2335601 INFO (zkConnectionManagerCallback-9655-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2335606 INFO (zkConnectionManagerCallback-9657-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2335609 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3) [junit4] 2> 2335611 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.c.ZkController Publish node=127.0.0.1:36857_solr as DOWN [junit4] 2> 2335612 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 2335612 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:36857_solr [junit4] 2> 2335613 INFO (zkCallback-9607-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2335613 INFO (zkCallback-9591-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2335613 INFO (zkCallback-9620-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2335613 INFO (zkCallback-9598-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2335613 INFO (zkCallback-9634-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2335613 INFO (zkCallback-9614-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2335613 INFO (zkCallback-9641-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2335614 INFO (zkCallback-9656-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2335632 INFO (zkConnectionManagerCallback-9664-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2335634 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4) [junit4] 2> 2335634 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:36111/solr ready [junit4] 2> 2335639 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 2335667 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_36857.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ac0645 [junit4] 2> 2335683 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_36857.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ac0645 [junit4] 2> 2335683 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_36857.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ac0645 [junit4] 2> 2335684 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderVoteWaitTimeoutTest_8D66CBF2891768D4-001/tempDir-001/node1/. [junit4] 2> 2335742 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.c.LeaderVoteWaitTimeoutTest Adding proxy for URL: https://127.0.0.1:40163/solr. Proxy: https://127.0.0.1:36857/solr [junit4] 2> 2335742 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=25836766 [junit4] 2> 2335742 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:43549_solr [junit4] 2> 2335742 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.c.CoreContainer Publish this node as DOWN... [junit4] 2> 2335742 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.c.ZkController Publish node=127.0.0.1:43549_solr as DOWN [junit4] 2> 2335745 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 2335745 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1612f58: rootName = solr_43549, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@d8c382 [junit4] 2> 2335751 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null [junit4] 2> 2335751 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@ed7565: rootName = solr_43549, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@1d352e8 [junit4] 2> 2335755 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null [junit4] 2> 2335755 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@5fa3d3: rootName = solr_43549, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@2a43fc [junit4] 2> 2335756 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null [junit4] 2> 2335760 INFO (closeThreadPool-9668-thread-1) [ ] o.a.s.c.Overseer Overseer (id=72328756302118926-127.0.0.1:43549_solr-n_0000000002) closing [junit4] 2> 2335760 INFO (OverseerStateUpdate-72328756302118926-127.0.0.1:43549_solr-n_0000000002) [n:127.0.0.1:43549_solr ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:43549_solr [junit4] 2> 2335762 INFO (OverseerAutoScalingTriggerThread-72328756302118926-127.0.0.1:43549_solr-n_0000000002) [ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we are closed, exiting. [junit4] 2> 2335767 INFO (closeThreadPool-9668-thread-2) [ ] o.a.s.c.Overseer Overseer (id=72328756302118926-127.0.0.1:43549_solr-n_0000000002) closing [junit4] 2> 2335767 INFO (zkCallback-9620-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 2335768 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.c.Overseer Overseer (id=72328756302118926-127.0.0.1:43549_solr-n_0000000002) closing [junit4] 2> 2335769 INFO (zkCallback-9607-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 2335770 INFO (zkCallback-9634-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 2335770 INFO (zkCallback-9614-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 2335770 INFO (zkCallback-9641-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 2335774 INFO (zkCallback-9663-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 2335774 INFO (zkCallback-9656-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 2335774 INFO (zkCallback-9607-thread-2) [ ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:34933_solr [junit4] 2> 2335775 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@1ebb7d0{SSL,[ssl, http/1.1]}{127.0.0.1:0} [junit4] 2> 2335775 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@1a0e836{/solr,null,UNAVAILABLE} [junit4] 2> 2335775 INFO (zkCallback-9607-thread-2) [n:127.0.0.1:34933_solr ] o.a.s.c.Overseer Overseer (id=72328756302118929-127.0.0.1:34933_solr-n_0000000003) starting [junit4] 2> 2335775 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.e.j.s.session node0 Stopped scavenging [junit4] 2> 2335775 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0) [junit4] 2> 2335776 WARN (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 2335777 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 2335777 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_172-b11 [junit4] 2> 2335777 INFO (OverseerStateUpdate-72328756302118929-127.0.0.1:34933_solr-n_0000000003) [n:127.0.0.1:34933_solr ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:34933_solr [junit4] 2> 2335802 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 2335802 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 2335802 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.e.j.s.session node0 Scavenging every 600000ms [junit4] 2> 2335805 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@22e085{/solr,null,AVAILABLE} [junit4] 2> 2335805 WARN (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@1b0d65d[provider=null,keyStore=null,trustStore=null] [junit4] 2> 2335806 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@6423f5{SSL,[ssl, http/1.1]}{127.0.0.1:38759} [junit4] 2> 2335806 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.e.j.s.Server Started @2335906ms [junit4] 2> 2335806 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=34539} [junit4] 2> 2335806 ERROR (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 2335806 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 2335806 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 9.0.0 [junit4] 2> 2335806 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 2335806 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 2335807 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-04-06T15:03:57.859Z [junit4] 2> 2335810 INFO (zkConnectionManagerCallback-9670-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2335810 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 2339054 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true] [junit4] 2> 2339057 WARN (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2 [junit4] 2> 2339066 WARN (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@a65878[provider=null,keyStore=null,trustStore=null] [junit4] 2> 2339079 WARN (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2 [junit4] 2> 2339098 WARN (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@19041c6[provider=null,keyStore=null,trustStore=null] [junit4] 2> 2339100 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:36111/solr [junit4] 2> 2339105 INFO (zkConnectionManagerCallback-9677-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2339121 INFO (zkConnectionManagerCallback-9679-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2339125 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3) [junit4] 2> 2339127 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.c.ZkController Publish node=127.0.0.1:34539_solr as DOWN [junit4] 2> 2339128 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 2339128 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:34539_solr [junit4] 2> 2339129 INFO (zkCallback-9607-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2339129 INFO (zkCallback-9663-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2339129 INFO (zkCallback-9656-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2339129 INFO (zkCallback-9620-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2339129 INFO (zkCallback-9641-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2339129 INFO (zkCallback-9614-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2339129 INFO (zkCallback-9634-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2339138 INFO (zkCallback-9678-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2339174 INFO (zkConnectionManagerCallback-9686-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2339175 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4) [junit4] 2> 2339176 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:36111/solr ready [junit4] 2> 2339185 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 2339207 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_34539.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ac0645 [junit4] 2> 2339223 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_34539.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ac0645 [junit4] 2> 2339223 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_34539.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ac0645 [junit4] 2> 2339224 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderVoteWaitTimeoutTest_8D66CBF2891768D4-001/tempDir-001/node4/. [junit4] 2> 2339305 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[8D66CBF2891768D4]) [ ] o.a.s.c.LeaderVoteWaitTimeoutTest Adding proxy for URL: https://127.0.0.1:38759/solr. Proxy: https://127.0.0.1:34539/solr [junit4] 2> 2339305 INFO (TE [...truncated too long message...] -Dtests.file.encoding=UTF-8 [junit4] ERROR 113s J0 | LeaderVoteWaitTimeoutTest.basicTest <<< [junit4] > Throwable #1: org.apache.solr.client.solrj.SolrServerException: Timeout occurred while waiting response from server at: https://127.0.0.1:32979/solr [junit4] > at __randomizedtesting.SeedInfo.seed([8D66CBF2891768D4:7F92DC90CDB265E7]:0) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:660) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:255) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:244) [junit4] > at org.apache.solr.client.solrj.impl.LBSolrClient.doRequest(LBSolrClient.java:368) [junit4] > at org.apache.solr.client.solrj.impl.LBSolrClient.request(LBSolrClient.java:296) [junit4] > at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.sendRequest(BaseCloudSolrClient.java:1055) [junit4] > at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.requestWithRetryOnStaleState(BaseCloudSolrClient.java:830) [junit4] > at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.request(BaseCloudSolrClient.java:763) [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:155) [junit4] > at java.lang.Thread.run(Thread.java:748) [junit4] > Caused by: java.net.SocketTimeoutException: Read timed out [junit4] > at java.net.SocketInputStream.socketRead0(Native Method) [junit4] > at java.net.SocketInputStream.socketRead(SocketInputStream.java:116) [junit4] > at java.net.SocketInputStream.read(SocketInputStream.java:171) [junit4] > at java.net.SocketInputStream.read(SocketInputStream.java:141) [junit4] > at sun.security.ssl.InputRecord.readFully(InputRecord.java:465) [junit4] > at sun.security.ssl.InputRecord.read(InputRecord.java:503) [junit4] > at sun.security.ssl.SSLSocketImpl.readRecord(SSLSocketImpl.java:983) [junit4] > at sun.security.ssl.SSLSocketImpl.readDataRecord(SSLSocketImpl.java:940) [junit4] > at sun.security.ssl.AppInputStream.read(AppInputStream.java:105) [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:548) [junit4] > ... 49 more [junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderVoteWaitTimeoutTest_8D66CBF2891768D4-001 [junit4] 2> Apr 06, 2019 3:06:21 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks [junit4] 2> WARNING: Will linger awaiting termination of 1 leaked thread(s). [junit4] 2> NOTE: test params are: codec=Asserting(Lucene80): {}, docValues:{}, maxPointsInLeafNode=1822, maxMBSortInHeap=5.905191365712265, sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@54e15b), locale=id, timezone=Etc/GMT+12 [junit4] 2> NOTE: Linux 4.18.0-15-generic i386/Oracle Corporation 1.8.0_172 (32-bit)/cpus=8,threads=1,free=123784816,total=536870912 [junit4] 2> NOTE: All tests run in this JVM: [TestStressReorder, HdfsSyncSliceTest, TestRecovery, TestPullReplica, FieldAnalysisRequestHandlerTest, SchemaVersionSpecificBehaviorTest, IndexSchemaRuntimeFieldTest, PrimitiveFieldTypeTest, DistributedSpellCheckComponentTest, XmlUpdateRequestHandlerTest, TestSolrIndexConfig, TestSerializedLuceneMatchVersion, SuggesterTSTTest, TestReqParamsAPI, TolerantUpdateProcessorTest, DocValuesTest, SolrCmdDistributorTest, SparseHLLTest, TestManagedSchemaAPI, BigEndianAscendingWordSerializerTest, CopyFieldTest, AssignTest, AddReplicaTest, RankQueryTest, TestLegacyTerms, TermsComponentTest, RecoveryAfterSoftCommitTest, TestComponentsName, TestConfigReload, AtomicUpdateProcessorFactoryTest, TestQueryUtils, HdfsLockFactoryTest, TestSimTriggerIntegration, NodeAddedTriggerTest, TestDeleteCollectionOnDownNodes, TestUninvertingReader, ForceLeaderTest, TestDeprecatedFilters, SmileWriterTest, MetricsHistoryIntegrationTest, TestNamedUpdateProcessors, HttpPartitionWithTlogReplicasTest, TestRangeQuery, TestReloadAndDeleteDocs, SSLMigrationTest, TestSortableTextField, CollectionsAPISolrJTest, TestSimDistribStateManager, InfoHandlerTest, DistributedQueryComponentCustomSortTest, TestCoreDiscovery, PropertiesRequestHandlerTest, TestConfig, ChaosMonkeySafeLeaderTest, TestSimpleQParserPlugin, TestSubQueryTransformer, RAMDirectoryFactoryTest, SolrPluginUtilsTest, TestFoldingMultitermQuery, FullHLLTest, SuggestComponentTest, SampleTest, TestWithCollection, PKIAuthenticationIntegrationTest, FacetPivotSmallTest, ImplicitSnitchTest, TestFaceting, BasicZkTest, TestClusterStateMutator, ConnectionManagerTest, RangeFacetCloudTest, TestExportWriter, TestRawResponseWriter, TestRequestStatusCollectionAPI, DistributedDebugComponentTest, TestSystemCollAutoCreate, TestPerFieldSimilarityWithDefaultOverride, TestPostingsSolrHighlighter, SolrMetricManagerTest, TestCoreAdminApis, SolrRequestParserTest, PathHierarchyTokenizerFactoryTest, RandomizedTaggerTest, DistanceUnitsTest, PolyFieldTest, PeerSyncWithLeaderTest, ShowFileRequestHandlerTest, SimpleFacetsTest, TestFileDictionaryLookup, TestLegacyFieldCache, HDFSCollectionsAPITest, DistributedFacetPivotLargeTest, TestUtils, SimpleCollectionCreateDeleteTest, TestUpdate, SolrGangliaReporterTest, BlockDirectoryTest, TestSolrCloudWithKerberosAlt, CategoryRoutedAliasUpdateProcessorTest, TestConfigSetsAPIExclusivity, SortSpecParsingTest, HealthCheckHandlerTest, ScheduledTriggerIntegrationTest, CoreSorterTest, StatelessScriptUpdateProcessorFactoryTest, TestImplicitCoreProperties, SolrIndexSplitterTest, SpellCheckComponentTest, TestElisionMultitermQuery, HdfsRecoverLeaseTest, TestCrossCoreJoin, ShardRoutingTest, TestHighFrequencyDictionaryFactory, TestSimNodeAddedTrigger, TestMinHashQParser, HighlighterConfigTest, CurrencyRangeFacetCloudTest, TestStandardQParsers, HttpSolrCallGetCoreTest, TestInPlaceUpdatesStandalone, ScriptEngineTest, TestFieldCache, DocumentBuilderTest, TestPKIAuthenticationPlugin, TriggerCooldownIntegrationTest, TestCloudJSONFacetSKG, IgnoreCommitOptimizeUpdateProcessorFactoryTest, CdcrUpdateLogTest, FileBasedSpellCheckerTest, CloudMLTQParserTest, TestCloudSearcherWarming, TestDynamicFieldResource, TestReloadDeadlock, TestObjectReleaseTracker, CoreAdminOperationTest, TestNumericRangeQuery64, RemoteQueryErrorTest, TestSolrCLIRunExample, TestBackupRepositoryFactory, ByteBuffersDirectoryFactoryTest, CreateRoutedAliasTest, DeleteLastCustomShardedReplicaTest, DeleteReplicaTest, LeaderTragicEventTest, LeaderVoteWaitTimeoutTest] [junit4] Completed [504/851 (1!)] on J0 in 151.48s, 2 tests, 1 error <<< FAILURES! [...truncated 46519 lines...] [repro] Jenkins log URL: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/23875/consoleText [repro] Revision: ef7be67ba12c8f518591b1e6ec7c1d88e0834dc1 [repro] Ant options: "-Dargs=-client -XX:+UseG1GC" [repro] Repro line: ant test -Dtestcase=LeaderVoteWaitTimeoutTest -Dtests.method=basicTest -Dtests.seed=8D66CBF2891768D4 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=id -Dtests.timezone=Etc/GMT+12 -Dtests.asserts=true -Dtests.file.encoding=UTF-8 [repro] ant clean [...truncated 6 lines...] [repro] Test suites by module: [repro] solr/core [repro] LeaderVoteWaitTimeoutTest [repro] ant compile-test [...truncated 3564 lines...] [repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5 -Dtests.class="*.LeaderVoteWaitTimeoutTest" -Dtests.showOutput=onerror "-Dargs=-client -XX:+UseG1GC" -Dtests.seed=8D66CBF2891768D4 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=id -Dtests.timezone=Etc/GMT+12 -Dtests.asserts=true -Dtests.file.encoding=UTF-8 [...truncated 75 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]
