Build: https://jenkins.thetaphi.de/job/Lucene-Solr-8.x-Linux/251/ Java: 64bit/jdk1.8.0_172 -XX:-UseCompressedOops -XX:+UseParallelGC
2 tests failed. FAILED: org.apache.solr.cloud.LeaderVoteWaitTimeoutTest.basicTest Error Message: Timeout occurred while waiting response from server at: https://127.0.0.1:34463/solr Stack Trace: org.apache.solr.client.solrj.SolrServerException: Timeout occurred while waiting response from server at: https://127.0.0.1:34463/solr at __randomizedtesting.SeedInfo.seed([972783BBFBA8E4FD:65D394D9BF0DE9CE]: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 FAILED: org.apache.solr.cloud.TestSolrCloudWithDelegationTokens.testDelegationTokenRenew Error Message: expected:<200> but was:<403> Stack Trace: java.lang.AssertionError: expected:<200> but was:<403> at __randomizedtesting.SeedInfo.seed([972783BBFBA8E4FD:A0BC77A5C3643959]:0) at org.junit.Assert.fail(Assert.java:88) at org.junit.Assert.failNotEquals(Assert.java:834) at org.junit.Assert.assertEquals(Assert.java:645) at org.junit.Assert.assertEquals(Assert.java:631) at org.apache.solr.cloud.TestSolrCloudWithDelegationTokens.renewDelegationToken(TestSolrCloudWithDelegationTokens.java:131) at org.apache.solr.cloud.TestSolrCloudWithDelegationTokens.verifyDelegationTokenRenew(TestSolrCloudWithDelegationTokens.java:316) at org.apache.solr.cloud.TestSolrCloudWithDelegationTokens.testDelegationTokenRenew(TestSolrCloudWithDelegationTokens.java:334) 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) Build Log: [...truncated 13991 lines...] [junit4] Suite: org.apache.solr.cloud.LeaderVoteWaitTimeoutTest [junit4] 2> 873396 INFO (SUITE-LeaderVoteWaitTimeoutTest-seed#[972783BBFBA8E4FD]-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-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderVoteWaitTimeoutTest_972783BBFBA8E4FD-001/init-core-data-001 [junit4] 2> 873396 WARN (SUITE-LeaderVoteWaitTimeoutTest-seed#[972783BBFBA8E4FD]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=14 numCloses=14 [junit4] 2> 873396 INFO (SUITE-LeaderVoteWaitTimeoutTest-seed#[972783BBFBA8E4FD]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=true [junit4] 2> 873397 INFO (SUITE-LeaderVoteWaitTimeoutTest-seed#[972783BBFBA8E4FD]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN) [junit4] 2> 873399 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testMostInSyncReplicasCanWinElection [junit4] 2> 873400 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderVoteWaitTimeoutTest_972783BBFBA8E4FD-001/tempDir-001 [junit4] 2> 873400 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 873400 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 873400 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 873500 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.c.ZkTestServer start zk server on port:42563 [junit4] 2> 873500 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:42563 [junit4] 2> 873500 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 42563 [junit4] 2> 873503 INFO (zkConnectionManagerCallback-5631-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 873508 INFO (zkConnectionManagerCallback-5633-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 873510 INFO (zkConnectionManagerCallback-5635-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 873513 WARN (jetty-launcher-5636-thread-3) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 873513 WARN (jetty-launcher-5636-thread-1) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 873513 WARN (jetty-launcher-5636-thread-4) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 873513 WARN (jetty-launcher-5636-thread-2) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 873513 INFO (jetty-launcher-5636-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0) [junit4] 2> 873513 INFO (jetty-launcher-5636-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0) [junit4] 2> 873513 INFO (jetty-launcher-5636-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0) [junit4] 2> 873513 INFO (jetty-launcher-5636-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0) [junit4] 2> 873513 INFO (jetty-launcher-5636-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 873513 INFO (jetty-launcher-5636-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 873513 INFO (jetty-launcher-5636-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 873513 INFO (jetty-launcher-5636-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 873513 INFO (jetty-launcher-5636-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> 873513 INFO (jetty-launcher-5636-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> 873513 INFO (jetty-launcher-5636-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> 873513 INFO (jetty-launcher-5636-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> 873514 INFO (jetty-launcher-5636-thread-3) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 873514 INFO (jetty-launcher-5636-thread-3) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 873514 INFO (jetty-launcher-5636-thread-3) [ ] o.e.j.s.session node0 Scavenging every 660000ms [junit4] 2> 873514 INFO (jetty-launcher-5636-thread-4) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 873514 INFO (jetty-launcher-5636-thread-4) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 873514 INFO (jetty-launcher-5636-thread-4) [ ] o.e.j.s.session node0 Scavenging every 660000ms [junit4] 2> 873514 INFO (jetty-launcher-5636-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 873514 INFO (jetty-launcher-5636-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 873514 INFO (jetty-launcher-5636-thread-1) [ ] o.e.j.s.session node0 Scavenging every 660000ms [junit4] 2> 873514 INFO (jetty-launcher-5636-thread-2) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 873514 INFO (jetty-launcher-5636-thread-2) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 873514 INFO (jetty-launcher-5636-thread-2) [ ] o.e.j.s.session node0 Scavenging every 660000ms [junit4] 2> 873514 INFO (jetty-launcher-5636-thread-3) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@5879baae{/solr,null,AVAILABLE} [junit4] 2> 873514 INFO (jetty-launcher-5636-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@4b827a32{/solr,null,AVAILABLE} [junit4] 2> 873514 INFO (jetty-launcher-5636-thread-4) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@4e13d0e1{/solr,null,AVAILABLE} [junit4] 2> 873515 INFO (jetty-launcher-5636-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@370f1155{/solr,null,AVAILABLE} [junit4] 2> 873515 WARN (jetty-launcher-5636-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@69fda06[provider=null,keyStore=null,trustStore=null] [junit4] 2> 873515 WARN (jetty-launcher-5636-thread-4) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@2c447a6a[provider=null,keyStore=null,trustStore=null] [junit4] 2> 873516 WARN (jetty-launcher-5636-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@4ed26abf[provider=null,keyStore=null,trustStore=null] [junit4] 2> 873516 WARN (jetty-launcher-5636-thread-3) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@3193c951[provider=null,keyStore=null,trustStore=null] [junit4] 2> 873516 INFO (jetty-launcher-5636-thread-4) [ ] o.e.j.s.AbstractConnector Started ServerConnector@435a0702{SSL,[ssl, http/1.1]}{127.0.0.1:44577} [junit4] 2> 873516 INFO (jetty-launcher-5636-thread-4) [ ] o.e.j.s.Server Started @873564ms [junit4] 2> 873516 INFO (jetty-launcher-5636-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@7d1058ee{SSL,[ssl, http/1.1]}{127.0.0.1:34505} [junit4] 2> 873516 INFO (jetty-launcher-5636-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=44577} [junit4] 2> 873516 INFO (jetty-launcher-5636-thread-2) [ ] o.e.j.s.Server Started @873564ms [junit4] 2> 873516 INFO (jetty-launcher-5636-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=34505} [junit4] 2> 873516 ERROR (jetty-launcher-5636-thread-4) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 873516 ERROR (jetty-launcher-5636-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 873516 INFO (jetty-launcher-5636-thread-2) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 873516 INFO (jetty-launcher-5636-thread-4) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 873516 INFO (jetty-launcher-5636-thread-4) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.1.0 [junit4] 2> 873516 INFO (jetty-launcher-5636-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.1.0 [junit4] 2> 873516 INFO (jetty-launcher-5636-thread-4) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 873516 INFO (jetty-launcher-5636-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 873516 INFO (jetty-launcher-5636-thread-4) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 873516 INFO (jetty-launcher-5636-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 873516 INFO (jetty-launcher-5636-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-03-11T19:40:34.464Z [junit4] 2> 873516 INFO (jetty-launcher-5636-thread-4) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-03-11T19:40:34.464Z [junit4] 2> 873517 INFO (jetty-launcher-5636-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@3705b443{SSL,[ssl, http/1.1]}{127.0.0.1:35863} [junit4] 2> 873517 INFO (jetty-launcher-5636-thread-1) [ ] o.e.j.s.Server Started @873564ms [junit4] 2> 873517 INFO (jetty-launcher-5636-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=35863} [junit4] 2> 873517 ERROR (jetty-launcher-5636-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 873517 INFO (jetty-launcher-5636-thread-1) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 873517 INFO (jetty-launcher-5636-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.1.0 [junit4] 2> 873517 INFO (jetty-launcher-5636-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 873517 INFO (jetty-launcher-5636-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 873517 INFO (jetty-launcher-5636-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-03-11T19:40:34.465Z [junit4] 2> 873517 INFO (zkConnectionManagerCallback-5639-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 873518 INFO (zkConnectionManagerCallback-5640-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 873518 INFO (jetty-launcher-5636-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 873518 INFO (zkConnectionManagerCallback-5642-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 873518 INFO (jetty-launcher-5636-thread-4) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 873518 INFO (jetty-launcher-5636-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 873519 INFO (jetty-launcher-5636-thread-3) [ ] o.e.j.s.AbstractConnector Started ServerConnector@47f327ea{SSL,[ssl, http/1.1]}{127.0.0.1:38949} [junit4] 2> 873519 INFO (jetty-launcher-5636-thread-3) [ ] o.e.j.s.Server Started @873566ms [junit4] 2> 873519 INFO (jetty-launcher-5636-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=38949} [junit4] 2> 873519 ERROR (jetty-launcher-5636-thread-3) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 873519 INFO (jetty-launcher-5636-thread-3) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 873519 INFO (jetty-launcher-5636-thread-3) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.1.0 [junit4] 2> 873519 INFO (jetty-launcher-5636-thread-3) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 873519 INFO (jetty-launcher-5636-thread-3) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 873519 INFO (jetty-launcher-5636-thread-3) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-03-11T19:40:34.467Z [junit4] 2> 873532 INFO (zkConnectionManagerCallback-5644-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 873532 INFO (jetty-launcher-5636-thread-3) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 873579 INFO (jetty-launcher-5636-thread-1) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true] [junit4] 2> 873579 WARN (jetty-launcher-5636-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> 873579 WARN (jetty-launcher-5636-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@59d45aaf[provider=null,keyStore=null,trustStore=null] [junit4] 2> 873581 WARN (jetty-launcher-5636-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> 873582 WARN (jetty-launcher-5636-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@11dc898f[provider=null,keyStore=null,trustStore=null] [junit4] 2> 873582 INFO (jetty-launcher-5636-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:42563/solr [junit4] 2> 873585 INFO (zkConnectionManagerCallback-5650-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 873586 INFO (zkConnectionManagerCallback-5652-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 873616 INFO (jetty-launcher-5636-thread-1) [n:127.0.0.1:35863_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:35863_solr [junit4] 2> 873617 INFO (jetty-launcher-5636-thread-1) [n:127.0.0.1:35863_solr ] o.a.s.c.Overseer Overseer (id=72182624391659528-127.0.0.1:35863_solr-n_0000000000) starting [junit4] 2> 873619 INFO (jetty-launcher-5636-thread-4) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true] [junit4] 2> 873619 WARN (jetty-launcher-5636-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> 873619 INFO (zkConnectionManagerCallback-5659-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 873620 WARN (jetty-launcher-5636-thread-4) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@40f5ec7c[provider=null,keyStore=null,trustStore=null] [junit4] 2> 873621 WARN (jetty-launcher-5636-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> 873622 WARN (jetty-launcher-5636-thread-4) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@58da7175[provider=null,keyStore=null,trustStore=null] [junit4] 2> 873622 INFO (jetty-launcher-5636-thread-1) [n:127.0.0.1:35863_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:42563/solr ready [junit4] 2> 873622 INFO (OverseerStateUpdate-72182624391659528-127.0.0.1:35863_solr-n_0000000000) [n:127.0.0.1:35863_solr ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:35863_solr [junit4] 2> 873622 INFO (jetty-launcher-5636-thread-4) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:42563/solr [junit4] 2> 873623 INFO (jetty-launcher-5636-thread-1) [n:127.0.0.1:35863_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:35863_solr [junit4] 2> 873635 INFO (zkCallback-5658-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 873635 INFO (zkCallback-5651-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 873639 DEBUG (OverseerAutoScalingTriggerThread-72182624391659528-127.0.0.1:35863_solr-n_0000000000) [ ] o.a.s.c.a.NodeLostTrigger NodeLostTrigger .auto_add_replicas - Initial livenodes: [127.0.0.1:35863_solr] [junit4] 2> 873642 INFO (jetty-launcher-5636-thread-1) [n:127.0.0.1:35863_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 873646 INFO (zkConnectionManagerCallback-5665-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 873647 DEBUG (ScheduledTrigger-5176-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 and last live nodes: 1 [junit4] 2> 873653 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 0x10071b6e5d2000a, likely client has closed socket [junit4] 2> 873659 INFO (jetty-launcher-5636-thread-1) [n:127.0.0.1:35863_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_35863.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@67507ecd [junit4] 2> 873665 INFO (jetty-launcher-5636-thread-1) [n:127.0.0.1:35863_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_35863.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@67507ecd [junit4] 2> 873665 INFO (jetty-launcher-5636-thread-1) [n:127.0.0.1:35863_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_35863.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@67507ecd [junit4] 2> 873665 INFO (jetty-launcher-5636-thread-1) [n:127.0.0.1:35863_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderVoteWaitTimeoutTest_972783BBFBA8E4FD-001/tempDir-001/node1/. [junit4] 2> 873666 INFO (zkConnectionManagerCallback-5668-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 873668 INFO (jetty-launcher-5636-thread-4) [n:127.0.0.1:44577_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 873669 INFO (jetty-launcher-5636-thread-4) [n:127.0.0.1:44577_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:44577_solr as DOWN [junit4] 2> 873669 INFO (jetty-launcher-5636-thread-2) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true] [junit4] 2> 873669 WARN (jetty-launcher-5636-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> 873669 INFO (jetty-launcher-5636-thread-4) [n:127.0.0.1:44577_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 873669 INFO (jetty-launcher-5636-thread-4) [n:127.0.0.1:44577_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:44577_solr [junit4] 2> 873674 INFO (zkCallback-5651-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 873674 INFO (zkCallback-5658-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 873679 INFO (zkCallback-5667-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 873685 WARN (jetty-launcher-5636-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@77b9f697[provider=null,keyStore=null,trustStore=null] [junit4] 2> 873687 WARN (jetty-launcher-5636-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> 873688 WARN (jetty-launcher-5636-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@78b50050[provider=null,keyStore=null,trustStore=null] [junit4] 2> 873688 INFO (jetty-launcher-5636-thread-3) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true] [junit4] 2> 873688 INFO (jetty-launcher-5636-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:42563/solr [junit4] 2> 873688 WARN (jetty-launcher-5636-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> 873689 INFO (zkConnectionManagerCallback-5677-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 873689 WARN (jetty-launcher-5636-thread-3) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@2ce980f3[provider=null,keyStore=null,trustStore=null] [junit4] 2> 873689 INFO (zkConnectionManagerCallback-5682-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 873689 INFO (jetty-launcher-5636-thread-4) [n:127.0.0.1:44577_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2) [junit4] 2> 873690 INFO (jetty-launcher-5636-thread-4) [n:127.0.0.1:44577_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:42563/solr ready [junit4] 2> 873690 INFO (jetty-launcher-5636-thread-4) [n:127.0.0.1:44577_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 873690 INFO (zkConnectionManagerCallback-5686-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 873690 WARN (jetty-launcher-5636-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> 873691 WARN (jetty-launcher-5636-thread-3) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@6ec257e5[provider=null,keyStore=null,trustStore=null] [junit4] 2> 873691 INFO (jetty-launcher-5636-thread-3) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:42563/solr [junit4] 2> 873692 INFO (jetty-launcher-5636-thread-2) [n:127.0.0.1:34505_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2) [junit4] 2> 873692 INFO (zkConnectionManagerCallback-5692-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 873693 INFO (zkConnectionManagerCallback-5694-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 873693 INFO (jetty-launcher-5636-thread-2) [n:127.0.0.1:34505_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:34505_solr as DOWN [junit4] 2> 873694 INFO (jetty-launcher-5636-thread-2) [n:127.0.0.1:34505_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 873694 INFO (jetty-launcher-5636-thread-2) [n:127.0.0.1:34505_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:34505_solr [junit4] 2> 873694 INFO (zkCallback-5658-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 873694 INFO (zkCallback-5651-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 873694 INFO (zkCallback-5667-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 873694 INFO (zkCallback-5676-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 873694 INFO (zkCallback-5685-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 873695 INFO (jetty-launcher-5636-thread-3) [n:127.0.0.1:38949_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3) [junit4] 2> 873702 INFO (jetty-launcher-5636-thread-3) [n:127.0.0.1:38949_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:38949_solr as DOWN [junit4] 2> 873703 INFO (jetty-launcher-5636-thread-3) [n:127.0.0.1:38949_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 873703 INFO (jetty-launcher-5636-thread-3) [n:127.0.0.1:38949_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:38949_solr [junit4] 2> 873704 INFO (zkCallback-5667-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 873704 INFO (zkCallback-5685-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 873704 INFO (zkCallback-5651-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 873704 INFO (zkCallback-5658-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 873704 INFO (zkCallback-5693-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 873704 INFO (zkCallback-5676-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 873704 INFO (jetty-launcher-5636-thread-4) [n:127.0.0.1:44577_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_44577.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@67507ecd [junit4] 2> 873708 INFO (zkConnectionManagerCallback-5701-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 873708 INFO (jetty-launcher-5636-thread-2) [n:127.0.0.1:34505_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4) [junit4] 2> 873708 INFO (jetty-launcher-5636-thread-2) [n:127.0.0.1:34505_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:42563/solr ready [junit4] 2> 873709 INFO (jetty-launcher-5636-thread-2) [n:127.0.0.1:34505_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 873713 INFO (jetty-launcher-5636-thread-4) [n:127.0.0.1:44577_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_44577.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@67507ecd [junit4] 2> 873713 INFO (jetty-launcher-5636-thread-4) [n:127.0.0.1:44577_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_44577.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@67507ecd [junit4] 2> 873713 INFO (zkConnectionManagerCallback-5707-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 873714 INFO (jetty-launcher-5636-thread-4) [n:127.0.0.1:44577_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderVoteWaitTimeoutTest_972783BBFBA8E4FD-001/tempDir-001/node4/. [junit4] 2> 873714 INFO (jetty-launcher-5636-thread-3) [n:127.0.0.1:38949_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4) [junit4] 2> 873714 INFO (jetty-launcher-5636-thread-3) [n:127.0.0.1:38949_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:42563/solr ready [junit4] 2> 873715 INFO (jetty-launcher-5636-thread-3) [n:127.0.0.1:38949_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 873718 INFO (jetty-launcher-5636-thread-2) [n:127.0.0.1:34505_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_34505.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@67507ecd [junit4] 2> 873730 INFO (jetty-launcher-5636-thread-2) [n:127.0.0.1:34505_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_34505.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@67507ecd [junit4] 2> 873731 INFO (jetty-launcher-5636-thread-2) [n:127.0.0.1:34505_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_34505.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@67507ecd [junit4] 2> 873731 INFO (jetty-launcher-5636-thread-2) [n:127.0.0.1:34505_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderVoteWaitTimeoutTest_972783BBFBA8E4FD-001/tempDir-001/node2/. [junit4] 2> 873734 INFO (jetty-launcher-5636-thread-3) [n:127.0.0.1:38949_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_38949.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@67507ecd [junit4] 2> 873742 INFO (jetty-launcher-5636-thread-3) [n:127.0.0.1:38949_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_38949.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@67507ecd [junit4] 2> 873742 INFO (jetty-launcher-5636-thread-3) [n:127.0.0.1:38949_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_38949.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@67507ecd [junit4] 2> 873743 INFO (jetty-launcher-5636-thread-3) [n:127.0.0.1:38949_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderVoteWaitTimeoutTest_972783BBFBA8E4FD-001/tempDir-001/node3/. [junit4] 2> 873796 INFO (zkConnectionManagerCallback-5713-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 873797 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4) [junit4] 2> 873797 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:42563/solr ready [junit4] 2> 873798 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1540474433 [junit4] 2> 873798 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:35863_solr [junit4] 2> 873798 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.c.CoreContainer Publish this node as DOWN... [junit4] 2> 873798 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.c.ZkController Publish node=127.0.0.1:35863_solr as DOWN [junit4] 2> 873799 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 873799 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 873799 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1affad67: rootName = solr_35863, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@4e329810 [junit4] 2> 873804 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null [junit4] 2> 873804 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@bde331c: rootName = solr_35863, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@25f278ad [junit4] 2> 873806 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null [junit4] 2> 873806 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@49cc0bfe: rootName = solr_35863, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@4683fd77 [junit4] 2> 873806 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null [junit4] 2> 873807 INFO (closeThreadPool-5716-thread-2) [ ] o.a.s.c.Overseer Overseer (id=72182624391659528-127.0.0.1:35863_solr-n_0000000000) closing [junit4] 2> 873808 INFO (OverseerStateUpdate-72182624391659528-127.0.0.1:35863_solr-n_0000000000) [n:127.0.0.1:35863_solr ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:35863_solr [junit4] 2> 873811 INFO (OverseerAutoScalingTriggerThread-72182624391659528-127.0.0.1:35863_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we are closed, exiting. [junit4] 2> 873811 INFO (closeThreadPool-5716-thread-1) [ ] o.a.s.c.Overseer Overseer (id=72182624391659528-127.0.0.1:35863_solr-n_0000000000) closing [junit4] 2> 873812 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.c.Overseer Overseer (id=72182624391659528-127.0.0.1:35863_solr-n_0000000000) closing [junit4] 2> 873812 INFO (zkCallback-5676-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 873812 INFO (zkCallback-5685-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 873812 INFO (zkCallback-5667-thread-1) [ ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:44577_solr [junit4] 2> 873812 INFO (zkCallback-5693-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 873812 INFO (zkCallback-5667-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 873812 INFO (zkCallback-5706-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 873812 INFO (zkCallback-5712-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 873812 INFO (zkCallback-5700-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 873813 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@3705b443{SSL,[ssl, http/1.1]}{127.0.0.1:0} [junit4] 2> 873813 INFO (zkCallback-5667-thread-1) [n:127.0.0.1:44577_solr ] o.a.s.c.Overseer Overseer (id=72182624391659531-127.0.0.1:44577_solr-n_0000000001) starting [junit4] 2> 873813 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@4b827a32{/solr,null,UNAVAILABLE} [junit4] 2> 873813 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.e.j.s.session node0 Stopped scavenging [junit4] 2> 873813 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0) [junit4] 2> 873814 WARN (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 873814 INFO (OverseerStateUpdate-72182624391659531-127.0.0.1:44577_solr-n_0000000001) [n:127.0.0.1:44577_solr ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:44577_solr [junit4] 2> 873814 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 873814 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] 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> 873815 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 873815 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 873815 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.e.j.s.session node0 Scavenging every 600000ms [junit4] 2> 873815 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@4d1b10af{/solr,null,AVAILABLE} [junit4] 2> 873815 WARN (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@2de8e09f[provider=null,keyStore=null,trustStore=null] [junit4] 2> 873815 DEBUG (OverseerAutoScalingTriggerThread-72182624391659531-127.0.0.1:44577_solr-n_0000000001) [ ] o.a.s.c.a.NodeLostTrigger NodeLostTrigger .auto_add_replicas - Initial livenodes: [127.0.0.1:44577_solr, 127.0.0.1:38949_solr, 127.0.0.1:34505_solr] [junit4] 2> 873815 DEBUG (OverseerAutoScalingTriggerThread-72182624391659531-127.0.0.1:44577_solr-n_0000000001) [ ] o.a.s.c.a.NodeLostTrigger Adding lost node from marker path: 127.0.0.1:35863_solr [junit4] 2> 873816 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@b42cbcd{SSL,[ssl, http/1.1]}{127.0.0.1:37285} [junit4] 2> 873816 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.e.j.s.Server Started @873863ms [junit4] 2> 873816 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=33345} [junit4] 2> 873816 DEBUG (ScheduledTrigger-5203-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 3 and last live nodes: 1 [junit4] 2> 873816 DEBUG (ScheduledTrigger-5203-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Tracking lost node: 127.0.0.1:35863_solr [junit4] 2> 873816 ERROR (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 873816 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 873816 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.1.0 [junit4] 2> 873816 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 873816 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 873816 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-03-11T19:40:34.764Z [junit4] 2> 873817 INFO (zkConnectionManagerCallback-5718-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 873817 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 873903 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true] [junit4] 2> 873903 WARN (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] 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> 873904 WARN (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@6d611fd7[provider=null,keyStore=null,trustStore=null] [junit4] 2> 873906 WARN (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] 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> 873906 WARN (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@75ca3d8b[provider=null,keyStore=null,trustStore=null] [junit4] 2> 873907 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:42563/solr [junit4] 2> 873909 INFO (zkConnectionManagerCallback-5724-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 873911 INFO (zkConnectionManagerCallback-5726-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 873912 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [n:127.0.0.1:33345_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3) [junit4] 2> 873913 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [n:127.0.0.1:33345_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:33345_solr as DOWN [junit4] 2> 873913 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [n:127.0.0.1:33345_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 873913 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [n:127.0.0.1:33345_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:33345_solr [junit4] 2> 873914 INFO (zkCallback-5706-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 873914 INFO (zkCallback-5676-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 873914 INFO (zkCallback-5693-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 873914 INFO (zkCallback-5667-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 873914 INFO (zkCallback-5700-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 873914 INFO (zkCallback-5685-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 873914 INFO (zkCallback-5712-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 873914 INFO (zkCallback-5725-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 873924 INFO (zkConnectionManagerCallback-5733-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 873925 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [n:127.0.0.1:33345_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4) [junit4] 2> 873926 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [n:127.0.0.1:33345_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:42563/solr ready [junit4] 2> 873926 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [n:127.0.0.1:33345_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 873937 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [n:127.0.0.1:33345_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_33345.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@67507ecd [junit4] 2> 873950 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [n:127.0.0.1:33345_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_33345.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@67507ecd [junit4] 2> 873950 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [n:127.0.0.1:33345_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_33345.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@67507ecd [junit4] 2> 873951 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [n:127.0.0.1:33345_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderVoteWaitTimeoutTest_972783BBFBA8E4FD-001/tempDir-001/node1/. [junit4] 2> 873982 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.c.LeaderVoteWaitTimeoutTest Adding proxy for URL: https://127.0.0.1:37285/solr. Proxy: https://127.0.0.1:33345/solr [junit4] 2> 873982 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1933559153 [junit4] 2> 873982 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:44577_solr [junit4] 2> 873983 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.c.CoreContainer Publish this node as DOWN... [junit4] 2> 873983 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.c.ZkController Publish node=127.0.0.1:44577_solr as DOWN [junit4] 2> 873984 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 873984 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@2487c3f5: rootName = solr_44577, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@2f46fa80 [junit4] 2> 873988 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null [junit4] 2> 873988 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@4941dcab: rootName = solr_44577, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@25f278ad [junit4] 2> 873990 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null [junit4] 2> 873990 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@5a8aa9ef: rootName = solr_44577, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@4683fd77 [junit4] 2> 873990 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null [junit4] 2> 873990 INFO (closeThreadPool-5737-thread-2) [ ] o.a.s.c.Overseer Overseer (id=72182624391659531-127.0.0.1:44577_solr-n_0000000001) closing [junit4] 2> 873991 INFO (OverseerStateUpdate-72182624391659531-127.0.0.1:44577_solr-n_0000000001) [n:127.0.0.1:44577_solr ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:44577_solr [junit4] 2> 873991 INFO (OverseerAutoScalingTriggerThread-72182624391659531-127.0.0.1:44577_solr-n_0000000001) [ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we are closed, exiting. [junit4] 2> 873993 INFO (closeThreadPool-5737-thread-1) [ ] o.a.s.c.Overseer Overseer (id=72182624391659531-127.0.0.1:44577_solr-n_0000000001) closing [junit4] 2> 873993 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.c.Overseer Overseer (id=72182624391659531-127.0.0.1:44577_solr-n_0000000001) closing [junit4] 2> 873993 INFO (zkCallback-5712-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 873993 INFO (zkCallback-5706-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 873993 INFO (zkCallback-5725-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 873993 INFO (zkCallback-5732-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 873993 INFO (zkCallback-5685-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 873995 INFO (zkCallback-5693-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 873995 INFO (zkCallback-5685-thread-2) [ ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:34505_solr [junit4] 2> 873995 INFO (zkCallback-5700-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 873995 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@435a0702{SSL,[ssl, http/1.1]}{127.0.0.1:0} [junit4] 2> 873995 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@4e13d0e1{/solr,null,UNAVAILABLE} [junit4] 2> 873995 INFO (zkCallback-5685-thread-2) [n:127.0.0.1:34505_solr ] o.a.s.c.Overseer Overseer (id=72182624391659534-127.0.0.1:34505_solr-n_0000000002) starting [junit4] 2> 873995 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.e.j.s.session node0 Stopped scavenging [junit4] 2> 873995 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0) [junit4] 2> 873996 WARN (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 873996 INFO (OverseerStateUpdate-72182624391659534-127.0.0.1:34505_solr-n_0000000002) [n:127.0.0.1:34505_solr ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:34505_solr [junit4] 2> 873997 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 873997 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] 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> 873997 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 873997 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 873997 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.e.j.s.session node0 Scavenging every 600000ms [junit4] 2> 873997 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@76c91329{/solr,null,AVAILABLE} [junit4] 2> 873997 DEBUG (OverseerAutoScalingTriggerThread-72182624391659534-127.0.0.1:34505_solr-n_0000000002) [ ] o.a.s.c.a.NodeLostTrigger NodeLostTrigger .auto_add_replicas - Initial livenodes: [127.0.0.1:33345_solr, 127.0.0.1:38949_solr, 127.0.0.1:34505_solr] [junit4] 2> 873998 WARN (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@5dd76389[provider=null,keyStore=null,trustStore=null] [junit4] 2> 873998 DEBUG (OverseerAutoScalingTriggerThread-72182624391659534-127.0.0.1:34505_solr-n_0000000002) [ ] o.a.s.c.a.NodeLostTrigger Adding lost node from marker path: 127.0.0.1:44577_solr [junit4] 2> 873998 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@386802d{SSL,[ssl, http/1.1]}{127.0.0.1:32949} [junit4] 2> 873998 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.e.j.s.Server Started @874046ms [junit4] 2> 873998 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=33289} [junit4] 2> 873998 DEBUG (ScheduledTrigger-5217-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 3 and last live nodes: 3 [junit4] 2> 873998 DEBUG (ScheduledTrigger-5217-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Tracking lost node: 127.0.0.1:44577_solr [junit4] 2> 873998 ERROR (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 873998 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 873998 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.1.0 [junit4] 2> 873998 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 873998 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 873998 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-03-11T19:40:34.946Z [junit4] 2> 873999 INFO (zkConnectionManagerCallback-5739-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 873999 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 874068 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true] [junit4] 2> 874069 WARN (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] 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> 874069 WARN (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@21ba3710[provider=null,keyStore=null,trustStore=null] [junit4] 2> 874071 WARN (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] 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> 874071 WARN (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@30020ae2[provider=null,keyStore=null,trustStore=null] [junit4] 2> 874072 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:42563/solr [junit4] 2> 874073 INFO (zkConnectionManagerCallback-5745-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 874074 INFO (zkConnectionManagerCallback-5747-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 874076 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3) [junit4] 2> 874077 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.c.ZkController Publish node=127.0.0.1:33289_solr as DOWN [junit4] 2> 874078 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 874078 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:33289_solr [junit4] 2> 874078 INFO (zkCallback-5693-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 874078 INFO (zkCallback-5706-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 874079 INFO (zkCallback-5700-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 874079 INFO (zkCallback-5685-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 874079 INFO (zkCallback-5725-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 874083 INFO (zkCallback-5732-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 874083 INFO (zkCallback-5712-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 874083 INFO (zkCallback-5746-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 874095 INFO (zkConnectionManagerCallback-5754-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 874096 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4) [junit4] 2> 874096 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:42563/solr ready [junit4] 2> 874097 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 874114 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_33289.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@67507ecd [junit4] 2> 874124 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_33289.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@67507ecd [junit4] 2> 874125 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_33289.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@67507ecd [junit4] 2> 874125 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderVoteWaitTimeoutTest_972783BBFBA8E4FD-001/tempDir-001/node4/. [junit4] 2> 874170 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.c.LeaderVoteWaitTimeoutTest Adding proxy for URL: https://127.0.0.1:32949/solr. Proxy: https://127.0.0.1:33289/solr [junit4] 2> 874170 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=210991737 [junit4] 2> 874170 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:38949_solr [junit4] 2> 874170 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.c.CoreContainer Publish this node as DOWN... [junit4] 2> 874170 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.c.ZkController Publish node=127.0.0.1:38949_solr as DOWN [junit4] 2> 874171 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 874171 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@22ca73a0: rootName = solr_38949, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@10680a9e [junit4] 2> 874176 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null [junit4] 2> 874176 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@6cce60e0: rootName = solr_38949, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@25f278ad [junit4] 2> 874178 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null [junit4] 2> 874178 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@3db51197: rootName = solr_38949, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@4683fd77 [junit4] 2> 874178 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null [junit4] 2> 874179 INFO (zkCallback-5732-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 874179 INFO (zkCallback-5700-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 874179 INFO (zkCallback-5746-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 874179 INFO (zkCallback-5685-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 874179 INFO (zkCallback-5712-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 874179 INFO (zkCallback-5753-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 874180 INFO (zkCallback-5725-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 874180 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@47f327ea{SSL,[ssl, http/1.1]}{127.0.0.1:0} [junit4] 2> 874180 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@5879baae{/solr,null,UNAVAILABLE} [junit4] 2> 874180 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.e.j.s.session node0 Stopped scavenging [junit4] 2> 874181 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0) [junit4] 2> 874181 WARN (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 874182 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 874182 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] 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> 874182 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 874182 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 874182 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.e.j.s.session node0 Scavenging every 660000ms [junit4] 2> 874182 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@3a7ee0ba{/solr,null,AVAILABLE} [junit4] 2> 874182 WARN (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@f036e97[provider=null,keyStore=null,trustStore=null] [junit4] 2> 874183 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@36ea5648{SSL,[ssl, http/1.1]}{127.0.0.1:38803} [junit4] 2> 874183 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.e.j.s.Server Started @874231ms [junit4] 2> 874183 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=42123} [junit4] 2> 874183 ERROR (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 874183 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 874183 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.1.0 [junit4] 2> 874183 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 874183 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 874183 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-03-11T19:40:35.131Z [junit4] 2> 874184 INFO (zkConnectionManagerCallback-5760-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 874185 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 874229 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true] [junit4] 2> 874229 WARN (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] 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> 874243 WARN (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@154ca803[provider=null,keyStore=null,trustStore=null] [junit4] 2> 874251 WARN (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] 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> 874266 WARN (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@19dcf0e6[provider=null,keyStore=null,trustStore=null] [junit4] 2> 874266 INFO (TEST-LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection-seed#[972783BBFBA8E4FD]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:42563/solr [junit4] 2> 874270 INFO (zkConnectionManagerCallback-5766-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] [...truncated too long message...] it4] OK 0.38s J2 | TestSolrCloudWithDelegationTokens.testDelegationTokenRenew [junit4] OK 0.15s J2 | TestSolrCloudWithDelegationTokens.testDelegationTokenCancel [junit4] OK 0.04s J2 | TestSolrCloudWithDelegationTokens.testDelegationTokenRenewFail [junit4] OK 0.03s J2 | TestSolrCloudWithDelegationTokens.testDelegationTokenCancelFail [junit4] Completed [1/10] on J2 in 10.16s, 8 tests [junit4] [junit4] Suite: org.apache.solr.cloud.TestSolrCloudWithDelegationTokens [junit4] OK 0.03s J2 | TestSolrCloudWithDelegationTokens.testZNodePaths [junit4] OK 0.02s J2 | TestSolrCloudWithDelegationTokens.testDelegationOtherOp [junit4] OK 0.04s J2 | TestSolrCloudWithDelegationTokens.testDelegationTokenVerify [junit4] OK 0.02s J2 | TestSolrCloudWithDelegationTokens.testDelegationTokenSolrClient [junit4] OK 0.20s J2 | TestSolrCloudWithDelegationTokens.testDelegationTokenRenew [junit4] OK 0.09s J2 | TestSolrCloudWithDelegationTokens.testDelegationTokenCancel [junit4] OK 0.03s J2 | TestSolrCloudWithDelegationTokens.testDelegationTokenRenewFail [junit4] OK 0.05s J2 | TestSolrCloudWithDelegationTokens.testDelegationTokenCancelFail [junit4] Completed [2/10] on J2 in 2.02s, 8 tests [junit4] [junit4] Suite: org.apache.solr.cloud.TestSolrCloudWithDelegationTokens [junit4] OK 0.12s J2 | TestSolrCloudWithDelegationTokens.testZNodePaths [junit4] OK 0.03s J2 | TestSolrCloudWithDelegationTokens.testDelegationOtherOp [junit4] OK 0.17s J2 | TestSolrCloudWithDelegationTokens.testDelegationTokenVerify [junit4] OK 0.05s J2 | TestSolrCloudWithDelegationTokens.testDelegationTokenSolrClient [junit4] OK 0.54s J2 | TestSolrCloudWithDelegationTokens.testDelegationTokenRenew [junit4] OK 0.16s J2 | TestSolrCloudWithDelegationTokens.testDelegationTokenCancel [junit4] OK 0.05s J2 | TestSolrCloudWithDelegationTokens.testDelegationTokenRenewFail [junit4] OK 0.06s J2 | TestSolrCloudWithDelegationTokens.testDelegationTokenCancelFail [junit4] Completed [3/10] on J2 in 4.04s, 8 tests [junit4] [junit4] Suite: org.apache.solr.cloud.LeaderVoteWaitTimeoutTest [junit4] OK 33.8s J0 | LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection [junit4] OK 14.3s J0 | LeaderVoteWaitTimeoutTest.basicTest [junit4] Completed [4/10] on J0 in 51.14s, 2 tests [junit4] [junit4] Suite: org.apache.solr.cloud.LeaderVoteWaitTimeoutTest [junit4] OK 34.3s J1 | LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection [junit4] OK 15.7s J1 | LeaderVoteWaitTimeoutTest.basicTest [junit4] Completed [5/10] on J1 in 53.28s, 2 tests [junit4] [junit4] Suite: org.apache.solr.cloud.LeaderVoteWaitTimeoutTest [junit4] OK 29.0s J2 | LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection [junit4] OK 12.0s J2 | LeaderVoteWaitTimeoutTest.basicTest [junit4] Completed [6/10] on J2 in 41.68s, 2 tests [junit4] [junit4] Suite: org.apache.solr.cloud.TestSolrCloudWithDelegationTokens [junit4] OK 0.06s J2 | TestSolrCloudWithDelegationTokens.testZNodePaths [junit4] OK 0.08s J2 | TestSolrCloudWithDelegationTokens.testDelegationOtherOp [junit4] OK 0.07s J2 | TestSolrCloudWithDelegationTokens.testDelegationTokenVerify [junit4] OK 0.04s J2 | TestSolrCloudWithDelegationTokens.testDelegationTokenSolrClient [junit4] OK 0.17s J2 | TestSolrCloudWithDelegationTokens.testDelegationTokenRenew [junit4] OK 0.06s J2 | TestSolrCloudWithDelegationTokens.testDelegationTokenCancel [junit4] OK 0.04s J2 | TestSolrCloudWithDelegationTokens.testDelegationTokenRenewFail [junit4] OK 0.07s J2 | TestSolrCloudWithDelegationTokens.testDelegationTokenCancelFail [junit4] Completed [7/10] on J2 in 2.01s, 8 tests [junit4] [junit4] Suite: org.apache.solr.cloud.TestSolrCloudWithDelegationTokens [junit4] OK 0.04s J2 | TestSolrCloudWithDelegationTokens.testZNodePaths [junit4] OK 0.03s J2 | TestSolrCloudWithDelegationTokens.testDelegationOtherOp [junit4] OK 0.05s J2 | TestSolrCloudWithDelegationTokens.testDelegationTokenVerify [junit4] OK 0.03s J2 | TestSolrCloudWithDelegationTokens.testDelegationTokenSolrClient [junit4] OK 0.29s J2 | TestSolrCloudWithDelegationTokens.testDelegationTokenRenew [junit4] OK 0.07s J2 | TestSolrCloudWithDelegationTokens.testDelegationTokenCancel [junit4] OK 0.03s J2 | TestSolrCloudWithDelegationTokens.testDelegationTokenRenewFail [junit4] OK 0.03s J2 | TestSolrCloudWithDelegationTokens.testDelegationTokenCancelFail [junit4] Completed [8/10] on J2 in 1.76s, 8 tests [junit4] [junit4] Suite: org.apache.solr.cloud.LeaderVoteWaitTimeoutTest [junit4] OK 24.5s J1 | LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection [junit4] OK 9.42s J1 | LeaderVoteWaitTimeoutTest.basicTest [junit4] Completed [9/10] on J1 in 34.85s, 2 tests [junit4] [junit4] Suite: org.apache.solr.cloud.LeaderVoteWaitTimeoutTest [junit4] OK 25.4s J0 | LeaderVoteWaitTimeoutTest.testMostInSyncReplicasCanWinElection [junit4] OK 11.3s J0 | LeaderVoteWaitTimeoutTest.basicTest [junit4] Completed [10/10] on J0 in 37.78s, 2 tests [junit4] [junit4] JVM J0: 0.70 .. 90.49 = 89.79s [junit4] JVM J1: 0.69 .. 89.53 = 88.84s [junit4] JVM J2: 0.68 .. 63.76 = 63.08s [junit4] Execution time total: 1 minute 30 seconds [junit4] Tests summary: 10 suites, 50 tests [junit4] Could not remove temporary path: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J2 (java.nio.file.DirectoryNotEmptyException: Remaining files: [/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J2/temp]) [junit4] Could not remove temporary path: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0 (java.nio.file.DirectoryNotEmptyException: Remaining files: [/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp]) [junit4] Could not remove temporary path: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1 (java.nio.file.DirectoryNotEmptyException: Remaining files: [/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp]) [echo] 5 slowest tests: [junit4:tophints] 171.60s | org.apache.solr.cloud.api.collections.ShardSplitTest [junit4:tophints] 116.83s | org.apache.solr.update.SoftAutoCommitTest [junit4:tophints] 102.83s | org.apache.solr.cloud.HttpPartitionWithTlogReplicasTest [junit4:tophints] 98.61s | org.apache.solr.search.facet.TestJsonFacets [junit4:tophints] 92.27s | org.apache.solr.cloud.BasicDistributedZkTest -check-totals: test-nocompile: BUILD SUCCESSFUL Total time: 1 minute 33 seconds [repro] Failures: [repro] 0/5 failed: org.apache.solr.cloud.LeaderVoteWaitTimeoutTest [repro] 0/5 failed: org.apache.solr.cloud.TestSolrCloudWithDelegationTokens [repro] Exiting with code 0 + mv lucene/build lucene/build.repro + mv solr/build solr/build.repro + mv lucene/build.orig lucene/build + mv solr/build.orig solr/build Archiving artifacts Setting ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 java.lang.InterruptedException: no matches found within 10000 at hudson.FilePath$ValidateAntFileMask.hasMatch(FilePath.java:2801) at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:2680) at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:2661) at hudson.FilePath.act(FilePath.java:1074) at hudson.FilePath.act(FilePath.java:1057) at hudson.FilePath.validateAntFileMask(FilePath.java:2659) at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:243) at hudson.tasks.BuildStepCompatibilityLayer.perform(BuildStepCompatibilityLayer.java:79) at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20) at hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:744) at hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:690) at hudson.model.Build$BuildExecution.post2(Build.java:186) at hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:635) at hudson.model.Run.execute(Run.java:1841) at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43) at hudson.model.ResourceController.execute(ResourceController.java:97) at hudson.model.Executor.run(Executor.java:429) No artifacts found that match the file pattern "**/*.events,heapdumps/**,**/*_pid*.log". Configuration error? [WARNINGS] Parsing warnings in console log with parser Java Compiler (javac) Setting ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 No credentials specified Setting ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 <Git Blamer> Using GitBlamer to create author and commit information for all warnings. <Git Blamer> GIT_COMMIT=132f5433103a121d400f071c5739a9af318f4807, workspace=/home/jenkins/workspace/Lucene-Solr-8.x-Linux [WARNINGS] Computing warning deltas based on reference build #250 Recording test results Setting ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 Build step 'Publish JUnit test result report' changed build result to UNSTABLE Email was triggered for: Unstable (Test Failures) Sending email for trigger: Unstable (Test Failures) Setting ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 Setting ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 Setting ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 Setting ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 Setting ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 Setting ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
--------------------------------------------------------------------- To unsubscribe, e-mail: [email protected] For additional commands, e-mail: [email protected]
