Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/21201/ Java: 64bit/jdk-10-ea+37 -XX:-UseCompressedOops -XX:+UseG1GC
2 tests failed. FAILED: org.apache.solr.cloud.TestLeaderElectionWithEmptyReplica.test Error Message: Stack Trace: java.util.concurrent.TimeoutException at __randomizedtesting.SeedInfo.seed([4A6ABB09D249B2AC:C23E84D37CB5DF54]:0) at org.apache.solr.common.cloud.ZkStateReader.waitForState(ZkStateReader.java:1261) at org.apache.solr.client.solrj.impl.CloudSolrClient.waitForState(CloudSolrClient.java:449) at org.apache.solr.cloud.TestLeaderElectionWithEmptyReplica.test(TestLeaderElectionWithEmptyReplica.java:97) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:564) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at java.base/java.lang.Thread.run(Thread.java:844) FAILED: org.apache.solr.schema.TestCloudSchemaless.test Error Message: Timeout occured while waiting response from server at: http://127.0.0.1:34559/bix Stack Trace: org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting response from server at: http://127.0.0.1:34559/bix at __randomizedtesting.SeedInfo.seed([4A6ABB09D249B2AC:C23E84D37CB5DF54]:0) at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:654) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:255) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:244) at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:483) at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:413) at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1104) at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:884) at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:817) at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:194) at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:211) at org.apache.solr.cloud.AbstractFullDistribZkTestBase.createServers(AbstractFullDistribZkTestBase.java:320) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:991) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:968) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at java.base/java.lang.Thread.run(Thread.java:844) Caused by: java.net.SocketTimeoutException: Read timed out at java.base/java.net.SocketInputStream.socketRead0(Native Method) at java.base/java.net.SocketInputStream.socketRead(SocketInputStream.java:116) at java.base/java.net.SocketInputStream.read(SocketInputStream.java:171) at java.base/java.net.SocketInputStream.read(SocketInputStream.java:141) at org.apache.http.impl.io.SessionInputBufferImpl.streamRead(SessionInputBufferImpl.java:137) at org.apache.http.impl.io.SessionInputBufferImpl.fillBuffer(SessionInputBufferImpl.java:153) at org.apache.http.impl.io.SessionInputBufferImpl.readLine(SessionInputBufferImpl.java:282) at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:138) at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:56) at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:259) at org.apache.http.impl.DefaultBHttpClientConnection.receiveResponseHeader(DefaultBHttpClientConnection.java:163) at org.apache.http.impl.conn.CPoolProxy.receiveResponseHeader(CPoolProxy.java:165) at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:273) at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:125) at org.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:272) at org.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:185) at org.apache.http.impl.execchain.RetryExec.execute(RetryExec.java:89) at org.apache.http.impl.execchain.RedirectExec.execute(RedirectExec.java:111) at org.apache.http.impl.client.InternalHttpClient.doExecute(InternalHttpClient.java:185) at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:83) at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:56) at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:542) ... 42 more Build Log: [...truncated 13486 lines...] [junit4] Suite: org.apache.solr.cloud.TestLeaderElectionWithEmptyReplica [junit4] 2> 2486131 INFO (SUITE-TestLeaderElectionWithEmptyReplica-seed#[4A6ABB09D249B2AC]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom [junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.TestLeaderElectionWithEmptyReplica_4A6ABB09D249B2AC-001/init-core-data-001 [junit4] 2> 2486131 WARN (SUITE-TestLeaderElectionWithEmptyReplica-seed#[4A6ABB09D249B2AC]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=28 numCloses=28 [junit4] 2> 2486131 INFO (SUITE-TestLeaderElectionWithEmptyReplica-seed#[4A6ABB09D249B2AC]-worker) [ ] o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) w/NUMERIC_DOCVALUES_SYSPROP=true [junit4] 2> 2486132 INFO (SUITE-TestLeaderElectionWithEmptyReplica-seed#[4A6ABB09D249B2AC]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason="", ssl=0.0/0.0, value=0.0/0.0, clientAuth=0.0/0.0) [junit4] 2> 2486133 INFO (SUITE-TestLeaderElectionWithEmptyReplica-seed#[4A6ABB09D249B2AC]-worker) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.TestLeaderElectionWithEmptyReplica_4A6ABB09D249B2AC-001/tempDir-001 [junit4] 2> 2486133 INFO (SUITE-TestLeaderElectionWithEmptyReplica-seed#[4A6ABB09D249B2AC]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 2486133 INFO (Thread-6134) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 2486133 INFO (Thread-6134) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 2486134 ERROR (Thread-6134) [ ] o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes [junit4] 2> 2486233 INFO (SUITE-TestLeaderElectionWithEmptyReplica-seed#[4A6ABB09D249B2AC]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port:39971 [junit4] 2> 2486235 INFO (zkConnectionManagerCallback-4322-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2486237 INFO (jetty-launcher-4319-thread-1) [ ] o.e.j.s.Server jetty-9.3.20.v20170531 [junit4] 2> 2486237 INFO (jetty-launcher-4319-thread-2) [ ] o.e.j.s.Server jetty-9.3.20.v20170531 [junit4] 2> 2486239 INFO (jetty-launcher-4319-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1c9a2646{/solr,null,AVAILABLE} [junit4] 2> 2486239 INFO (jetty-launcher-4319-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@380217f8{/solr,null,AVAILABLE} [junit4] 2> 2486239 INFO (jetty-launcher-4319-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@7118407c{SSL,[ssl, http/1.1]}{127.0.0.1:44563} [junit4] 2> 2486239 INFO (jetty-launcher-4319-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@df2e422{SSL,[ssl, http/1.1]}{127.0.0.1:33333} [junit4] 2> 2486239 INFO (jetty-launcher-4319-thread-1) [ ] o.e.j.s.Server Started @2488155ms [junit4] 2> 2486239 INFO (jetty-launcher-4319-thread-2) [ ] o.e.j.s.Server Started @2488155ms [junit4] 2> 2486240 INFO (jetty-launcher-4319-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=44563} [junit4] 2> 2486240 INFO (jetty-launcher-4319-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=33333} [junit4] 2> 2486240 ERROR (jetty-launcher-4319-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 2486240 ERROR (jetty-launcher-4319-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 2486240 INFO (jetty-launcher-4319-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.0.0 [junit4] 2> 2486240 INFO (jetty-launcher-4319-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.0.0 [junit4] 2> 2486240 INFO (jetty-launcher-4319-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 2486240 INFO (jetty-launcher-4319-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 2486240 INFO (jetty-launcher-4319-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 2486240 INFO (jetty-launcher-4319-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 2486240 INFO (jetty-launcher-4319-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-01-03T00:36:13.475436Z [junit4] 2> 2486240 INFO (jetty-launcher-4319-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-01-03T00:36:13.475475Z [junit4] 2> 2486241 INFO (zkConnectionManagerCallback-4326-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2486241 INFO (zkConnectionManagerCallback-4325-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2486241 INFO (jetty-launcher-4319-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 2486241 INFO (jetty-launcher-4319-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 2486247 INFO (jetty-launcher-4319-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:39971/solr [junit4] 2> 2486248 INFO (zkConnectionManagerCallback-4330-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2486249 INFO (jetty-launcher-4319-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:39971/solr [junit4] 2> 2486249 INFO (zkConnectionManagerCallback-4334-thread-1-processing-n:127.0.0.1:33333_solr) [n:127.0.0.1:33333_solr ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2486249 INFO (zkConnectionManagerCallback-4336-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2486250 INFO (zkConnectionManagerCallback-4338-thread-1-processing-n:127.0.0.1:44563_solr) [n:127.0.0.1:44563_solr ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2486284 INFO (jetty-launcher-4319-thread-1) [n:127.0.0.1:44563_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 2486284 INFO (jetty-launcher-4319-thread-1) [n:127.0.0.1:44563_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:44563_solr [junit4] 2> 2486285 INFO (jetty-launcher-4319-thread-1) [n:127.0.0.1:44563_solr ] o.a.s.c.Overseer Overseer (id=99283092987510790-127.0.0.1:44563_solr-n_0000000000) starting [junit4] 2> 2486285 INFO (jetty-launcher-4319-thread-2) [n:127.0.0.1:33333_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 2486285 INFO (jetty-launcher-4319-thread-2) [n:127.0.0.1:33333_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:33333_solr [junit4] 2> 2486289 INFO (zkCallback-4333-thread-1-processing-n:127.0.0.1:33333_solr) [n:127.0.0.1:33333_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 2486289 INFO (zkCallback-4337-thread-1-processing-n:127.0.0.1:44563_solr) [n:127.0.0.1:44563_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 2486294 INFO (jetty-launcher-4319-thread-1) [n:127.0.0.1:44563_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:44563_solr [junit4] 2> 2486294 INFO (zkCallback-4337-thread-1-processing-n:127.0.0.1:44563_solr) [n:127.0.0.1:44563_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 2486297 INFO (zkCallback-4333-thread-1-processing-n:127.0.0.1:33333_solr) [n:127.0.0.1:33333_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 2486380 INFO (jetty-launcher-4319-thread-2) [n:127.0.0.1:33333_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_33333.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@e8c54a3 [junit4] 2> 2486389 INFO (jetty-launcher-4319-thread-2) [n:127.0.0.1:33333_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_33333.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@e8c54a3 [junit4] 2> 2486390 INFO (jetty-launcher-4319-thread-2) [n:127.0.0.1:33333_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_33333.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@e8c54a3 [junit4] 2> 2486391 INFO (jetty-launcher-4319-thread-2) [n:127.0.0.1:33333_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.TestLeaderElectionWithEmptyReplica_4A6ABB09D249B2AC-001/tempDir-001/node2/. [junit4] 2> 2486391 INFO (jetty-launcher-4319-thread-1) [n:127.0.0.1:44563_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_44563.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@e8c54a3 [junit4] 2> 2486399 INFO (jetty-launcher-4319-thread-1) [n:127.0.0.1:44563_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_44563.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@e8c54a3 [junit4] 2> 2486400 INFO (jetty-launcher-4319-thread-1) [n:127.0.0.1:44563_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_44563.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@e8c54a3 [junit4] 2> 2486401 INFO (jetty-launcher-4319-thread-1) [n:127.0.0.1:44563_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.TestLeaderElectionWithEmptyReplica_4A6ABB09D249B2AC-001/tempDir-001/node1/. [junit4] 2> 2486544 INFO (zkConnectionManagerCallback-4344-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2486546 INFO (zkConnectionManagerCallback-4348-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2486546 INFO (SUITE-TestLeaderElectionWithEmptyReplica-seed#[4A6ABB09D249B2AC]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2) [junit4] 2> 2486547 INFO (SUITE-TestLeaderElectionWithEmptyReplica-seed#[4A6ABB09D249B2AC]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:39971/solr ready [junit4] 2> 2486559 INFO (qtp470993904-22563) [n:127.0.0.1:33333_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params async=16a1e0b9-4a44-4ab9-9a7e-60d05866b5b0&replicationFactor=1&collection.configName=config&name=solr_9504&nrtReplicas=1&action=CREATE&numShards=1&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 2486560 INFO (qtp470993904-22563) [n:127.0.0.1:33333_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={async=16a1e0b9-4a44-4ab9-9a7e-60d05866b5b0&replicationFactor=1&collection.configName=config&name=solr_9504&nrtReplicas=1&action=CREATE&numShards=1&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 2486560 INFO (qtp470993904-22571) [n:127.0.0.1:33333_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :requeststatus with params requestid=16a1e0b9-4a44-4ab9-9a7e-60d05866b5b0&action=REQUESTSTATUS&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 2486561 INFO (qtp470993904-22571) [n:127.0.0.1:33333_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={requestid=16a1e0b9-4a44-4ab9-9a7e-60d05866b5b0&action=REQUESTSTATUS&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 2486561 INFO (OverseerThreadFactory-7887-thread-1-processing-n:127.0.0.1:44563_solr) [n:127.0.0.1:44563_solr ] o.a.s.c.CreateCollectionCmd Create collection solr_9504 [junit4] 2> 2486664 INFO (OverseerStateUpdate-99283092987510790-127.0.0.1:44563_solr-n_0000000000) [n:127.0.0.1:44563_solr ] o.a.s.c.o.SliceMutator createReplica() { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"solr_9504", [junit4] 2> "shard":"shard1", [junit4] 2> "core":"solr_9504_shard1_replica_n1", [junit4] 2> "state":"down", [junit4] 2> "base_url":"https://127.0.0.1:33333/solr", [junit4] 2> "type":"NRT", [junit4] 2> "waitForFinalState":"false"} [junit4] 2> 2486867 INFO (qtp470993904-22571) [n:127.0.0.1:33333_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&collection.configName=config&newCollection=true&collection=solr_9504&version=2&replicaType=NRT&async=16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698&coreNodeName=core_node2&name=solr_9504_shard1_replica_n1&action=CREATE&numShards=1&shard=shard1&wt=javabin} status=0 QTime=0 [junit4] 2> 2486867 INFO (parallelCoreAdminExecutor-7888-thread-1-processing-n:127.0.0.1:33333_solr 16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698 CREATE) [n:127.0.0.1:33333_solr ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=config&newCollection=true&collection=solr_9504&version=2&replicaType=NRT&async=16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698&coreNodeName=core_node2&name=solr_9504_shard1_replica_n1&action=CREATE&numShards=1&shard=shard1&wt=javabin [junit4] 2> 2486867 INFO (parallelCoreAdminExecutor-7888-thread-1-processing-n:127.0.0.1:33333_solr 16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698 CREATE) [n:127.0.0.1:33333_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 2486867 INFO (qtp470993904-22565) [n:127.0.0.1:33333_solr ] o.a.s.h.a.CoreAdminOperation Checking request status for : 16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698 [junit4] 2> 2486867 INFO (qtp470993904-22565) [n:127.0.0.1:33333_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&requestid=16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698&action=REQUESTSTATUS&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 2486969 INFO (zkCallback-4333-thread-1-processing-n:127.0.0.1:33333_solr) [n:127.0.0.1:33333_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/solr_9504/state.json] for collection [solr_9504] has occurred - updating... (live nodes size: [2]) [junit4] 2> 2486969 INFO (zkCallback-4333-thread-2-processing-n:127.0.0.1:33333_solr) [n:127.0.0.1:33333_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/solr_9504/state.json] for collection [solr_9504] has occurred - updating... (live nodes size: [2]) [junit4] 2> 2487562 INFO (qtp470993904-22573) [n:127.0.0.1:33333_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :requeststatus with params requestid=16a1e0b9-4a44-4ab9-9a7e-60d05866b5b0&action=REQUESTSTATUS&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 2487562 INFO (qtp470993904-22573) [n:127.0.0.1:33333_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={requestid=16a1e0b9-4a44-4ab9-9a7e-60d05866b5b0&action=REQUESTSTATUS&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 2487868 INFO (qtp470993904-22565) [n:127.0.0.1:33333_solr ] o.a.s.h.a.CoreAdminOperation Checking request status for : 16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698 [junit4] 2> 2487868 INFO (qtp470993904-22565) [n:127.0.0.1:33333_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&requestid=16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698&action=REQUESTSTATUS&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 2487872 INFO (parallelCoreAdminExecutor-7888-thread-1-processing-n:127.0.0.1:33333_solr 16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698 CREATE) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0 [junit4] 2> 2487876 INFO (parallelCoreAdminExecutor-7888-thread-1-processing-n:127.0.0.1:33333_solr 16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698 CREATE) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.s.IndexSchema [solr_9504_shard1_replica_n1] Schema name=minimal [junit4] 2> 2487877 INFO (parallelCoreAdminExecutor-7888-thread-1-processing-n:127.0.0.1:33333_solr 16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698 CREATE) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id [junit4] 2> 2487877 INFO (parallelCoreAdminExecutor-7888-thread-1-processing-n:127.0.0.1:33333_solr 16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698 CREATE) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.c.CoreContainer Creating SolrCore 'solr_9504_shard1_replica_n1' using configuration from collection solr_9504, trusted=true [junit4] 2> 2487877 INFO (parallelCoreAdminExecutor-7888-thread-1-processing-n:127.0.0.1:33333_solr 16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698 CREATE) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_33333.solr.core.solr_9504.shard1.replica_n1' (registry 'solr.core.solr_9504.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@e8c54a3 [junit4] 2> 2487877 INFO (parallelCoreAdminExecutor-7888-thread-1-processing-n:127.0.0.1:33333_solr 16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698 CREATE) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 2487877 INFO (parallelCoreAdminExecutor-7888-thread-1-processing-n:127.0.0.1:33333_solr 16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698 CREATE) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.c.SolrCore [[solr_9504_shard1_replica_n1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.TestLeaderElectionWithEmptyReplica_4A6ABB09D249B2AC-001/tempDir-001/node2/solr_9504_shard1_replica_n1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.TestLeaderElectionWithEmptyReplica_4A6ABB09D249B2AC-001/tempDir-001/node2/./solr_9504_shard1_replica_n1/data/] [junit4] 2> 2487965 INFO (parallelCoreAdminExecutor-7888-thread-1-processing-n:127.0.0.1:33333_solr 16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698 CREATE) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 2487965 INFO (parallelCoreAdminExecutor-7888-thread-1-processing-n:127.0.0.1:33333_solr 16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698 CREATE) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 2487966 INFO (parallelCoreAdminExecutor-7888-thread-1-processing-n:127.0.0.1:33333_solr 16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698 CREATE) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 2487966 INFO (parallelCoreAdminExecutor-7888-thread-1-processing-n:127.0.0.1:33333_solr 16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698 CREATE) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 2487967 INFO (parallelCoreAdminExecutor-7888-thread-1-processing-n:127.0.0.1:33333_solr 16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698 CREATE) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.s.SolrIndexSearcher Opening [Searcher@20507dce[solr_9504_shard1_replica_n1] main] [junit4] 2> 2487968 INFO (parallelCoreAdminExecutor-7888-thread-1-processing-n:127.0.0.1:33333_solr 16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698 CREATE) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/config [junit4] 2> 2487968 INFO (parallelCoreAdminExecutor-7888-thread-1-processing-n:127.0.0.1:33333_solr 16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698 CREATE) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/config [junit4] 2> 2487968 INFO (parallelCoreAdminExecutor-7888-thread-1-processing-n:127.0.0.1:33333_solr 16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698 CREATE) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 2487969 INFO (searcherExecutor-7892-thread-1-processing-x:solr_9504_shard1_replica_n1 r:core_node2 16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698 CREATE n:127.0.0.1:33333_solr s:shard1 c:solr_9504) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.c.SolrCore [solr_9504_shard1_replica_n1] Registered new searcher Searcher@20507dce[solr_9504_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 2487969 INFO (parallelCoreAdminExecutor-7888-thread-1-processing-n:127.0.0.1:33333_solr 16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698 CREATE) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1588529489724309504 [junit4] 2> 2487971 INFO (parallelCoreAdminExecutor-7888-thread-1-processing-n:127.0.0.1:33333_solr 16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698 CREATE) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue. [junit4] 2> 2487971 INFO (parallelCoreAdminExecutor-7888-thread-1-processing-n:127.0.0.1:33333_solr 16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698 CREATE) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync [junit4] 2> 2487971 INFO (parallelCoreAdminExecutor-7888-thread-1-processing-n:127.0.0.1:33333_solr 16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698 CREATE) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.c.SyncStrategy Sync replicas to https://127.0.0.1:33333/solr/solr_9504_shard1_replica_n1/ [junit4] 2> 2487971 INFO (parallelCoreAdminExecutor-7888-thread-1-processing-n:127.0.0.1:33333_solr 16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698 CREATE) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me [junit4] 2> 2487972 INFO (parallelCoreAdminExecutor-7888-thread-1-processing-n:127.0.0.1:33333_solr 16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698 CREATE) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.c.SyncStrategy https://127.0.0.1:33333/solr/solr_9504_shard1_replica_n1/ has no replicas [junit4] 2> 2487972 INFO (parallelCoreAdminExecutor-7888-thread-1-processing-n:127.0.0.1:33333_solr 16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698 CREATE) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext Found all replicas participating in election, clear LIR [junit4] 2> 2487973 INFO (parallelCoreAdminExecutor-7888-thread-1-processing-n:127.0.0.1:33333_solr 16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698 CREATE) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I am the new leader: https://127.0.0.1:33333/solr/solr_9504_shard1_replica_n1/ shard1 [junit4] 2> 2488074 INFO (zkCallback-4333-thread-1-processing-n:127.0.0.1:33333_solr) [n:127.0.0.1:33333_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/solr_9504/state.json] for collection [solr_9504] has occurred - updating... (live nodes size: [2]) [junit4] 2> 2488074 INFO (zkCallback-4333-thread-2-processing-n:127.0.0.1:33333_solr) [n:127.0.0.1:33333_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/solr_9504/state.json] for collection [solr_9504] has occurred - updating... (live nodes size: [2]) [junit4] 2> 2488123 INFO (parallelCoreAdminExecutor-7888-thread-1-processing-n:127.0.0.1:33333_solr 16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698 CREATE) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.c.ZkController I am the leader, no recovery necessary [junit4] 2> 2488225 INFO (zkCallback-4333-thread-1-processing-n:127.0.0.1:33333_solr) [n:127.0.0.1:33333_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/solr_9504/state.json] for collection [solr_9504] has occurred - updating... (live nodes size: [2]) [junit4] 2> 2488225 INFO (zkCallback-4333-thread-2-processing-n:127.0.0.1:33333_solr) [n:127.0.0.1:33333_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/solr_9504/state.json] for collection [solr_9504] has occurred - updating... (live nodes size: [2]) [junit4] 2> 2488563 INFO (qtp470993904-22574) [n:127.0.0.1:33333_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :requeststatus with params requestid=16a1e0b9-4a44-4ab9-9a7e-60d05866b5b0&action=REQUESTSTATUS&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 2488564 INFO (qtp470993904-22574) [n:127.0.0.1:33333_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={requestid=16a1e0b9-4a44-4ab9-9a7e-60d05866b5b0&action=REQUESTSTATUS&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 2488868 INFO (qtp470993904-22571) [n:127.0.0.1:33333_solr ] o.a.s.h.a.CoreAdminOperation Checking request status for : 16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698 [junit4] 2> 2488869 INFO (qtp470993904-22571) [n:127.0.0.1:33333_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&requestid=16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698&action=REQUESTSTATUS&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 2488870 INFO (OverseerThreadFactory-7887-thread-1-processing-n:127.0.0.1:44563_solr) [n:127.0.0.1:44563_solr ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000000 doesn't exist. Requestor may have disconnected from ZooKeeper [junit4] 2> 2489564 INFO (qtp470993904-22563) [n:127.0.0.1:33333_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :requeststatus with params requestid=16a1e0b9-4a44-4ab9-9a7e-60d05866b5b0&action=REQUESTSTATUS&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 2489565 INFO (qtp470993904-22563) [n:127.0.0.1:33333_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={requestid=16a1e0b9-4a44-4ab9-9a7e-60d05866b5b0&action=REQUESTSTATUS&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 2489565 INFO (qtp470993904-22565) [n:127.0.0.1:33333_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :deletestatus with params requestid=16a1e0b9-4a44-4ab9-9a7e-60d05866b5b0&action=DELETESTATUS&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 2489565 INFO (qtp470993904-22565) [n:127.0.0.1:33333_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={requestid=16a1e0b9-4a44-4ab9-9a7e-60d05866b5b0&action=DELETESTATUS&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 2489572 INFO (TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [ ] o.a.s.SolrTestCaseJ4 ###Starting test [junit4] 2> 2489574 INFO (qtp470993904-22574) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [solr_9504_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[0 (1588529491406225408)]} 0 0 [junit4] 2> 2489575 INFO (qtp470993904-22571) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [solr_9504_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[1 (1588529491408322560)]} 0 0 [junit4] 2> 2489576 INFO (qtp470993904-22563) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [solr_9504_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[2 (1588529491409371136)]} 0 0 [junit4] 2> 2489578 INFO (qtp470993904-22563) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [solr_9504_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[3 (1588529491411468288)]} 0 0 [junit4] 2> 2489579 INFO (qtp470993904-22574) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [solr_9504_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[4 (1588529491412516864)]} 0 0 [junit4] 2> 2489579 INFO (qtp470993904-22571) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [solr_9504_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[5 (1588529491412516865)]} 0 0 [junit4] 2> 2489580 INFO (qtp470993904-22565) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [solr_9504_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[6 (1588529491413565440)]} 0 0 [junit4] 2> 2489580 INFO (qtp470993904-22563) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [solr_9504_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[7 (1588529491413565441)]} 0 0 [junit4] 2> 2489581 INFO (qtp470993904-22563) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [solr_9504_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[8 (1588529491413565442)]} 0 0 [junit4] 2> 2489581 INFO (qtp470993904-22563) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [solr_9504_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[9 (1588529491414614016)]} 0 0 [junit4] 2> 2489581 INFO (qtp470993904-22563) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1588529491414614017,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 2489581 INFO (qtp470993904-22563) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@3aafc2f3 commitCommandVersion:1588529491414614017 [junit4] 2> 2489660 INFO (qtp470993904-22563) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.s.SolrIndexSearcher Opening [Searcher@610efca5[solr_9504_shard1_replica_n1] main] [junit4] 2> 2489660 INFO (qtp470993904-22563) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 2489661 INFO (searcherExecutor-7892-thread-1-processing-n:127.0.0.1:33333_solr x:solr_9504_shard1_replica_n1 s:shard1 c:solr_9504 r:core_node2) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.c.SolrCore [solr_9504_shard1_replica_n1] Registered new searcher Searcher@610efca5[solr_9504_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):C10)))} [junit4] 2> 2489662 INFO (qtp470993904-22563) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [solr_9504_shard1_replica_n1] webapp=/solr path=/update params={_stateVer_=solr_9504:4&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 80 [junit4] 2> 2489662 INFO (TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [ ] o.a.s.c.ChaosMonkey monkey: kill jetty! 33333 [junit4] 2> 2489663 INFO (TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@df2e422{SSL,[ssl, http/1.1]}{127.0.0.1:0} [junit4] 2> 2489663 INFO (TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=426980389 [junit4] 2> 2489663 INFO (TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 2489663 INFO (TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@caaedd2: rootName = solr_33333, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@fbbb095 [junit4] 2> 2489671 INFO (TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null [junit4] 2> 2489671 INFO (TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@6803b07c: rootName = solr_33333, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@4ad8b71a [junit4] 2> 2489676 INFO (TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null [junit4] 2> 2489676 INFO (TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@70f6d734: rootName = solr_33333, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@334360d0 [junit4] 2> 2489677 INFO (TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:33333_solr [junit4] 2> 2489677 INFO (TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null [junit4] 2> 2489677 INFO (zkCallback-4337-thread-1-processing-n:127.0.0.1:44563_solr) [n:127.0.0.1:44563_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1) [junit4] 2> 2489677 INFO (zkCallback-4347-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1) [junit4] 2> 2489677 INFO (zkCallback-4333-thread-2-processing-n:127.0.0.1:33333_solr) [n:127.0.0.1:33333_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1) [junit4] 2> 2489677 INFO (coreCloseExecutor-7897-thread-1) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.c.SolrCore [solr_9504_shard1_replica_n1] CLOSING SolrCore org.apache.solr.core.SolrCore@fced1ef [junit4] 2> 2489677 INFO (coreCloseExecutor-7897-thread-1) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.solr_9504.shard1.replica_n1, tag=265212399 [junit4] 2> 2489677 INFO (coreCloseExecutor-7897-thread-1) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@16ef28a2: rootName = solr_33333, domain = solr.core.solr_9504.shard1.replica_n1, service url = null, agent id = null] for registry solr.core.solr_9504.shard1.replica_n1 / com.codahale.metrics.MetricRegistry@40a666d2 [junit4] 2> 2489686 INFO (coreCloseExecutor-7897-thread-1) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.solr_9504.shard1.leader, tag=265212399 [junit4] 2> 2489689 INFO (TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@380217f8{/solr,null,UNAVAILABLE} [junit4] 2> 2489689 INFO (TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [ ] o.a.s.c.ChaosMonkey monkey: stop jetty! 33333 [junit4] 2> 2489708 INFO (qtp1879563970-22562) [n:127.0.0.1:44563_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with params async=3a3e5919-300f-435e-bace-e121b1616fa8&action=ADDREPLICA&collection=solr_9504&shard=shard1&type=NRT&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 2489709 INFO (qtp1879563970-22562) [n:127.0.0.1:44563_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={async=3a3e5919-300f-435e-bace-e121b1616fa8&action=ADDREPLICA&collection=solr_9504&shard=shard1&type=NRT&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 2489709 INFO (OverseerCollectionConfigSetProcessor-99283092987510790-127.0.0.1:44563_solr-n_0000000000) [n:127.0.0.1:44563_solr ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000000 doesn't exist. Requestor may have disconnected from ZooKeeper [junit4] 2> 2489710 INFO (OverseerThreadFactory-7887-thread-2-processing-n:127.0.0.1:44563_solr) [n:127.0.0.1:44563_solr ] o.a.s.c.AddReplicaCmd Node Identified 127.0.0.1:44563_solr for creating new replica [junit4] 2> 2490709 INFO (TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [ ] o.a.s.c.ChaosMonkey monkey: starting jetty! 33333 [junit4] 2> 2490710 INFO (TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [ ] o.e.j.s.Server jetty-9.3.20.v20170531 [junit4] 2> 2490711 INFO (TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@293bafb5{/solr,null,AVAILABLE} [junit4] 2> 2490712 INFO (TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@32839f8{SSL,[ssl, http/1.1]}{127.0.0.1:33333} [junit4] 2> 2490712 INFO (TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [ ] o.e.j.s.Server Started @2492627ms [junit4] 2> 2490712 INFO (TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=33333} [junit4] 2> 2490712 ERROR (TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 2490712 INFO (TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.0.0 [junit4] 2> 2490712 INFO (TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 2490712 INFO (TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 2490712 INFO (TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-01-03T00:36:17.947940Z [junit4] 2> 2490716 INFO (zkConnectionManagerCallback-4350-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2490717 INFO (TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 2490725 INFO (TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:39971/solr [junit4] 2> 2490726 INFO (zkConnectionManagerCallback-4354-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2490729 INFO (zkConnectionManagerCallback-4356-thread-1-processing-n:127.0.0.1:33333_solr) [n:127.0.0.1:33333_solr ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2490731 INFO (TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [n:127.0.0.1:33333_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 2490732 INFO (TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [n:127.0.0.1:33333_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 2490733 INFO (TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [n:127.0.0.1:33333_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:33333_solr [junit4] 2> 2490734 INFO (zkCallback-4347-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 2490734 INFO (zkCallback-4337-thread-1-processing-n:127.0.0.1:44563_solr) [n:127.0.0.1:44563_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 2490740 INFO (zkCallback-4355-thread-1-processing-n:127.0.0.1:33333_solr) [n:127.0.0.1:33333_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 2490794 INFO (TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [n:127.0.0.1:33333_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_33333.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@e8c54a3 [junit4] 2> 2490806 INFO (TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [n:127.0.0.1:33333_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_33333.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@e8c54a3 [junit4] 2> 2490806 INFO (TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [n:127.0.0.1:33333_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_33333.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@e8c54a3 [junit4] 2> 2490808 INFO (TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [n:127.0.0.1:33333_solr ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.TestLeaderElectionWithEmptyReplica_4A6ABB09D249B2AC-001/tempDir-001/node2/. [junit4] 2> 2490809 INFO (TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [n:127.0.0.1:33333_solr ] o.a.s.c.CorePropertiesLocator Cores are: [solr_9504_shard1_replica_n1] [junit4] 2> 2490809 INFO (coreLoadExecutor-7904-thread-1-processing-n:127.0.0.1:33333_solr) [n:127.0.0.1:33333_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 2490812 INFO (coreLoadExecutor-7904-thread-1-processing-n:127.0.0.1:33333_solr) [n:127.0.0.1:33333_solr ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0 [junit4] 2> 2490828 INFO (coreLoadExecutor-7904-thread-1-processing-n:127.0.0.1:33333_solr) [n:127.0.0.1:33333_solr ] o.a.s.s.IndexSchema [solr_9504_shard1_replica_n1] Schema name=minimal [junit4] 2> 2490829 INFO (coreLoadExecutor-7904-thread-1-processing-n:127.0.0.1:33333_solr) [n:127.0.0.1:33333_solr ] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id [junit4] 2> 2490835 INFO (coreLoadExecutor-7904-thread-1-processing-n:127.0.0.1:33333_solr) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0 [junit4] 2> 2490839 INFO (coreLoadExecutor-7904-thread-1-processing-n:127.0.0.1:33333_solr) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.s.IndexSchema [solr_9504_shard1_replica_n1] Schema name=minimal [junit4] 2> 2490840 INFO (coreLoadExecutor-7904-thread-1-processing-n:127.0.0.1:33333_solr) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id [junit4] 2> 2490840 INFO (coreLoadExecutor-7904-thread-1-processing-n:127.0.0.1:33333_solr) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.c.CoreContainer Creating SolrCore 'solr_9504_shard1_replica_n1' using configuration from collection solr_9504, trusted=true [junit4] 2> 2490840 INFO (coreLoadExecutor-7904-thread-1-processing-n:127.0.0.1:33333_solr) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_33333.solr.core.solr_9504.shard1.replica_n1' (registry 'solr.core.solr_9504.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@e8c54a3 [junit4] 2> 2490840 INFO (coreLoadExecutor-7904-thread-1-processing-n:127.0.0.1:33333_solr) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 2490840 INFO (coreLoadExecutor-7904-thread-1-processing-n:127.0.0.1:33333_solr) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.c.SolrCore [[solr_9504_shard1_replica_n1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.TestLeaderElectionWithEmptyReplica_4A6ABB09D249B2AC-001/tempDir-001/node2/solr_9504_shard1_replica_n1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.TestLeaderElectionWithEmptyReplica_4A6ABB09D249B2AC-001/tempDir-001/node2/./solr_9504_shard1_replica_n1/data/] [junit4] 2> 2490862 INFO (coreLoadExecutor-7904-thread-1-processing-n:127.0.0.1:33333_solr) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 2490862 INFO (coreLoadExecutor-7904-thread-1-processing-n:127.0.0.1:33333_solr) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 2490882 INFO (coreLoadExecutor-7904-thread-1-processing-n:127.0.0.1:33333_solr) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 2490883 INFO (coreLoadExecutor-7904-thread-1-processing-n:127.0.0.1:33333_solr) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 2490886 INFO (coreLoadExecutor-7904-thread-1-processing-n:127.0.0.1:33333_solr) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1becd156[solr_9504_shard1_replica_n1] main] [junit4] 2> 2490887 INFO (coreLoadExecutor-7904-thread-1-processing-n:127.0.0.1:33333_solr) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/config [junit4] 2> 2490887 INFO (coreLoadExecutor-7904-thread-1-processing-n:127.0.0.1:33333_solr) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/config [junit4] 2> 2490887 INFO (coreLoadExecutor-7904-thread-1-processing-n:127.0.0.1:33333_solr) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 2490889 INFO (searcherExecutor-7905-thread-1-processing-n:127.0.0.1:33333_solr x:solr_9504_shard1_replica_n1 s:shard1 c:solr_9504 r:core_node2) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.c.SolrCore [solr_9504_shard1_replica_n1] Registered new searcher Searcher@1becd156[solr_9504_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):C10)))} [junit4] 2> 2490894 INFO (coreZkRegister-7899-thread-1-processing-n:127.0.0.1:33333_solr x:solr_9504_shard1_replica_n1 s:shard1 c:solr_9504 r:core_node2) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue. [junit4] 2> 2490894 INFO (coreZkRegister-7899-thread-1-processing-n:127.0.0.1:33333_solr x:solr_9504_shard1_replica_n1 s:shard1 c:solr_9504 r:core_node2) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync [junit4] 2> 2490894 INFO (coreZkRegister-7899-thread-1-processing-n:127.0.0.1:33333_solr x:solr_9504_shard1_replica_n1 s:shard1 c:solr_9504 r:core_node2) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.c.SyncStrategy Sync replicas to https://127.0.0.1:33333/solr/solr_9504_shard1_replica_n1/ [junit4] 2> 2490894 INFO (coreZkRegister-7899-thread-1-processing-n:127.0.0.1:33333_solr x:solr_9504_shard1_replica_n1 s:shard1 c:solr_9504 r:core_node2) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me [junit4] 2> 2490894 INFO (coreZkRegister-7899-thread-1-processing-n:127.0.0.1:33333_solr x:solr_9504_shard1_replica_n1 s:shard1 c:solr_9504 r:core_node2) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.c.SyncStrategy https://127.0.0.1:33333/solr/solr_9504_shard1_replica_n1/ has no replicas [junit4] 2> 2490894 INFO (coreZkRegister-7899-thread-1-processing-n:127.0.0.1:33333_solr x:solr_9504_shard1_replica_n1 s:shard1 c:solr_9504 r:core_node2) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext Found all replicas participating in election, clear LIR [junit4] 2> 2490895 INFO (coreZkRegister-7899-thread-1-processing-n:127.0.0.1:33333_solr x:solr_9504_shard1_replica_n1 s:shard1 c:solr_9504 r:core_node2) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I am the new leader: https://127.0.0.1:33333/solr/solr_9504_shard1_replica_n1/ shard1 [junit4] 2> 2490895 INFO (coreZkRegister-7899-thread-1-processing-n:127.0.0.1:33333_solr x:solr_9504_shard1_replica_n1 s:shard1 c:solr_9504 r:core_node2) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.c.ZkController I am the leader, no recovery necessary [junit4] 2> 2519807 ERROR (OverseerThreadFactory-7887-thread-2-processing-n:127.0.0.1:44563_solr) [n:127.0.0.1:44563_solr ] o.a.s.c.OverseerCollectionMessageHandler Collection: solr_9504 operation: addreplica failed:org.apache.solr.common.SolrException: Timed out waiting to see all replicas: [solr_9504_shard1_replica_n3] in cluster state. Last state: DocCollection(solr_9504//collections/solr_9504/state.json/4)={ [junit4] 2> "pullReplicas":"0", [junit4] 2> "replicationFactor":"1", [junit4] 2> "shards":{"shard1":{ [junit4] 2> "range":"80000000-7fffffff", [junit4] 2> "state":"active", [junit4] 2> "replicas":{"core_node2":{ [junit4] 2> "core":"solr_9504_shard1_replica_n1", [junit4] 2> "base_url":"https://127.0.0.1:33333/solr", [junit4] 2> "node_name":"127.0.0.1:33333_solr", [junit4] 2> "state":"active", [junit4] 2> "type":"NRT", [junit4] 2> "leader":"true"}}}}, [junit4] 2> "router":{"name":"compositeId"}, [junit4] 2> "maxShardsPerNode":"1", [junit4] 2> "autoAddReplicas":"false", [junit4] 2> "nrtReplicas":"1", [junit4] 2> "tlogReplicas":"0"} [junit4] 2> at org.apache.solr.cloud.OverseerCollectionMessageHandler.waitToSeeReplicasInState(OverseerCollectionMessageHandler.java:714) [junit4] 2> at org.apache.solr.cloud.AddReplicaCmd.addReplica(AddReplicaCmd.java:121) [junit4] 2> at org.apache.solr.cloud.AddReplicaCmd.call(AddReplicaCmd.java:73) [junit4] 2> at org.apache.solr.cloud.OverseerCollectionMessageHandler.processMessage(OverseerCollectionMessageHandler.java:242) [junit4] 2> at org.apache.solr.cloud.OverseerTaskProcessor$Runner.run(OverseerTaskProcessor.java:464) [junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:188) [junit4] 2> at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1135) [junit4] 2> at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) [junit4] 2> at java.base/java.lang.Thread.run(Thread.java:844) [junit4] 2> [junit4] 2> 2519808 INFO (OverseerThreadFactory-7887-thread-2-processing-n:127.0.0.1:44563_solr) [n:127.0.0.1:44563_solr ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000001 doesn't exist. Requestor may have disconnected from ZooKeeper [junit4] 2> 2521717 INFO (OverseerCollectionConfigSetProcessor-99283092987510790-127.0.0.1:44563_solr-n_0000000000) [n:127.0.0.1:44563_solr ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000001 doesn't exist. Requestor may have disconnected from ZooKeeper [junit4] 2> 2580997 INFO (TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [ ] o.a.s.SolrTestCaseJ4 ###Ending test [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestLeaderElectionWithEmptyReplica -Dtests.method=test -Dtests.seed=4A6ABB09D249B2AC -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=en-FM -Dtests.timezone=Asia/Manila -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1 [junit4] ERROR 91.4s J1 | TestLeaderElectionWithEmptyReplica.test <<< [junit4] > Throwable #1: java.util.concurrent.TimeoutException [junit4] > at __randomizedtesting.SeedInfo.seed([4A6ABB09D249B2AC:C23E84D37CB5DF54]:0) [junit4] > at org.apache.solr.common.cloud.ZkStateReader.waitForState(ZkStateReader.java:1261) [junit4] > at org.apache.solr.client.solrj.impl.CloudSolrClient.waitForState(CloudSolrClient.java:449) [junit4] > at org.apache.solr.cloud.TestLeaderElectionWithEmptyReplica.test(TestLeaderElectionWithEmptyReplica.java:97) [junit4] > at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [junit4] > at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) [junit4] > at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [junit4] > at java.base/java.lang.reflect.Method.invoke(Method.java:564) [junit4] > at java.base/java.lang.Thread.run(Thread.java:844) [junit4] 2> 2581000 INFO (jetty-closer-4320-thread-1) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@32839f8{SSL,[ssl, http/1.1]}{127.0.0.1:33333} [junit4] 2> 2581000 INFO (jetty-closer-4320-thread-2) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@7118407c{SSL,[ssl, http/1.1]}{127.0.0.1:0} [junit4] 2> 2581000 INFO (jetty-closer-4320-thread-1) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=131347605 [junit4] 2> 2581000 INFO (jetty-closer-4320-thread-2) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1771540959 [junit4] 2> 2581000 INFO (jetty-closer-4320-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 2581000 INFO (jetty-closer-4320-thread-2) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 2581000 INFO (jetty-closer-4320-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@22b95fad: rootName = solr_33333, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@7fa92172 [junit4] 2> 2581000 INFO (jetty-closer-4320-thread-2) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1f473fde: rootName = solr_44563, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@13143cee [junit4] 2> 2581006 INFO (jetty-closer-4320-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null [junit4] 2> 2581006 INFO (jetty-closer-4320-thread-2) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null [junit4] 2> 2581006 INFO (jetty-closer-4320-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@75e15442: rootName = solr_33333, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@4ad8b71a [junit4] 2> 2581006 INFO (jetty-closer-4320-thread-2) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@c89736f: rootName = solr_44563, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@4ad8b71a [junit4] 2> 2581011 INFO (jetty-closer-4320-thread-2) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null [junit4] 2> 2581011 INFO (jetty-closer-4320-thread-2) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@4078f53e: rootName = solr_44563, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@334360d0 [junit4] 2> 2581011 INFO (jetty-closer-4320-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null [junit4] 2> 2581011 INFO (jetty-closer-4320-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1137062b: rootName = solr_33333, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@334360d0 [junit4] 2> 2581011 INFO (jetty-closer-4320-thread-2) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:44563_solr [junit4] 2> 2581011 INFO (jetty-closer-4320-thread-1) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:33333_solr [junit4] 2> 2581013 INFO (jetty-closer-4320-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null [junit4] 2> 2581013 INFO (jetty-closer-4320-thread-2) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null [junit4] 2> 2581013 INFO (jetty-closer-4320-thread-2) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 2581013 INFO (zkCallback-4337-thread-2-processing-n:127.0.0.1:44563_solr) [n:127.0.0.1:44563_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (0) [junit4] 2> 2581013 INFO (coreCloseExecutor-7910-thread-1) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.c.SolrCore [solr_9504_shard1_replica_n1] CLOSING SolrCore org.apache.solr.core.SolrCore@4e81073c [junit4] 2> 2581013 INFO (coreCloseExecutor-7910-thread-1) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.solr_9504.shard1.replica_n1, tag=1317078844 [junit4] 2> 2581013 INFO (coreCloseExecutor-7910-thread-1) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@647a978: rootName = solr_33333, domain = solr.core.solr_9504.shard1.replica_n1, service url = null, agent id = null] for registry solr.core.solr_9504.shard1.replica_n1 / com.codahale.metrics.MetricRegistry@5d6ee2ac [junit4] 2> 2581013 INFO (jetty-closer-4320-thread-2) [ ] o.a.s.c.Overseer Overseer (id=99283092987510790-127.0.0.1:44563_solr-n_0000000000) closing [junit4] 2> 2581013 INFO (OverseerStateUpdate-99283092987510790-127.0.0.1:44563_solr-n_0000000000) [n:127.0.0.1:44563_solr ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:44563_solr [junit4] 2> 2581016 WARN (OverseerAutoScalingTriggerThread-99283092987510790-127.0.0.1:44563_solr-n_0000000000) [n:127.0.0.1:44563_solr ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we are closed, exiting. [junit4] 2> 2581017 INFO (jetty-closer-4320-thread-2) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@1c9a2646{/solr,null,UNAVAILABLE} [junit4] 2> 2581021 INFO (zkCallback-4355-thread-2-processing-n:127.0.0.1:33333_solr) [n:127.0.0.1:33333_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (0) [junit4] 2> 2581021 INFO (zkCallback-4355-thread-3-processing-n:127.0.0.1:33333_solr) [n:127.0.0.1:33333_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:33333_solr [junit4] 2> 2581021 INFO (coreCloseExecutor-7910-thread-1) [n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.solr_9504.shard1.leader, tag=1317078844 [junit4] 2> 2581025 INFO (jetty-closer-4320-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@293bafb5{/solr,null,UNAVAILABLE} [junit4] 2> 2581025 ERROR (SUITE-TestLeaderElectionWithEmptyReplica-seed#[4A6ABB09D249B2AC]-worker) [ ] o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes [junit4] 2> 2581025 INFO (SUITE-TestLeaderElectionWithEmptyReplica-seed#[4A6ABB09D249B2AC]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:39971 39971 [junit4] 2> 2586142 INFO (Thread-6134) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:39971 39971 [junit4] 2> 2586142 WARN (Thread-6134) [ ] o.a.s.c.ZkTestServer Watch limit violations: [junit4] 2> Maximum concurrent create/delete watches above limit: [junit4] 2> [junit4] 2> 4 /solr/aliases.json [junit4] 2> 3 /solr/security.json [junit4] 2> 2 /solr/configs/config [junit4] 2> [junit4] 2> Maximum concurrent data watches above limit: [junit4] 2> [junit4] 2> 9 /solr/collections/solr_9504/state.json [junit4] 2> 4 /solr/clusterstate.json [junit4] 2> 4 /solr/clusterprops.json [junit4] 2> 2 /solr/overseer_elect/election/99283092987510790-127.0.0.1:44563_solr-n_0000000000 [junit4] 2> [junit4] 2> Maximum concurrent children watches above limit: [junit4] 2> [junit4] 2> 4 /solr/live_nodes [junit4] 2> 4 /solr/collections [junit4] 2> [junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.TestLeaderElectionWithEmptyReplica_4A6ABB09D249B2AC-001 [junit4] 2> NOTE: test params are: codec=CheapBastard, sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@16cd8f16), locale=en-FM, timezone=Asia/Manila [junit4] 2> NOTE: Linux 4.10.0-40-generic amd64/Oracle Corporation 10-ea (64-bit)/cpus=8,threads=1,free=316973960,total=536870912 [junit4] 2> NOTE: All tests run in this JVM: [SimpleCollectionCreateDeleteTest, TestFastLRUCache, AtomicUpdatesTest, TestUtilizeNode, TestSolrCloudWithHadoopAuthPlugin, DOMUtilTest, TestCollationField, TestLuceneMatchVersion, TestStressCloudBlindAtomicUpdates, SpellingQueryConverterTest, SuggesterTSTTest, SolrCmdDistributorTest, SOLR749Test, TestNumericTokenStream, RemoteQueryErrorTest, SolrMetricReporterTest, TestCoreBackup, CreateCollectionCleanupTest, TestCorePropertiesReload, HdfsLockFactoryTest, ClusterStateUpdateTest, TestBinaryResponseWriter, SaslZkACLProviderTest, TestPolicyCloud, TestReRankQParserPlugin, WrapperMergePolicyFactoryTest, SignatureUpdateProcessorFactoryTest, DistributedVersionInfoTest, DistributedFacetPivotLongTailTest, MissingSegmentRecoveryTest, SolrSlf4jReporterTest, TestClusterProperties, ChaosMonkeySafeLeaderTest, TestFieldCacheVsDocValues, AddReplicaTest, QueryResultKeyTest, TestQuerySenderNoQuery, TestJmxIntegration, CoreMergeIndexesAdminHandlerTest, TestExpandComponent, TestXmlQParser, TestCursorMarkWithoutUniqueKey, RegexBoostProcessorTest, CloudExitableDirectoryReaderTest, BlockJoinFacetDistribTest, TestLocalFSCloudBackupRestore, AnalyticsQueryTest, OpenCloseCoreStressTest, BlockDirectoryTest, TestLargeCluster, ZkSolrClientTest, PrimUtilsTest, DeleteLastCustomShardedReplicaTest, IgnoreCommitOptimizeUpdateProcessorFactoryTest, BasicAuthIntegrationTest, SolrIndexSplitterTest, TestScoreJoinQPNoScore, TestRTGBase, AssignTest, CloudMLTQParserTest, TestAnalyzeInfixSuggestions, HealthCheckHandlerTest, HighlighterConfigTest, TestPullReplicaErrorHandling, StatsReloadRaceTest, TestDistribStateManager, TestFieldCacheReopen, TestPointFields, LukeRequestHandlerTest, SolrXmlInZkTest, DocumentAnalysisRequestHandlerTest, TestMacros, DebugComponentTest, TestCloudInspectUtil, ManagedSchemaRoundRobinCloudTest, TestRemoteStreaming, TestSQLHandlerNonCloud, TestQueryWrapperFilter, SynonymTokenizerTest, StressHdfsTest, MetricsConfigTest, LeaderFailoverAfterPartitionTest, MergeStrategyTest, OutputWriterTest, TestCloudPseudoReturnFields, TestSolrCloudSnapshots, ClassificationUpdateProcessorTest, TestSimpleTrackingShardHandler, OverseerModifyCollectionTest, ResponseHeaderTest, ConvertedLegacyTest, TestCryptoKeys, PingRequestHandlerTest, ConcurrentDeleteAndCreateCollectionTest, TestNRTOpen, TestAtomicUpdateErrorCases, TestMultiValuedNumericRangeQuery, TestNumericTerms32, TestFieldTypeCollectionResource, CachingDirectoryFactoryTest, TestShortCircuitedRequests, AutoscalingHistoryHandlerTest, TestExactSharedStatsCache, RestartWhileUpdatingTest, TestFreeTextSuggestions, NotRequiredUniqueKeyTest, SearchHandlerTest, TestFaceting, TestStressReorder, TestSolrCloudWithDelegationTokens, TestLegacyFieldReuse, TriggerIntegrationTest, TestSolr4Spatial, RegexBytesRefFilterTest, TestConfigSetsAPI, PropertiesRequestHandlerTest, BooleanFieldTest, SampleTest, TestManagedSynonymFilterFactory, DistributedSuggestComponentTest, TestImplicitCoreProperties, SchemaVersionSpecificBehaviorTest, BaseCdcrDistributedZkTest, CdcrReplicationDistributedZkTest, BasicDistributedZk2Test, CollectionsAPIDistributedZkTest, RecoveryZkTest, TestReplicationHandler, ZkCLITest, StatsComponentTest, SpellCheckComponentTest, QueryElevationComponentTest, BadIndexSchemaTest, TestSort, TestFiltering, BasicFunctionalityTest, TestLazyCores, DirectUpdateHandlerTest, ShowFileRequestHandlerTest, SimplePostToolTest, TestCoreDiscovery, AnalysisAfterCoreReloadTest, SpellCheckCollatorTest, SuggesterFSTTest, CoreAdminHandlerTest, PolyFieldTest, TestUpdate, TestWordDelimiterFilterFactory, DirectUpdateHandlerOptimizeTest, IndexBasedSpellCheckerTest, PrimitiveFieldTypeTest, FileBasedSpellCheckerTest, XmlUpdateRequestHandlerTest, RequestHandlersTest, DocumentBuilderTest, TestValueSourceCache, TestIndexingPerformance, RequiredFieldsTest, IndexSchemaRuntimeFieldTest, SolrPluginUtilsTest, ReturnFieldsTest, MBeansHandlerTest, MultiTermTest, TestDocSet, NumericFieldsTest, TestElisionMultitermQuery, DirectSolrConnectionTest, SpellPossibilityIteratorTest, TestXIncludeConfig, EchoParamsTest, TestDFRSimilarityFactory, TestPerFieldSimilarity, TestLMJelinekMercerSimilarityFactory, TestBM25SimilarityFactory, TimeZoneUtilsTest, OpenExchangeRatesOrgProviderTest, PreAnalyzedFieldTest, DateFieldTest, SliceStateTest, FileUtilsTest, DistributedIntervalFacetingTest, ConnectionReuseTest, AsyncCallRequestStatusResponseTest, ChaosMonkeyNothingIsSafeWithPullReplicasTest, ConfigSetsAPITest, ConnectionManagerTest, DeleteNodeTest, DeleteShardTest, DeleteStatusTest, DistribDocExpirationUpdateProcessorTest, DistributedQueueTest, LeaderInitiatedRecoveryOnShardRestartTest, LegacyCloudClusterPropTest, MoveReplicaHDFSFailoverTest, MoveReplicaTest, OutOfBoxZkACLAndCredentialsProvidersTest, OverseerCollectionConfigSetProcessorTest, OverseerRolesTest, OverseerTaskQueueTest, RecoveryAfterSoftCommitTest, SharedFSAutoReplicaFailoverTest, SolrCloudExampleTest, TestCloudDeleteByQuery, TestCloudJSONFacetJoinDomain, TestCloudPivotFacet, TestCloudSearcherWarming, TestCollectionAPI, TestCollectionsAPIViaSolrCloudCluster, TestLeaderElectionWithEmptyReplica] [junit4] Completed [559/765 (1!)] on J1 in 100.02s, 1 test, 1 error <<< FAILURES! [...truncated 800 lines...] [junit4] Suite: org.apache.solr.schema.TestCloudSchemaless [junit4] 2> 3215349 INFO (SUITE-TestCloudSchemaless-seed#[4A6ABB09D249B2AC]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom [junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.schema.TestCloudSchemaless_4A6ABB09D249B2AC-001/init-core-data-001 [junit4] 2> 3215349 WARN (SUITE-TestCloudSchemaless-seed#[4A6ABB09D249B2AC]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=23 numCloses=23 [junit4] 2> 3215350 INFO (SUITE-TestCloudSchemaless-seed#[4A6ABB09D249B2AC]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false [junit4] 2> 3215350 INFO (SUITE-TestCloudSchemaless-seed#[4A6ABB09D249B2AC]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl="https://issues.apache.org/jira/browse/SOLR-5776") [junit4] 2> 3215350 INFO (SUITE-TestCloudSchemaless-seed#[4A6ABB09D249B2AC]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /bix/ [junit4] 2> 3215352 INFO (TEST-TestCloudSchemaless.test-seed#[4A6ABB09D249B2AC]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 3215353 INFO (Thread-7447) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 3215353 INFO (Thread-7447) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 3215358 ERROR (Thread-7447) [ ] o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes [junit4] 2> 3215453 INFO (TEST-TestCloudSchemaless.test-seed#[4A6ABB09D249B2AC]) [ ] o.a.s.c.ZkTestServer start zk server on port:43529 [junit4] 2> 3215454 INFO (zkConnectionManagerCallback-5620-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 3215455 INFO (zkConnectionManagerCallback-5622-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 3215457 INFO (TEST-TestCloudSchemaless.test-seed#[4A6ABB09D249B2AC]) [ ] o.a.s.c.AbstractZkTestCase put /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf/solrconfig-schemaless.xml to /configs/conf1/solrconfig.xml [junit4] 2> 3215457 INFO (TEST-TestCloudSchemaless.test-seed#[4A6ABB09D249B2AC]) [ ] o.a.s.c.AbstractZkTestCase put /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf/schema-add-schema-fields-update-processor.xml to /configs/conf1/schema.xml [junit4] 2> 3215458 INFO (TEST-TestCloudSchemaless.test-seed#[4A6ABB09D249B2AC]) [ ] o.a.s.c.AbstractZkTestCase put /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml to /configs/conf1/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 3215458 INFO (TEST-TestCloudSchemaless.test-seed#[4A6ABB09D249B2AC]) [ ] o.a.s.c.AbstractZkTestCase put /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf/stopwords.txt to /configs/conf1/stopwords.txt [junit4] 2> 3215458 INFO (TEST-TestCloudSchemaless.test-seed#[4A6ABB09D249B2AC]) [ ] o.a.s.c.AbstractZkTestCase put /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf/protwords.txt to /configs/conf1/protwords.txt [junit4] 2> 3215459 INFO (TEST-TestCloudSchemaless.test-seed#[4A6ABB09D249B2AC]) [ ] o.a.s.c.AbstractZkTestCase put /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf/currency.xml to /configs/conf1/currency.xml [junit4] 2> 3215459 INFO (TEST-TestCloudSchemaless.test-seed#[4A6ABB09D249B2AC]) [ ] o.a.s.c.AbstractZkTestCase put /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml to /configs/conf1/enumsConfig.xml [junit4] 2> 3215459 INFO (TEST-TestCloudSchemaless.test-seed#[4A6ABB09D249B2AC]) [ ] o.a.s.c.AbstractZkTestCase put /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json to /configs/conf1/open-exchange-rates.json [junit4] 2> 3215460 INFO (TEST-TestCloudSchemaless.test-seed#[4A6ABB09D249B2AC]) [ ] o.a.s.c.AbstractZkTestCase put /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt [junit4] 2> 3215460 INFO (TEST-TestCloudSchemaless.test-seed#[4A6ABB09D249B2AC]) [ ] o.a.s.c.AbstractZkTestCase put /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt to /configs/conf1/old_synonyms.txt [junit4] 2> 3215460 INFO (TEST-TestCloudSchemaless.test-seed#[4A6ABB09D249B2AC]) [ ] o.a.s.c.AbstractZkTestCase put /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf/synonyms.txt to /configs/conf1/synonyms.txt [junit4] 2> 3215461 INFO (TEST-TestCloudSchemaless.test-seed#[4A6ABB09D249B2AC]) [ ] o.a.s.c.AbstractFullDistribZkTestBase Will use NRT replicas unless explicitly asked otherwise [junit4] 2> 3215535 INFO (TEST-TestCloudSchemaless.test-seed#[4A6ABB09D249B2AC]) [ ] o.e.j.s.Server jetty-9.3.20.v20170531 [junit4] 2> 3215537 INFO (TEST-TestCloudSchemaless.test-seed#[4A6ABB09D249B2AC]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@42e87429{/bix,null,AVAILABLE} [junit4] 2> 3215537 INFO (TEST-TestCloudSchemaless.test-seed#[4A6ABB09D249B2AC]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@8ecf2ca{HTTP/1.1,[http/1.1]}{127.0.0.1:34559} [junit4] 2> 3215537 INFO (TEST-TestCloudSchemaless.test-seed#[4A6ABB09D249B2AC]) [ ] o.e.j.s.Server Started @3217453ms [junit4] 2> 3215537 INFO (TEST-TestCloudSchemaless.test-seed#[ [...truncated too long message...] ava.base/java.lang.Thread.run(Thread.java:844) [junit4] > Caused by: java.net.SocketTimeoutException: Read timed out [junit4] > at java.base/java.net.SocketInputStream.socketRead0(Native Method) [junit4] > at java.base/java.net.SocketInputStream.socketRead(SocketInputStream.java:116) [junit4] > at java.base/java.net.SocketInputStream.read(SocketInputStream.java:171) [junit4] > at java.base/java.net.SocketInputStream.read(SocketInputStream.java:141) [junit4] > at org.apache.http.impl.io.SessionInputBufferImpl.streamRead(SessionInputBufferImpl.java:137) [junit4] > at org.apache.http.impl.io.SessionInputBufferImpl.fillBuffer(SessionInputBufferImpl.java:153) [junit4] > at org.apache.http.impl.io.SessionInputBufferImpl.readLine(SessionInputBufferImpl.java:282) [junit4] > at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:138) [junit4] > at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:56) [junit4] > at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:259) [junit4] > at org.apache.http.impl.DefaultBHttpClientConnection.receiveResponseHeader(DefaultBHttpClientConnection.java:163) [junit4] > at org.apache.http.impl.conn.CPoolProxy.receiveResponseHeader(CPoolProxy.java:165) [junit4] > at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:273) [junit4] > at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:125) [junit4] > at org.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:272) [junit4] > at org.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:185) [junit4] > at org.apache.http.impl.execchain.RetryExec.execute(RetryExec.java:89) [junit4] > at org.apache.http.impl.execchain.RedirectExec.execute(RedirectExec.java:111) [junit4] > at org.apache.http.impl.client.InternalHttpClient.doExecute(InternalHttpClient.java:185) [junit4] > at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:83) [junit4] > at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:56) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:542) [junit4] > ... 42 more [junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.schema.TestCloudSchemaless_4A6ABB09D249B2AC-001 [junit4] 2> Jan 03, 2018 12:58:53 AM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks [junit4] 2> WARNING: Will linger awaiting termination of 1 leaked thread(s). [junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {}, docValues:{}, maxPointsInLeafNode=1170, maxMBSortInHeap=5.994875124160612, sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@3ad643b1), locale=ln-CD, timezone=Australia/Perth [junit4] 2> NOTE: Linux 4.10.0-40-generic amd64/Oracle Corporation 10-ea (64-bit)/cpus=8,threads=1,free=338751824,total=536870912 [junit4] 2> NOTE: All tests run in this JVM: [SimpleCollectionCreateDeleteTest, TestFastLRUCache, AtomicUpdatesTest, TestUtilizeNode, TestSolrCloudWithHadoopAuthPlugin, DOMUtilTest, TestCollationField, TestLuceneMatchVersion, TestStressCloudBlindAtomicUpdates, SpellingQueryConverterTest, SuggesterTSTTest, SolrCmdDistributorTest, SOLR749Test, TestNumericTokenStream, RemoteQueryErrorTest, SolrMetricReporterTest, TestCoreBackup, CreateCollectionCleanupTest, TestCorePropertiesReload, HdfsLockFactoryTest, ClusterStateUpdateTest, TestBinaryResponseWriter, SaslZkACLProviderTest, TestPolicyCloud, TestReRankQParserPlugin, WrapperMergePolicyFactoryTest, SignatureUpdateProcessorFactoryTest, DistributedVersionInfoTest, DistributedFacetPivotLongTailTest, MissingSegmentRecoveryTest, SolrSlf4jReporterTest, TestClusterProperties, ChaosMonkeySafeLeaderTest, TestFieldCacheVsDocValues, AddReplicaTest, QueryResultKeyTest, TestQuerySenderNoQuery, TestJmxIntegration, CoreMergeIndexesAdminHandlerTest, TestExpandComponent, TestXmlQParser, TestCursorMarkWithoutUniqueKey, RegexBoostProcessorTest, CloudExitableDirectoryReaderTest, BlockJoinFacetDistribTest, TestLocalFSCloudBackupRestore, AnalyticsQueryTest, OpenCloseCoreStressTest, BlockDirectoryTest, TestLargeCluster, ZkSolrClientTest, PrimUtilsTest, DeleteLastCustomShardedReplicaTest, IgnoreCommitOptimizeUpdateProcessorFactoryTest, BasicAuthIntegrationTest, SolrIndexSplitterTest, TestScoreJoinQPNoScore, TestRTGBase, AssignTest, CloudMLTQParserTest, TestAnalyzeInfixSuggestions, HealthCheckHandlerTest, HighlighterConfigTest, TestPullReplicaErrorHandling, StatsReloadRaceTest, TestDistribStateManager, TestFieldCacheReopen, TestPointFields, LukeRequestHandlerTest, SolrXmlInZkTest, DocumentAnalysisRequestHandlerTest, TestMacros, DebugComponentTest, TestCloudInspectUtil, ManagedSchemaRoundRobinCloudTest, TestRemoteStreaming, TestSQLHandlerNonCloud, TestQueryWrapperFilter, SynonymTokenizerTest, StressHdfsTest, MetricsConfigTest, LeaderFailoverAfterPartitionTest, MergeStrategyTest, OutputWriterTest, TestCloudPseudoReturnFields, TestSolrCloudSnapshots, ClassificationUpdateProcessorTest, TestSimpleTrackingShardHandler, OverseerModifyCollectionTest, ResponseHeaderTest, ConvertedLegacyTest, TestCryptoKeys, PingRequestHandlerTest, ConcurrentDeleteAndCreateCollectionTest, TestNRTOpen, TestAtomicUpdateErrorCases, TestMultiValuedNumericRangeQuery, TestNumericTerms32, TestFieldTypeCollectionResource, CachingDirectoryFactoryTest, TestShortCircuitedRequests, AutoscalingHistoryHandlerTest, TestExactSharedStatsCache, RestartWhileUpdatingTest, TestFreeTextSuggestions, NotRequiredUniqueKeyTest, SearchHandlerTest, TestFaceting, TestStressReorder, TestSolrCloudWithDelegationTokens, TestLegacyFieldReuse, TriggerIntegrationTest, TestSolr4Spatial, RegexBytesRefFilterTest, TestConfigSetsAPI, PropertiesRequestHandlerTest, BooleanFieldTest, SampleTest, TestManagedSynonymFilterFactory, DistributedSuggestComponentTest, TestImplicitCoreProperties, SchemaVersionSpecificBehaviorTest, BaseCdcrDistributedZkTest, CdcrReplicationDistributedZkTest, BasicDistributedZk2Test, CollectionsAPIDistributedZkTest, RecoveryZkTest, TestReplicationHandler, ZkCLITest, StatsComponentTest, SpellCheckComponentTest, QueryElevationComponentTest, BadIndexSchemaTest, TestSort, TestFiltering, BasicFunctionalityTest, TestLazyCores, DirectUpdateHandlerTest, ShowFileRequestHandlerTest, SimplePostToolTest, TestCoreDiscovery, AnalysisAfterCoreReloadTest, SpellCheckCollatorTest, SuggesterFSTTest, CoreAdminHandlerTest, PolyFieldTest, TestUpdate, TestWordDelimiterFilterFactory, DirectUpdateHandlerOptimizeTest, IndexBasedSpellCheckerTest, PrimitiveFieldTypeTest, FileBasedSpellCheckerTest, XmlUpdateRequestHandlerTest, RequestHandlersTest, DocumentBuilderTest, TestValueSourceCache, TestIndexingPerformance, RequiredFieldsTest, IndexSchemaRuntimeFieldTest, SolrPluginUtilsTest, ReturnFieldsTest, MBeansHandlerTest, MultiTermTest, TestDocSet, NumericFieldsTest, TestElisionMultitermQuery, DirectSolrConnectionTest, SpellPossibilityIteratorTest, TestXIncludeConfig, EchoParamsTest, TestDFRSimilarityFactory, TestPerFieldSimilarity, TestLMJelinekMercerSimilarityFactory, TestBM25SimilarityFactory, TimeZoneUtilsTest, OpenExchangeRatesOrgProviderTest, PreAnalyzedFieldTest, DateFieldTest, SliceStateTest, FileUtilsTest, DistributedIntervalFacetingTest, ConnectionReuseTest, AsyncCallRequestStatusResponseTest, ChaosMonkeyNothingIsSafeWithPullReplicasTest, ConfigSetsAPITest, ConnectionManagerTest, DeleteNodeTest, DeleteShardTest, DeleteStatusTest, DistribDocExpirationUpdateProcessorTest, DistributedQueueTest, LeaderInitiatedRecoveryOnShardRestartTest, LegacyCloudClusterPropTest, MoveReplicaHDFSFailoverTest, MoveReplicaTest, OutOfBoxZkACLAndCredentialsProvidersTest, OverseerCollectionConfigSetProcessorTest, OverseerRolesTest, OverseerTaskQueueTest, RecoveryAfterSoftCommitTest, SharedFSAutoReplicaFailoverTest, SolrCloudExampleTest, TestCloudDeleteByQuery, TestCloudJSONFacetJoinDomain, TestCloudPivotFacet, TestCloudSearcherWarming, TestCollectionAPI, TestCollectionsAPIViaSolrCloudCluster, TestLeaderElectionWithEmptyReplica, TestRandomFlRTGCloud, TestRequestForwarding, TestRequestStatusCollectionAPI, TestSizeLimitedDistributedMap, TestSkipOverseerOperations, TestStressInPlaceUpdates, TestTolerantUpdateProcessorRandomCloud, VMParamsZkACLAndCredentialsProvidersTest, AutoAddReplicasPlanActionTest, ExecutePlanActionTest, MetricTriggerTest, NodeAddedTriggerTest, NodeLostTriggerTest, SystemLogListenerTest, TestPolicyCloud, HdfsBasicDistributedZkTest, HdfsChaosMonkeyNothingIsSafeTest, HdfsChaosMonkeySafeLeaderTest, HdfsCollectionsAPIDistributedZkTest, HdfsNNFailoverTest, HdfsTlogReplayBufferedWhileIndexingTest, HdfsWriteToMultipleCollectionsTest, TestClusterStateMutator, ZkStateReaderTest, CoreSorterTest, DirectoryFactoryTest, ExitableDirectoryReaderTest, TestConfigOverlay, TestConfigSetImmutable, TestConfigSets, TestInfoStreamLogging, TestSimpleTextCodec, TestSolrXml, TestBlobHandler, TestSystemCollAutoCreate, TestNumericRangeQuery32, JvmMetricsTest, SolrCoreMetricManagerTest, SolrMetricsIntegrationTest, SolrGangliaReporterTest, SolrGraphiteReporterTest, SolrCloudReportersTest, TestStreamBody, JSONWriterTest, TestCustomDocTransformer, TestExportWriter, TestGeoJSONResponseWriter, TestPushWriter, TestRawResponseWriter, TestRawTransformer, TestRetrieveFieldsOptimizer, TestSubQueryTransformer, TestManagedResource, TestBulkSchemaAPI, TestSchemaResource, TestSerializedLuceneMatchVersion, ChangedSchemaMergeTest, DateRangeFieldTest, EnumFieldTest, SpatialRPTFieldTypeTest, TestCloudSchemaless] [junit4] Completed [765/765 (2!)] on J1 in 631.55s, 1 test, 1 error <<< FAILURES! [...truncated 40780 lines...]
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org