You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2019/04/10 04:12:22 UTC
[JENKINS] Lucene-Solr-Tests-master - Build # 3257 - Unstable
Build: https://builds.apache.org/job/Lucene-Solr-Tests-master/3257/
1 tests failed.
FAILED: org.apache.solr.client.solrj.request.TestV2Request.testCloudSolrClient
Error Message:
Error from server at https://127.0.0.1:41874/solr: 4 out of 5 the property overlay to be of version 0 within 30 seconds! Failed cores: [https://127.0.0.1:41874/solr/test_shard2_replica_n4/, https://127.0.0.1:43986/solr/test_shard2_replica_n6/, https://127.0.0.1:41239/solr/test_shard1_replica_n1/, https://127.0.0.1:42595/solr/test_shard1_replica_n2/]
Stack Trace:
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteExecutionException: Error from server at https://127.0.0.1:41874/solr: 4 out of 5 the property overlay to be of version 0 within 30 seconds! Failed cores: [https://127.0.0.1:41874/solr/test_shard2_replica_n4/, https://127.0.0.1:43986/solr/test_shard2_replica_n6/, https://127.0.0.1:41239/solr/test_shard1_replica_n1/, https://127.0.0.1:42595/solr/test_shard1_replica_n2/]
at __randomizedtesting.SeedInfo.seed([1BA199CBA29ED70B:8257127B072D5F60]:0)
at org.apache.solr.client.solrj.impl.BaseHttpSolrClient$RemoteExecutionException.create(BaseHttpSolrClient.java:65)
at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:626)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:255)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:244)
at org.apache.solr.client.solrj.impl.LBSolrClient.doRequest(LBSolrClient.java:368)
at org.apache.solr.client.solrj.impl.LBSolrClient.request(LBSolrClient.java:296)
at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.sendRequest(BaseCloudSolrClient.java:1055)
at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.requestWithRetryOnStaleState(BaseCloudSolrClient.java:830)
at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.request(BaseCloudSolrClient.java:763)
at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1274)
at org.apache.solr.client.solrj.request.TestV2Request.assertSuccess(TestV2Request.java:55)
at org.apache.solr.client.solrj.request.TestV2Request.doTest(TestV2Request.java:102)
at org.apache.solr.client.solrj.request.TestV2Request.testCloudSolrClient(TestV2Request.java:83)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
Build Log:
[...truncated 16207 lines...]
[junit4] Suite: org.apache.solr.client.solrj.request.TestV2Request
[junit4] 2> Creating dataDir: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.request.TestV2Request_1BA199CBA29ED70B-001/init-core-data-001
[junit4] 2> 90103 INFO (SUITE-TestV2Request-seed#[1BA199CBA29ED70B]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 90153 INFO (SUITE-TestV2Request-seed#[1BA199CBA29ED70B]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
[junit4] 2> 90154 INFO (SUITE-TestV2Request-seed#[1BA199CBA29ED70B]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 90227 INFO (TEST-TestV2Request.testCloudSolrClient-seed#[1BA199CBA29ED70B]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testCloudSolrClient
[junit4] 2> 90227 INFO (TEST-TestV2Request.testCloudSolrClient-seed#[1BA199CBA29ED70B]) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.request.TestV2Request_1BA199CBA29ED70B-001/tempDir-001
[junit4] 2> 90228 INFO (TEST-TestV2Request.testCloudSolrClient-seed#[1BA199CBA29ED70B]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 90243 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 90243 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 90351 INFO (TEST-TestV2Request.testCloudSolrClient-seed#[1BA199CBA29ED70B]) [ ] o.a.s.c.ZkTestServer start zk server on port:33739
[junit4] 2> 90352 INFO (TEST-TestV2Request.testCloudSolrClient-seed#[1BA199CBA29ED70B]) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:33739
[junit4] 2> 90352 INFO (TEST-TestV2Request.testCloudSolrClient-seed#[1BA199CBA29ED70B]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 33739
[junit4] 2> 90461 INFO (zkConnectionManagerCallback-217-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 90611 INFO (zkConnectionManagerCallback-219-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 90667 INFO (zkConnectionManagerCallback-221-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 90738 WARN (jetty-launcher-222-thread-1) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 90738 INFO (jetty-launcher-222-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
[junit4] 2> 90738 INFO (jetty-launcher-222-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 90738 INFO (jetty-launcher-222-thread-1) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_191-b12
[junit4] 2> 90740 WARN (jetty-launcher-222-thread-2) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 90740 INFO (jetty-launcher-222-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
[junit4] 2> 90740 INFO (jetty-launcher-222-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 90740 INFO (jetty-launcher-222-thread-2) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_191-b12
[junit4] 2> 90759 WARN (jetty-launcher-222-thread-3) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 90759 INFO (jetty-launcher-222-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
[junit4] 2> 90759 INFO (jetty-launcher-222-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 90759 INFO (jetty-launcher-222-thread-3) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_191-b12
[junit4] 2> 90775 WARN (jetty-launcher-222-thread-4) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 90775 INFO (jetty-launcher-222-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
[junit4] 2> 90775 INFO (jetty-launcher-222-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 90775 INFO (jetty-launcher-222-thread-4) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_191-b12
[junit4] 2> 90850 INFO (jetty-launcher-222-thread-4) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 90850 INFO (jetty-launcher-222-thread-4) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 90850 INFO (jetty-launcher-222-thread-4) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 90851 INFO (jetty-launcher-222-thread-4) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@4107b7d8{/solr,null,AVAILABLE}
[junit4] 2> 90854 WARN (jetty-launcher-222-thread-4) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@3604cfcc[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 90942 INFO (jetty-launcher-222-thread-3) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 90942 INFO (jetty-launcher-222-thread-3) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 90942 INFO (jetty-launcher-222-thread-3) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 90988 INFO (jetty-launcher-222-thread-2) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 90988 INFO (jetty-launcher-222-thread-2) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 90988 INFO (jetty-launcher-222-thread-2) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 90996 INFO (jetty-launcher-222-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@78344980{/solr,null,AVAILABLE}
[junit4] 2> 90997 WARN (jetty-launcher-222-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@44e94217[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 91061 INFO (jetty-launcher-222-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 91061 INFO (jetty-launcher-222-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 91061 INFO (jetty-launcher-222-thread-1) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 91063 INFO (jetty-launcher-222-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@5838467d{/solr,null,AVAILABLE}
[junit4] 2> 91064 WARN (jetty-launcher-222-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@40a72a72[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 91101 INFO (jetty-launcher-222-thread-3) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@37f66692{/solr,null,AVAILABLE}
[junit4] 2> 91102 WARN (jetty-launcher-222-thread-3) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@23d638ea[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 91215 INFO (jetty-launcher-222-thread-4) [ ] o.e.j.s.AbstractConnector Started ServerConnector@7c9681c7{SSL,[ssl, http/1.1]}{127.0.0.1:43986}
[junit4] 2> 91215 INFO (jetty-launcher-222-thread-4) [ ] o.e.j.s.Server Started @91382ms
[junit4] 2> 91215 INFO (jetty-launcher-222-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=43986}
[junit4] 2> 91216 ERROR (jetty-launcher-222-thread-4) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 91216 INFO (jetty-launcher-222-thread-4) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 91216 INFO (jetty-launcher-222-thread-4) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 9.0.0
[junit4] 2> 91216 INFO (jetty-launcher-222-thread-4) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 91216 INFO (jetty-launcher-222-thread-4) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 91216 INFO (jetty-launcher-222-thread-4) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-04-10T03:21:04.093Z
[junit4] 2> 91316 INFO (jetty-launcher-222-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@5023a2c1{SSL,[ssl, http/1.1]}{127.0.0.1:41239}
[junit4] 2> 91316 INFO (jetty-launcher-222-thread-1) [ ] o.e.j.s.Server Started @91482ms
[junit4] 2> 91316 INFO (jetty-launcher-222-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=41239}
[junit4] 2> 91317 ERROR (jetty-launcher-222-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 91317 INFO (jetty-launcher-222-thread-1) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 91317 INFO (jetty-launcher-222-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 9.0.0
[junit4] 2> 91317 INFO (jetty-launcher-222-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 91317 INFO (jetty-launcher-222-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 91317 INFO (jetty-launcher-222-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-04-10T03:21:04.194Z
[junit4] 2> 91318 INFO (jetty-launcher-222-thread-3) [ ] o.e.j.s.AbstractConnector Started ServerConnector@3518c3c{SSL,[ssl, http/1.1]}{127.0.0.1:42595}
[junit4] 2> 91318 INFO (jetty-launcher-222-thread-3) [ ] o.e.j.s.Server Started @91485ms
[junit4] 2> 91318 INFO (jetty-launcher-222-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=42595}
[junit4] 2> 91319 ERROR (jetty-launcher-222-thread-3) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 91319 INFO (jetty-launcher-222-thread-3) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 91319 INFO (jetty-launcher-222-thread-3) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 9.0.0
[junit4] 2> 91319 INFO (jetty-launcher-222-thread-3) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 91319 INFO (jetty-launcher-222-thread-3) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 91319 INFO (jetty-launcher-222-thread-3) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-04-10T03:21:04.196Z
[junit4] 2> 91353 INFO (jetty-launcher-222-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@72495490{SSL,[ssl, http/1.1]}{127.0.0.1:41874}
[junit4] 2> 91353 INFO (jetty-launcher-222-thread-2) [ ] o.e.j.s.Server Started @91519ms
[junit4] 2> 91353 INFO (jetty-launcher-222-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=41874}
[junit4] 2> 91353 ERROR (jetty-launcher-222-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 91353 INFO (jetty-launcher-222-thread-2) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 91353 INFO (jetty-launcher-222-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 9.0.0
[junit4] 2> 91353 INFO (jetty-launcher-222-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 91353 INFO (jetty-launcher-222-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 91353 INFO (jetty-launcher-222-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-04-10T03:21:04.230Z
[junit4] 2> 91413 INFO (zkConnectionManagerCallback-226-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 91433 INFO (zkConnectionManagerCallback-224-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 91450 INFO (jetty-launcher-222-thread-4) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 91466 INFO (zkConnectionManagerCallback-228-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 91478 INFO (zkConnectionManagerCallback-230-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 91631 INFO (jetty-launcher-222-thread-3) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 91631 INFO (jetty-launcher-222-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 91669 INFO (jetty-launcher-222-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 91689 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 0x108a985e9fa0003, likely client has closed socket
[junit4] 2> 93428 INFO (jetty-launcher-222-thread-2) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 93429 WARN (jetty-launcher-222-thread-2) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 93536 WARN (jetty-launcher-222-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@405da606[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 93569 WARN (jetty-launcher-222-thread-2) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 93626 WARN (jetty-launcher-222-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@f8a55b2[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 93627 INFO (jetty-launcher-222-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:33739/solr
[junit4] 2> 93628 INFO (jetty-launcher-222-thread-4) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 93714 WARN (jetty-launcher-222-thread-4) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 93744 WARN (jetty-launcher-222-thread-4) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@7b3fd26a[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 93771 INFO (zkConnectionManagerCallback-240-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 93821 INFO (jetty-launcher-222-thread-3) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 93822 WARN (jetty-launcher-222-thread-3) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 93836 WARN (jetty-launcher-222-thread-4) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 94063 WARN (jetty-launcher-222-thread-4) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@3b840817[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 94064 INFO (jetty-launcher-222-thread-4) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:33739/solr
[junit4] 2> 94064 INFO (zkConnectionManagerCallback-246-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 94173 WARN (jetty-launcher-222-thread-3) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@136fa734[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 94209 INFO (zkConnectionManagerCallback-249-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 94213 WARN (jetty-launcher-222-thread-3) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 94338 WARN (jetty-launcher-222-thread-3) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@35544dd6[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 94339 INFO (jetty-launcher-222-thread-3) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:33739/solr
[junit4] 2> 94557 INFO (zkConnectionManagerCallback-256-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 94557 INFO (zkConnectionManagerCallback-254-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 94644 WARN (jetty-launcher-222-thread-4) [n:127.0.0.1:43986_solr ] o.a.s.c.ZkController The _default configset could not be uploaded. Please provide 'solr.default.confdir' parameter that points to a configset intended to be the default. Current 'solr.default.confdir' value: null
[junit4] 2> 94732 WARN (jetty-launcher-222-thread-2) [n:127.0.0.1:41874_solr ] o.a.s.c.ZkController The _default configset could not be uploaded. Please provide 'solr.default.confdir' parameter that points to a configset intended to be the default. Current 'solr.default.confdir' value: null
[junit4] 2> 94942 INFO (zkConnectionManagerCallback-262-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 95082 INFO (jetty-launcher-222-thread-4) [n:127.0.0.1:43986_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:43986_solr
[junit4] 2> 95083 INFO (jetty-launcher-222-thread-4) [n:127.0.0.1:43986_solr ] o.a.s.c.Overseer Overseer (id=74495786472833035-127.0.0.1:43986_solr-n_0000000000) starting
[junit4] 2> 95098 INFO (jetty-launcher-222-thread-2) [n:127.0.0.1:41874_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:41874_solr
[junit4] 2> 95136 INFO (zkCallback-255-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 95169 INFO (zkCallback-245-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 95259 WARN (jetty-launcher-222-thread-3) [n:127.0.0.1:42595_solr ] o.a.s.c.ZkController The _default configset could not be uploaded. Please provide 'solr.default.confdir' parameter that points to a configset intended to be the default. Current 'solr.default.confdir' value: null
[junit4] 2> 95323 INFO (zkConnectionManagerCallback-269-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 95412 INFO (jetty-launcher-222-thread-3) [n:127.0.0.1:42595_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 95414 INFO (jetty-launcher-222-thread-4) [n:127.0.0.1:43986_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 95449 INFO (jetty-launcher-222-thread-4) [n:127.0.0.1:43986_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:33739/solr ready
[junit4] 2> 95590 INFO (OverseerStateUpdate-74495786472833035-127.0.0.1:43986_solr-n_0000000000) [n:127.0.0.1:43986_solr ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:43986_solr
[junit4] 2> 95607 INFO (jetty-launcher-222-thread-4) [n:127.0.0.1:43986_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:43986_solr as DOWN
[junit4] 2> 95643 INFO (zkConnectionManagerCallback-274-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 95714 INFO (jetty-launcher-222-thread-3) [n:127.0.0.1:42595_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:42595_solr as DOWN
[junit4] 2> 95715 INFO (jetty-launcher-222-thread-2) [n:127.0.0.1:41874_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 95732 INFO (jetty-launcher-222-thread-4) [n:127.0.0.1:43986_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 95732 INFO (jetty-launcher-222-thread-4) [n:127.0.0.1:43986_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:43986_solr
[junit4] 2> 95735 INFO (jetty-launcher-222-thread-2) [n:127.0.0.1:41874_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:33739/solr ready
[junit4] 2> 95749 INFO (jetty-launcher-222-thread-2) [n:127.0.0.1:41874_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 95769 INFO (jetty-launcher-222-thread-3) [n:127.0.0.1:42595_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 95769 INFO (jetty-launcher-222-thread-3) [n:127.0.0.1:42595_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:42595_solr
[junit4] 2> 95773 INFO (zkCallback-268-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 95777 INFO (zkCallback-245-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 95786 INFO (zkCallback-261-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 95813 INFO (zkCallback-255-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (3)
[junit4] 2> 95821 INFO (zkCallback-273-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (3)
[junit4] 2> 95822 INFO (zkCallback-245-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 95827 INFO (zkCallback-268-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 95858 INFO (zkCallback-261-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 95875 INFO (jetty-launcher-222-thread-4) [n:127.0.0.1:43986_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 96077 INFO (jetty-launcher-222-thread-2) [n:127.0.0.1:41874_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_41874.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@bed109
[junit4] 2> 96351 INFO (jetty-launcher-222-thread-2) [n:127.0.0.1:41874_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_41874.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@bed109
[junit4] 2> 96352 INFO (jetty-launcher-222-thread-2) [n:127.0.0.1:41874_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_41874.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@bed109
[junit4] 2> 96377 INFO (jetty-launcher-222-thread-4) [n:127.0.0.1:43986_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_43986.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@bed109
[junit4] 2> 96393 INFO (zkConnectionManagerCallback-281-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 96503 INFO (jetty-launcher-222-thread-2) [n:127.0.0.1:41874_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.request.TestV2Request_1BA199CBA29ED70B-001/tempDir-001/node2/.
[junit4] 2> 96555 INFO (jetty-launcher-222-thread-3) [n:127.0.0.1:42595_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
[junit4] 2> 96567 INFO (jetty-launcher-222-thread-4) [n:127.0.0.1:43986_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_43986.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@bed109
[junit4] 2> 96567 INFO (jetty-launcher-222-thread-4) [n:127.0.0.1:43986_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_43986.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@bed109
[junit4] 2> 96568 INFO (jetty-launcher-222-thread-4) [n:127.0.0.1:43986_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.request.TestV2Request_1BA199CBA29ED70B-001/tempDir-001/node4/.
[junit4] 2> 96628 INFO (jetty-launcher-222-thread-3) [n:127.0.0.1:42595_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:33739/solr ready
[junit4] 2> 96648 INFO (jetty-launcher-222-thread-3) [n:127.0.0.1:42595_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 96797 INFO (jetty-launcher-222-thread-3) [n:127.0.0.1:42595_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_42595.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@bed109
[junit4] 2> 96867 INFO (jetty-launcher-222-thread-3) [n:127.0.0.1:42595_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_42595.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@bed109
[junit4] 2> 96979 INFO (jetty-launcher-222-thread-3) [n:127.0.0.1:42595_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_42595.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@bed109
[junit4] 2> 96980 INFO (jetty-launcher-222-thread-3) [n:127.0.0.1:42595_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.request.TestV2Request_1BA199CBA29ED70B-001/tempDir-001/node3/.
[junit4] 2> 97658 INFO (jetty-launcher-222-thread-1) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 97659 WARN (jetty-launcher-222-thread-1) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 97949 WARN (jetty-launcher-222-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@1ea55fd1[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 98019 WARN (jetty-launcher-222-thread-1) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 98148 WARN (jetty-launcher-222-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@618a671c[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 98149 INFO (jetty-launcher-222-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:33739/solr
[junit4] 2> 98293 INFO (zkConnectionManagerCallback-288-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 98419 INFO (zkConnectionManagerCallback-290-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 98472 WARN (jetty-launcher-222-thread-1) [n:127.0.0.1:41239_solr ] o.a.s.c.ZkController The _default configset could not be uploaded. Please provide 'solr.default.confdir' parameter that points to a configset intended to be the default. Current 'solr.default.confdir' value: null
[junit4] 2> 98473 INFO (jetty-launcher-222-thread-1) [n:127.0.0.1:41239_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
[junit4] 2> 98490 INFO (jetty-launcher-222-thread-1) [n:127.0.0.1:41239_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:41239_solr as DOWN
[junit4] 2> 98491 INFO (jetty-launcher-222-thread-1) [n:127.0.0.1:41239_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 98491 INFO (jetty-launcher-222-thread-1) [n:127.0.0.1:41239_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:41239_solr
[junit4] 2> 98510 INFO (zkCallback-268-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 98516 INFO (zkCallback-261-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 98533 INFO (zkCallback-255-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 98546 INFO (zkCallback-273-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 98548 INFO (zkCallback-245-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 98561 INFO (zkCallback-280-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 98617 INFO (zkCallback-289-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 98800 INFO (zkConnectionManagerCallback-297-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 98801 INFO (jetty-launcher-222-thread-1) [n:127.0.0.1:41239_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 98803 INFO (jetty-launcher-222-thread-1) [n:127.0.0.1:41239_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:33739/solr ready
[junit4] 2> 98803 INFO (jetty-launcher-222-thread-1) [n:127.0.0.1:41239_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 98912 INFO (jetty-launcher-222-thread-1) [n:127.0.0.1:41239_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_41239.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@bed109
[junit4] 2> 98998 INFO (jetty-launcher-222-thread-1) [n:127.0.0.1:41239_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_41239.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@bed109
[junit4] 2> 98999 INFO (jetty-launcher-222-thread-1) [n:127.0.0.1:41239_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_41239.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@bed109
[junit4] 2> 99000 INFO (jetty-launcher-222-thread-1) [n:127.0.0.1:41239_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.request.TestV2Request_1BA199CBA29ED70B-001/tempDir-001/node1/.
[junit4] 2> 99679 INFO (zkConnectionManagerCallback-303-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 99700 INFO (TEST-TestV2Request.testCloudSolrClient-seed#[1BA199CBA29ED70B]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 99701 INFO (TEST-TestV2Request.testCloudSolrClient-seed#[1BA199CBA29ED70B]) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:33739/solr ready
[junit4] 2> 100246 INFO (OverseerThreadFactory-162-thread-1-processing-n:127.0.0.1:43986_solr) [n:127.0.0.1:43986_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection test
[junit4] 2> 100495 INFO (OverseerStateUpdate-74495786472833035-127.0.0.1:43986_solr-n_0000000000) [n:127.0.0.1:43986_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"test",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"test_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:41239/solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 100511 INFO (OverseerStateUpdate-74495786472833035-127.0.0.1:43986_solr-n_0000000000) [n:127.0.0.1:43986_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"test",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"test_shard1_replica_n2",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:42595/solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 100529 INFO (OverseerStateUpdate-74495786472833035-127.0.0.1:43986_solr-n_0000000000) [n:127.0.0.1:43986_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"test",
[junit4] 2> "shard":"shard2",
[junit4] 2> "core":"test_shard2_replica_n4",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:41874/solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 100566 INFO (OverseerStateUpdate-74495786472833035-127.0.0.1:43986_solr-n_0000000000) [n:127.0.0.1:43986_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"test",
[junit4] 2> "shard":"shard2",
[junit4] 2> "core":"test_shard2_replica_n6",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:43986/solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 101232 INFO (qtp1623443225-529) [n:127.0.0.1:43986_solr x:test_shard2_replica_n6] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node8&collection.configName=config&newCollection=true&name=test_shard2_replica_n6&action=CREATE&numShards=2&collection=test&shard=shard2&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 101251 INFO (qtp55865245-552) [n:127.0.0.1:41874_solr x:test_shard2_replica_n4] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node7&collection.configName=config&newCollection=true&name=test_shard2_replica_n4&action=CREATE&numShards=2&collection=test&shard=shard2&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 101251 INFO (qtp55865245-552) [n:127.0.0.1:41874_solr x:test_shard2_replica_n4] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 101309 INFO (qtp636469283-543) [n:127.0.0.1:42595_solr x:test_shard1_replica_n2] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node5&collection.configName=config&newCollection=true&name=test_shard1_replica_n2&action=CREATE&numShards=2&collection=test&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 101506 INFO (qtp1933728738-561) [n:127.0.0.1:41239_solr x:test_shard1_replica_n1] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node3&collection.configName=config&newCollection=true&name=test_shard1_replica_n1&action=CREATE&numShards=2&collection=test&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 102627 INFO (qtp1623443225-529) [n:127.0.0.1:43986_solr c:test s:shard2 r:core_node8 x:test_shard2_replica_n6] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0
[junit4] 2> 102747 INFO (qtp55865245-552) [n:127.0.0.1:41874_solr c:test s:shard2 r:core_node7 x:test_shard2_replica_n4] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0
[junit4] 2> 102762 INFO (qtp636469283-543) [n:127.0.0.1:42595_solr c:test s:shard1 r:core_node5 x:test_shard1_replica_n2] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0
[junit4] 2> 115396 INFO (qtp1933728738-561) [n:127.0.0.1:41239_solr c:test s:shard1 r:core_node3 x:test_shard1_replica_n1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0
[junit4] 2> 115406 INFO (qtp55865245-552) [n:127.0.0.1:41874_solr c:test s:shard2 r:core_node7 x:test_shard2_replica_n4] o.a.s.s.IndexSchema [test_shard2_replica_n4] Schema name=test
[junit4] 2> 115426 INFO (qtp1623443225-529) [n:127.0.0.1:43986_solr c:test s:shard2 r:core_node8 x:test_shard2_replica_n6] o.a.s.s.IndexSchema [test_shard2_replica_n6] Schema name=test
[junit4] 2> 115470 INFO (qtp636469283-543) [n:127.0.0.1:42595_solr c:test s:shard1 r:core_node5 x:test_shard1_replica_n2] o.a.s.s.IndexSchema [test_shard1_replica_n2] Schema name=test
[junit4] 2> 115523 INFO (qtp1933728738-561) [n:127.0.0.1:41239_solr c:test s:shard1 r:core_node3 x:test_shard1_replica_n1] o.a.s.s.IndexSchema [test_shard1_replica_n1] Schema name=test
[junit4] 2> 116398 WARN (qtp636469283-543) [n:127.0.0.1:42595_solr c:test s:shard1 r:core_node5 x:test_shard1_replica_n2] o.a.s.s.IndexSchema Field lowerfilt1and2 is not multivalued and destination for multiple copyFields (2)
[junit4] 2> 116759 WARN (qtp636469283-543) [n:127.0.0.1:42595_solr c:test s:shard1 r:core_node5 x:test_shard1_replica_n2] o.a.s.s.IndexSchema Field text is not multivalued and destination for multiple copyFields (3)
[junit4] 2> 116760 INFO (qtp636469283-543) [n:127.0.0.1:42595_solr c:test s:shard1 r:core_node5 x:test_shard1_replica_n2] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 116760 INFO (qtp636469283-543) [n:127.0.0.1:42595_solr c:test s:shard1 r:core_node5 x:test_shard1_replica_n2] o.a.s.c.CoreContainer Creating SolrCore 'test_shard1_replica_n2' using configuration from collection test, trusted=true
[junit4] 2> 116761 INFO (qtp636469283-543) [n:127.0.0.1:42595_solr c:test s:shard1 r:core_node5 x:test_shard1_replica_n2] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_42595.solr.core.test.shard1.replica_n2' (registry 'solr.core.test.shard1.replica_n2') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@bed109
[junit4] 2> 116761 INFO (qtp636469283-543) [n:127.0.0.1:42595_solr c:test s:shard1 r:core_node5 x:test_shard1_replica_n2] o.a.s.c.SolrCore [[test_shard1_replica_n2] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.request.TestV2Request_1BA199CBA29ED70B-001/tempDir-001/node3/test_shard1_replica_n2], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.request.TestV2Request_1BA199CBA29ED70B-001/tempDir-001/node3/./test_shard1_replica_n2/data/]
[junit4] 2> 116779 WARN (qtp1623443225-529) [n:127.0.0.1:43986_solr c:test s:shard2 r:core_node8 x:test_shard2_replica_n6] o.a.s.s.IndexSchema Field lowerfilt1and2 is not multivalued and destination for multiple copyFields (2)
[junit4] 2> 116779 WARN (qtp1623443225-529) [n:127.0.0.1:43986_solr c:test s:shard2 r:core_node8 x:test_shard2_replica_n6] o.a.s.s.IndexSchema Field text is not multivalued and destination for multiple copyFields (3)
[junit4] 2> 116780 INFO (qtp1623443225-529) [n:127.0.0.1:43986_solr c:test s:shard2 r:core_node8 x:test_shard2_replica_n6] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 116815 INFO (qtp1623443225-529) [n:127.0.0.1:43986_solr c:test s:shard2 r:core_node8 x:test_shard2_replica_n6] o.a.s.c.CoreContainer Creating SolrCore 'test_shard2_replica_n6' using configuration from collection test, trusted=true
[junit4] 2> 116815 INFO (qtp1623443225-529) [n:127.0.0.1:43986_solr c:test s:shard2 r:core_node8 x:test_shard2_replica_n6] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_43986.solr.core.test.shard2.replica_n6' (registry 'solr.core.test.shard2.replica_n6') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@bed109
[junit4] 2> 116816 INFO (qtp1623443225-529) [n:127.0.0.1:43986_solr c:test s:shard2 r:core_node8 x:test_shard2_replica_n6] o.a.s.c.SolrCore [[test_shard2_replica_n6] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.request.TestV2Request_1BA199CBA29ED70B-001/tempDir-001/node4/test_shard2_replica_n6], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.request.TestV2Request_1BA199CBA29ED70B-001/tempDir-001/node4/./test_shard2_replica_n6/data/]
[junit4] 2> 116888 WARN (qtp55865245-552) [n:127.0.0.1:41874_solr c:test s:shard2 r:core_node7 x:test_shard2_replica_n4] o.a.s.s.IndexSchema Field lowerfilt1and2 is not multivalued and destination for multiple copyFields (2)
[junit4] 2> 116888 WARN (qtp55865245-552) [n:127.0.0.1:41874_solr c:test s:shard2 r:core_node7 x:test_shard2_replica_n4] o.a.s.s.IndexSchema Field text is not multivalued and destination for multiple copyFields (3)
[junit4] 2> 116888 INFO (qtp55865245-552) [n:127.0.0.1:41874_solr c:test s:shard2 r:core_node7 x:test_shard2_replica_n4] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 116888 INFO (qtp55865245-552) [n:127.0.0.1:41874_solr c:test s:shard2 r:core_node7 x:test_shard2_replica_n4] o.a.s.c.CoreContainer Creating SolrCore 'test_shard2_replica_n4' using configuration from collection test, trusted=true
[junit4] 2> 116889 WARN (qtp1933728738-561) [n:127.0.0.1:41239_solr c:test s:shard1 r:core_node3 x:test_shard1_replica_n1] o.a.s.s.IndexSchema Field lowerfilt1and2 is not multivalued and destination for multiple copyFields (2)
[junit4] 2> 116889 WARN (qtp1933728738-561) [n:127.0.0.1:41239_solr c:test s:shard1 r:core_node3 x:test_shard1_replica_n1] o.a.s.s.IndexSchema Field text is not multivalued and destination for multiple copyFields (3)
[junit4] 2> 116901 INFO (qtp55865245-552) [n:127.0.0.1:41874_solr c:test s:shard2 r:core_node7 x:test_shard2_replica_n4] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_41874.solr.core.test.shard2.replica_n4' (registry 'solr.core.test.shard2.replica_n4') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@bed109
[junit4] 2> 116902 INFO (qtp55865245-552) [n:127.0.0.1:41874_solr c:test s:shard2 r:core_node7 x:test_shard2_replica_n4] o.a.s.c.SolrCore [[test_shard2_replica_n4] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.request.TestV2Request_1BA199CBA29ED70B-001/tempDir-001/node2/test_shard2_replica_n4], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.request.TestV2Request_1BA199CBA29ED70B-001/tempDir-001/node2/./test_shard2_replica_n4/data/]
[junit4] 2> 116923 INFO (qtp1933728738-561) [n:127.0.0.1:41239_solr c:test s:shard1 r:core_node3 x:test_shard1_replica_n1] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 116923 INFO (qtp1933728738-561) [n:127.0.0.1:41239_solr c:test s:shard1 r:core_node3 x:test_shard1_replica_n1] o.a.s.c.CoreContainer Creating SolrCore 'test_shard1_replica_n1' using configuration from collection test, trusted=true
[junit4] 2> 117031 INFO (qtp1933728738-561) [n:127.0.0.1:41239_solr c:test s:shard1 r:core_node3 x:test_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_41239.solr.core.test.shard1.replica_n1' (registry 'solr.core.test.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@bed109
[junit4] 2> 117031 INFO (qtp1933728738-561) [n:127.0.0.1:41239_solr c:test s:shard1 r:core_node3 x:test_shard1_replica_n1] o.a.s.c.SolrCore [[test_shard1_replica_n1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.request.TestV2Request_1BA199CBA29ED70B-001/tempDir-001/node1/test_shard1_replica_n1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.request.TestV2Request_1BA199CBA29ED70B-001/tempDir-001/node1/./test_shard1_replica_n1/data/]
[junit4] 2> 117659 INFO (qtp636469283-543) [n:127.0.0.1:42595_solr c:test s:shard1 r:core_node5 x:test_shard1_replica_n2] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 117659 INFO (qtp636469283-543) [n:127.0.0.1:42595_solr c:test s:shard1 r:core_node5 x:test_shard1_replica_n2] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 117661 INFO (qtp636469283-543) [n:127.0.0.1:42595_solr c:test s:shard1 r:core_node5 x:test_shard1_replica_n2] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 117661 INFO (qtp636469283-543) [n:127.0.0.1:42595_solr c:test s:shard1 r:core_node5 x:test_shard1_replica_n2] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 117712 INFO (qtp636469283-543) [n:127.0.0.1:42595_solr c:test s:shard1 r:core_node5 x:test_shard1_replica_n2] o.a.s.s.SolrIndexSearcher Opening [Searcher@23af0a32[test_shard1_replica_n2] main]
[junit4] 2> 117720 INFO (qtp1933728738-561) [n:127.0.0.1:41239_solr c:test s:shard1 r:core_node3 x:test_shard1_replica_n1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 117720 INFO (qtp1933728738-561) [n:127.0.0.1:41239_solr c:test s:shard1 r:core_node3 x:test_shard1_replica_n1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 117723 INFO (qtp1933728738-561) [n:127.0.0.1:41239_solr c:test s:shard1 r:core_node3 x:test_shard1_replica_n1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 117723 INFO (qtp1933728738-561) [n:127.0.0.1:41239_solr c:test s:shard1 r:core_node3 x:test_shard1_replica_n1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 117740 INFO (qtp1623443225-529) [n:127.0.0.1:43986_solr c:test s:shard2 r:core_node8 x:test_shard2_replica_n6] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 117740 INFO (qtp1623443225-529) [n:127.0.0.1:43986_solr c:test s:shard2 r:core_node8 x:test_shard2_replica_n6] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 117743 INFO (qtp1623443225-529) [n:127.0.0.1:43986_solr c:test s:shard2 r:core_node8 x:test_shard2_replica_n6] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 117743 INFO (qtp1623443225-529) [n:127.0.0.1:43986_solr c:test s:shard2 r:core_node8 x:test_shard2_replica_n6] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 117748 INFO (qtp636469283-543) [n:127.0.0.1:42595_solr c:test s:shard1 r:core_node5 x:test_shard1_replica_n2] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/config
[junit4] 2> 117749 INFO (qtp636469283-543) [n:127.0.0.1:42595_solr c:test s:shard1 r:core_node5 x:test_shard1_replica_n2] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/config
[junit4] 2> 117749 INFO (qtp636469283-543) [n:127.0.0.1:42595_solr c:test s:shard1 r:core_node5 x:test_shard1_replica_n2] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 117749 INFO (qtp636469283-543) [n:127.0.0.1:42595_solr c:test s:shard1 r:core_node5 x:test_shard1_replica_n2] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1630395685274648576
[junit4] 2> 117785 INFO (qtp55865245-552) [n:127.0.0.1:41874_solr c:test s:shard2 r:core_node7 x:test_shard2_replica_n4] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 117785 INFO (qtp55865245-552) [n:127.0.0.1:41874_solr c:test s:shard2 r:core_node7 x:test_shard2_replica_n4] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 117787 INFO (qtp55865245-552) [n:127.0.0.1:41874_solr c:test s:shard2 r:core_node7 x:test_shard2_replica_n4] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 117787 INFO (qtp55865245-552) [n:127.0.0.1:41874_solr c:test s:shard2 r:core_node7 x:test_shard2_replica_n4] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 117926 INFO (qtp55865245-552) [n:127.0.0.1:41874_solr c:test s:shard2 r:core_node7 x:test_shard2_replica_n4] o.a.s.s.SolrIndexSearcher Opening [Searcher@70b7f70b[test_shard2_replica_n4] main]
[junit4] 2> 117960 INFO (qtp1623443225-529) [n:127.0.0.1:43986_solr c:test s:shard2 r:core_node8 x:test_shard2_replica_n6] o.a.s.s.SolrIndexSearcher Opening [Searcher@244d17cf[test_shard2_replica_n6] main]
[junit4] 2> 117960 INFO (qtp1933728738-561) [n:127.0.0.1:41239_solr c:test s:shard1 r:core_node3 x:test_shard1_replica_n1] o.a.s.s.SolrIndexSearcher Opening [Searcher@120c4445[test_shard1_replica_n1] main]
[junit4] 2> 117961 INFO (qtp1933728738-561) [n:127.0.0.1:41239_solr c:test s:shard1 r:core_node3 x:test_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/config
[junit4] 2> 117962 INFO (qtp1933728738-561) [n:127.0.0.1:41239_solr c:test s:shard1 r:core_node3 x:test_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/config
[junit4] 2> 117962 INFO (qtp1933728738-561) [n:127.0.0.1:41239_solr c:test s:shard1 r:core_node3 x:test_shard1_replica_n1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 117963 INFO (qtp1933728738-561) [n:127.0.0.1:41239_solr c:test s:shard1 r:core_node3 x:test_shard1_replica_n1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1630395685499043840
[junit4] 2> 117968 INFO (qtp1623443225-529) [n:127.0.0.1:43986_solr c:test s:shard2 r:core_node8 x:test_shard2_replica_n6] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/config
[junit4] 2> 117968 INFO (qtp1623443225-529) [n:127.0.0.1:43986_solr c:test s:shard2 r:core_node8 x:test_shard2_replica_n6] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/config
[junit4] 2> 117968 INFO (qtp1623443225-529) [n:127.0.0.1:43986_solr c:test s:shard2 r:core_node8 x:test_shard2_replica_n6] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 117969 INFO (qtp1623443225-529) [n:127.0.0.1:43986_solr c:test s:shard2 r:core_node8 x:test_shard2_replica_n6] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1630395685505335296
[junit4] 2> 118203 INFO (searcherExecutor-182-thread-1-processing-n:127.0.0.1:43986_solr x:test_shard2_replica_n6 c:test s:shard2 r:core_node8) [n:127.0.0.1:43986_solr c:test s:shard2 r:core_node8 x:test_shard2_replica_n6] o.a.s.c.SolrCore [test_shard2_replica_n6] Registered new searcher Searcher@244d17cf[test_shard2_replica_n6] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 118202 INFO (searcherExecutor-181-thread-1-processing-n:127.0.0.1:42595_solr x:test_shard1_replica_n2 c:test s:shard1 r:core_node5) [n:127.0.0.1:42595_solr c:test s:shard1 r:core_node5 x:test_shard1_replica_n2] o.a.s.c.SolrCore [test_shard1_replica_n2] Registered new searcher Searcher@23af0a32[test_shard1_replica_n2] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 118277 INFO (qtp1623443225-529) [n:127.0.0.1:43986_solr c:test s:shard2 r:core_node8 x:test_shard2_replica_n6] o.a.s.c.ZkShardTerms Successful update of terms at /collections/test/terms/shard2 to Terms{values={core_node8=0}, version=0}
[junit4] 2> 118277 INFO (qtp1623443225-529) [n:127.0.0.1:43986_solr c:test s:shard2 r:core_node8 x:test_shard2_replica_n6] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/test/leaders/shard2
[junit4] 2> 118407 INFO (qtp636469283-543) [n:127.0.0.1:42595_solr c:test s:shard1 r:core_node5 x:test_shard1_replica_n2] o.a.s.c.ZkShardTerms Successful update of terms at /collections/test/terms/shard1 to Terms{values={core_node5=0}, version=0}
[junit4] 2> 118407 INFO (qtp636469283-543) [n:127.0.0.1:42595_solr c:test s:shard1 r:core_node5 x:test_shard1_replica_n2] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/test/leaders/shard1
[junit4] 2> 118442 INFO (searcherExecutor-184-thread-1-processing-n:127.0.0.1:41239_solr x:test_shard1_replica_n1 c:test s:shard1 r:core_node3) [n:127.0.0.1:41239_solr c:test s:shard1 r:core_node3 x:test_shard1_replica_n1] o.a.s.c.SolrCore [test_shard1_replica_n1] Registered new searcher Searcher@120c4445[test_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 118459 INFO (qtp636469283-543) [n:127.0.0.1:42595_solr c:test s:shard1 r:core_node5 x:test_shard1_replica_n2] o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for shard shard1: total=2 found=1 timeoutin=9965ms
[junit4] 2> 118479 INFO (qtp1623443225-529) [n:127.0.0.1:43986_solr c:test s:shard2 r:core_node8 x:test_shard2_replica_n6] o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for shard shard2: total=2 found=1 timeoutin=9999ms
[junit4] 2> 118552 INFO (qtp1933728738-561) [n:127.0.0.1:41239_solr c:test s:shard1 r:core_node3 x:test_shard1_replica_n1] o.a.s.c.ZkShardTerms Successful update of terms at /collections/test/terms/shard1 to Terms{values={core_node3=0, core_node5=0}, version=1}
[junit4] 2> 118552 INFO (qtp1933728738-561) [n:127.0.0.1:41239_solr c:test s:shard1 r:core_node3 x:test_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/test/leaders/shard1
[junit4] 2> 118595 INFO (qtp55865245-552) [n:127.0.0.1:41874_solr c:test s:shard2 r:core_node7 x:test_shard2_replica_n4] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/config
[junit4] 2> 118595 INFO (qtp55865245-552) [n:127.0.0.1:41874_solr c:test s:shard2 r:core_node7 x:test_shard2_replica_n4] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/config
[junit4] 2> 118596 INFO (qtp55865245-552) [n:127.0.0.1:41874_solr c:test s:shard2 r:core_node7 x:test_shard2_replica_n4] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 118596 INFO (qtp55865245-552) [n:127.0.0.1:41874_solr c:test s:shard2 r:core_node7 x:test_shard2_replica_n4] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1630395686162792448
[junit4] 2> 118632 INFO (searcherExecutor-183-thread-1-processing-n:127.0.0.1:41874_solr x:test_shard2_replica_n4 c:test s:shard2 r:core_node7) [n:127.0.0.1:41874_solr c:test s:shard2 r:core_node7 x:test_shard2_replica_n4] o.a.s.c.SolrCore [test_shard2_replica_n4] Registered new searcher Searcher@70b7f70b[test_shard2_replica_n4] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 118690 INFO (qtp55865245-552) [n:127.0.0.1:41874_solr c:test s:shard2 r:core_node7 x:test_shard2_replica_n4] o.a.s.c.ZkShardTerms Successful update of terms at /collections/test/terms/shard2 to Terms{values={core_node7=0, core_node8=0}, version=1}
[junit4] 2> 118691 INFO (qtp55865245-552) [n:127.0.0.1:41874_solr c:test s:shard2 r:core_node7 x:test_shard2_replica_n4] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/test/leaders/shard2
[junit4] 2> 118960 INFO (qtp636469283-543) [n:127.0.0.1:42595_solr c:test s:shard1 r:core_node5 x:test_shard1_replica_n2] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 118961 INFO (qtp636469283-543) [n:127.0.0.1:42595_solr c:test s:shard1 r:core_node5 x:test_shard1_replica_n2] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 118961 INFO (qtp636469283-543) [n:127.0.0.1:42595_solr c:test s:shard1 r:core_node5 x:test_shard1_replica_n2] o.a.s.c.SyncStrategy Sync replicas to https://127.0.0.1:42595/solr/test_shard1_replica_n2/
[junit4] 2> 118982 INFO (qtp1623443225-529) [n:127.0.0.1:43986_solr c:test s:shard2 r:core_node8 x:test_shard2_replica_n6] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 118982 INFO (qtp1623443225-529) [n:127.0.0.1:43986_solr c:test s:shard2 r:core_node8 x:test_shard2_replica_n6] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 118982 INFO (qtp1623443225-529) [n:127.0.0.1:43986_solr c:test s:shard2 r:core_node8 x:test_shard2_replica_n6] o.a.s.c.SyncStrategy Sync replicas to https://127.0.0.1:43986/solr/test_shard2_replica_n6/
[junit4] 2> 119034 INFO (qtp636469283-543) [n:127.0.0.1:42595_solr c:test s:shard1 r:core_node5 x:test_shard1_replica_n2] o.a.s.u.PeerSync PeerSync: core=test_shard1_replica_n2 url=https://127.0.0.1:42595/solr START replicas=[https://127.0.0.1:41239/solr/test_shard1_replica_n1/] nUpdates=100
[junit4] 2> 119035 INFO (qtp1623443225-529) [n:127.0.0.1:43986_solr c:test s:shard2 r:core_node8 x:test_shard2_replica_n6] o.a.s.u.PeerSync PeerSync: core=test_shard2_replica_n6 url=https://127.0.0.1:43986/solr START replicas=[https://127.0.0.1:41874/solr/test_shard2_replica_n4/] nUpdates=100
[junit4] 2> 119089 INFO (qtp636469283-543) [n:127.0.0.1:42595_solr c:test s:shard1 r:core_node5 x:test_shard1_replica_n2] o.a.s.u.PeerSync PeerSync: core=test_shard1_replica_n2 url=https://127.0.0.1:42595/solr DONE. We have no versions. sync failed.
[junit4] 2> 119105 INFO (qtp1623443225-529) [n:127.0.0.1:43986_solr c:test s:shard2 r:core_node8 x:test_shard2_replica_n6] o.a.s.u.PeerSync PeerSync: core=test_shard2_replica_n6 url=https://127.0.0.1:43986/solr DONE. We have no versions. sync failed.
[junit4] 2> 119291 INFO (qtp55865245-550) [n:127.0.0.1:41874_solr c:test s:shard2 r:core_node7 x:test_shard2_replica_n4] o.a.s.c.S.Request [test_shard2_replica_n4] webapp=/solr path=/get params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2} status=0 QTime=1
[junit4] 2> 119328 INFO (qtp1623443225-529) [n:127.0.0.1:43986_solr c:test s:shard2 r:core_node8 x:test_shard2_replica_n6] o.a.s.c.SyncStrategy Leader's attempt to sync with shard failed, moving to the next candidate
[junit4] 2> 119328 INFO (qtp1623443225-529) [n:127.0.0.1:43986_solr c:test s:shard2 r:core_node8 x:test_shard2_replica_n6] o.a.s.c.ShardLeaderElectionContext We failed sync, but we have no versions - we can't sync in that case - we were active before, so become leader anyway
[junit4] 2> 119345 INFO (qtp1623443225-529) [n:127.0.0.1:43986_solr c:test s:shard2 r:core_node8 x:test_shard2_replica_n6] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/test/leaders/shard2/leader after winning as /collections/test/leader_elect/shard2/election/74495786472833035-core_node8-n_0000000000
[junit4] 2> 119387 INFO (qtp1933728738-559) [n:127.0.0.1:41239_solr c:test s:shard1 r:core_node3 x:test_shard1_replica_n1] o.a.s.c.S.Request [test_shard1_replica_n1] webapp=/solr path=/get params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2} status=0 QTime=95
[junit4] 2> 119388 INFO (qtp636469283-543) [n:127.0.0.1:42595_solr c:test s:shard1 r:core_node5 x:test_shard1_replica_n2] o.a.s.c.SyncStrategy Leader's attempt to sync with shard failed, moving to the next candidate
[junit4] 2> 119388 INFO (qtp636469283-543) [n:127.0.0.1:42595_solr c:test s:shard1 r:core_node5 x:test_shard1_replica_n2] o.a.s.c.ShardLeaderElectionContext We failed sync, but we have no versions - we can't sync in that case - we were active before, so become leader anyway
[junit4] 2> 119388 INFO (qtp636469283-543) [n:127.0.0.1:42595_solr c:test s:shard1 r:core_node5 x:test_shard1_replica_n2] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/test/leaders/shard1/leader after winning as /collections/test/leader_elect/shard1/election/74495786472833036-core_node5-n_0000000000
[junit4] 2> 119442 INFO (qtp1623443225-529) [n:127.0.0.1:43986_solr c:test s:shard2 r:core_node8 x:test_shard2_replica_n6] o.a.s.c.ShardLeaderElectionContext I am the new leader: https://127.0.0.1:43986/solr/test_shard2_replica_n6/ shard2
[junit4] 2> 119481 INFO (qtp636469283-543) [n:127.0.0.1:42595_solr c:test s:shard1 r:core_node5 x:test_shard1_replica_n2] o.a.s.c.ShardLeaderElectionContext I am the new leader: https://127.0.0.1:42595/solr/test_shard1_replica_n2/ shard1
[junit4] 2> 119625 INFO (zkCallback-261-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/test/state.json] for collection [test] has occurred - updating... (live nodes size: [4])
[junit4] 2> 119625 INFO (zkCallback-289-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/test/state.json] for collection [test] has occurred - updating... (live nodes size: [4])
[junit4] 2> 119626 INFO (zkCallback-255-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/test/state.json] for collection [test] has occurred - updating... (live nodes size: [4])
[junit4] 2> 119627 INFO (qtp636469283-543) [n:127.0.0.1:42595_solr c:test s:shard1 r:core_node5 x:test_shard1_replica_n2] o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 119627 INFO (qtp1623443225-529) [n:127.0.0.1:43986_solr c:test s:shard2 r:core_node8 x:test_shard2_replica_n6] o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 119642 INFO (qtp636469283-543) [n:127.0.0.1:42595_solr c:test s:shard1 r:core_node5 x:test_shard1_replica_n2] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node5&collection.configName=config&newCollection=true&name=test_shard1_replica_n2&action=CREATE&numShards=2&collection=test&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=18333
[junit4] 2> 119714 INFO (qtp1933728738-561) [n:127.0.0.1:41239_solr c:test s:shard1 r:core_node3 x:test_shard1_replica_n1] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node3&collection.configName=config&newCollection=true&name=test_shard1_replica_n1&action=CREATE&numShards=2&collection=test&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=18208
[junit4] 2> 119726 INFO (qtp1623443225-529) [n:127.0.0.1:43986_solr c:test s:shard2 r:core_node8 x:test_shard2_replica_n6] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node8&collection.configName=config&newCollection=true&name=test_shard2_replica_n6&action=CREATE&numShards=2&collection=test&shard=shard2&wt=javabin&version=2&replicaType=NRT} status=0 QTime=18494
[junit4] 2> 119893 INFO (qtp55865245-552) [n:127.0.0.1:41874_solr c:test s:shard2 r:core_node7 x:test_shard2_replica_n4] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node7&collection.configName=config&newCollection=true&name=test_shard2_replica_n4&action=CREATE&numShards=2&collection=test&shard=shard2&wt=javabin&version=2&replicaType=NRT} status=0 QTime=18642
[junit4] 2> 120119 INFO (qtp1623443225-535) [n:127.0.0.1:43986_solr ] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 45 seconds. Check all shard replicas
[junit4] 2> 120159 INFO (zkCallback-255-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/test/state.json] for collection [test] has occurred - updating... (live nodes size: [4])
[junit4] 2> 120159 INFO (zkCallback-255-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/test/state.json] for collection [test] has occurred - updating... (live nodes size: [4])
[junit4] 2> 120159 INFO (zkCallback-289-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/test/state.json] for collection [test] has occurred - updating... (live nodes size: [4])
[junit4] 2> 120159 INFO (zkCallback-289-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/test/state.json] for collection [test] has occurred - updating... (live nodes size: [4])
[junit4] 2> 120159 INFO (zkCallback-261-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/test/state.json] for collection [test] has occurred - updating... (live nodes size: [4])
[junit4] 2> 120159 INFO (zkCallback-261-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/test/state.json] for collection [test] has occurred - updating... (live nodes size: [4])
[junit4] 2> 120163 INFO (zkCallback-245-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/test/state.json] for collection [test] has occurred - updating... (live nodes size: [4])
[junit4] 2> 120163 INFO (zkCallback-245-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/test/state.json] for collection [test] has occurred - updating... (live nodes size: [4])
[junit4] 2> 120176 INFO (qtp1623443225-535) [n:127.0.0.1:43986_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/collections params={wt=javabin&version=2} status=0 QTime=20032
[junit4] 2> 120334 INFO (qtp636469283-541) [n:127.0.0.1:42595_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/c params={wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 121310 ERROR (qtp1933728738-558) [n:127.0.0.1:41239_solr ] o.a.s.a.V2HttpCall >> path: '/c/_introspect'
[junit4] 2> 121312 INFO (qtp1933728738-558) [n:127.0.0.1:41239_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/c/_introspect params={wt=javabin&version=2} status=0 QTime=59
[junit4] 2> 121530 INFO (OverseerCollectionConfigSetProcessor-74495786472833035-127.0.0.1:43986_solr-n_0000000000) [n:127.0.0.1:43986_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> 121697 INFO (qtp55865245-549) [n:127.0.0.1:41874_solr c:test s:shard2 r:core_node7 x:test_shard2_replica_n4] o.a.s.h.SolrConfigHandler Executed config commands successfully and persisted to ZK [{"create-requesthandler":{
[junit4] 2> "name":"/x688720793",
[junit4] 2> "class":"org.apache.solr.handler.DumpRequestHandler",
[junit4] 2> "startup":"lazy"}}]
[junit4] 2> 121727 INFO (Thread-122) [ ] o.a.s.c.SolrCore config update listener called for core test_shard1_replica_n1
[junit4] 2> 121731 INFO (qtp55865245-549) [n:127.0.0.1:41874_solr c:test s:shard2 r:core_node7 x:test_shard2_replica_n4] o.a.s.h.SolrConfigHandler Waiting up to 30 secs for 4 replicas to set the property overlay to be of version 0 for collection test
[junit4] 2> 121783 INFO (Thread-122) [ ] o.a.s.c.SolrCore core reload test_shard1_replica_n1
[junit4] 2> 121805 INFO (Thread-125) [ ] o.a.s.c.SolrCore config update listener called for core test_shard2_replica_n6
[junit4] 2> 121824 INFO (Thread-124) [ ] o.a.s.c.SolrCore config update listener called for core test_shard1_replica_n2
[junit4] 2> 121825 INFO (Thread-124) [ ] o.a.s.c.SolrCore core reload test_shard1_replica_n2
[junit4] 2> 121840 INFO (Thread-125) [ ] o.a.s.c.SolrCore core reload test_shard2_replica_n6
[junit4] 2> 121877 INFO (Thread-123) [ ] o.a.s.c.SolrCore config update listener called for core test_shard2_replica_n4
[junit4] 2> 121898 INFO (Thread-123) [ ] o.a.s.c.SolrCore core reload test_shard2_replica_n4
[junit4] 2> 121914 INFO (solrHandlerExecutor-201-thread-4-processing-n:127.0.0.1:41874_solr x:test_shard2_replica_n4 c:test s:shard2 r:core_node7) [n:127.0.0.1:41874_solr c:test s:shard2 r:core_node7 x:test_shard2_replica_n4] o.a.s.h.SolrConfigHandler Time elapsed : 0 secs, maxWait 30
[junit4] 2> 121929 INFO (solrHandlerExecutor-201-thread-3-processing-n:127.0.0.1:41874_solr x:test_shard2_replica_n4 c:test s:shard2 r:core_node7) [n:127.0.0.1:41874_solr c:test s:shard2 r:core_node7 x:test_shard2_replica_n4] o.a.s.h.SolrConfigHandler Time elapsed : 0 secs, maxWait 30
[junit4] 2> 121936 INFO (Thread-124) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0
[junit4] 2> 121946 INFO (solrHandlerExecutor-201-thread-2-processing-n:127.0.0.1:41874_solr x:test_shard2_replica_n4 c:test s:shard2 r:core_node7) [n:127.0.0.1:41874_solr c:test s:shard2 r:core_node7 x:test_shard2_replica_n4] o.a.s.h.SolrConfigHandler Time elapsed : 0 secs, maxWait 30
[junit4] 2> 121946 INFO (solrHandlerExecutor-201-thread-1-processing-n:127.0.0.1:41874_solr x:test_shard2_replica_n4 c:test s:shard2 r:core_node7) [n:127.0.0.1:41874_solr c:test s:shard2 r:core_node7 x:test_shard2_replica_n4] o.a.s.h.SolrConfigHandler Time elapsed : 0 secs, maxWait 30
[junit4] 2> 122037 INFO (Thread-123) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0
[junit4] 2> 122163 INFO (Thread-125) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0
[junit4] 2> 122255 INFO (Thread-124) [ ] o.a.s.s.IndexSchema [test_shard1_replica_n2] Schema name=test
[junit4] 2> 122366 INFO (Thread-123) [ ] o.a.s.s.IndexSchema [test_shard2_replica_n4] Schema name=test
[junit4] 2> 122549 INFO (Thread-125) [ ] o.a.s.s.IndexSchema [test_shard2_replica_n6] Schema name=test
[junit4] 2> 149640 WARN (jetty-launcher-222-thread-2-SendThread(lucene2-us-west.apache.org:33739)) [ ] o.a.z.ClientCnxn Client session timed out, have not heard from server in 34262ms for sessionid 0x108a985e9fa000e
[junit4] 2> 149640 WARN (jetty-launcher-222-thread-4-SendThread(lucene2-us-west.apache.org:33739)) [ ] o.a.z.ClientCnxn Client session timed out, have not heard from server in 33808ms for sessionid 0x108a985e9fa000d
[junit4] 2> 149641 WARN (jetty-launcher-222-thread-1-SendThread(lucene2-us-west.apache.org:33739)) [ ] o.a.z.ClientCnxn Client session timed out, have not heard from server in 34280ms for sessionid 0x108a985e9fa0012
[junit4] 2> 149641 WARN (TEST-TestV2Request.testCloudSolrClient-seed#[1BA199CBA29ED70B]-SendThread(lucene2-us-west.apache.org:33739)) [ ] o.a.z.ClientCnxn Client session timed out, have not heard from server in 34319ms for sessionid 0x108a985e9fa0000
[junit4] 2> 149641 WARN (TEST-TestV2Request.testCloudSolrClient-seed#[1BA199CBA29ED70B]-SendThread(lucene2-us-west.apache.org:33739)) [ ] o.a.z.ClientCnxn Client session timed out, have not heard from server in 34319ms for sessionid 0x108a985e9fa0001
[junit4] 2> 149641 WARN (jetty-launcher-222-thread-3-SendThread(lucene2-us-west.apache.org:33739)) [ ] o.a.z.ClientCnxn Client session timed out, have not heard from server in 34309ms for sessionid 0x108a985e9fa000f
[junit4] 2> 149642 WARN (TEST-TestV2Request.testCloudSolrClient-seed#[1BA199CBA29ED70B]-SendThread(lucene2-us-west.apache.org:33739)) [ ] o.a.z.ClientCnxn Client session timed out, have not heard from server in 34320ms for sessionid 0x108a985e9fa0013
[junit4] 2> 149649 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 0x108a985e9fa000e, likely client has closed socket
[junit4] 2> 149649 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 0x108a985e9fa0000, likely client has closed socket
[junit4] 2> 149649 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 0x108a985e9fa0001, likely client has closed socket
[junit4] 2> 149650 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 0x108a985e9fa0012, likely client has closed socket
[junit4] 2> 149650 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 0x108a985e9fa000d, likely client has closed socket
[junit4] 2> 149650 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 0x108a985e9fa000f, likely client has closed socket
[junit4] 2> 149650 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 0x108a985e9fa0013, likely client has closed socket
[junit4] 2> 149724 INFO (Thread-122) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0
[junit4] 2> 149884 WARN (zkConnectionManagerCallback-274-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@734c62d3 name: ZooKeeperConnection Watcher:127.0.0.1:33739/solr got event WatchedEvent state:Disconnected type:None path:null path: null type: None
[junit4] 2> 149885 WARN (zkConnectionManagerCallback-274-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has disconnected
[junit4] 2> 149896 WARN (zkConnectionManagerCallback-219-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@84de343 name: ZooKeeperConnection Watcher:127.0.0.1:33739/solr got event WatchedEvent state:Disconnected type:None path:null path: null type: None
[junit4] 2> 149896 WARN (zkConnectionManagerCallback-217-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@64070b5b name: ZooKeeperConnection Watcher:127.0.0.1:33739 got event WatchedEvent state:Disconnected type:None path:null path: null type: None
[junit4] 2> 149896 WARN (zkConnectionManagerCallback-219-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has disconnected
[junit4] 2> 149896 WARN (zkConnectionManagerCallback-217-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has disconnected
[junit4] 2> 149897 WARN (zkConnectionManagerCallback-303-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@56d8fbb0 name: ZooKeeperConnection Watcher:127.0.0.1:33739/solr got event WatchedEvent state:Disconnected type:None path:null path: null type: None
[junit4] 2> 149897 WARN (zkConnectionManagerCallback-303-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has disconnected
[junit4] 2> 149898 WARN (zkConnectionManagerCallback-281-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@35b6484f name: ZooKeeperConnection Watcher:127.0.0.1:33739/solr got event WatchedEvent state:Disconnected type:None path:null path: null type: None
[junit4] 2> 149898 WARN (zkConnectionManagerCallback-281-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has disconnected
[junit4] 2> 149970 INFO (qtp1623443225-533) [n:127.0.0.1:43986_solr c:test s:shard2 r:core_node8 x:test_shard2_replica_n6] o.a.s.h.SolrConfigHandler expecting overlay version 0 but my version is -1
[junit4] 2> 149970 INFO (qtp636469283-544) [n:127.0.0.1:42595_solr c:test s:shard1 r:core_node5 x:test_shard1_replica_n2] o.a.s.h.SolrConfigHandler expecting overlay version 0 but my version is -1
[junit4] 2> 149970 INFO (qtp55865245-551) [n:127.0.0.1:41874_solr c:test s:shard2 r:core_node7 x:test_shard2_replica_n4] o.a.s.h.SolrConfigHandler expecting overlay version 0 but my version is -1
[junit4] 2> 149989 WARN (zkConnectionManagerCallback-269-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@632aa504 name: ZooKeeperConnection Watcher:127.0.0.1:33739/solr got event WatchedEvent state:Disconnected type:None path:null path: null type: None
[junit4] 2> 149989 WARN (zkConnectionManagerCallback-269-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has disconnected
[junit4] 2> 150062 INFO (qtp55865245-551) [n:127.0.0.1:41874_solr c:test s:shard2 r:core_node7 x:test_shard2_replica_n4] o.a.s.c.S.Request [test_shard2_replica_n4] webapp=/solr path=/config/znodeVersion params={overlay=0&wt=javabin&version=2} status=0 QTime=272
[junit4] 2> 150224 INFO (SolrConfigHandler-refreshconf) [ ] o.a.s.h.SolrConfigHandler Another reload is in progress . Not doing anything
[junit4] 2> 150224 WARN (zkConnectionManagerCallback-297-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@3c87e1c4 name: ZooKeeperConnection Watcher:127.0.0.1:33739/solr got event WatchedEvent state:Disconnected type:None path:null path: null type: None
[junit4] 2> 150244 WARN (zkConnectionManagerCallback-297-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has disconnected
[junit4] 2> 150224 INFO (SolrConfigHandler-refreshconf) [ ] o.a.s.h.SolrConfigHandler Another reload is in progress . Not doing anything
[junit4] 2> 150209 INFO (qtp1933728738-560) [n:127.0.0.1:41239_solr c:test s:shard1 r:core_node3 x:test_shard1_replica_n1] o.a.s.h.SolrConfigHandler expecting overlay version 0 but my version is -1
[junit4] 2> 150209 INFO (qtp1623443225-533) [n:127.0.0.1:43986_solr c:test s:shard2 r:core_node8 x:test_shard2_replica_n6] o.a.s.c.S.Request [test_shard2_replica_n6] webapp=/solr path=/config/znodeVersion params={overlay=0&wt=javabin&version=2} status=0 QTime=420
[junit4] 2> 150208 INFO (SolrConfigHandler-refreshconf) [ ] o.a.s.h.SolrConfigHandler Another reload is in progress . Not doing anything
[junit4] 2> 150261 INFO (qtp1933728738-560) [n:127.0.0.1:41239_solr c:test s:shard1 r:core_node3 x:test_shard1_replica_n1] o.a.s.c.S.Request [test_shard1_replica_n1] webapp=/solr path=/config/znodeVersion params={overlay=0&wt=javabin&version=2} status=0 QTime=328
[junit4] 2> 150078 INFO (qtp636469283-544) [n:127.0.0.1:42595_solr c:test s:shard1 r:core_node5 x:test_shard1_replica_n2] o.a.s.c.S.Request [test_shard1_replica_n2] webapp=/solr path=/config/znodeVersion params={overlay=0&wt=javabin&version=2} status=0 QTime=289
[junit4] 2> 150282 INFO (solrHandlerExecutor-201-thread-4-processing-n:127.0.0.1:41874_solr x:test_shard2_replica_n4 c:test s:shard2 r:core_node7) [n:127.0.0.1:41874_solr c:test s:shard2 r:core_node7 x:test_shard2_replica_n4] o.a.s.h.SolrConfigHandler Could not get expectedVersion 0 from https://127.0.0.1:42595/solr/test_shard1_replica_n2/ for prop overlay after 1 attempts
[junit4] 2> 150282 INFO (solrHandlerExecutor-201-thread-3-processing-n:127.0.0.1:41874_solr x:test_shard2_replica_n4 c:test s:shard2 r:core_node7) [n:127.0.0.1:41874_solr c:test s:shard2 r:core_node7 x:test_shard2_replica_n4] o.a.s.h.SolrConfigHandler Could not get expectedVersion 0 from https://127.0.0.1:41239/solr/test_shard1_replica_n1/ for prop overlay after 1 attempts
[junit4] 2> 150282 INFO (solrHandlerExecutor-201-thread-4-processing-n:127.0.0.1:41874_solr x:test_shard2_replica_n4 c:test s:shard2 r:core_node7) [n:127.0.0.1:41874_solr c:test s:shard2 r:core_node7 x:test_shard2_replica_n4] o.a.s.h.SolrConfigHandler Time elapsed : 28 secs, maxWait 30
[junit4] 2> 150282 INFO (solrHandlerExecutor-201-thread-3-processing-n:127.0.0.1:41874_solr x:test_shard2_replica_n4 c:test s:shard2 r:core_node7) [n:127.0.0.1:41874_solr c:test s:shard2 r:core_node7 x:test_shard2_replica_n4] o.a.s.h.SolrConfigHandler Time elapsed : 28 secs, maxWait 30
[junit4] 2> 150248 INFO (solrHandlerExecutor-201-thread-1-processing-n:127.0.0.1:41874_solr x:test_shard2_replica_n4 c:test s:shard2 r:core_node7) [n:127.0.0.1:41874_solr c:test s:shard2 r:core_node7 x:test_shard2_replica_n4] o.a.s.h.SolrConfigHandler Could not get expectedVersion 0 from https://127.0.0.1:41874/solr/test_shard2_replica_n4/ for prop overlay after 1 attempts
[junit4] 2> 150285 INFO (solrHandlerExecutor-201-thread-1-processing-n:127.0.0.1:41874_solr x:test_shard2_replica_n4 c:test s:shard2 r:core_node7) [n:127.0.0.1:41874_solr c:test s:shard2 r:core_node7 x:test_shard2_replica_n4] o.a.s.h.SolrConfigHandler Time elapsed : 28 secs, maxWait 30
[junit4] 2> 150297 INFO (SolrConfigHandler-refreshconf) [ ] o.a.s.h.SolrConfigHandler Another reload is in progress . Not doing anything
[junit4] 2> 150305 INFO (solrHandlerExecutor-201-thread-2-processing-n:127.0.0.1:41874_solr x:test_shard2_replica_n4 c:test s:shard2 r:core_n
[...truncated too long message...]
il:
ivy-configure:
[ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/top-level-ivy-settings.xml
resolve:
jar-checksums:
[mkdir] Created dir: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/null1038806239
[copy] Copying 240 files to /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/null1038806239
[delete] Deleting directory /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/null1038806239
check-working-copy:
[ivy:cachepath] :: resolving dependencies :: org.eclipse.jgit#org.eclipse.jgit-caller;working
[ivy:cachepath] confs: [default]
[ivy:cachepath] found org.eclipse.jgit#org.eclipse.jgit;4.6.0.201612231935-r in public
[ivy:cachepath] found com.jcraft#jsch;0.1.53 in public
[ivy:cachepath] found com.googlecode.javaewah#JavaEWAH;1.1.6 in public
[ivy:cachepath] found org.apache.httpcomponents#httpclient;4.3.6 in public
[ivy:cachepath] found org.apache.httpcomponents#httpcore;4.3.3 in public
[ivy:cachepath] found commons-logging#commons-logging;1.1.3 in public
[ivy:cachepath] found commons-codec#commons-codec;1.6 in public
[ivy:cachepath] found org.slf4j#slf4j-api;1.7.2 in public
[ivy:cachepath] :: resolution report :: resolve 36ms :: artifacts dl 1ms
---------------------------------------------------------------------
| | modules || artifacts |
| conf | number| search|dwnlded|evicted|| number|dwnlded|
---------------------------------------------------------------------
| default | 8 | 0 | 0 | 0 || 8 | 0 |
---------------------------------------------------------------------
[wc-checker] Initializing working copy...
[wc-checker] SLF4J: Failed to load class "org.slf4j.impl.StaticLoggerBinder".
[wc-checker] SLF4J: Defaulting to no-operation (NOP) logger implementation
[wc-checker] SLF4J: See http://www.slf4j.org/codes.html#StaticLoggerBinder for further details.
[wc-checker] Checking working copy status...
-jenkins-base:
BUILD SUCCESSFUL
Total time: 233 minutes 14 seconds
Archiving artifacts
java.lang.InterruptedException: no matches found within 10000
at hudson.FilePath$ValidateAntFileMask.hasMatch(FilePath.java:2847)
at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:2726)
at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:2707)
at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3086)
Also: hudson.remoting.Channel$CallSiteStackTrace: Remote call to lucene2
at hudson.remoting.Channel.attachCallSiteStackTrace(Channel.java:1741)
at hudson.remoting.UserRequest$ExceptionResponse.retrieve(UserRequest.java:357)
at hudson.remoting.Channel.call(Channel.java:955)
at hudson.FilePath.act(FilePath.java:1072)
at hudson.FilePath.act(FilePath.java:1061)
at hudson.FilePath.validateAntFileMask(FilePath.java:2705)
at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:243)
at hudson.tasks.BuildStepCompatibilityLayer.perform(BuildStepCompatibilityLayer.java:81)
at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
at hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:744)
at hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:690)
at hudson.model.Build$BuildExecution.post2(Build.java:186)
at hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:635)
at hudson.model.Run.execute(Run.java:1835)
at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
at hudson.model.ResourceController.execute(ResourceController.java:97)
at hudson.model.Executor.run(Executor.java:429)
Caused: hudson.FilePath$TunneledInterruptedException
at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3088)
at hudson.remoting.UserRequest.perform(UserRequest.java:212)
at hudson.remoting.UserRequest.perform(UserRequest.java:54)
at hudson.remoting.Request$2.run(Request.java:369)
at hudson.remoting.InterceptingExecutorService$1.call(InterceptingExecutorService.java:72)
at java.util.concurrent.FutureTask.run(FutureTask.java:266)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:748)
Caused: java.lang.InterruptedException: java.lang.InterruptedException: no matches found within 10000
at hudson.FilePath.act(FilePath.java:1074)
at hudson.FilePath.act(FilePath.java:1061)
at hudson.FilePath.validateAntFileMask(FilePath.java:2705)
at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:243)
at hudson.tasks.BuildStepCompatibilityLayer.perform(BuildStepCompatibilityLayer.java:81)
at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
at hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:744)
at hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:690)
at hudson.model.Build$BuildExecution.post2(Build.java:186)
at hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:635)
at hudson.model.Run.execute(Run.java:1835)
at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
at hudson.model.ResourceController.execute(ResourceController.java:97)
at hudson.model.Executor.run(Executor.java:429)
No artifacts found that match the file pattern "**/*.events,heapdumps/**,**/hs_err_pid*". Configuration error?
Recording test results
Build step 'Publish JUnit test result report' changed build result to UNSTABLE
Email was triggered for: Unstable (Test Failures)
Sending email for trigger: Unstable (Test Failures)
[JENKINS] Lucene-Solr-Tests-master - Build # 3259 - Still Failing
Posted by Apache Jenkins Server <je...@builds.apache.org>.
Build: https://builds.apache.org/job/Lucene-Solr-Tests-master/3259/
3 tests failed.
FAILED: junit.framework.TestSuite.org.apache.solr.handler.admin.AutoscalingHistoryHandlerTest
Error Message:
ObjectTracker found 2 object(s) that were not released!!! [SolrZkClient, ZkStateReader] org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.solr.common.cloud.SolrZkClient at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.common.cloud.SolrZkClient.<init>(SolrZkClient.java:203) at org.apache.solr.common.cloud.SolrZkClient.<init>(SolrZkClient.java:126) at org.apache.solr.common.cloud.SolrZkClient.<init>(SolrZkClient.java:116) at org.apache.solr.common.cloud.ZkStateReader.<init>(ZkStateReader.java:309) at org.apache.solr.client.solrj.impl.ZkClientClusterStateProvider.connect(ZkClientClusterStateProvider.java:160) at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.connect(BaseCloudSolrClient.java:329) at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.requestWithRetryOnStaleState(BaseCloudSolrClient.java:773) at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.requestWithRetryOnStaleState(BaseCloudSolrClient.java:942) at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.request(BaseCloudSolrClient.java:763) at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:207) at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:224) at org.apache.solr.client.solrj.impl.SolrClientCloudManager.request(SolrClientCloudManager.java:115) at org.apache.solr.cloud.autoscaling.SystemLogListener.onEvent(SystemLogListener.java:126) at org.apache.solr.cloud.autoscaling.ScheduledTriggers$TriggerListeners.fireListeners(ScheduledTriggers.java:836) at org.apache.solr.cloud.autoscaling.ScheduledTriggers$TriggerListeners.fireListeners(ScheduledTriggers.java:803) at org.apache.solr.cloud.autoscaling.ScheduledTriggers.lambda$add$4(ScheduledTriggers.java:297) at org.apache.solr.cloud.autoscaling.NodeLostTrigger.run(NodeLostTrigger.java:185) at org.apache.solr.cloud.autoscaling.ScheduledTriggers$TriggerWrapper.run(ScheduledTriggers.java:633) at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:308) at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:180) at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:294) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.solr.common.cloud.ZkStateReader at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.common.cloud.ZkStateReader.<init>(ZkStateReader.java:331) at org.apache.solr.client.solrj.impl.ZkClientClusterStateProvider.connect(ZkClientClusterStateProvider.java:160) at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.connect(BaseCloudSolrClient.java:329) at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.requestWithRetryOnStaleState(BaseCloudSolrClient.java:773) at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.requestWithRetryOnStaleState(BaseCloudSolrClient.java:942) at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.request(BaseCloudSolrClient.java:763) at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:207) at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:224) at org.apache.solr.client.solrj.impl.SolrClientCloudManager.request(SolrClientCloudManager.java:115) at org.apache.solr.cloud.autoscaling.SystemLogListener.onEvent(SystemLogListener.java:126) at org.apache.solr.cloud.autoscaling.ScheduledTriggers$TriggerListeners.fireListeners(ScheduledTriggers.java:836) at org.apache.solr.cloud.autoscaling.ScheduledTriggers$TriggerListeners.fireListeners(ScheduledTriggers.java:803) at org.apache.solr.cloud.autoscaling.ScheduledTriggers.lambda$add$4(ScheduledTriggers.java:297) at org.apache.solr.cloud.autoscaling.NodeLostTrigger.run(NodeLostTrigger.java:185) at org.apache.solr.cloud.autoscaling.ScheduledTriggers$TriggerWrapper.run(ScheduledTriggers.java:633) at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:308) at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:180) at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:294) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748) expected null, but was:<ObjectTracker found 2 object(s) that were not released!!! [SolrZkClient, ZkStateReader] org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.solr.common.cloud.SolrZkClient at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.common.cloud.SolrZkClient.<init>(SolrZkClient.java:203) at org.apache.solr.common.cloud.SolrZkClient.<init>(SolrZkClient.java:126) at org.apache.solr.common.cloud.SolrZkClient.<init>(SolrZkClient.java:116) at org.apache.solr.common.cloud.ZkStateReader.<init>(ZkStateReader.java:309) at org.apache.solr.client.solrj.impl.ZkClientClusterStateProvider.connect(ZkClientClusterStateProvider.java:160) at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.connect(BaseCloudSolrClient.java:329) at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.requestWithRetryOnStaleState(BaseCloudSolrClient.java:773) at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.requestWithRetryOnStaleState(BaseCloudSolrClient.java:942) at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.request(BaseCloudSolrClient.java:763) at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:207) at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:224) at org.apache.solr.client.solrj.impl.SolrClientCloudManager.request(SolrClientCloudManager.java:115) at org.apache.solr.cloud.autoscaling.SystemLogListener.onEvent(SystemLogListener.java:126) at org.apache.solr.cloud.autoscaling.ScheduledTriggers$TriggerListeners.fireListeners(ScheduledTriggers.java:836) at org.apache.solr.cloud.autoscaling.ScheduledTriggers$TriggerListeners.fireListeners(ScheduledTriggers.java:803) at org.apache.solr.cloud.autoscaling.ScheduledTriggers.lambda$add$4(ScheduledTriggers.java:297) at org.apache.solr.cloud.autoscaling.NodeLostTrigger.run(NodeLostTrigger.java:185) at org.apache.solr.cloud.autoscaling.ScheduledTriggers$TriggerWrapper.run(ScheduledTriggers.java:633) at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:308) at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:180) at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:294) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.solr.common.cloud.ZkStateReader at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.common.cloud.ZkStateReader.<init>(ZkStateReader.java:331) at org.apache.solr.client.solrj.impl.ZkClientClusterStateProvider.connect(ZkClientClusterStateProvider.java:160) at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.connect(BaseCloudSolrClient.java:329) at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.requestWithRetryOnStaleState(BaseCloudSolrClient.java:773) at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.requestWithRetryOnStaleState(BaseCloudSolrClient.java:942) at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.request(BaseCloudSolrClient.java:763) at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:207) at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:224) at org.apache.solr.client.solrj.impl.SolrClientCloudManager.request(SolrClientCloudManager.java:115) at org.apache.solr.cloud.autoscaling.SystemLogListener.onEvent(SystemLogListener.java:126) at org.apache.solr.cloud.autoscaling.ScheduledTriggers$TriggerListeners.fireListeners(ScheduledTriggers.java:836) at org.apache.solr.cloud.autoscaling.ScheduledTriggers$TriggerListeners.fireListeners(ScheduledTriggers.java:803) at org.apache.solr.cloud.autoscaling.ScheduledTriggers.lambda$add$4(ScheduledTriggers.java:297) at org.apache.solr.cloud.autoscaling.NodeLostTrigger.run(NodeLostTrigger.java:185) at org.apache.solr.cloud.autoscaling.ScheduledTriggers$TriggerWrapper.run(ScheduledTriggers.java:633) at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:308) at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:180) at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:294) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748) >
Stack Trace:
java.lang.AssertionError: ObjectTracker found 2 object(s) that were not released!!! [SolrZkClient, ZkStateReader]
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.solr.common.cloud.SolrZkClient
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.common.cloud.SolrZkClient.<init>(SolrZkClient.java:203)
at org.apache.solr.common.cloud.SolrZkClient.<init>(SolrZkClient.java:126)
at org.apache.solr.common.cloud.SolrZkClient.<init>(SolrZkClient.java:116)
at org.apache.solr.common.cloud.ZkStateReader.<init>(ZkStateReader.java:309)
at org.apache.solr.client.solrj.impl.ZkClientClusterStateProvider.connect(ZkClientClusterStateProvider.java:160)
at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.connect(BaseCloudSolrClient.java:329)
at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.requestWithRetryOnStaleState(BaseCloudSolrClient.java:773)
at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.requestWithRetryOnStaleState(BaseCloudSolrClient.java:942)
at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.request(BaseCloudSolrClient.java:763)
at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:207)
at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:224)
at org.apache.solr.client.solrj.impl.SolrClientCloudManager.request(SolrClientCloudManager.java:115)
at org.apache.solr.cloud.autoscaling.SystemLogListener.onEvent(SystemLogListener.java:126)
at org.apache.solr.cloud.autoscaling.ScheduledTriggers$TriggerListeners.fireListeners(ScheduledTriggers.java:836)
at org.apache.solr.cloud.autoscaling.ScheduledTriggers$TriggerListeners.fireListeners(ScheduledTriggers.java:803)
at org.apache.solr.cloud.autoscaling.ScheduledTriggers.lambda$add$4(ScheduledTriggers.java:297)
at org.apache.solr.cloud.autoscaling.NodeLostTrigger.run(NodeLostTrigger.java:185)
at org.apache.solr.cloud.autoscaling.ScheduledTriggers$TriggerWrapper.run(ScheduledTriggers.java:633)
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:308)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:180)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:294)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.solr.common.cloud.ZkStateReader
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.common.cloud.ZkStateReader.<init>(ZkStateReader.java:331)
at org.apache.solr.client.solrj.impl.ZkClientClusterStateProvider.connect(ZkClientClusterStateProvider.java:160)
at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.connect(BaseCloudSolrClient.java:329)
at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.requestWithRetryOnStaleState(BaseCloudSolrClient.java:773)
at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.requestWithRetryOnStaleState(BaseCloudSolrClient.java:942)
at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.request(BaseCloudSolrClient.java:763)
at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:207)
at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:224)
at org.apache.solr.client.solrj.impl.SolrClientCloudManager.request(SolrClientCloudManager.java:115)
at org.apache.solr.cloud.autoscaling.SystemLogListener.onEvent(SystemLogListener.java:126)
at org.apache.solr.cloud.autoscaling.ScheduledTriggers$TriggerListeners.fireListeners(ScheduledTriggers.java:836)
at org.apache.solr.cloud.autoscaling.ScheduledTriggers$TriggerListeners.fireListeners(ScheduledTriggers.java:803)
at org.apache.solr.cloud.autoscaling.ScheduledTriggers.lambda$add$4(ScheduledTriggers.java:297)
at org.apache.solr.cloud.autoscaling.NodeLostTrigger.run(NodeLostTrigger.java:185)
at org.apache.solr.cloud.autoscaling.ScheduledTriggers$TriggerWrapper.run(ScheduledTriggers.java:633)
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:308)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:180)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:294)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
expected null, but was:<ObjectTracker found 2 object(s) that were not released!!! [SolrZkClient, ZkStateReader]
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.solr.common.cloud.SolrZkClient
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.common.cloud.SolrZkClient.<init>(SolrZkClient.java:203)
at org.apache.solr.common.cloud.SolrZkClient.<init>(SolrZkClient.java:126)
at org.apache.solr.common.cloud.SolrZkClient.<init>(SolrZkClient.java:116)
at org.apache.solr.common.cloud.ZkStateReader.<init>(ZkStateReader.java:309)
at org.apache.solr.client.solrj.impl.ZkClientClusterStateProvider.connect(ZkClientClusterStateProvider.java:160)
at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.connect(BaseCloudSolrClient.java:329)
at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.requestWithRetryOnStaleState(BaseCloudSolrClient.java:773)
at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.requestWithRetryOnStaleState(BaseCloudSolrClient.java:942)
at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.request(BaseCloudSolrClient.java:763)
at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:207)
at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:224)
at org.apache.solr.client.solrj.impl.SolrClientCloudManager.request(SolrClientCloudManager.java:115)
at org.apache.solr.cloud.autoscaling.SystemLogListener.onEvent(SystemLogListener.java:126)
at org.apache.solr.cloud.autoscaling.ScheduledTriggers$TriggerListeners.fireListeners(ScheduledTriggers.java:836)
at org.apache.solr.cloud.autoscaling.ScheduledTriggers$TriggerListeners.fireListeners(ScheduledTriggers.java:803)
at org.apache.solr.cloud.autoscaling.ScheduledTriggers.lambda$add$4(ScheduledTriggers.java:297)
at org.apache.solr.cloud.autoscaling.NodeLostTrigger.run(NodeLostTrigger.java:185)
at org.apache.solr.cloud.autoscaling.ScheduledTriggers$TriggerWrapper.run(ScheduledTriggers.java:633)
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:308)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:180)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:294)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.solr.common.cloud.ZkStateReader
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.common.cloud.ZkStateReader.<init>(ZkStateReader.java:331)
at org.apache.solr.client.solrj.impl.ZkClientClusterStateProvider.connect(ZkClientClusterStateProvider.java:160)
at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.connect(BaseCloudSolrClient.java:329)
at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.requestWithRetryOnStaleState(BaseCloudSolrClient.java:773)
at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.requestWithRetryOnStaleState(BaseCloudSolrClient.java:942)
at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.request(BaseCloudSolrClient.java:763)
at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:207)
at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:224)
at org.apache.solr.client.solrj.impl.SolrClientCloudManager.request(SolrClientCloudManager.java:115)
at org.apache.solr.cloud.autoscaling.SystemLogListener.onEvent(SystemLogListener.java:126)
at org.apache.solr.cloud.autoscaling.ScheduledTriggers$TriggerListeners.fireListeners(ScheduledTriggers.java:836)
at org.apache.solr.cloud.autoscaling.ScheduledTriggers$TriggerListeners.fireListeners(ScheduledTriggers.java:803)
at org.apache.solr.cloud.autoscaling.ScheduledTriggers.lambda$add$4(ScheduledTriggers.java:297)
at org.apache.solr.cloud.autoscaling.NodeLostTrigger.run(NodeLostTrigger.java:185)
at org.apache.solr.cloud.autoscaling.ScheduledTriggers$TriggerWrapper.run(ScheduledTriggers.java:633)
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:308)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:180)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:294)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
>
at __randomizedtesting.SeedInfo.seed([E3F0BD9314006C3]:0)
at org.junit.Assert.fail(Assert.java:88)
at org.junit.Assert.failNotNull(Assert.java:755)
at org.junit.Assert.assertNull(Assert.java:737)
at org.apache.solr.SolrTestCaseJ4.teardownTestCases(SolrTestCaseJ4.java:326)
at sun.reflect.GeneratedMethodAccessor65.invoke(Unknown Source)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:901)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
FAILED: junit.framework.TestSuite.org.apache.solr.handler.admin.AutoscalingHistoryHandlerTest
Error Message:
3 threads leaked from SUITE scope at org.apache.solr.handler.admin.AutoscalingHistoryHandlerTest: 1) Thread[id=5943, name=ScheduledTrigger-2355-thread-1-EventThread, state=WAITING, group=TGRP-AutoscalingHistoryHandlerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:504) 2) Thread[id=5942, name=ScheduledTrigger-2355-thread-1-SendThread(lucene2-us-west.apache.org:46693), state=TIMED_WAITING, group=TGRP-AutoscalingHistoryHandlerTest] at java.lang.Thread.sleep(Native Method) at org.apache.zookeeper.ClientCnxnSocketNIO.cleanup(ClientCnxnSocketNIO.java:230) at org.apache.zookeeper.ClientCnxn$SendThread.cleanup(ClientCnxn.java:1246) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1170) 3) Thread[id=5944, name=zkConnectionManagerCallback-1873-thread-1, state=WAITING, group=TGRP-AutoscalingHistoryHandlerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 3 threads leaked from SUITE scope at org.apache.solr.handler.admin.AutoscalingHistoryHandlerTest:
1) Thread[id=5943, name=ScheduledTrigger-2355-thread-1-EventThread, state=WAITING, group=TGRP-AutoscalingHistoryHandlerTest]
at sun.misc.Unsafe.park(Native Method)
at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:504)
2) Thread[id=5942, name=ScheduledTrigger-2355-thread-1-SendThread(lucene2-us-west.apache.org:46693), state=TIMED_WAITING, group=TGRP-AutoscalingHistoryHandlerTest]
at java.lang.Thread.sleep(Native Method)
at org.apache.zookeeper.ClientCnxnSocketNIO.cleanup(ClientCnxnSocketNIO.java:230)
at org.apache.zookeeper.ClientCnxn$SendThread.cleanup(ClientCnxn.java:1246)
at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1170)
3) Thread[id=5944, name=zkConnectionManagerCallback-1873-thread-1, state=WAITING, group=TGRP-AutoscalingHistoryHandlerTest]
at sun.misc.Unsafe.park(Native Method)
at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
at __randomizedtesting.SeedInfo.seed([E3F0BD9314006C3]:0)
FAILED: junit.framework.TestSuite.org.apache.solr.handler.admin.AutoscalingHistoryHandlerTest
Error Message:
There are still zombie threads that couldn't be terminated: 1) Thread[id=5942, name=ScheduledTrigger-2355-thread-1-SendThread(lucene2-us-west.apache.org:46693), state=TIMED_WAITING, group=TGRP-AutoscalingHistoryHandlerTest] at java.lang.Thread.sleep(Native Method) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1045) 2) Thread[id=5944, name=zkConnectionManagerCallback-1873-thread-1, state=WAITING, group=TGRP-AutoscalingHistoryHandlerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie threads that couldn't be terminated:
1) Thread[id=5942, name=ScheduledTrigger-2355-thread-1-SendThread(lucene2-us-west.apache.org:46693), state=TIMED_WAITING, group=TGRP-AutoscalingHistoryHandlerTest]
at java.lang.Thread.sleep(Native Method)
at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1045)
2) Thread[id=5944, name=zkConnectionManagerCallback-1873-thread-1, state=WAITING, group=TGRP-AutoscalingHistoryHandlerTest]
at sun.misc.Unsafe.park(Native Method)
at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
at __randomizedtesting.SeedInfo.seed([E3F0BD9314006C3]:0)
Build Log:
[...truncated 13428 lines...]
[junit4] Suite: org.apache.solr.handler.admin.AutoscalingHistoryHandlerTest
[junit4] 2> Creating dataDir: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_E3F0BD9314006C3-001/init-core-data-001
[junit4] 2> 1031913 WARN (SUITE-AutoscalingHistoryHandlerTest-seed#[E3F0BD9314006C3]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=27 numCloses=27
[junit4] 2> 1031920 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[E3F0BD9314006C3]-worker) [ ] o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 1031921 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[E3F0BD9314006C3]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 1031922 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[E3F0BD9314006C3]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 1031922 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[E3F0BD9314006C3]-worker) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_E3F0BD9314006C3-001/tempDir-001
[junit4] 2> 1031922 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[E3F0BD9314006C3]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1031931 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1031931 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 1032031 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[E3F0BD9314006C3]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port:46693
[junit4] 2> 1032031 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[E3F0BD9314006C3]-worker) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:46693
[junit4] 2> 1032031 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[E3F0BD9314006C3]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 46693
[junit4] 2> 1032086 INFO (zkConnectionManagerCallback-1740-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1032129 INFO (zkConnectionManagerCallback-1742-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1032163 INFO (zkConnectionManagerCallback-1744-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1032176 WARN (jetty-launcher-1745-thread-1) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 1032176 INFO (jetty-launcher-1745-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
[junit4] 2> 1032176 INFO (jetty-launcher-1745-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 1032177 INFO (jetty-launcher-1745-thread-1) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_191-b12
[junit4] 2> 1032183 INFO (jetty-launcher-1745-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1032183 INFO (jetty-launcher-1745-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1032183 INFO (jetty-launcher-1745-thread-1) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 1032184 INFO (jetty-launcher-1745-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@386371b9{/solr,null,AVAILABLE}
[junit4] 2> 1032188 WARN (jetty-launcher-1745-thread-2) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 1032188 WARN (jetty-launcher-1745-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@59bec01f[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1032188 INFO (jetty-launcher-1745-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
[junit4] 2> 1032188 INFO (jetty-launcher-1745-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 1032188 INFO (jetty-launcher-1745-thread-2) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_191-b12
[junit4] 2> 1032224 INFO (jetty-launcher-1745-thread-2) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1032224 INFO (jetty-launcher-1745-thread-2) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1032224 INFO (jetty-launcher-1745-thread-2) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 1032237 INFO (jetty-launcher-1745-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@141d392e{/solr,null,AVAILABLE}
[junit4] 2> 1032238 WARN (jetty-launcher-1745-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@2e48498f[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1032238 INFO (jetty-launcher-1745-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@30952a75{SSL,[ssl, http/1.1]}{127.0.0.1:34663}
[junit4] 2> 1032238 INFO (jetty-launcher-1745-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@37bc45e3{SSL,[ssl, http/1.1]}{127.0.0.1:39178}
[junit4] 2> 1032238 INFO (jetty-launcher-1745-thread-2) [ ] o.e.j.s.Server Started @1032519ms
[junit4] 2> 1032238 INFO (jetty-launcher-1745-thread-1) [ ] o.e.j.s.Server Started @1032519ms
[junit4] 2> 1032238 INFO (jetty-launcher-1745-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=34663}
[junit4] 2> 1032238 INFO (jetty-launcher-1745-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=39178}
[junit4] 2> 1032238 ERROR (jetty-launcher-1745-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1032238 ERROR (jetty-launcher-1745-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1032238 INFO (jetty-launcher-1745-thread-2) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1032238 INFO (jetty-launcher-1745-thread-1) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1032238 INFO (jetty-launcher-1745-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 9.0.0
[junit4] 2> 1032238 INFO (jetty-launcher-1745-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 9.0.0
[junit4] 2> 1032238 INFO (jetty-launcher-1745-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1032238 INFO (jetty-launcher-1745-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1032239 INFO (jetty-launcher-1745-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1032239 INFO (jetty-launcher-1745-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-04-10T15:50:40.163Z
[junit4] 2> 1032239 INFO (jetty-launcher-1745-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1032239 INFO (jetty-launcher-1745-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-04-10T15:50:40.163Z
[junit4] 2> 1032268 INFO (zkConnectionManagerCallback-1747-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1032268 INFO (jetty-launcher-1745-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1032275 INFO (zkConnectionManagerCallback-1749-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1032275 INFO (jetty-launcher-1745-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1032515 INFO (jetty-launcher-1745-thread-1) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 1032515 WARN (jetty-launcher-1745-thread-1) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 1032539 WARN (jetty-launcher-1745-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@2ee2904[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1032546 WARN (jetty-launcher-1745-thread-1) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 1032555 WARN (jetty-launcher-1745-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@1c16d07b[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1032556 INFO (jetty-launcher-1745-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:46693/solr
[junit4] 2> 1032583 INFO (zkConnectionManagerCallback-1757-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1032597 INFO (zkConnectionManagerCallback-1759-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1032692 INFO (jetty-launcher-1745-thread-1) [n:127.0.0.1:39178_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:39178_solr
[junit4] 2> 1032693 INFO (jetty-launcher-1745-thread-1) [n:127.0.0.1:39178_solr ] o.a.s.c.Overseer Overseer (id=74498734068596742-127.0.0.1:39178_solr-n_0000000000) starting
[junit4] 2> 1032735 INFO (jetty-launcher-1745-thread-2) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 1032735 WARN (jetty-launcher-1745-thread-2) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 1032740 INFO (zkConnectionManagerCallback-1766-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1032741 WARN (jetty-launcher-1745-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@6d3e6fbb[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1032743 INFO (jetty-launcher-1745-thread-1) [n:127.0.0.1:39178_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:46693/solr ready
[junit4] 2> 1032743 WARN (jetty-launcher-1745-thread-2) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 1032745 WARN (jetty-launcher-1745-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@4cbd0a6a[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1032746 INFO (jetty-launcher-1745-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:46693/solr
[junit4] 2> 1032755 INFO (OverseerStateUpdate-74498734068596742-127.0.0.1:39178_solr-n_0000000000) [n:127.0.0.1:39178_solr ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:39178_solr
[junit4] 2> 1032763 INFO (jetty-launcher-1745-thread-1) [n:127.0.0.1:39178_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:39178_solr
[junit4] 2> 1032775 INFO (zkConnectionManagerCallback-1772-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1032776 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 0x108ac3434600008, likely client has closed socket
[junit4] 2> 1032778 DEBUG (OverseerAutoScalingTriggerThread-74498734068596742-127.0.0.1:39178_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Adding .auto_add_replicas and .scheduled_maintenance triggers
[junit4] 2> 1032778 DEBUG (OverseerAutoScalingTriggerThread-74498734068596742-127.0.0.1:39178_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 1
[junit4] 2> 1032779 INFO (zkCallback-1765-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1032781 DEBUG (OverseerAutoScalingTriggerThread-74498734068596742-127.0.0.1:39178_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion 0
[junit4] 2> 1032781 DEBUG (OverseerAutoScalingTriggerThread-74498734068596742-127.0.0.1:39178_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 1
[junit4] 2> 1032789 INFO (zkCallback-1758-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1032789 INFO (zkConnectionManagerCallback-1774-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1032794 INFO (jetty-launcher-1745-thread-2) [n:127.0.0.1:34663_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1032797 INFO (jetty-launcher-1745-thread-2) [n:127.0.0.1:34663_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:34663_solr as DOWN
[junit4] 2> 1032798 INFO (jetty-launcher-1745-thread-2) [n:127.0.0.1:34663_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 1032798 INFO (jetty-launcher-1745-thread-2) [n:127.0.0.1:34663_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:34663_solr
[junit4] 2> 1032803 DEBUG (OverseerAutoScalingTriggerThread-74498734068596742-127.0.0.1:39178_solr-n_0000000000) [ ] o.a.s.c.a.NodeLostTrigger NodeLostTrigger .auto_add_replicas - Initial livenodes: [127.0.0.1:39178_solr]
[junit4] 2> 1032807 DEBUG (OverseerAutoScalingTriggerThread-74498734068596742-127.0.0.1:39178_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread -- cleaning old nodeLost / nodeAdded markers
[junit4] 2> 1032807 DEBUG (OverseerAutoScalingTriggerThread-74498734068596742-127.0.0.1:39178_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion 1
[junit4] 2> 1032811 DEBUG (ScheduledTrigger-2355-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 and last live nodes: 1
[junit4] 2> 1032813 INFO (zkCallback-1758-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1032815 INFO (zkCallback-1773-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1032819 INFO (zkCallback-1765-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1032820 DEBUG (OverseerStateUpdate-74498734068596742-127.0.0.1:39178_solr-n_0000000000) [n:127.0.0.1:39178_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"downnode",
[junit4] 2> "node_name":"127.0.0.1:34663_solr"} current state version: 0
[junit4] 2> 1032820 DEBUG (OverseerStateUpdate-74498734068596742-127.0.0.1:39178_solr-n_0000000000) [n:127.0.0.1:39178_solr ] o.a.s.c.o.NodeMutator DownNode state invoked for node: 127.0.0.1:34663_solr
[junit4] 2> 1032843 INFO (jetty-launcher-1745-thread-1) [n:127.0.0.1:39178_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 1032867 INFO (jetty-launcher-1745-thread-1) [n:127.0.0.1:39178_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_39178.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5e0b9dad
[junit4] 2> 1032869 INFO (zkConnectionManagerCallback-1782-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1032870 INFO (jetty-launcher-1745-thread-2) [n:127.0.0.1:34663_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 1032872 INFO (jetty-launcher-1745-thread-2) [n:127.0.0.1:34663_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:46693/solr ready
[junit4] 2> 1032874 INFO (jetty-launcher-1745-thread-1) [n:127.0.0.1:39178_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_39178.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5e0b9dad
[junit4] 2> 1032874 INFO (jetty-launcher-1745-thread-1) [n:127.0.0.1:39178_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_39178.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5e0b9dad
[junit4] 2> 1032881 INFO (jetty-launcher-1745-thread-1) [n:127.0.0.1:39178_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_E3F0BD9314006C3-001/tempDir-001/node1/.
[junit4] 2> 1032882 INFO (jetty-launcher-1745-thread-2) [n:127.0.0.1:34663_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 1032991 INFO (jetty-launcher-1745-thread-2) [n:127.0.0.1:34663_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_34663.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5e0b9dad
[junit4] 2> 1032998 INFO (jetty-launcher-1745-thread-2) [n:127.0.0.1:34663_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_34663.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5e0b9dad
[junit4] 2> 1032999 INFO (jetty-launcher-1745-thread-2) [n:127.0.0.1:34663_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_34663.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5e0b9dad
[junit4] 2> 1032999 INFO (jetty-launcher-1745-thread-2) [n:127.0.0.1:34663_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_E3F0BD9314006C3-001/tempDir-001/node2/.
[junit4] 2> 1033071 INFO (zkConnectionManagerCallback-1788-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1033078 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[E3F0BD9314006C3]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 1033080 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[E3F0BD9314006C3]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:46693/solr ready
[junit4] 2> 1033097 INFO (qtp1802866272-5634) [n:127.0.0.1:39178_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params name=.system&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=127.0.0.1:39178_solr&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 1033108 INFO (OverseerThreadFactory-2357-thread-1-processing-n:127.0.0.1:39178_solr) [n:127.0.0.1:39178_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection .system
[junit4] 2> 1033115 DEBUG (OverseerStateUpdate-74498734068596742-127.0.0.1:39178_solr-n_0000000000) [n:127.0.0.1:39178_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "name":".system",
[junit4] 2> "fromApi":"true",
[junit4] 2> "numShards":1,
[junit4] 2> "createNodeSet":"127.0.0.1:39178_solr",
[junit4] 2> "nrtReplicas":"1",
[junit4] 2> "stateFormat":"2",
[junit4] 2> "replicationFactor":"1",
[junit4] 2> "operation":"create"} current state version: 0
[junit4] 2> 1033115 DEBUG (OverseerStateUpdate-74498734068596742-127.0.0.1:39178_solr-n_0000000000) [n:127.0.0.1:39178_solr ] o.a.s.c.o.ClusterStateMutator building a new cName: .system
[junit4] 2> 1033115 DEBUG (OverseerStateUpdate-74498734068596742-127.0.0.1:39178_solr-n_0000000000) [n:127.0.0.1:39178_solr ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/.system/state.json
[junit4] 2> 1033227 DEBUG (OverseerStateUpdate-74498734068596742-127.0.0.1:39178_solr-n_0000000000) [n:127.0.0.1:39178_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":".system",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":".system_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:39178/solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"} current state version: 0
[junit4] 2> 1033227 INFO (OverseerStateUpdate-74498734068596742-127.0.0.1:39178_solr-n_0000000000) [n:127.0.0.1:39178_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":".system",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":".system_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:39178/solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1033232 DEBUG (OverseerStateUpdate-74498734068596742-127.0.0.1:39178_solr-n_0000000000) [n:127.0.0.1:39178_solr ] o.a.s.c.o.SliceMutator Old Slice: shard1:{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{}}
[junit4] 2> 1033232 DEBUG (OverseerStateUpdate-74498734068596742-127.0.0.1:39178_solr-n_0000000000) [n:127.0.0.1:39178_solr ] o.a.s.c.o.SliceMutator New Slice: shard1:{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{"core_node2":{
[junit4] 2> "core":".system_shard1_replica_n1",
[junit4] 2> "base_url":"https://127.0.0.1:39178/solr",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":null,
[junit4] 2> "type":"NRT"}}}
[junit4] 2> 1033335 DEBUG (OverseerStateUpdate-74498734068596742-127.0.0.1:39178_solr-n_0000000000) [n:127.0.0.1:39178_solr ] o.a.s.c.o.ZkStateWriter going to update_collection /collections/.system/state.json version: 0
[junit4] 2> 1033441 INFO (qtp1802866272-5632) [n:127.0.0.1:39178_solr x:.system_shard1_replica_n1] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node2&collection.configName=.system&newCollection=true&name=.system_shard1_replica_n1&action=CREATE&numShards=1&collection=.system&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1033441 INFO (qtp1802866272-5632) [n:127.0.0.1:39178_solr x:.system_shard1_replica_n1] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 1033452 DEBUG (OverseerStateUpdate-74498734068596742-127.0.0.1:39178_solr-n_0000000000) [n:127.0.0.1:39178_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "core":".system_shard1_replica_n1",
[junit4] 2> "core_node_name":"core_node2",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"https://127.0.0.1:39178/solr",
[junit4] 2> "node_name":"127.0.0.1:39178_solr",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":".system",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "operation":"state"} current state version: 0
[junit4] 2> 1033452 DEBUG (OverseerStateUpdate-74498734068596742-127.0.0.1:39178_solr-n_0000000000) [n:127.0.0.1:39178_solr ] o.a.s.c.o.ReplicaMutator Update state numShards=1 message={
[junit4] 2> "core":".system_shard1_replica_n1",
[junit4] 2> "core_node_name":"core_node2",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"https://127.0.0.1:39178/solr",
[junit4] 2> "node_name":"127.0.0.1:39178_solr",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":".system",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "operation":"state"}
[junit4] 2> 1033452 DEBUG (OverseerStateUpdate-74498734068596742-127.0.0.1:39178_solr-n_0000000000) [n:127.0.0.1:39178_solr ] o.a.s.c.o.ReplicaMutator Will update state for replica: core_node2:{"core":".system_shard1_replica_n1","base_url":"https://127.0.0.1:39178/solr","node_name":"127.0.0.1:39178_solr","state":"down","type":"NRT","force_set_state":"false"}
[junit4] 2> 1033452 DEBUG (OverseerStateUpdate-74498734068596742-127.0.0.1:39178_solr-n_0000000000) [n:127.0.0.1:39178_solr ] o.a.s.c.o.ReplicaMutator Collection is now: DocCollection(.system//collections/.system/state.json/1)={
[junit4] 2> "pullReplicas":"0",
[junit4] 2> "replicationFactor":"1",
[junit4] 2> "router":{"name":"compositeId"},
[junit4] 2> "maxShardsPerNode":"1",
[junit4] 2> "autoAddReplicas":"false",
[junit4] 2> "nrtReplicas":"1",
[junit4] 2> "tlogReplicas":"0",
[junit4] 2> "shards":{"shard1":{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{"core_node2":{
[junit4] 2> "core":".system_shard1_replica_n1",
[junit4] 2> "base_url":"https://127.0.0.1:39178/solr",
[junit4] 2> "node_name":"127.0.0.1:39178_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false"}}}}}
[junit4] 2> 1033553 DEBUG (OverseerStateUpdate-74498734068596742-127.0.0.1:39178_solr-n_0000000000) [n:127.0.0.1:39178_solr ] o.a.s.c.o.ZkStateWriter going to update_collection /collections/.system/state.json version: 1
[junit4] 2> 1033812 DEBUG (ScheduledTrigger-2355-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 1
[junit4] 2> 1034461 WARN (qtp1802866272-5632) [n:127.0.0.1:39178_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.c.SolrConfig You should not use LATEST as luceneMatchVersion property: if you use this setting, and then Solr upgrades to a newer release of Lucene, sizable changes may happen. If precise back compatibility is important then you should instead explicitly specify an actual Lucene version.
[junit4] 2> 1034462 INFO (qtp1802866272-5632) [n:127.0.0.1:39178_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0
[junit4] 2> 1034467 INFO (qtp1802866272-5632) [n:127.0.0.1:39178_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.s.ManagedIndexSchemaFactory The schema is configured as managed, but managed schema resource managed-schema not found - loading non-managed schema schema.xml instead
[junit4] 2> 1034469 INFO (qtp1802866272-5632) [n:127.0.0.1:39178_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.s.IndexSchema [.system_shard1_replica_n1] Schema name=_system collection or core
[junit4] 2> 1034473 INFO (qtp1802866272-5632) [n:127.0.0.1:39178_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.s.IndexSchema Loaded schema _system collection or core/1.1 with uniqueid field id
[junit4] 2> 1034474 INFO (qtp1802866272-5632) [n:127.0.0.1:39178_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.s.ManagedIndexSchema Created and persisted managed schema znode at /configs/.system/managed-schema
[junit4] 2> 1034477 INFO (qtp1802866272-5632) [n:127.0.0.1:39178_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.s.ManagedIndexSchemaFactory After upgrading to managed schema in ZooKeeper, renamed the non-managed schema /configs/.system/schema.xml to /configs/.system/schema.xml.bak
[junit4] 2> 1034477 INFO (qtp1802866272-5632) [n:127.0.0.1:39178_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.c.CoreContainer Creating SolrCore '.system_shard1_replica_n1' using configuration from collection .system, trusted=true
[junit4] 2> 1034478 INFO (qtp1802866272-5632) [n:127.0.0.1:39178_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_39178.solr.core..system.shard1.replica_n1' (registry 'solr.core..system.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5e0b9dad
[junit4] 2> 1034478 INFO (qtp1802866272-5632) [n:127.0.0.1:39178_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.c.SolrCore [[.system_shard1_replica_n1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_E3F0BD9314006C3-001/tempDir-001/node1/.system_shard1_replica_n1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_E3F0BD9314006C3-001/tempDir-001/node1/./.system_shard1_replica_n1/data/]
[junit4] 2> 1034529 INFO (qtp1802866272-5632) [n:127.0.0.1:39178_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1034529 INFO (qtp1802866272-5632) [n:127.0.0.1:39178_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1034531 INFO (qtp1802866272-5632) [n:127.0.0.1:39178_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.u.CommitTracker Hard AutoCommit: if 1 uncommitted docs;
[junit4] 2> 1034531 INFO (qtp1802866272-5632) [n:127.0.0.1:39178_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1034533 INFO (qtp1802866272-5632) [n:127.0.0.1:39178_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.s.SolrIndexSearcher Opening [Searcher@3cc6ca00[.system_shard1_replica_n1] main]
[junit4] 2> 1034534 INFO (qtp1802866272-5632) [n:127.0.0.1:39178_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/.system
[junit4] 2> 1034537 INFO (qtp1802866272-5632) [n:127.0.0.1:39178_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/.system
[junit4] 2> 1034537 INFO (qtp1802866272-5632) [n:127.0.0.1:39178_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at /configs/.system/managed-schema
[junit4] 2> 1034537 INFO (qtp1802866272-5632) [n:127.0.0.1:39178_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
[junit4] 2> 1034538 INFO (qtp1802866272-5632) [n:127.0.0.1:39178_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1034538 INFO (qtp1802866272-5632) [n:127.0.0.1:39178_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1630442820691034112
[junit4] 2> 1034540 INFO (searcherExecutor-2366-thread-1-processing-n:127.0.0.1:39178_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node2) [n:127.0.0.1:39178_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.c.SolrCore [.system_shard1_replica_n1] Registered new searcher Searcher@3cc6ca00[.system_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1034550 INFO (qtp1802866272-5632) [n:127.0.0.1:39178_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.c.ZkShardTerms Successful update of terms at /collections/.system/terms/shard1 to Terms{values={core_node2=0}, version=0}
[junit4] 2> 1034550 INFO (qtp1802866272-5632) [n:127.0.0.1:39178_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/.system/leaders/shard1
[junit4] 2> 1034557 INFO (qtp1802866272-5632) [n:127.0.0.1:39178_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 1034557 INFO (qtp1802866272-5632) [n:127.0.0.1:39178_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 1034557 INFO (qtp1802866272-5632) [n:127.0.0.1:39178_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.c.SyncStrategy Sync replicas to https://127.0.0.1:39178/solr/.system_shard1_replica_n1/
[junit4] 2> 1034557 INFO (qtp1802866272-5632) [n:127.0.0.1:39178_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 1034558 INFO (qtp1802866272-5632) [n:127.0.0.1:39178_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.c.SyncStrategy https://127.0.0.1:39178/solr/.system_shard1_replica_n1/ has no replicas
[junit4] 2> 1034558 INFO (qtp1802866272-5632) [n:127.0.0.1:39178_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/.system/leaders/shard1/leader after winning as /collections/.system/leader_elect/shard1/election/74498734068596742-core_node2-n_0000000000
[junit4] 2> 1034559 INFO (qtp1802866272-5632) [n:127.0.0.1:39178_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I am the new leader: https://127.0.0.1:39178/solr/.system_shard1_replica_n1/ shard1
[junit4] 2> 1034560 DEBUG (OverseerStateUpdate-74498734068596742-127.0.0.1:39178_solr-n_0000000000) [n:127.0.0.1:39178_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":".system",
[junit4] 2> "base_url":"https://127.0.0.1:39178/solr",
[junit4] 2> "core":".system_shard1_replica_n1",
[junit4] 2> "state":"active"} current state version: 0
[junit4] 2> 1034661 DEBUG (OverseerStateUpdate-74498734068596742-127.0.0.1:39178_solr-n_0000000000) [n:127.0.0.1:39178_solr ] o.a.s.c.o.ZkStateWriter going to update_collection /collections/.system/state.json version: 2
[junit4] 2> 1034661 INFO (zkCallback-1758-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/.system/state.json] for collection [.system] has occurred - updating... (live nodes size: [2])
[junit4] 2> 1034661 INFO (zkCallback-1758-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/.system/state.json] for collection [.system] has occurred - updating... (live nodes size: [2])
[junit4] 2> 1034662 INFO (qtp1802866272-5632) [n:127.0.0.1:39178_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 1034663 DEBUG (OverseerStateUpdate-74498734068596742-127.0.0.1:39178_solr-n_0000000000) [n:127.0.0.1:39178_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "core":".system_shard1_replica_n1",
[junit4] 2> "core_node_name":"core_node2",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"https://127.0.0.1:39178/solr",
[junit4] 2> "node_name":"127.0.0.1:39178_solr",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":".system",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "operation":"state"} current state version: 0
[junit4] 2> 1034663 DEBUG (OverseerStateUpdate-74498734068596742-127.0.0.1:39178_solr-n_0000000000) [n:127.0.0.1:39178_solr ] o.a.s.c.o.ReplicaMutator Update state numShards=1 message={
[junit4] 2> "core":".system_shard1_replica_n1",
[junit4] 2> "core_node_name":"core_node2",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"https://127.0.0.1:39178/solr",
[junit4] 2> "node_name":"127.0.0.1:39178_solr",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":".system",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "operation":"state"}
[junit4] 2> 1034663 DEBUG (OverseerStateUpdate-74498734068596742-127.0.0.1:39178_solr-n_0000000000) [n:127.0.0.1:39178_solr ] o.a.s.c.o.ReplicaMutator Will update state for replica: core_node2:{"core":".system_shard1_replica_n1","base_url":"https://127.0.0.1:39178/solr","node_name":"127.0.0.1:39178_solr","state":"active","type":"NRT","force_set_state":"false","leader":"true"}
[junit4] 2> 1034663 DEBUG (OverseerStateUpdate-74498734068596742-127.0.0.1:39178_solr-n_0000000000) [n:127.0.0.1:39178_solr ] o.a.s.c.o.ReplicaMutator Collection is now: DocCollection(.system//collections/.system/state.json/3)={
[junit4] 2> "pullReplicas":"0",
[junit4] 2> "replicationFactor":"1",
[junit4] 2> "router":{"name":"compositeId"},
[junit4] 2> "maxShardsPerNode":"1",
[junit4] 2> "autoAddReplicas":"false",
[junit4] 2> "nrtReplicas":"1",
[junit4] 2> "tlogReplicas":"0",
[junit4] 2> "shards":{"shard1":{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{"core_node2":{
[junit4] 2> "core":".system_shard1_replica_n1",
[junit4] 2> "base_url":"https://127.0.0.1:39178/solr",
[junit4] 2> "node_name":"127.0.0.1:39178_solr",
[junit4] 2> "state":"active",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "leader":"true"}}}}}
[junit4] 2> 1034664 INFO (qtp1802866272-5632) [n:127.0.0.1:39178_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node2&collection.configName=.system&newCollection=true&name=.system_shard1_replica_n1&action=CREATE&numShards=1&collection=.system&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=1223
[junit4] 2> 1034668 INFO (qtp1802866272-5634) [n:127.0.0.1:39178_solr ] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 45 seconds. Check all shard replicas
[junit4] 2> 1034764 DEBUG (OverseerStateUpdate-74498734068596742-127.0.0.1:39178_solr-n_0000000000) [n:127.0.0.1:39178_solr ] o.a.s.c.o.ZkStateWriter going to update_collection /collections/.system/state.json version: 3
[junit4] 2> 1034765 INFO (zkCallback-1758-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/.system/state.json] for collection [.system] has occurred - updating... (live nodes size: [2])
[junit4] 2> 1034765 INFO (zkCallback-1758-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/.system/state.json] for collection [.system] has occurred - updating... (live nodes size: [2])
[junit4] 2> 1034765 INFO (zkCallback-1758-thread-3) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/.system/state.json] for collection [.system] has occurred - updating... (live nodes size: [2])
[junit4] 2> 1034765 INFO (qtp1802866272-5634) [n:127.0.0.1:39178_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={name=.system&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=127.0.0.1:39178_solr&wt=javabin&version=2} status=0 QTime=1668
[junit4] 2> 1034768 INFO (qtp1802866272-5630) [n:127.0.0.1:39178_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params maxShardsPerNode=3&name=AutoscalingHistoryHandlerTest_collection&nrtReplicas=3&action=CREATE&numShards=1&createNodeSet=127.0.0.1:34663_solr&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 1034770 INFO (OverseerThreadFactory-2357-thread-2-processing-n:127.0.0.1:39178_solr) [n:127.0.0.1:39178_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection AutoscalingHistoryHandlerTest_collection
[junit4] 2> 1034770 INFO (OverseerCollectionConfigSetProcessor-74498734068596742-127.0.0.1:39178_solr-n_0000000000) [n:127.0.0.1:39178_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> 1034771 INFO (OverseerThreadFactory-2357-thread-2-processing-n:127.0.0.1:39178_solr) [n:127.0.0.1:39178_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/protwords.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/protwords.txt
[junit4] 2> 1034772 INFO (OverseerThreadFactory-2357-thread-2-processing-n:127.0.0.1:39178_solr) [n:127.0.0.1:39178_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/managed-schema to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/managed-schema
[junit4] 2> 1034774 INFO (OverseerThreadFactory-2357-thread-2-processing-n:127.0.0.1:39178_solr) [n:127.0.0.1:39178_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/solrconfig.xml to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/solrconfig.xml
[junit4] 2> 1034775 INFO (OverseerThreadFactory-2357-thread-2-processing-n:127.0.0.1:39178_solr) [n:127.0.0.1:39178_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/synonyms.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/synonyms.txt
[junit4] 2> 1034777 INFO (OverseerThreadFactory-2357-thread-2-processing-n:127.0.0.1:39178_solr) [n:127.0.0.1:39178_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/stopwords.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/stopwords.txt
[junit4] 2> 1034778 INFO (OverseerThreadFactory-2357-thread-2-processing-n:127.0.0.1:39178_solr) [n:127.0.0.1:39178_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/params.json to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/params.json
[junit4] 2> 1034798 INFO (OverseerThreadFactory-2357-thread-2-processing-n:127.0.0.1:39178_solr) [n:127.0.0.1:39178_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/contractions_it.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/contractions_it.txt
[junit4] 2> 1034799 INFO (OverseerThreadFactory-2357-thread-2-processing-n:127.0.0.1:39178_solr) [n:127.0.0.1:39178_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_no.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_no.txt
[junit4] 2> 1034808 INFO (OverseerThreadFactory-2357-thread-2-processing-n:127.0.0.1:39178_solr) [n:127.0.0.1:39178_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_hy.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_hy.txt
[junit4] 2> 1034809 INFO (OverseerThreadFactory-2357-thread-2-processing-n:127.0.0.1:39178_solr) [n:127.0.0.1:39178_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stemdict_nl.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stemdict_nl.txt
[junit4] 2> 1034810 INFO (OverseerThreadFactory-2357-thread-2-processing-n:127.0.0.1:39178_solr) [n:127.0.0.1:39178_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/contractions_ca.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/contractions_ca.txt
[junit4] 2> 1034812 INFO (OverseerThreadFactory-2357-thread-2-processing-n:127.0.0.1:39178_solr) [n:127.0.0.1:39178_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_id.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_id.txt
[junit4] 2> 1034813 INFO (OverseerThreadFactory-2357-thread-2-processing-n:127.0.0.1:39178_solr) [n:127.0.0.1:39178_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ga.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_ga.txt
[junit4] 2> 1034815 INFO (OverseerThreadFactory-2357-thread-2-processing-n:127.0.0.1:39178_solr) [n:127.0.0.1:39178_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_da.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_da.txt
[junit4] 2> 1034816 DEBUG (ScheduledTrigger-2355-thread-4) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
[junit4] 2> 1034816 INFO (OverseerThreadFactory-2357-thread-2-processing-n:127.0.0.1:39178_solr) [n:127.0.0.1:39178_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_hi.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_hi.txt
[junit4] 2> 1034818 INFO (OverseerThreadFactory-2357-thread-2-processing-n:127.0.0.1:39178_solr) [n:127.0.0.1:39178_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ja.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_ja.txt
[junit4] 2> 1034820 INFO (OverseerThreadFactory-2357-thread-2-processing-n:127.0.0.1:39178_solr) [n:127.0.0.1:39178_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_pt.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_pt.txt
[junit4] 2> 1034821 INFO (OverseerThreadFactory-2357-thread-2-processing-n:127.0.0.1:39178_solr) [n:127.0.0.1:39178_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_hu.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_hu.txt
[junit4] 2> 1034823 INFO (OverseerThreadFactory-2357-thread-2-processing-n:127.0.0.1:39178_solr) [n:127.0.0.1:39178_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_el.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_el.txt
[junit4] 2> 1034824 INFO (OverseerThreadFactory-2357-thread-2-processing-n:127.0.0.1:39178_solr) [n:127.0.0.1:39178_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ru.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_ru.txt
[junit4] 2> 1034825 INFO (OverseerThreadFactory-2357-thread-2-processing-n:127.0.0.1:39178_solr) [n:127.0.0.1:39178_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_tr.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_tr.txt
[junit4] 2> 1034826 INFO (OverseerThreadFactory-2357-thread-2-processing-n:127.0.0.1:39178_solr) [n:127.0.0.1:39178_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ar.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_ar.txt
[junit4] 2> 1034828 INFO (OverseerThreadFactory-2357-thread-2-processing-n:127.0.0.1:39178_solr) [n:127.0.0.1:39178_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/userdict_ja.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/userdict_ja.txt
[junit4] 2> 1034829 INFO (OverseerThreadFactory-2357-thread-2-processing-n:127.0.0.1:39178_solr) [n:127.0.0.1:39178_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_it.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_it.txt
[junit4] 2> 1034830 INFO (OverseerThreadFactory-2357-thread-2-processing-n:127.0.0.1:39178_solr) [n:127.0.0.1:39178_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_eu.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_eu.txt
[junit4] 2> 1034832 INFO (OverseerThreadFactory-2357-thread-2-processing-n:127.0.0.1:39178_solr) [n:127.0.0.1:39178_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_cz.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_cz.txt
[junit4] 2> 1034833 INFO (OverseerThreadFactory-2357-thread-2-processing-n:127.0.0.1:39178_solr) [n:127.0.0.1:39178_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stoptags_ja.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stoptags_ja.txt
[junit4] 2> 1034835 INFO (OverseerThreadFactory-2357-thread-2-processing-n:127.0.0.1:39178_solr) [n:127.0.0.1:39178_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/contractions_fr.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/contractions_fr.txt
[junit4] 2> 1034836 INFO (OverseerThreadFactory-2357-thread-2-processing-n:127.0.0.1:39178_solr) [n:127.0.0.1:39178_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_fa.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_fa.txt
[junit4] 2> 1034837 INFO (OverseerThreadFactory-2357-thread-2-processing-n:127.0.0.1:39178_solr) [n:127.0.0.1:39178_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_de.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_de.txt
[junit4] 2> 1034839 INFO (OverseerThreadFactory-2357-thread-2-processing-n:127.0.0.1:39178_solr) [n:127.0.0.1:39178_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/contractions_ga.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/contractions_ga.txt
[junit4] 2> 1034840 INFO (OverseerThreadFactory-2357-thread-2-processing-n:127.0.0.1:39178_solr) [n:127.0.0.1:39178_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ca.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_ca.txt
[junit4] 2> 1034841 INFO (OverseerThreadFactory-2357-thread-2-processing-n:127.0.0.1:39178_solr) [n:127.0.0.1:39178_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_nl.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_nl.txt
[junit4] 2> 1034843 INFO (OverseerThreadFactory-2357-thread-2-processing-n:127.0.0.1:39178_solr) [n:127.0.0.1:39178_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_bg.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_bg.txt
[junit4] 2> 1034844 INFO (OverseerThreadFactory-2357-thread-2-processing-n:127.0.0.1:39178_solr) [n:127.0.0.1:39178_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_es.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_es.txt
[junit4] 2> 1034846 INFO (OverseerThreadFactory-2357-thread-2-processing-n:127.0.0.1:39178_solr) [n:127.0.0.1:39178_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_en.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_en.txt
[junit4] 2> 1034847 INFO (OverseerThreadFactory-2357-thread-2-processing-n:127.0.0.1:39178_solr) [n:127.0.0.1:39178_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_lv.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_lv.txt
[junit4] 2> 1034849 INFO (OverseerThreadFactory-2357-thread-2-processing-n:127.0.0.1:39178_solr) [n:127.0.0.1:39178_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_th.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_th.txt
[junit4] 2> 1034850 INFO (OverseerThreadFactory-2357-thread-2-processing-n:127.0.0.1:39178_solr) [n:127.0.0.1:39178_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ro.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_ro.txt
[junit4] 2> 1034852 INFO (OverseerThreadFactory-2357-thread-2-processing-n:127.0.0.1:39178_solr) [n:127.0.0.1:39178_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_fr.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_fr.txt
[junit4] 2> 1034853 INFO (OverseerThreadFactory-2357-thread-2-processing-n:127.0.0.1:39178_solr) [n:127.0.0.1:39178_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_sv.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_sv.txt
[junit4] 2> 1034854 INFO (OverseerThreadFactory-2357-thread-2-processing-n:127.0.0.1:39178_solr) [n:127.0.0.1:39178_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_fi.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_fi.txt
[junit4] 2> 1034856 INFO (OverseerThreadFactory-2357-thread-2-processing-n:127.0.0.1:39178_solr) [n:127.0.0.1:39178_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/hyphenations_ga.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/hyphenations_ga.txt
[junit4] 2> 1034857 INFO (OverseerThreadFactory-2357-thread-2-processing-n:127.0.0.1:39178_solr) [n:127.0.0.1:39178_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_gl.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_gl.txt
[junit4] 2> 1034862 DEBUG (OverseerStateUpdate-74498734068596742-127.0.0.1:39178_solr-n_0000000000) [n:127.0.0.1:39178_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "name":"AutoscalingHistoryHandlerTest_collection",
[junit4] 2> "fromApi":"true",
[junit4] 2> "numShards":"1",
[junit4] 2> "maxShardsPerNode":"3",
[junit4] 2> "createNodeSet":"127.0.0.1:34663_solr",
[junit4] 2> "nrtReplicas":"3",
[junit4] 2> "stateFormat":"2",
[junit4] 2> "replicationFactor":"3",
[junit4] 2> "operation":"create"} current state version: 0
[junit4] 2> 1034862 DEBUG (OverseerStateUpdate-74498734068596742-127.0.0.1:39178_solr-n_0000000000) [n:127.0.0.1:39178_solr ] o.a.s.c.o.ClusterStateMutator building a new cName: AutoscalingHistoryHandlerTest_collection
[junit4] 2> 1034963 DEBUG (OverseerStateUpdate-74498734068596742-127.0.0.1:39178_solr-n_0000000000) [n:127.0.0.1:39178_solr ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/AutoscalingHistoryHandlerTest_collection/state.json
[junit4] 2> 1035063 WARN (OverseerThreadFactory-2357-thread-2-processing-n:127.0.0.1:39178_solr) [n:127.0.0.1:39178_solr ] o.a.s.c.a.c.CreateCollectionCmd Specified number of replicas of 3 on collection AutoscalingHistoryHandlerTest_collection is higher than the number of Solr instances currently live or live and part of your createNodeSet(1). It's unusual to run two replica of the same slice on the same Solr-instance.
[junit4] 2> 1035067 DEBUG (OverseerStateUpdate-74498734068596742-127.0.0.1:39178_solr-n_0000000000) [n:127.0.0.1:39178_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"AutoscalingHistoryHandlerTest_collection",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:34663/solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"} current state version: 0
[junit4] 2> 1035067 INFO (OverseerStateUpdate-74498734068596742-127.0.0.1:39178_solr-n_0000000000) [n:127.0.0.1:39178_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"AutoscalingHistoryHandlerTest_collection",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:34663/solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1035075 DEBUG (OverseerStateUpdate-74498734068596742-127.0.0.1:39178_solr-n_0000000000) [n:127.0.0.1:39178_solr ] o.a.s.c.o.SliceMutator Old Slice: shard1:{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{}}
[junit4] 2> 1035075 DEBUG (OverseerStateUpdate-74498734068596742-127.0.0.1:39178_solr-n_0000000000) [n:127.0.0.1:39178_solr ] o.a.s.c.o.SliceMutator New Slice: shard1:{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{"core_node3":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "base_url":"https://127.0.0.1:34663/solr",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":null,
[junit4] 2> "type":"NRT"}}}
[junit4] 2> 1035075 DEBUG (OverseerStateUpdate-74498734068596742-127.0.0.1:39178_solr-n_0000000000) [n:127.0.0.1:39178_solr ] o.a.s.c.Overseer processMessage: queueSize: 2, message = {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"AutoscalingHistoryHandlerTest_collection",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:34663/solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"} current state version: 0
[junit4] 2> 1035075 INFO (OverseerStateUpdate-74498734068596742-127.0.0.1:39178_solr-n_0000000000) [n:127.0.0.1:39178_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"AutoscalingHistoryHandlerTest_collection",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:34663/solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalSt
[...truncated too long message...]
ins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/search/TestLRUQueryCache.java (at line 178)
[ecj-lint] throw error.get();
[ecj-lint] ^^^^^^^^^^^^^^^^^^
[ecj-lint] Resource leak: 'mgr' is not closed at this location
[ecj-lint] ----------
[ecj-lint] ----------
[ecj-lint] 72. ERROR in /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/search/TestMatchesIterator.java (at line 37)
[ecj-lint] import org.apache.lucene.index.NumericDocValues;
[ecj-lint] ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[ecj-lint] The import org.apache.lucene.index.NumericDocValues is never used
[ecj-lint] ----------
[ecj-lint] ----------
[ecj-lint] 73. WARNING in /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/search/TestSameScoresWithThreads.java (at line 49)
[ecj-lint] LineFileDocs docs = new LineFileDocs(random());
[ecj-lint] ^^^^
[ecj-lint] Resource leak: 'docs' is never closed
[ecj-lint] ----------
[ecj-lint] ----------
[ecj-lint] 74. WARNING in /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/search/TestSearcherManager.java (at line 313)
[ecj-lint] SearcherManager sm = new SearcherManager(writer, false, false, new SearcherFactory());
[ecj-lint] ^^
[ecj-lint] Resource leak: 'sm' is never closed
[ecj-lint] ----------
[ecj-lint] ----------
[ecj-lint] 75. WARNING in /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/search/TestTermQuery.java (at line 52)
[ecj-lint] new TermQuery(new Term("foo", "bar"), TermStates.build(new MultiReader().getContext(), new Term("foo", "bar"), true)));
[ecj-lint] ^^^^^^^^^^^^^^^^^
[ecj-lint] Resource leak: '<unassigned Closeable value>' is never closed
[ecj-lint] ----------
[ecj-lint] ----------
[ecj-lint] 76. WARNING in /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/store/TestBufferedIndexInput.java (at line 50)
[ecj-lint] MyBufferedIndexInput input = new MyBufferedIndexInput();
[ecj-lint] ^^^^^
[ecj-lint] Resource leak: 'input' is never closed
[ecj-lint] ----------
[ecj-lint] ----------
[ecj-lint] 77. WARNING in /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/store/TestTrackingDirectoryWrapper.java (at line 32)
[ecj-lint] TrackingDirectoryWrapper dir = new TrackingDirectoryWrapper(new ByteBuffersDirectory());
[ecj-lint] ^^^
[ecj-lint] Resource leak: 'dir' is never closed
[ecj-lint] ----------
[ecj-lint] 78. WARNING in /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/store/TestTrackingDirectoryWrapper.java (at line 37)
[ecj-lint] TrackingDirectoryWrapper dir = new TrackingDirectoryWrapper(new ByteBuffersDirectory());
[ecj-lint] ^^^
[ecj-lint] Resource leak: 'dir' is never closed
[ecj-lint] ----------
[ecj-lint] 79. WARNING in /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/store/TestTrackingDirectoryWrapper.java (at line 43)
[ecj-lint] TrackingDirectoryWrapper dir = new TrackingDirectoryWrapper(new ByteBuffersDirectory());
[ecj-lint] ^^^
[ecj-lint] Resource leak: 'dir' is never closed
[ecj-lint] ----------
[ecj-lint] 80. WARNING in /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/store/TestTrackingDirectoryWrapper.java (at line 51)
[ecj-lint] TrackingDirectoryWrapper dir = new TrackingDirectoryWrapper(new ByteBuffersDirectory());
[ecj-lint] ^^^
[ecj-lint] Resource leak: 'dir' is never closed
[ecj-lint] ----------
[ecj-lint] 81. WARNING in /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/store/TestTrackingDirectoryWrapper.java (at line 60)
[ecj-lint] TrackingDirectoryWrapper dest = new TrackingDirectoryWrapper(new ByteBuffersDirectory());
[ecj-lint] ^^^^
[ecj-lint] Resource leak: 'dest' is never closed
[ecj-lint] ----------
[ecj-lint] ----------
[ecj-lint] 82. WARNING in /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/util/TestCloseableThreadLocal.java (at line 31)
[ecj-lint] CloseableThreadLocal<Object> ctl = new CloseableThreadLocal<>();
[ecj-lint] ^^^
[ecj-lint] Resource leak: 'ctl' is never closed
[ecj-lint] ----------
[ecj-lint] 83. WARNING in /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/util/TestCloseableThreadLocal.java (at line 39)
[ecj-lint] CloseableThreadLocal<Object> ctl = new CloseableThreadLocal<>();
[ecj-lint] ^^^
[ecj-lint] Resource leak: 'ctl' is never closed
[ecj-lint] ----------
[ecj-lint] ----------
[ecj-lint] 84. WARNING in /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/util/bkd/Test2BBKDPoints.java (at line 44)
[ecj-lint] BKDWriter w = new BKDWriter(numDocs, dir, "_0", 1, 1, Long.BYTES,
[ecj-lint] ^
[ecj-lint] Resource leak: 'w' is never closed
[ecj-lint] ----------
[ecj-lint] 85. WARNING in /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/util/bkd/Test2BBKDPoints.java (at line 81)
[ecj-lint] BKDWriter w = new BKDWriter(numDocs, dir, "_0", 2, 2, Long.BYTES,
[ecj-lint] ^
[ecj-lint] Resource leak: 'w' is never closed
[ecj-lint] ----------
[ecj-lint] ----------
[ecj-lint] 86. WARNING in /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/util/bkd/TestBKD.java (at line 51)
[ecj-lint] BKDWriter w = new BKDWriter(100, dir, "tmp", 1, 1, 4, 2, 1.0f, 100);
[ecj-lint] ^
[ecj-lint] Resource leak: 'w' is never closed
[ecj-lint] ----------
[ecj-lint] 87. WARNING in /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/util/bkd/TestBKD.java (at line 127)
[ecj-lint] BKDWriter w = new BKDWriter(numDocs, dir, "tmp", numDims, numIndexDims, 4, maxPointsInLeafNode, maxMB, numDocs);
[ecj-lint] ^
[ecj-lint] Resource leak: 'w' is never closed
[ecj-lint] ----------
[ecj-lint] 88. WARNING in /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/util/bkd/TestBKD.java (at line 268)
[ecj-lint] BKDWriter w = new BKDWriter(numDocs, dir, "tmp", numDims, numDims, numBytesPerDim, maxPointsInLeafNode, maxMB, numDocs);
[ecj-lint] ^
[ecj-lint] Resource leak: 'w' is never closed
[ecj-lint] ----------
[ecj-lint] 89. WARNING in /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/util/bkd/TestBKD.java (at line 760)
[ecj-lint] w = new BKDWriter(numValues, dir, "_" + seg, numDataDims, numIndexDims, numBytesPerDim, maxPointsInLeafNode, maxMB, docValues.length);
[ecj-lint] ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[ecj-lint] Resource leak: 'w' is not closed at this location
[ecj-lint] ----------
[ecj-lint] 90. WARNING in /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/util/bkd/TestBKD.java (at line 1019)
[ecj-lint] BKDWriter w = new BKDWriter(numDocs+1, dir, "tmp", 1, 1, Integer.BYTES, 2, 0.01f, numDocs);
[ecj-lint] ^
[ecj-lint] Resource leak: 'w' is never closed
[ecj-lint] ----------
[ecj-lint] 91. WARNING in /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/util/bkd/TestBKD.java (at line 1057)
[ecj-lint] BKDWriter w = new BKDWriter(numDocs+1, dir, "tmp", 2, 2, Integer.BYTES, 2, 0.01f, numDocs);
[ecj-lint] ^
[ecj-lint] Resource leak: 'w' is never closed
[ecj-lint] ----------
[ecj-lint] 92. WARNING in /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/util/bkd/TestBKD.java (at line 1108)
[ecj-lint] BKDWriter w = new BKDWriter(numDocs+1, dir, "tmp", numDims, numIndexDims, bytesPerDim, 32, 1f, numDocs);
[ecj-lint] ^
[ecj-lint] Resource leak: 'w' is never closed
[ecj-lint] ----------
[ecj-lint] ----------
[ecj-lint] 93. WARNING in /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/util/fst/TestFSTs.java (at line 311)
[ecj-lint] final LineFileDocs docs = new LineFileDocs(random());
[ecj-lint] ^^^^
[ecj-lint] Resource leak: 'docs' is never closed
[ecj-lint] ----------
[ecj-lint] 93 problems (1 error, 92 warnings)
BUILD FAILED
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/build.xml:633: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/build.xml:101: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build.xml:202: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/common-build.xml:2100: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/common-build.xml:2133: Compile failed; see the compiler error output for details.
Total time: 168 minutes 26 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
[JENKINS] Lucene-Solr-Tests-master - Build # 3258 - Failure
Posted by Apache Jenkins Server <je...@builds.apache.org>.
Build: https://builds.apache.org/job/Lucene-Solr-Tests-master/3258/
All tests passed
Build Log:
[...truncated 52551 lines...]
-ecj-javadoc-lint-tests:
[mkdir] Created dir: /tmp/ecj211469902
[ecj-lint] Compiling 527 source files to /tmp/ecj211469902
[ecj-lint] ----------
[ecj-lint] 1. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/TestAssertions.java (at line 44)
[ecj-lint] new TestTokenStream1();
[ecj-lint] ^^^^^^^^^^^^^^^^^^^^^^
[ecj-lint] Resource leak: '<unassigned Closeable value>' is never closed
[ecj-lint] ----------
[ecj-lint] 2. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/TestAssertions.java (at line 45)
[ecj-lint] new TestTokenStream2();
[ecj-lint] ^^^^^^^^^^^^^^^^^^^^^^
[ecj-lint] Resource leak: '<unassigned Closeable value>' is never closed
[ecj-lint] ----------
[ecj-lint] 3. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/TestAssertions.java (at line 47)
[ecj-lint] new TestTokenStream3();
[ecj-lint] ^^^^^^^^^^^^^^^^^^^^^^
[ecj-lint] Resource leak: '<unassigned Closeable value>' is never closed
[ecj-lint] ----------
[ecj-lint] ----------
[ecj-lint] 4. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/TestMergeSchedulerExternal.java (at line 130)
[ecj-lint] IndexWriter writer = new IndexWriter(dir, iwc);
[ecj-lint] ^^^^^^
[ecj-lint] Resource leak: 'writer' is never closed
[ecj-lint] ----------
[ecj-lint] ----------
[ecj-lint] 5. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/analysis/TestCachingTokenFilter.java (at line 120)
[ecj-lint] Analyzer analyzer = new MockAnalyzer(random());
[ecj-lint] ^^^^^^^^
[ecj-lint] Resource leak: 'analyzer' is never closed
[ecj-lint] ----------
[ecj-lint] 6. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/analysis/TestCachingTokenFilter.java (at line 122)
[ecj-lint] CachingTokenFilter buffer = new CachingTokenFilter(input);
[ecj-lint] ^^^^^^
[ecj-lint] Resource leak: 'buffer' is never closed
[ecj-lint] ----------
[ecj-lint] ----------
[ecj-lint] 7. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/analysis/TestCharFilter.java (at line 29)
[ecj-lint] CharFilter cs = new CharFilter1(new StringReader(""));
[ecj-lint] ^^
[ecj-lint] Resource leak: 'cs' is never closed
[ecj-lint] ----------
[ecj-lint] 8. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/analysis/TestCharFilter.java (at line 34)
[ecj-lint] CharFilter cs = new CharFilter2(new StringReader(""));
[ecj-lint] ^^
[ecj-lint] Resource leak: 'cs' is never closed
[ecj-lint] ----------
[ecj-lint] 9. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/analysis/TestCharFilter.java (at line 39)
[ecj-lint] CharFilter cs = new CharFilter2(new CharFilter1(new StringReader("")));
[ecj-lint] ^^
[ecj-lint] Resource leak: 'cs' is never closed
[ecj-lint] ----------
[ecj-lint] 10. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/analysis/TestCharFilter.java (at line 44)
[ecj-lint] CharFilter cs = new CharFilter1(new CharFilter1(new StringReader("")));
[ecj-lint] ^^
[ecj-lint] Resource leak: 'cs' is never closed
[ecj-lint] ----------
[ecj-lint] ----------
[ecj-lint] 11. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/analysis/TestDelegatingAnalyzerWrapper.java (at line 39)
[ecj-lint] DelegatingAnalyzerWrapper w2 = new DelegatingAnalyzerWrapper(Analyzer.GLOBAL_REUSE_STRATEGY) {
[ecj-lint] ^^
[ecj-lint] Resource leak: 'w2' is never closed
[ecj-lint] ----------
[ecj-lint] 12. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/analysis/TestDelegatingAnalyzerWrapper.java (at line 50)
[ecj-lint] DelegatingAnalyzerWrapper w1 = new DelegatingAnalyzerWrapper(Analyzer.GLOBAL_REUSE_STRATEGY) {
[ecj-lint] ^^
[ecj-lint] Resource leak: 'w1' is never closed
[ecj-lint] ----------
[ecj-lint] 13. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/analysis/TestDelegatingAnalyzerWrapper.java (at line 71)
[ecj-lint] DelegatingAnalyzerWrapper w1 = new DelegatingAnalyzerWrapper(Analyzer.GLOBAL_REUSE_STRATEGY) {
[ecj-lint] ^^
[ecj-lint] Resource leak: 'w1' is never closed
[ecj-lint] ----------
[ecj-lint] ----------
[ecj-lint] 14. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/analysis/TestGraphTokenFilter.java (at line 43)
[ecj-lint] GraphTokenFilter graph = new TestFilter(tok);
[ecj-lint] ^^^^^
[ecj-lint] Resource leak: 'graph' is never closed
[ecj-lint] ----------
[ecj-lint] 15. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/analysis/TestGraphTokenFilter.java (at line 174)
[ecj-lint] GraphTokenFilter gts = new TestFilter(cts);
[ecj-lint] ^^^
[ecj-lint] Resource leak: 'gts' is never closed
[ecj-lint] ----------
[ecj-lint] 16. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/analysis/TestGraphTokenFilter.java (at line 194)
[ecj-lint] GraphTokenFilter gts = new TestFilter(new CannedTokenStream(tokens));
[ecj-lint] ^^^
[ecj-lint] Resource leak: 'gts' is never closed
[ecj-lint] ----------
[ecj-lint] 17. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/analysis/TestGraphTokenFilter.java (at line 221)
[ecj-lint] GraphTokenFilter graph = new TestFilter(new CannedTokenStream(tokens));
[ecj-lint] ^^^^^
[ecj-lint] Resource leak: 'graph' is never closed
[ecj-lint] ----------
[ecj-lint] ----------
[ecj-lint] 18. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/analysis/TestToken.java (at line 103)
[ecj-lint] TokenStream ts = new MockTokenizer(Token.TOKEN_ATTRIBUTE_FACTORY, MockTokenizer.WHITESPACE, false, MockTokenizer.DEFAULT_MAX_TOKEN_LENGTH);
[ecj-lint] ^^
[ecj-lint] Resource leak: 'ts' is never closed
[ecj-lint] ----------
[ecj-lint] ----------
[ecj-lint] 19. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/analysis/standard/TestStandardAnalyzer.java (at line 469)
[ecj-lint] Analyzer a = new StandardAnalyzer();
[ecj-lint] ^
[ecj-lint] Resource leak: 'a' is never closed
[ecj-lint] ----------
[ecj-lint] 20. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/analysis/standard/TestStandardAnalyzer.java (at line 500)
[ecj-lint] StandardAnalyzer a = new StandardAnalyzer();
[ecj-lint] ^
[ecj-lint] Resource leak: 'a' is never closed
[ecj-lint] ----------
[ecj-lint] ----------
[ecj-lint] 21. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/analysis/tokenattributes/TestCharTermAttributeImpl.java (at line 172)
[ecj-lint] Formatter formatter = new Formatter(t, Locale.ROOT);
[ecj-lint] ^^^^^^^^^
[ecj-lint] Resource leak: 'formatter' is never closed
[ecj-lint] ----------
[ecj-lint] ----------
[ecj-lint] 22. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/analysis/tokenattributes/TestPackedTokenAttributeImpl.java (at line 62)
[ecj-lint] TokenStream ts = new MockTokenizer(TokenStream.DEFAULT_TOKEN_ATTRIBUTE_FACTORY, MockTokenizer.WHITESPACE, false, MockTokenizer.DEFAULT_MAX_TOKEN_LENGTH);
[ecj-lint] ^^
[ecj-lint] Resource leak: 'ts' is never closed
[ecj-lint] ----------
[ecj-lint] ----------
[ecj-lint] 23. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/index/TestAddIndexes.java (at line 424)
[ecj-lint] IndexWriter writer = new IndexWriter(aux, dontMergeConfig);
[ecj-lint] ^^^^^^
[ecj-lint] Resource leak: 'writer' is never closed
[ecj-lint] ----------
[ecj-lint] 24. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/index/TestAddIndexes.java (at line 1431)
[ecj-lint] DirectoryReader wrappedReader = new SoftDeletesDirectoryReaderWrapper(reader, "soft_delete");
[ecj-lint] ^^^^^^^^^^^^^
[ecj-lint] Resource leak: 'wrappedReader' is never closed
[ecj-lint] ----------
[ecj-lint] ----------
[ecj-lint] 25. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/index/TestAllFilesCheckIndexHeader.java (at line 58)
[ecj-lint] LineFileDocs docs = new LineFileDocs(random());
[ecj-lint] ^^^^
[ecj-lint] Resource leak: 'docs' is never closed
[ecj-lint] ----------
[ecj-lint] ----------
[ecj-lint] 26. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/index/TestAllFilesDetectTruncation.java (at line 55)
[ecj-lint] LineFileDocs docs = new LineFileDocs(random());
[ecj-lint] ^^^^
[ecj-lint] Resource leak: 'docs' is never closed
[ecj-lint] ----------
[ecj-lint] ----------
[ecj-lint] 27. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/index/TestAllFilesHaveChecksumFooter.java (at line 41)
[ecj-lint] LineFileDocs docs = new LineFileDocs(random());
[ecj-lint] ^^^^
[ecj-lint] Resource leak: 'docs' is never closed
[ecj-lint] ----------
[ecj-lint] ----------
[ecj-lint] 28. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/index/TestAllFilesHaveCodecHeader.java (at line 44)
[ecj-lint] LineFileDocs docs = new LineFileDocs(random());
[ecj-lint] ^^^^
[ecj-lint] Resource leak: 'docs' is never closed
[ecj-lint] ----------
[ecj-lint] ----------
[ecj-lint] 29. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/index/TestConcurrentMergeScheduler.java (at line 394)
[ecj-lint] ConcurrentMergeScheduler cms = new ConcurrentMergeScheduler();
[ecj-lint] ^^^
[ecj-lint] Resource leak: 'cms' is never closed
[ecj-lint] ----------
[ecj-lint] 30. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/index/TestConcurrentMergeScheduler.java (at line 520)
[ecj-lint] final IndexWriter w = new IndexWriter(dir, iwc);
[ecj-lint] ^
[ecj-lint] Resource leak: 'w' is never closed
[ecj-lint] ----------
[ecj-lint] 31. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/index/TestConcurrentMergeScheduler.java (at line 592)
[ecj-lint] ConcurrentMergeScheduler cms = new ConcurrentMergeScheduler();
[ecj-lint] ^^^
[ecj-lint] Resource leak: 'cms' is never closed
[ecj-lint] ----------
[ecj-lint] 32. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/index/TestConcurrentMergeScheduler.java (at line 613)
[ecj-lint] ConcurrentMergeScheduler cms = new ConcurrentMergeScheduler();
[ecj-lint] ^^^
[ecj-lint] Resource leak: 'cms' is never closed
[ecj-lint] ----------
[ecj-lint] 33. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/index/TestConcurrentMergeScheduler.java (at line 620)
[ecj-lint] ConcurrentMergeScheduler cms = new ConcurrentMergeScheduler();
[ecj-lint] ^^^
[ecj-lint] Resource leak: 'cms' is never closed
[ecj-lint] ----------
[ecj-lint] 34. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/index/TestConcurrentMergeScheduler.java (at line 628)
[ecj-lint] ConcurrentMergeScheduler cms = new ConcurrentMergeScheduler();
[ecj-lint] ^^^
[ecj-lint] Resource leak: 'cms' is never closed
[ecj-lint] ----------
[ecj-lint] ----------
[ecj-lint] 35. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/index/TestDeletionPolicy.java (at line 451)
[ecj-lint] writer = new IndexWriter(dir, newIndexWriterConfig(new MockAnalyzer(random()))
[ecj-lint] .setIndexDeletionPolicy(policy)
[ecj-lint] .setIndexCommit(lastCommit));
[ecj-lint] ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[ecj-lint] Resource leak: 'writer' is not closed at this location
[ecj-lint] ----------
[ecj-lint] ----------
[ecj-lint] 36. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/index/TestDocValuesIndexing.java (at line 835)
[ecj-lint] IndexWriter writer = new IndexWriter(dir, conf);
[ecj-lint] ^^^^^^
[ecj-lint] Resource leak: 'writer' is never closed
[ecj-lint] ----------
[ecj-lint] ----------
[ecj-lint] 37. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/index/TestForceMergeForever.java (at line 82)
[ecj-lint] return;
[ecj-lint] ^^^^^^^
[ecj-lint] Resource leak: 'docs' is not closed at this location
[ecj-lint] ----------
[ecj-lint] ----------
[ecj-lint] 38. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/index/TestIndexFileDeleter.java (at line 451)
[ecj-lint] RandomIndexWriter w = new RandomIndexWriter(random(), dir, iwc);
[ecj-lint] ^
[ecj-lint] Resource leak: 'w' is never closed
[ecj-lint] ----------
[ecj-lint] ----------
[ecj-lint] 39. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/index/TestIndexWriter.java (at line 210)
[ecj-lint] new IndexWriter(dir, new IndexWriterConfig(new MockAnalyzer(random()))).rollback();
[ecj-lint] ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[ecj-lint] Resource leak: '<unassigned Closeable value>' is never closed
[ecj-lint] ----------
[ecj-lint] 40. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/index/TestIndexWriter.java (at line 1694)
[ecj-lint] IndexWriter w = new IndexWriter(dir,
[ecj-lint] ^
[ecj-lint] Resource leak: 'w' is never closed
[ecj-lint] ----------
[ecj-lint] 41. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/index/TestIndexWriter.java (at line 1706)
[ecj-lint] IndexWriter w = new IndexWriter(dir,
[ecj-lint] ^
[ecj-lint] Resource leak: 'w' is never closed
[ecj-lint] ----------
[ecj-lint] 42. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/index/TestIndexWriter.java (at line 3580)
[ecj-lint] new IndexWriter(dir, config);
[ecj-lint] ^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[ecj-lint] Resource leak: '<unassigned Closeable value>' is never closed
[ecj-lint] ----------
[ecj-lint] ----------
[ecj-lint] 43. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/index/TestIndexWriterCommit.java (at line 297)
[ecj-lint] writer = new IndexWriter(dir, newIndexWriterConfig(new MockAnalyzer(random()))
[ecj-lint] .setOpenMode(OpenMode.APPEND));
[ecj-lint] ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[ecj-lint] Resource leak: 'writer' is not closed at this location
[ecj-lint] ----------
[ecj-lint] ----------
[ecj-lint] 44. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/index/TestIndexWriterDelete.java (at line 912)
[ecj-lint] IndexWriter modifier = new IndexWriter(dir, newIndexWriterConfig(new MockAnalyzer(random(), MockTokenizer.WHITESPACE, false)));
[ecj-lint] ^^^^^^^^
[ecj-lint] Resource leak: 'modifier' is never closed
[ecj-lint] ----------
[ecj-lint] ----------
[ecj-lint] 45. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/index/TestIndexWriterExceptions.java (at line 597)
[ecj-lint] IndexWriter writer = new IndexWriter(dir, newIndexWriterConfig(new MockAnalyzer(random()))
[ecj-lint] ^^^^^^
[ecj-lint] Resource leak: 'writer' is never closed
[ecj-lint] ----------
[ecj-lint] ----------
[ecj-lint] 46. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/index/TestIndexWriterLockRelease.java (at line 39)
[ecj-lint] new IndexWriter(dir, new IndexWriterConfig(new MockAnalyzer(random())).setOpenMode(OpenMode.APPEND));
[ecj-lint] ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[ecj-lint] Resource leak: '<unassigned Closeable value>' is never closed
[ecj-lint] ----------
[ecj-lint] 47. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/index/TestIndexWriterLockRelease.java (at line 42)
[ecj-lint] new IndexWriter(dir, new IndexWriterConfig(new MockAnalyzer(random())).setOpenMode(OpenMode.APPEND));
[ecj-lint] ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[ecj-lint] Resource leak: '<unassigned Closeable value>' is never closed
[ecj-lint] ----------
[ecj-lint] ----------
[ecj-lint] 48. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/index/TestIndexWriterMaxDocs.java (at line 313)
[ecj-lint] MultiReader mr = new MultiReader(subReaders);
[ecj-lint] ^^
[ecj-lint] Resource leak: 'mr' is never closed
[ecj-lint] ----------
[ecj-lint] 49. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/index/TestIndexWriterMaxDocs.java (at line 401)
[ecj-lint] throw e;
[ecj-lint] ^^^^^^^^
[ecj-lint] Resource leak: 'w' is not closed at this location
[ecj-lint] ----------
[ecj-lint] 50. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/index/TestIndexWriterMaxDocs.java (at line 450)
[ecj-lint] throw e;
[ecj-lint] ^^^^^^^^
[ecj-lint] Resource leak: 'w' is not closed at this location
[ecj-lint] ----------
[ecj-lint] ----------
[ecj-lint] 51. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/index/TestIndexWriterOnDiskFull.java (at line 499)
[ecj-lint] IndexWriter w = new IndexWriter(
[ecj-lint] ^
[ecj-lint] Resource leak: 'w' is never closed
[ecj-lint] ----------
[ecj-lint] 52. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/index/TestIndexWriterOnDiskFull.java (at line 545)
[ecj-lint] IndexWriter writer = new IndexWriter(dir, newIndexWriterConfig(new MockAnalyzer(random()))
[ecj-lint] ^^^^^^
[ecj-lint] Resource leak: 'writer' is never closed
[ecj-lint] ----------
[ecj-lint] ----------
[ecj-lint] 53. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/index/TestIndexWriterOutOfFileDescriptors.java (at line 40)
[ecj-lint] LineFileDocs docs = new LineFileDocs(random());
[ecj-lint] ^^^^
[ecj-lint] Resource leak: 'docs' is never closed
[ecj-lint] ----------
[ecj-lint] ----------
[ecj-lint] 54. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/index/TestIndexWriterWithThreads.java (at line 585)
[ecj-lint] final LineFileDocs docs = new LineFileDocs(random());
[ecj-lint] ^^^^
[ecj-lint] Resource leak: 'docs' is never closed
[ecj-lint] ----------
[ecj-lint] ----------
[ecj-lint] 55. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/index/TestLongPostings.java (at line 44)
[ecj-lint] Analyzer a = new MockAnalyzer(random());
[ecj-lint] ^
[ecj-lint] Resource leak: 'a' is never closed
[ecj-lint] ----------
[ecj-lint] ----------
[ecj-lint] 56. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/index/TestParallelReaderEmptyIndex.java (at line 57)
[ecj-lint] ParallelCompositeReader cpr = new ParallelCompositeReader(
[ecj-lint] ^^^
[ecj-lint] Resource leak: 'cpr' is never closed
[ecj-lint] ----------
[ecj-lint] ----------
[ecj-lint] 57. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/index/TestParallelTermEnum.java (at line 90)
[ecj-lint] ParallelLeafReader pr = new ParallelLeafReader(ir1, ir2);
[ecj-lint] ^^
[ecj-lint] Resource leak: 'pr' is never closed
[ecj-lint] ----------
[ecj-lint] ----------
[ecj-lint] 58. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/index/TestPersistentSnapshotDeletionPolicy.java (at line 139)
[ecj-lint] throw ioe;
[ecj-lint] ^^^^^^^^^^
[ecj-lint] Resource leak: 'writer' is not closed at this location
[ecj-lint] ----------
[ecj-lint] ----------
[ecj-lint] 59. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/index/TestReaderPool.java (at line 234)
[ecj-lint] throw new AssertionError(ex);
[ecj-lint] ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[ecj-lint] Resource leak: 'pool' is not closed at this location
[ecj-lint] ----------
[ecj-lint] ----------
[ecj-lint] 60. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/index/TestRollback.java (at line 40)
[ecj-lint] IndexWriter w = new IndexWriter(dir, newIndexWriterConfig(new MockAnalyzer(random()))
[ecj-lint] ^
[ecj-lint] Resource leak: 'w' is never closed
[ecj-lint] ----------
[ecj-lint] ----------
[ecj-lint] 61. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/index/TestSoftDeletesRetentionMergePolicy.java (at line 470)
[ecj-lint] throw new AssertionError(e);
[ecj-lint] ^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[ecj-lint] Resource leak: 'writer' is not closed at this location
[ecj-lint] ----------
[ecj-lint] 62. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/index/TestSoftDeletesRetentionMergePolicy.java (at line 536)
[ecj-lint] throw new AssertionError(e);
[ecj-lint] ^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[ecj-lint] Resource leak: 'writer' is not closed at this location
[ecj-lint] ----------
[ecj-lint] 63. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/index/TestSoftDeletesRetentionMergePolicy.java (at line 675)
[ecj-lint] DirectoryReader reader = new IncludeSoftDeletesWrapper(unwrapped);
[ecj-lint] ^^^^^^
[ecj-lint] Resource leak: 'reader' is never closed
[ecj-lint] ----------
[ecj-lint] ----------
[ecj-lint] 64. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/index/TestSwappedIndexFiles.java (at line 50)
[ecj-lint] LineFileDocs docs = new LineFileDocs(random());
[ecj-lint] ^^^^
[ecj-lint] Resource leak: 'docs' is never closed
[ecj-lint] ----------
[ecj-lint] ----------
[ecj-lint] 65. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/index/TestTryDelete.java (at line 79)
[ecj-lint] ReferenceManager<IndexSearcher> mgr = new SearcherManager(writer,
[ecj-lint] ^^^
[ecj-lint] Resource leak: 'mgr' is never closed
[ecj-lint] ----------
[ecj-lint] 66. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/index/TestTryDelete.java (at line 124)
[ecj-lint] ReferenceManager<IndexSearcher> mgr = new SearcherManager(writer,
[ecj-lint] ^^^
[ecj-lint] Resource leak: 'mgr' is never closed
[ecj-lint] ----------
[ecj-lint] 67. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/index/TestTryDelete.java (at line 166)
[ecj-lint] ReferenceManager<IndexSearcher> mgr = new SearcherManager(writer,
[ecj-lint] ^^^
[ecj-lint] Resource leak: 'mgr' is never closed
[ecj-lint] ----------
[ecj-lint] ----------
[ecj-lint] 68. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/search/TestFuzzyQuery.java (at line 406)
[ecj-lint] MockAnalyzer analyzer = new MockAnalyzer(random());
[ecj-lint] ^^^^^^^^
[ecj-lint] Resource leak: 'analyzer' is never closed
[ecj-lint] ----------
[ecj-lint] 69. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/search/TestFuzzyQuery.java (at line 524)
[ecj-lint] RandomIndexWriter w = new RandomIndexWriter(random(), dir);
[ecj-lint] ^
[ecj-lint] Resource leak: 'w' is never closed
[ecj-lint] ----------
[ecj-lint] ----------
[ecj-lint] 70. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/search/TestLRUQueryCache.java (at line 178)
[ecj-lint] throw error.get();
[ecj-lint] ^^^^^^^^^^^^^^^^^^
[ecj-lint] Resource leak: 'mgr' is not closed at this location
[ecj-lint] ----------
[ecj-lint] 71. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/search/TestLRUQueryCache.java (at line 178)
[ecj-lint] throw error.get();
[ecj-lint] ^^^^^^^^^^^^^^^^^^
[ecj-lint] Resource leak: 'w' is not closed at this location
[ecj-lint] ----------
[ecj-lint] ----------
[ecj-lint] 72. ERROR in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/search/TestMatchesIterator.java (at line 37)
[ecj-lint] import org.apache.lucene.index.NumericDocValues;
[ecj-lint] ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[ecj-lint] The import org.apache.lucene.index.NumericDocValues is never used
[ecj-lint] ----------
[ecj-lint] ----------
[ecj-lint] 73. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/search/TestSameScoresWithThreads.java (at line 49)
[ecj-lint] LineFileDocs docs = new LineFileDocs(random());
[ecj-lint] ^^^^
[ecj-lint] Resource leak: 'docs' is never closed
[ecj-lint] ----------
[ecj-lint] ----------
[ecj-lint] 74. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/search/TestSearcherManager.java (at line 313)
[ecj-lint] SearcherManager sm = new SearcherManager(writer, false, false, new SearcherFactory());
[ecj-lint] ^^
[ecj-lint] Resource leak: 'sm' is never closed
[ecj-lint] ----------
[ecj-lint] ----------
[ecj-lint] 75. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/search/TestTermQuery.java (at line 52)
[ecj-lint] new TermQuery(new Term("foo", "bar"), TermStates.build(new MultiReader().getContext(), new Term("foo", "bar"), true)));
[ecj-lint] ^^^^^^^^^^^^^^^^^
[ecj-lint] Resource leak: '<unassigned Closeable value>' is never closed
[ecj-lint] ----------
[ecj-lint] ----------
[ecj-lint] 76. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/store/TestBufferedIndexInput.java (at line 50)
[ecj-lint] MyBufferedIndexInput input = new MyBufferedIndexInput();
[ecj-lint] ^^^^^
[ecj-lint] Resource leak: 'input' is never closed
[ecj-lint] ----------
[ecj-lint] ----------
[ecj-lint] 77. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/store/TestTrackingDirectoryWrapper.java (at line 32)
[ecj-lint] TrackingDirectoryWrapper dir = new TrackingDirectoryWrapper(new ByteBuffersDirectory());
[ecj-lint] ^^^
[ecj-lint] Resource leak: 'dir' is never closed
[ecj-lint] ----------
[ecj-lint] 78. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/store/TestTrackingDirectoryWrapper.java (at line 37)
[ecj-lint] TrackingDirectoryWrapper dir = new TrackingDirectoryWrapper(new ByteBuffersDirectory());
[ecj-lint] ^^^
[ecj-lint] Resource leak: 'dir' is never closed
[ecj-lint] ----------
[ecj-lint] 79. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/store/TestTrackingDirectoryWrapper.java (at line 43)
[ecj-lint] TrackingDirectoryWrapper dir = new TrackingDirectoryWrapper(new ByteBuffersDirectory());
[ecj-lint] ^^^
[ecj-lint] Resource leak: 'dir' is never closed
[ecj-lint] ----------
[ecj-lint] 80. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/store/TestTrackingDirectoryWrapper.java (at line 51)
[ecj-lint] TrackingDirectoryWrapper dir = new TrackingDirectoryWrapper(new ByteBuffersDirectory());
[ecj-lint] ^^^
[ecj-lint] Resource leak: 'dir' is never closed
[ecj-lint] ----------
[ecj-lint] 81. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/store/TestTrackingDirectoryWrapper.java (at line 60)
[ecj-lint] TrackingDirectoryWrapper dest = new TrackingDirectoryWrapper(new ByteBuffersDirectory());
[ecj-lint] ^^^^
[ecj-lint] Resource leak: 'dest' is never closed
[ecj-lint] ----------
[ecj-lint] ----------
[ecj-lint] 82. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/util/TestCloseableThreadLocal.java (at line 31)
[ecj-lint] CloseableThreadLocal<Object> ctl = new CloseableThreadLocal<>();
[ecj-lint] ^^^
[ecj-lint] Resource leak: 'ctl' is never closed
[ecj-lint] ----------
[ecj-lint] 83. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/util/TestCloseableThreadLocal.java (at line 39)
[ecj-lint] CloseableThreadLocal<Object> ctl = new CloseableThreadLocal<>();
[ecj-lint] ^^^
[ecj-lint] Resource leak: 'ctl' is never closed
[ecj-lint] ----------
[ecj-lint] ----------
[ecj-lint] 84. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/util/bkd/Test2BBKDPoints.java (at line 44)
[ecj-lint] BKDWriter w = new BKDWriter(numDocs, dir, "_0", 1, 1, Long.BYTES,
[ecj-lint] ^
[ecj-lint] Resource leak: 'w' is never closed
[ecj-lint] ----------
[ecj-lint] 85. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/util/bkd/Test2BBKDPoints.java (at line 81)
[ecj-lint] BKDWriter w = new BKDWriter(numDocs, dir, "_0", 2, 2, Long.BYTES,
[ecj-lint] ^
[ecj-lint] Resource leak: 'w' is never closed
[ecj-lint] ----------
[ecj-lint] ----------
[ecj-lint] 86. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/util/bkd/TestBKD.java (at line 51)
[ecj-lint] BKDWriter w = new BKDWriter(100, dir, "tmp", 1, 1, 4, 2, 1.0f, 100);
[ecj-lint] ^
[ecj-lint] Resource leak: 'w' is never closed
[ecj-lint] ----------
[ecj-lint] 87. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/util/bkd/TestBKD.java (at line 127)
[ecj-lint] BKDWriter w = new BKDWriter(numDocs, dir, "tmp", numDims, numIndexDims, 4, maxPointsInLeafNode, maxMB, numDocs);
[ecj-lint] ^
[ecj-lint] Resource leak: 'w' is never closed
[ecj-lint] ----------
[ecj-lint] 88. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/util/bkd/TestBKD.java (at line 268)
[ecj-lint] BKDWriter w = new BKDWriter(numDocs, dir, "tmp", numDims, numDims, numBytesPerDim, maxPointsInLeafNode, maxMB, numDocs);
[ecj-lint] ^
[ecj-lint] Resource leak: 'w' is never closed
[ecj-lint] ----------
[ecj-lint] 89. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/util/bkd/TestBKD.java (at line 760)
[ecj-lint] w = new BKDWriter(numValues, dir, "_" + seg, numDataDims, numIndexDims, numBytesPerDim, maxPointsInLeafNode, maxMB, docValues.length);
[ecj-lint] ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[ecj-lint] Resource leak: 'w' is not closed at this location
[ecj-lint] ----------
[ecj-lint] 90. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/util/bkd/TestBKD.java (at line 1019)
[ecj-lint] BKDWriter w = new BKDWriter(numDocs+1, dir, "tmp", 1, 1, Integer.BYTES, 2, 0.01f, numDocs);
[ecj-lint] ^
[ecj-lint] Resource leak: 'w' is never closed
[ecj-lint] ----------
[ecj-lint] 91. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/util/bkd/TestBKD.java (at line 1057)
[ecj-lint] BKDWriter w = new BKDWriter(numDocs+1, dir, "tmp", 2, 2, Integer.BYTES, 2, 0.01f, numDocs);
[ecj-lint] ^
[ecj-lint] Resource leak: 'w' is never closed
[ecj-lint] ----------
[ecj-lint] 92. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/util/bkd/TestBKD.java (at line 1108)
[ecj-lint] BKDWriter w = new BKDWriter(numDocs+1, dir, "tmp", numDims, numIndexDims, bytesPerDim, 32, 1f, numDocs);
[ecj-lint] ^
[ecj-lint] Resource leak: 'w' is never closed
[ecj-lint] ----------
[ecj-lint] ----------
[ecj-lint] 93. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/core/src/test/org/apache/lucene/util/fst/TestFSTs.java (at line 311)
[ecj-lint] final LineFileDocs docs = new LineFileDocs(random());
[ecj-lint] ^^^^
[ecj-lint] Resource leak: 'docs' is never closed
[ecj-lint] ----------
[ecj-lint] 93 problems (1 error, 92 warnings)
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/build.xml:633: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/build.xml:101: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build.xml:202: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/common-build.xml:2100: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/common-build.xml:2133: Compile failed; see the compiler error output for details.
Total time: 100 minutes 2 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any