You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2019/04/03 22:41:38 UTC
[JENKINS] Lucene-Solr-8.x-Windows (64bit/jdk-11) - Build # 186 -
Unstable!
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-8.x-Windows/186/
Java: 64bit/jdk-11 -XX:+UseCompressedOops -XX:+UseG1GC
1 tests failed.
FAILED: junit.framework.TestSuite.org.apache.solr.client.solrj.impl.CloudHttp2SolrClientTest
Error Message:
ObjectTracker found 2 object(s) that were not released!!! [SolrCore, MockDirectoryWrapper] org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.solr.core.SolrCore at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:1063) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:883) at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1193) at org.apache.solr.core.CoreContainer.create(CoreContainer.java:1103) at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:92) at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:360) at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:396) at org.apache.solr.handler.admin.CoreAdminHandler.lambda$handleRequestBody$0(CoreAdminHandler.java:188) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:176) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) at java.base/java.lang.Thread.run(Thread.java:834) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MockDirectoryWrapper at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348) at org.apache.solr.update.SolrIndexWriter.create(SolrIndexWriter.java:99) at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:779) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:976) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:883) at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1193) at org.apache.solr.core.CoreContainer.create(CoreContainer.java:1103) at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:92) at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:360) at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:396) at org.apache.solr.handler.admin.CoreAdminHandler.lambda$handleRequestBody$0(CoreAdminHandler.java:188) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:176) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) at java.base/java.lang.Thread.run(Thread.java:834) expected null, but was:<ObjectTracker found 2 object(s) that were not released!!! [SolrCore, MockDirectoryWrapper] org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.solr.core.SolrCore at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:1063) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:883) at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1193) at org.apache.solr.core.CoreContainer.create(CoreContainer.java:1103) at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:92) at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:360) at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:396) at org.apache.solr.handler.admin.CoreAdminHandler.lambda$handleRequestBody$0(CoreAdminHandler.java:188) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:176) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) at java.base/java.lang.Thread.run(Thread.java:834) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MockDirectoryWrapper at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348) at org.apache.solr.update.SolrIndexWriter.create(SolrIndexWriter.java:99) at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:779) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:976) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:883) at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1193) at org.apache.solr.core.CoreContainer.create(CoreContainer.java:1103) at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:92) at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:360) at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:396) at org.apache.solr.handler.admin.CoreAdminHandler.lambda$handleRequestBody$0(CoreAdminHandler.java:188) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:176) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) at java.base/java.lang.Thread.run(Thread.java:834) >
Stack Trace:
java.lang.AssertionError: ObjectTracker found 2 object(s) that were not released!!! [SolrCore, MockDirectoryWrapper]
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.solr.core.SolrCore
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:1063)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:883)
at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1193)
at org.apache.solr.core.CoreContainer.create(CoreContainer.java:1103)
at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:92)
at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:360)
at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:396)
at org.apache.solr.handler.admin.CoreAdminHandler.lambda$handleRequestBody$0(CoreAdminHandler.java:188)
at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:176)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209)
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
at java.base/java.lang.Thread.run(Thread.java:834)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MockDirectoryWrapper
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348)
at org.apache.solr.update.SolrIndexWriter.create(SolrIndexWriter.java:99)
at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:779)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:976)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:883)
at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1193)
at org.apache.solr.core.CoreContainer.create(CoreContainer.java:1103)
at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:92)
at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:360)
at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:396)
at org.apache.solr.handler.admin.CoreAdminHandler.lambda$handleRequestBody$0(CoreAdminHandler.java:188)
at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:176)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209)
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
at java.base/java.lang.Thread.run(Thread.java:834)
expected null, but was:<ObjectTracker found 2 object(s) that were not released!!! [SolrCore, MockDirectoryWrapper]
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.solr.core.SolrCore
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:1063)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:883)
at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1193)
at org.apache.solr.core.CoreContainer.create(CoreContainer.java:1103)
at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:92)
at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:360)
at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:396)
at org.apache.solr.handler.admin.CoreAdminHandler.lambda$handleRequestBody$0(CoreAdminHandler.java:188)
at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:176)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209)
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
at java.base/java.lang.Thread.run(Thread.java:834)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MockDirectoryWrapper
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348)
at org.apache.solr.update.SolrIndexWriter.create(SolrIndexWriter.java:99)
at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:779)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:976)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:883)
at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1193)
at org.apache.solr.core.CoreContainer.create(CoreContainer.java:1103)
at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:92)
at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:360)
at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:396)
at org.apache.solr.handler.admin.CoreAdminHandler.lambda$handleRequestBody$0(CoreAdminHandler.java:188)
at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:176)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209)
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
at java.base/java.lang.Thread.run(Thread.java:834)
>
at __randomizedtesting.SeedInfo.seed([7F9E81B62DB59F2C]: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:325)
at jdk.internal.reflect.GeneratedMethodAccessor38.invoke(Unknown Source)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:566)
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 org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:834)
Build Log:
[...truncated 16567 lines...]
[junit4] Suite: org.apache.solr.client.solrj.impl.CloudHttp2SolrClientTest
[junit4] 2> 360655 INFO (SUITE-CloudHttp2SolrClientTest-seed#[7F9E81B62DB59F2C]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> Creating dataDir: C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.impl.CloudHttp2SolrClientTest_7F9E81B62DB59F2C-001\init-core-data-001
[junit4] 2> 360656 WARN (SUITE-CloudHttp2SolrClientTest-seed#[7F9E81B62DB59F2C]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=2 numCloses=2
[junit4] 2> 360656 INFO (SUITE-CloudHttp2SolrClientTest-seed#[7F9E81B62DB59F2C]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 360657 INFO (SUITE-CloudHttp2SolrClientTest-seed#[7F9E81B62DB59F2C]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason="", value=0.0/0.0, ssl=0.0/0.0, clientAuth=0.0/0.0)
[junit4] 2> 360659 INFO (TEST-CloudHttp2SolrClientTest.testAliasHandling-seed#[7F9E81B62DB59F2C]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testAliasHandling
[junit4] 2> 360660 INFO (TEST-CloudHttp2SolrClientTest.testAliasHandling-seed#[7F9E81B62DB59F2C]) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 3 servers in C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.impl.CloudHttp2SolrClientTest_7F9E81B62DB59F2C-001\tempDir-001
[junit4] 2> 360661 INFO (TEST-CloudHttp2SolrClientTest.testAliasHandling-seed#[7F9E81B62DB59F2C]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 360661 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 360661 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 360761 INFO (TEST-CloudHttp2SolrClientTest.testAliasHandling-seed#[7F9E81B62DB59F2C]) [ ] o.a.s.c.ZkTestServer start zk server on port:57296
[junit4] 2> 360761 INFO (TEST-CloudHttp2SolrClientTest.testAliasHandling-seed#[7F9E81B62DB59F2C]) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:57296
[junit4] 2> 360761 INFO (TEST-CloudHttp2SolrClientTest.testAliasHandling-seed#[7F9E81B62DB59F2C]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 57296
[junit4] 2> 360767 INFO (zkConnectionManagerCallback-4125-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 360771 INFO (zkConnectionManagerCallback-4127-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 360774 INFO (zkConnectionManagerCallback-4129-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 360776 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 0x1006d31dfb40002, likely client has closed socket
[junit4] 2> 360777 WARN (jetty-launcher-4130-thread-2) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 360777 WARN (jetty-launcher-4130-thread-1) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 360777 INFO (jetty-launcher-4130-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
[junit4] 2> 360777 INFO (jetty-launcher-4130-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 360777 INFO (jetty-launcher-4130-thread-2) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 11+28
[junit4] 2> 360777 INFO (jetty-launcher-4130-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
[junit4] 2> 360777 INFO (jetty-launcher-4130-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 360777 INFO (jetty-launcher-4130-thread-1) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 11+28
[junit4] 2> 360777 WARN (jetty-launcher-4130-thread-3) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 360777 INFO (jetty-launcher-4130-thread-2) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 360777 INFO (jetty-launcher-4130-thread-2) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 360777 INFO (jetty-launcher-4130-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
[junit4] 2> 360777 INFO (jetty-launcher-4130-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 360777 INFO (jetty-launcher-4130-thread-2) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 360777 INFO (jetty-launcher-4130-thread-3) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 11+28
[junit4] 2> 360778 INFO (jetty-launcher-4130-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@337eda54{/solr,null,AVAILABLE}
[junit4] 2> 360778 INFO (jetty-launcher-4130-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 360778 INFO (jetty-launcher-4130-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 360778 INFO (jetty-launcher-4130-thread-1) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 360779 INFO (jetty-launcher-4130-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@5cbfda5d{/solr,null,AVAILABLE}
[junit4] 2> 360779 INFO (jetty-launcher-4130-thread-3) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 360779 INFO (jetty-launcher-4130-thread-3) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 360779 INFO (jetty-launcher-4130-thread-3) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 360780 INFO (jetty-launcher-4130-thread-3) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@2f64efd7{/solr,null,AVAILABLE}
[junit4] 2> 360783 INFO (jetty-launcher-4130-thread-3) [ ] o.e.j.s.AbstractConnector Started ServerConnector@2e79a3b4{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:?????}
[junit4] 2> 360783 INFO (jetty-launcher-4130-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@d18c8f5{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:?????}
[junit4] 2> 360783 INFO (jetty-launcher-4130-thread-3) [ ] o.e.j.s.Server Started @??????ms
[junit4] 2> 360783 INFO (jetty-launcher-4130-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=57313}
[junit4] 2> 360784 ERROR (jetty-launcher-4130-thread-3) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 360784 INFO (jetty-launcher-4130-thread-3) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 360784 INFO (jetty-launcher-4130-thread-3) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.1.0
[junit4] 2> 360784 INFO (jetty-launcher-4130-thread-3) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 360784 INFO (jetty-launcher-4130-thread-3) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 360784 INFO (jetty-launcher-4130-thread-3) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-04-03T22:14:46.090012300Z
[junit4] 2> 360785 INFO (jetty-launcher-4130-thread-2) [ ] o.e.j.s.Server Started @??????ms
[junit4] 2> 360785 INFO (jetty-launcher-4130-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=57307}
[junit4] 2> 360785 ERROR (jetty-launcher-4130-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 360785 INFO (jetty-launcher-4130-thread-2) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 360785 INFO (jetty-launcher-4130-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.1.0
[junit4] 2> 360785 INFO (jetty-launcher-4130-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 360785 INFO (jetty-launcher-4130-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 360785 INFO (jetty-launcher-4130-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-04-03T22:14:46.091534500Z
[junit4] 2> 360785 INFO (jetty-launcher-4130-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@1793c16a{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:?????}
[junit4] 2> 360785 INFO (jetty-launcher-4130-thread-1) [ ] o.e.j.s.Server Started @??????ms
[junit4] 2> 360785 INFO (jetty-launcher-4130-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=57310}
[junit4] 2> 360786 ERROR (jetty-launcher-4130-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 360786 INFO (jetty-launcher-4130-thread-1) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 360786 INFO (jetty-launcher-4130-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.1.0
[junit4] 2> 360786 INFO (jetty-launcher-4130-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 360786 INFO (jetty-launcher-4130-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 360786 INFO (jetty-launcher-4130-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-04-03T22:14:46.092573200Z
[junit4] 2> 360790 INFO (zkConnectionManagerCallback-4132-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 360790 INFO (jetty-launcher-4130-thread-3) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 360791 INFO (zkConnectionManagerCallback-4134-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 360792 INFO (jetty-launcher-4130-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 360795 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 0x1006d31dfb40003, likely client has closed socket
[junit4] 2> 360852 INFO (zkConnectionManagerCallback-4136-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 360852 INFO (jetty-launcher-4130-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 360917 INFO (jetty-launcher-4130-thread-1) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 360921 WARN (jetty-launcher-4130-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@69e29779[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 360924 WARN (jetty-launcher-4130-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@69417fd6[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 360925 INFO (jetty-launcher-4130-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:57296/solr
[junit4] 2> 360928 INFO (zkConnectionManagerCallback-4145-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 360932 INFO (zkConnectionManagerCallback-4147-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 360941 WARN (jetty-launcher-4130-thread-1) [n:127.0.0.1:57310_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> 360946 INFO (jetty-launcher-4130-thread-1) [n:127.0.0.1:57310_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:57310_solr
[junit4] 2> 360947 INFO (jetty-launcher-4130-thread-1) [n:127.0.0.1:57310_solr ] o.a.s.c.Overseer Overseer (id=72177655011868679-127.0.0.1:57310_solr-n_0000000000) starting
[junit4] 2> 360953 INFO (zkConnectionManagerCallback-4154-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 360955 INFO (jetty-launcher-4130-thread-1) [n:127.0.0.1:57310_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:57296/solr ready
[junit4] 2> 360956 INFO (jetty-launcher-4130-thread-1) [n:127.0.0.1:57310_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:57310_solr
[junit4] 2> 360994 INFO (zkCallback-4146-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 360994 INFO (zkCallback-4153-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 361001 INFO (OverseerStateUpdate-72177655011868679-127.0.0.1:57310_solr-n_0000000000) [n:127.0.0.1:57310_solr ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:57310_solr
[junit4] 2> 361004 INFO (jetty-launcher-4130-thread-1) [n:127.0.0.1:57310_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 361031 INFO (jetty-launcher-4130-thread-1) [n:127.0.0.1:57310_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_57310.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5b343b9d
[junit4] 2> 361038 INFO (jetty-launcher-4130-thread-1) [n:127.0.0.1:57310_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_57310.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5b343b9d
[junit4] 2> 361039 INFO (jetty-launcher-4130-thread-1) [n:127.0.0.1:57310_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_57310.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5b343b9d
[junit4] 2> 361039 INFO (jetty-launcher-4130-thread-1) [n:127.0.0.1:57310_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.impl.CloudHttp2SolrClientTest_7F9E81B62DB59F2C-001\tempDir-001\node1\.
[junit4] 2> 361111 INFO (jetty-launcher-4130-thread-2) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 361114 WARN (jetty-launcher-4130-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@51f8fea0[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 361118 WARN (jetty-launcher-4130-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@41661110[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 361119 INFO (jetty-launcher-4130-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:57296/solr
[junit4] 2> 361122 INFO (zkConnectionManagerCallback-4161-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 361126 INFO (zkConnectionManagerCallback-4163-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 361131 WARN (jetty-launcher-4130-thread-2) [n:127.0.0.1:57307_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> 361132 INFO (jetty-launcher-4130-thread-2) [n:127.0.0.1:57307_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 361136 INFO (jetty-launcher-4130-thread-2) [n:127.0.0.1:57307_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:57307_solr as DOWN
[junit4] 2> 361136 INFO (jetty-launcher-4130-thread-2) [n:127.0.0.1:57307_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 361136 INFO (jetty-launcher-4130-thread-2) [n:127.0.0.1:57307_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:57307_solr
[junit4] 2> 361138 INFO (zkCallback-4146-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 361138 INFO (zkCallback-4153-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 361138 INFO (zkCallback-4162-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 361171 INFO (zkConnectionManagerCallback-4170-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 361173 INFO (jetty-launcher-4130-thread-2) [n:127.0.0.1:57307_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 361173 INFO (jetty-launcher-4130-thread-2) [n:127.0.0.1:57307_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:57296/solr ready
[junit4] 2> 361173 INFO (jetty-launcher-4130-thread-2) [n:127.0.0.1:57307_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 361201 INFO (jetty-launcher-4130-thread-2) [n:127.0.0.1:57307_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_57307.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5b343b9d
[junit4] 2> 361206 INFO (jetty-launcher-4130-thread-2) [n:127.0.0.1:57307_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_57307.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5b343b9d
[junit4] 2> 361206 INFO (jetty-launcher-4130-thread-2) [n:127.0.0.1:57307_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_57307.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5b343b9d
[junit4] 2> 361209 INFO (jetty-launcher-4130-thread-2) [n:127.0.0.1:57307_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.impl.CloudHttp2SolrClientTest_7F9E81B62DB59F2C-001\tempDir-001\node2\.
[junit4] 2> 361251 INFO (jetty-launcher-4130-thread-3) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 361253 WARN (jetty-launcher-4130-thread-3) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@43b47a96[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 361256 WARN (jetty-launcher-4130-thread-3) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@690d70a8[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 361257 INFO (jetty-launcher-4130-thread-3) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:57296/solr
[junit4] 2> 361260 INFO (zkConnectionManagerCallback-4177-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 361261 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 0x1006d31dfb4000c, likely client has closed socket
[junit4] 2> 361264 INFO (zkConnectionManagerCallback-4179-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 361268 WARN (jetty-launcher-4130-thread-3) [n:127.0.0.1:57313_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> 361270 INFO (jetty-launcher-4130-thread-3) [n:127.0.0.1:57313_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 361274 INFO (jetty-launcher-4130-thread-3) [n:127.0.0.1:57313_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:57313_solr as DOWN
[junit4] 2> 361275 INFO (jetty-launcher-4130-thread-3) [n:127.0.0.1:57313_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 361275 INFO (jetty-launcher-4130-thread-3) [n:127.0.0.1:57313_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:57313_solr
[junit4] 2> 361276 INFO (zkCallback-4146-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 361276 INFO (zkCallback-4162-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 361276 INFO (zkCallback-4153-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 361277 INFO (zkCallback-4178-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 361277 INFO (zkCallback-4169-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 361305 INFO (zkConnectionManagerCallback-4186-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 361307 INFO (jetty-launcher-4130-thread-3) [n:127.0.0.1:57313_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
[junit4] 2> 361308 INFO (jetty-launcher-4130-thread-3) [n:127.0.0.1:57313_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:57296/solr ready
[junit4] 2> 361308 INFO (jetty-launcher-4130-thread-3) [n:127.0.0.1:57313_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 361330 INFO (jetty-launcher-4130-thread-3) [n:127.0.0.1:57313_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_57313.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5b343b9d
[junit4] 2> 361339 INFO (jetty-launcher-4130-thread-3) [n:127.0.0.1:57313_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_57313.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5b343b9d
[junit4] 2> 361339 INFO (jetty-launcher-4130-thread-3) [n:127.0.0.1:57313_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_57313.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5b343b9d
[junit4] 2> 361340 INFO (jetty-launcher-4130-thread-3) [n:127.0.0.1:57313_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.impl.CloudHttp2SolrClientTest_7F9E81B62DB59F2C-001\tempDir-001\node3\.
[junit4] 2> 361370 INFO (zkConnectionManagerCallback-4192-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 361372 INFO (TEST-CloudHttp2SolrClientTest.testAliasHandling-seed#[7F9E81B62DB59F2C]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
[junit4] 2> 361373 INFO (TEST-CloudHttp2SolrClientTest.testAliasHandling-seed#[7F9E81B62DB59F2C]) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:57296/solr ready
[junit4] 2> 361380 WARN (TEST-CloudHttp2SolrClientTest.testAliasHandling-seed#[7F9E81B62DB59F2C]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@28f887f8[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 361383 INFO (qtp1683059374-8681) [n:127.0.0.1:57310_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :clusterstatus with params action=CLUSTERSTATUS&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 361384 INFO (qtp1683059374-8681) [n:127.0.0.1:57310_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=CLUSTERSTATUS&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 361387 WARN (TEST-CloudHttp2SolrClientTest.testAliasHandling-seed#[7F9E81B62DB59F2C]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@52aecd38[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 361388 WARN (TEST-CloudHttp2SolrClientTest.testAliasHandling-seed#[7F9E81B62DB59F2C]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@6d34f568[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 361390 INFO (qtp1683059374-8679) [n:127.0.0.1:57310_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params collection.configName=conf&name=collection1&nrtReplicas=1&action=CREATE&numShards=2&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 361393 INFO (OverseerThreadFactory-1857-thread-1-processing-n:127.0.0.1:57310_solr) [n:127.0.0.1:57310_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection collection1
[junit4] 2> 361502 INFO (OverseerStateUpdate-72177655011868679-127.0.0.1:57310_solr-n_0000000000) [n:127.0.0.1:57310_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"collection1",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"collection1_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:57313/solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 361504 INFO (OverseerStateUpdate-72177655011868679-127.0.0.1:57310_solr-n_0000000000) [n:127.0.0.1:57310_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"collection1",
[junit4] 2> "shard":"shard2",
[junit4] 2> "core":"collection1_shard2_replica_n2",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:57310/solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 361714 INFO (qtp700063528-8690) [n:127.0.0.1:57313_solr x:collection1_shard1_replica_n1] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=collection1_shard1_replica_n1&action=CREATE&numShards=2&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 361725 INFO (qtp1683059374-8700) [n:127.0.0.1:57310_solr x:collection1_shard2_replica_n2] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf&newCollection=true&name=collection1_shard2_replica_n2&action=CREATE&numShards=2&collection=collection1&shard=shard2&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 361726 INFO (qtp1683059374-8700) [n:127.0.0.1:57310_solr x:collection1_shard2_replica_n2] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 362732 INFO (qtp700063528-8690) [n:127.0.0.1:57313_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0
[junit4] 2> 362739 INFO (qtp1683059374-8700) [n:127.0.0.1:57310_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0
[junit4] 2> 362740 INFO (qtp700063528-8690) [n:127.0.0.1:57313_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.s.IndexSchema [collection1_shard1_replica_n1] Schema name=test
[junit4] 2> 362756 INFO (qtp1683059374-8700) [n:127.0.0.1:57310_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.s.IndexSchema [collection1_shard2_replica_n2] Schema name=test
[junit4] 2> 362783 WARN (qtp700063528-8690) [n:127.0.0.1:57313_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.s.IndexSchema Field lowerfilt1and2 is not multivalued and destination for multiple copyFields (2)
[junit4] 2> 362783 WARN (qtp700063528-8690) [n:127.0.0.1:57313_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.s.IndexSchema Field text is not multivalued and destination for multiple copyFields (3)
[junit4] 2> 362783 INFO (qtp700063528-8690) [n:127.0.0.1:57313_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 362783 INFO (qtp700063528-8690) [n:127.0.0.1:57313_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.CoreContainer Creating SolrCore 'collection1_shard1_replica_n1' using configuration from collection collection1, trusted=true
[junit4] 2> 362783 INFO (qtp700063528-8690) [n:127.0.0.1:57313_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_57313.solr.core.collection1.shard1.replica_n1' (registry 'solr.core.collection1.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5b343b9d
[junit4] 2> 362783 INFO (qtp700063528-8690) [n:127.0.0.1:57313_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.SolrCore [[collection1_shard1_replica_n1] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.impl.CloudHttp2SolrClientTest_7F9E81B62DB59F2C-001\tempDir-001\node3\collection1_shard1_replica_n1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.impl.CloudHttp2SolrClientTest_7F9E81B62DB59F2C-001\tempDir-001\node3\.\collection1_shard1_replica_n1\data\]
[junit4] 2> 362803 WARN (qtp1683059374-8700) [n:127.0.0.1:57310_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.s.IndexSchema Field lowerfilt1and2 is not multivalued and destination for multiple copyFields (2)
[junit4] 2> 362803 WARN (qtp1683059374-8700) [n:127.0.0.1:57310_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.s.IndexSchema Field text is not multivalued and destination for multiple copyFields (3)
[junit4] 2> 362804 INFO (qtp1683059374-8700) [n:127.0.0.1:57310_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 362804 INFO (qtp1683059374-8700) [n:127.0.0.1:57310_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.CoreContainer Creating SolrCore 'collection1_shard2_replica_n2' using configuration from collection collection1, trusted=true
[junit4] 2> 362804 INFO (qtp1683059374-8700) [n:127.0.0.1:57310_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_57310.solr.core.collection1.shard2.replica_n2' (registry 'solr.core.collection1.shard2.replica_n2') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5b343b9d
[junit4] 2> 362804 INFO (qtp1683059374-8700) [n:127.0.0.1:57310_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.SolrCore [[collection1_shard2_replica_n2] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.impl.CloudHttp2SolrClientTest_7F9E81B62DB59F2C-001\tempDir-001\node1\collection1_shard2_replica_n2], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.impl.CloudHttp2SolrClientTest_7F9E81B62DB59F2C-001\tempDir-001\node1\.\collection1_shard2_replica_n2\data\]
[junit4] 2> 362863 INFO (qtp700063528-8690) [n:127.0.0.1:57313_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 362863 INFO (qtp700063528-8690) [n:127.0.0.1:57313_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 362866 INFO (qtp700063528-8690) [n:127.0.0.1:57313_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 362866 INFO (qtp700063528-8690) [n:127.0.0.1:57313_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 362867 INFO (qtp700063528-8690) [n:127.0.0.1:57313_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.s.SolrIndexSearcher Opening [Searcher@42f2092c[collection1_shard1_replica_n1] main]
[junit4] 2> 362869 INFO (qtp700063528-8690) [n:127.0.0.1:57313_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf
[junit4] 2> 362869 INFO (qtp700063528-8690) [n:127.0.0.1:57313_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 362869 INFO (qtp700063528-8690) [n:127.0.0.1:57313_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 362870 INFO (qtp700063528-8690) [n:127.0.0.1:57313_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1629832807108837376
[junit4] 2> 362872 INFO (searcherExecutor-1873-thread-1-processing-n:127.0.0.1:57313_solr x:collection1_shard1_replica_n1 c:collection1 s:shard1 r:core_node3) [n:127.0.0.1:57313_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.SolrCore [collection1_shard1_replica_n1] Registered new searcher Searcher@42f2092c[collection1_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 362875 INFO (qtp700063528-8690) [n:127.0.0.1:57313_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.ZkShardTerms Successful update of terms at /collections/collection1/terms/shard1 to Terms{values={core_node3=0}, version=0}
[junit4] 2> 362875 INFO (qtp700063528-8690) [n:127.0.0.1:57313_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/collection1/leaders/shard1
[junit4] 2> 362879 INFO (qtp700063528-8690) [n:127.0.0.1:57313_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 362879 INFO (qtp700063528-8690) [n:127.0.0.1:57313_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 362879 INFO (qtp700063528-8690) [n:127.0.0.1:57313_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:57313/solr/collection1_shard1_replica_n1/
[junit4] 2> 362879 INFO (qtp700063528-8690) [n:127.0.0.1:57313_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 362879 INFO (qtp700063528-8690) [n:127.0.0.1:57313_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.SyncStrategy http://127.0.0.1:57313/solr/collection1_shard1_replica_n1/ has no replicas
[junit4] 2> 362879 INFO (qtp700063528-8690) [n:127.0.0.1:57313_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/collection1/leaders/shard1/leader after winning as /collections/collection1/leader_elect/shard1/election/72177655011868685-core_node3-n_0000000000
[junit4] 2> 362881 INFO (qtp700063528-8690) [n:127.0.0.1:57313_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:57313/solr/collection1_shard1_replica_n1/ shard1
[junit4] 2> 362897 INFO (qtp1683059374-8700) [n:127.0.0.1:57310_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 362897 INFO (qtp1683059374-8700) [n:127.0.0.1:57310_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 362900 INFO (qtp1683059374-8700) [n:127.0.0.1:57310_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 362900 INFO (qtp1683059374-8700) [n:127.0.0.1:57310_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 362901 INFO (qtp1683059374-8700) [n:127.0.0.1:57310_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.s.SolrIndexSearcher Opening [Searcher@2aeb5e3f[collection1_shard2_replica_n2] main]
[junit4] 2> 362902 INFO (qtp1683059374-8700) [n:127.0.0.1:57310_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf
[junit4] 2> 362902 INFO (qtp1683059374-8700) [n:127.0.0.1:57310_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 362903 INFO (qtp1683059374-8700) [n:127.0.0.1:57310_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 362903 INFO (qtp1683059374-8700) [n:127.0.0.1:57310_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1629832807143440384
[junit4] 2> 362905 INFO (searcherExecutor-1874-thread-1-processing-n:127.0.0.1:57310_solr x:collection1_shard2_replica_n2 c:collection1 s:shard2 r:core_node4) [n:127.0.0.1:57310_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.SolrCore [collection1_shard2_replica_n2] Registered new searcher Searcher@2aeb5e3f[collection1_shard2_replica_n2] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 362907 INFO (qtp1683059374-8700) [n:127.0.0.1:57310_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.ZkShardTerms Successful update of terms at /collections/collection1/terms/shard2 to Terms{values={core_node4=0}, version=0}
[junit4] 2> 362908 INFO (qtp1683059374-8700) [n:127.0.0.1:57310_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/collection1/leaders/shard2
[junit4] 2> 362911 INFO (qtp1683059374-8700) [n:127.0.0.1:57310_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 362911 INFO (qtp1683059374-8700) [n:127.0.0.1:57310_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 362911 INFO (qtp1683059374-8700) [n:127.0.0.1:57310_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:57310/solr/collection1_shard2_replica_n2/
[junit4] 2> 362911 INFO (qtp1683059374-8700) [n:127.0.0.1:57310_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 362911 INFO (qtp1683059374-8700) [n:127.0.0.1:57310_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.SyncStrategy http://127.0.0.1:57310/solr/collection1_shard2_replica_n2/ has no replicas
[junit4] 2> 362911 INFO (qtp1683059374-8700) [n:127.0.0.1:57310_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/collection1/leaders/shard2/leader after winning as /collections/collection1/leader_elect/shard2/election/72177655011868679-core_node4-n_0000000000
[junit4] 2> 362913 INFO (qtp1683059374-8700) [n:127.0.0.1:57310_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:57310/solr/collection1_shard2_replica_n2/ shard2
[junit4] 2> 363015 INFO (zkCallback-4146-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [3])
[junit4] 2> 363015 INFO (zkCallback-4178-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [3])
[junit4] 2> 363016 INFO (qtp700063528-8690) [n:127.0.0.1:57313_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 363016 INFO (qtp1683059374-8700) [n:127.0.0.1:57310_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 363018 INFO (zkCallback-4178-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [3])
[junit4] 2> 363019 INFO (qtp700063528-8690) [n:127.0.0.1:57313_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=collection1_shard1_replica_n1&action=CREATE&numShards=2&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=1305
[junit4] 2> 363018 INFO (zkCallback-4146-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [3])
[junit4] 2> 363022 INFO (qtp1683059374-8700) [n:127.0.0.1:57310_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf&newCollection=true&name=collection1_shard2_replica_n2&action=CREATE&numShards=2&collection=collection1&shard=shard2&wt=javabin&version=2&replicaType=NRT} status=0 QTime=1297
[junit4] 2> 363025 INFO (qtp1683059374-8679) [n:127.0.0.1:57310_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> 363124 INFO (zkCallback-4146-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [3])
[junit4] 2> 363124 INFO (zkCallback-4146-thread-3) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [3])
[junit4] 2> 363124 INFO (zkCallback-4178-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [3])
[junit4] 2> 363124 INFO (zkCallback-4178-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [3])
[junit4] 2> 363124 INFO (zkCallback-4146-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [3])
[junit4] 2> 363124 INFO (qtp1683059374-8679) [n:127.0.0.1:57310_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={collection.configName=conf&name=collection1&nrtReplicas=1&action=CREATE&numShards=2&wt=javabin&version=2} status=0 QTime=1734
[junit4] 2> 363125 INFO (zkCallback-4178-thread-3) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [3])
[junit4] 2> 363125 INFO (qtp1683059374-8684) [n:127.0.0.1:57310_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params collection.configName=conf&name=2nd_collection&nrtReplicas=1&action=CREATE&numShards=2&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 363129 INFO (OverseerThreadFactory-1857-thread-2-processing-n:127.0.0.1:57310_solr) [n:127.0.0.1:57310_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection 2nd_collection
[junit4] 2> 363129 INFO (OverseerCollectionConfigSetProcessor-72177655011868679-127.0.0.1:57310_solr-n_0000000000) [n:127.0.0.1:57310_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> 363337 INFO (OverseerStateUpdate-72177655011868679-127.0.0.1:57310_solr-n_0000000000) [n:127.0.0.1:57310_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"2nd_collection",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"2nd_collection_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:57310/solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 363340 INFO (OverseerStateUpdate-72177655011868679-127.0.0.1:57310_solr-n_0000000000) [n:127.0.0.1:57310_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"2nd_collection",
[junit4] 2> "shard":"shard2",
[junit4] 2> "core":"2nd_collection_shard2_replica_n2",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:57313/solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 363543 INFO (qtp700063528-8689) [n:127.0.0.1:57313_solr x:2nd_collection_shard2_replica_n2] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf&newCollection=true&name=2nd_collection_shard2_replica_n2&action=CREATE&numShards=2&collection=2nd_collection&shard=shard2&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 363543 INFO (qtp1683059374-8682) [n:127.0.0.1:57310_solr x:2nd_collection_shard1_replica_n1] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=2nd_collection_shard1_replica_n1&action=CREATE&numShards=2&collection=2nd_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 364558 INFO (qtp1683059374-8682) [n:127.0.0.1:57310_solr c:2nd_collection s:shard1 r:core_node3 x:2nd_collection_shard1_replica_n1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0
[junit4] 2> 364558 INFO (qtp700063528-8689) [n:127.0.0.1:57313_solr c:2nd_collection s:shard2 r:core_node4 x:2nd_collection_shard2_replica_n2] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0
[junit4] 2> 364569 INFO (qtp700063528-8689) [n:127.0.0.1:57313_solr c:2nd_collection s:shard2 r:core_node4 x:2nd_collection_shard2_replica_n2] o.a.s.s.IndexSchema [2nd_collection_shard2_replica_n2] Schema name=test
[junit4] 2> 364569 INFO (qtp1683059374-8682) [n:127.0.0.1:57310_solr c:2nd_collection s:shard1 r:core_node3 x:2nd_collection_shard1_replica_n1] o.a.s.s.IndexSchema [2nd_collection_shard1_replica_n1] Schema name=test
[junit4] 2> 364666 WARN (qtp700063528-8689) [n:127.0.0.1:57313_solr c:2nd_collection s:shard2 r:core_node4 x:2nd_collection_shard2_replica_n2] o.a.s.s.IndexSchema Field lowerfilt1and2 is not multivalued and destination for multiple copyFields (2)
[junit4] 2> 364666 WARN (qtp700063528-8689) [n:127.0.0.1:57313_solr c:2nd_collection s:shard2 r:core_node4 x:2nd_collection_shard2_replica_n2] o.a.s.s.IndexSchema Field text is not multivalued and destination for multiple copyFields (3)
[junit4] 2> 364666 INFO (qtp700063528-8689) [n:127.0.0.1:57313_solr c:2nd_collection s:shard2 r:core_node4 x:2nd_collection_shard2_replica_n2] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 364666 INFO (qtp700063528-8689) [n:127.0.0.1:57313_solr c:2nd_collection s:shard2 r:core_node4 x:2nd_collection_shard2_replica_n2] o.a.s.c.CoreContainer Creating SolrCore '2nd_collection_shard2_replica_n2' using configuration from collection 2nd_collection, trusted=true
[junit4] 2> 364667 INFO (qtp700063528-8689) [n:127.0.0.1:57313_solr c:2nd_collection s:shard2 r:core_node4 x:2nd_collection_shard2_replica_n2] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_57313.solr.core.2nd_collection.shard2.replica_n2' (registry 'solr.core.2nd_collection.shard2.replica_n2') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5b343b9d
[junit4] 2> 364667 INFO (qtp700063528-8689) [n:127.0.0.1:57313_solr c:2nd_collection s:shard2 r:core_node4 x:2nd_collection_shard2_replica_n2] o.a.s.c.SolrCore [[2nd_collection_shard2_replica_n2] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.impl.CloudHttp2SolrClientTest_7F9E81B62DB59F2C-001\tempDir-001\node3\2nd_collection_shard2_replica_n2], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.impl.CloudHttp2SolrClientTest_7F9E81B62DB59F2C-001\tempDir-001\node3\.\2nd_collection_shard2_replica_n2\data\]
[junit4] 2> 364687 WARN (qtp1683059374-8682) [n:127.0.0.1:57310_solr c:2nd_collection s:shard1 r:core_node3 x:2nd_collection_shard1_replica_n1] o.a.s.s.IndexSchema Field lowerfilt1and2 is not multivalued and destination for multiple copyFields (2)
[junit4] 2> 364687 WARN (qtp1683059374-8682) [n:127.0.0.1:57310_solr c:2nd_collection s:shard1 r:core_node3 x:2nd_collection_shard1_replica_n1] o.a.s.s.IndexSchema Field text is not multivalued and destination for multiple copyFields (3)
[junit4] 2> 364689 INFO (qtp1683059374-8682) [n:127.0.0.1:57310_solr c:2nd_collection s:shard1 r:core_node3 x:2nd_collection_shard1_replica_n1] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 364689 INFO (qtp1683059374-8682) [n:127.0.0.1:57310_solr c:2nd_collection s:shard1 r:core_node3 x:2nd_collection_shard1_replica_n1] o.a.s.c.CoreContainer Creating SolrCore '2nd_collection_shard1_replica_n1' using configuration from collection 2nd_collection, trusted=true
[junit4] 2> 364689 INFO (qtp1683059374-8682) [n:127.0.0.1:57310_solr c:2nd_collection s:shard1 r:core_node3 x:2nd_collection_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_57310.solr.core.2nd_collection.shard1.replica_n1' (registry 'solr.core.2nd_collection.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5b343b9d
[junit4] 2> 364690 INFO (qtp1683059374-8682) [n:127.0.0.1:57310_solr c:2nd_collection s:shard1 r:core_node3 x:2nd_collection_shard1_replica_n1] o.a.s.c.SolrCore [[2nd_collection_shard1_replica_n1] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.impl.CloudHttp2SolrClientTest_7F9E81B62DB59F2C-001\tempDir-001\node1\2nd_collection_shard1_replica_n1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.impl.CloudHttp2SolrClientTest_7F9E81B62DB59F2C-001\tempDir-001\node1\.\2nd_collection_shard1_replica_n1\data\]
[junit4] 2> 364752 INFO (qtp700063528-8689) [n:127.0.0.1:57313_solr c:2nd_collection s:shard2 r:core_node4 x:2nd_collection_shard2_replica_n2] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 364752 INFO (qtp700063528-8689) [n:127.0.0.1:57313_solr c:2nd_collection s:shard2 r:core_node4 x:2nd_collection_shard2_replica_n2] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 364806 INFO (qtp700063528-8689) [n:127.0.0.1:57313_solr c:2nd_collection s:shard2 r:core_node4 x:2nd_collection_shard2_replica_n2] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 364806 INFO (qtp700063528-8689) [n:127.0.0.1:57313_solr c:2nd_collection s:shard2 r:core_node4 x:2nd_collection_shard2_replica_n2] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 364808 INFO (qtp700063528-8689) [n:127.0.0.1:57313_solr c:2nd_collection s:shard2 r:core_node4 x:2nd_collection_shard2_replica_n2] o.a.s.s.SolrIndexSearcher Opening [Searcher@6c8cbc28[2nd_collection_shard2_replica_n2] main]
[junit4] 2> 364809 INFO (qtp700063528-8689) [n:127.0.0.1:57313_solr c:2nd_collection s:shard2 r:core_node4 x:2nd_collection_shard2_replica_n2] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf
[junit4] 2> 364810 INFO (qtp700063528-8689) [n:127.0.0.1:57313_solr c:2nd_collection s:shard2 r:core_node4 x:2nd_collection_shard2_replica_n2] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 364811 INFO (qtp700063528-8689) [n:127.0.0.1:57313_solr c:2nd_collection s:shard2 r:core_node4 x:2nd_collection_shard2_replica_n2] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 364811 INFO (qtp700063528-8689) [n:127.0.0.1:57313_solr c:2nd_collection s:shard2 r:core_node4 x:2nd_collection_shard2_replica_n2] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1629832809144123392
[junit4] 2> 364814 INFO (searcherExecutor-1883-thread-1-processing-n:127.0.0.1:57313_solr x:2nd_collection_shard2_replica_n2 c:2nd_collection s:shard2 r:core_node4) [n:127.0.0.1:57313_solr c:2nd_collection s:shard2 r:core_node4 x:2nd_collection_shard2_replica_n2] o.a.s.c.SolrCore [2nd_collection_shard2_replica_n2] Registered new searcher Searcher@6c8cbc28[2nd_collection_shard2_replica_n2] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 364819 INFO (qtp700063528-8689) [n:127.0.0.1:57313_solr c:2nd_collection s:shard2 r:core_node4 x:2nd_collection_shard2_replica_n2] o.a.s.c.ZkShardTerms Successful update of terms at /collections/2nd_collection/terms/shard2 to Terms{values={core_node4=0}, version=0}
[junit4] 2> 364820 INFO (qtp700063528-8689) [n:127.0.0.1:57313_solr c:2nd_collection s:shard2 r:core_node4 x:2nd_collection_shard2_replica_n2] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/2nd_collection/leaders/shard2
[junit4] 2> 364823 INFO (qtp700063528-8689) [n:127.0.0.1:57313_solr c:2nd_collection s:shard2 r:core_node4 x:2nd_collection_shard2_replica_n2] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 364823 INFO (qtp700063528-8689) [n:127.0.0.1:57313_solr c:2nd_collection s:shard2 r:core_node4 x:2nd_collection_shard2_replica_n2] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 364823 INFO (qtp700063528-8689) [n:127.0.0.1:57313_solr c:2nd_collection s:shard2 r:core_node4 x:2nd_collection_shard2_replica_n2] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:57313/solr/2nd_collection_shard2_replica_n2/
[junit4] 2> 364823 INFO (qtp700063528-8689) [n:127.0.0.1:57313_solr c:2nd_collection s:shard2 r:core_node4 x:2nd_collection_shard2_replica_n2] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 364823 INFO (qtp700063528-8689) [n:127.0.0.1:57313_solr c:2nd_collection s:shard2 r:core_node4 x:2nd_collection_shard2_replica_n2] o.a.s.c.SyncStrategy http://127.0.0.1:57313/solr/2nd_collection_shard2_replica_n2/ has no replicas
[junit4] 2> 364823 INFO (qtp700063528-8689) [n:127.0.0.1:57313_solr c:2nd_collection s:shard2 r:core_node4 x:2nd_collection_shard2_replica_n2] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/2nd_collection/leaders/shard2/leader after winning as /collections/2nd_collection/leader_elect/shard2/election/72177655011868685-core_node4-n_0000000000
[junit4] 2> 364827 INFO (qtp700063528-8689) [n:127.0.0.1:57313_solr c:2nd_collection s:shard2 r:core_node4 x:2nd_collection_shard2_replica_n2] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:57313/solr/2nd_collection_shard2_replica_n2/ shard2
[junit4] 2> 364847 INFO (qtp1683059374-8682) [n:127.0.0.1:57310_solr c:2nd_collection s:shard1 r:core_node3 x:2nd_collection_shard1_replica_n1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 364847 INFO (qtp1683059374-8682) [n:127.0.0.1:57310_solr c:2nd_collection s:shard1 r:core_node3 x:2nd_collection_shard1_replica_n1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 364850 INFO (qtp1683059374-8682) [n:127.0.0.1:57310_solr c:2nd_collection s:shard1 r:core_node3 x:2nd_collection_shard1_replica_n1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 364850 INFO (qtp1683059374-8682) [n:127.0.0.1:57310_solr c:2nd_collection s:shard1 r:core_node3 x:2nd_collection_shard1_replica_n1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 364850 INFO (qtp1683059374-8682) [n:127.0.0.1:57310_solr c:2nd_collection s:shard1 r:core_node3 x:2nd_collection_shard1_replica_n1] o.a.s.s.SolrIndexSearcher Opening [Searcher@308c5946[2nd_collection_shard1_replica_n1] main]
[junit4] 2> 364854 INFO (qtp1683059374-8682) [n:127.0.0.1:57310_solr c:2nd_collection s:shard1 r:core_node3 x:2nd_collection_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf
[junit4] 2> 364854 INFO (qtp1683059374-8682) [n:127.0.0.1:57310_solr c:2nd_collection s:shard1 r:core_node3 x:2nd_collection_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 364855 INFO (qtp1683059374-8682) [n:127.0.0.1:57310_solr c:2nd_collection s:shard1 r:core_node3 x:2nd_collection_shard1_replica_n1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 364855 INFO (qtp1683059374-8682) [n:127.0.0.1:57310_solr c:2nd_collection s:shard1 r:core_node3 x:2nd_collection_shard1_replica_n1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1629832809190260736
[junit4] 2> 364856 INFO (searcherExecutor-1884-thread-1-processing-n:127.0.0.1:57310_solr x:2nd_collection_shard1_replica_n1 c:2nd_collection s:shard1 r:core_node3) [n:127.0.0.1:57310_solr c:2nd_collection s:shard1 r:core_node3 x:2nd_collection_shard1_replica_n1] o.a.s.c.SolrCore [2nd_collection_shard1_replica_n1] Registered new searcher Searcher@308c5946[2nd_collection_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 364860 INFO (qtp1683059374-8682) [n:127.0.0.1:57310_solr c:2nd_collection s:shard1 r:core_node3 x:2nd_collection_shard1_replica_n1] o.a.s.c.ZkShardTerms Successful update of terms at /collections/2nd_collection/terms/shard1 to Terms{values={core_node3=0}, version=0}
[junit4] 2> 364860 INFO (qtp1683059374-8682) [n:127.0.0.1:57310_solr c:2nd_collection s:shard1 r:core_node3 x:2nd_collection_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/2nd_collection/leaders/shard1
[junit4] 2> 364865 INFO (qtp1683059374-8682) [n:127.0.0.1:57310_solr c:2nd_collection s:shard1 r:core_node3 x:2nd_collection_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 364865 INFO (qtp1683059374-8682) [n:127.0.0.1:57310_solr c:2nd_collection s:shard1 r:core_node3 x:2nd_collection_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 364865 INFO (qtp1683059374-8682) [n:127.0.0.1:57310_solr c:2nd_collection s:shard1 r:core_node3 x:2nd_collection_shard1_replica_n1] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:57310/solr/2nd_collection_shard1_replica_n1/
[junit4] 2> 364865 INFO (qtp1683059374-8682) [n:127.0.0.1:57310_solr c:2nd_collection s:shard1 r:core_node3 x:2nd_collection_shard1_replica_n1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 364865 INFO (qtp1683059374-8682) [n:127.0.0.1:57310_solr c:2nd_collection s:shard1 r:core_node3 x:2nd_collection_shard1_replica_n1] o.a.s.c.SyncStrategy http://127.0.0.1:57310/solr/2nd_collection_shard1_replica_n1/ has no replicas
[junit4] 2> 364865 INFO (qtp1683059374-8682) [n:127.0.0.1:57310_solr c:2nd_collection s:shard1 r:core_node3 x:2nd_collection_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/2nd_collection/leaders/shard1/leader after winning as /collections/2nd_collection/leader_elect/shard1/election/72177655011868679-core_node3-n_0000000000
[junit4] 2> 364867 INFO (qtp1683059374-8682) [n:127.0.0.1:57310_solr c:2nd_collection s:shard1 r:core_node3 x:2nd_collection_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:57310/solr/2nd_collection_shard1_replica_n1/ shard1
[junit4] 2> 364970 INFO (zkCallback-4146-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/2nd_collection/state.json] for collection [2nd_collection] has occurred - updating... (live nodes size: [3])
[junit4] 2> 364970 INFO (zkCallback-4178-thread-3) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/2nd_collection/state.json] for collection [2nd_collection] has occurred - updating... (live nodes size: [3])
[junit4] 2> 364970 INFO (zkCallback-4146-thread-3) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/2nd_collection/state.json] for collection [2nd_collection] has occurred - updating... (live nodes size: [3])
[junit4] 2> 364970 INFO (zkCallback-4178-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/2nd_collection/state.json] for collection [2nd_collection] has occurred - updating... (live nodes size: [3])
[junit4] 2> 364971 INFO (qtp1683059374-8682) [n:127.0.0.1:57310_solr c:2nd_collection s:shard1 r:core_node3 x:2nd_collection_shard1_replica_n1] o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 364971 INFO (qtp700063528-8689) [n:127.0.0.1:57313_solr c:2nd_collection s:shard2 r:core_node4 x:2nd_collection_shard2_replica_n2] o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 364974 INFO (qtp1683059374-8682) [n:127.0.0.1:57310_solr c:2nd_collection s:shard1 r:core_node3 x:2nd_collection_shard1_replica_n1] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=2nd_collection_shard1_replica_n1&action=CREATE&numShards=2&collection=2nd_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=1431
[junit4] 2> 364974 INFO (qtp700063528-8689) [n:127.0.0.1:57313_solr c:2nd_collection s:shard2 r:core_node4 x:2nd_collection_shard2_replica_n2] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf&newCollection=true&name=2nd_collection_shard2_replica_n2&action=CREATE&numShards=2&collection=2nd_collection&shard=shard2&wt=javabin&version=2&replicaType=NRT} status=0 QTime=1431
[junit4] 2> 364977 INFO (qtp1683059374-8684) [n:127.0.0.1:57310_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> 365074 INFO (zkCallback-4146-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/2nd_collection/state.json] for collection [2nd_collection] has occurred - updating... (live nodes size: [3])
[junit4] 2> 365074 INFO (zkCallback-4146-thread-3) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/2nd_collection/state.json] for collection [2nd_collection] has occurred - updating... (live nodes size: [3])
[junit4] 2> 365074 INFO (zkCallback-4178-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/2nd_collection/state.json] for collection [2nd_collection] has occurred - updating... (live nodes size: [3])
[junit4] 2> 365074 INFO (zkCallback-4178-thread-3) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/2nd_collection/state.json] for collection [2nd_collection] has occurred - updating... (live nodes size: [3])
[junit4] 2> 365074 INFO (zkCallback-4146-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/2nd_collection/state.json] for collection [2nd_collection] has occurred - updating... (live nodes size: [3])
[junit4] 2> 365074 INFO (zkCallback-4178-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/2nd_collection/state.json] for collection [2nd_collection] has occurred - updating... (live nodes size: [3])
[junit4] 2> 365075 INFO (qtp1683059374-8684) [n:127.0.0.1:57310_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={collection.configName=conf&name=2nd_collection&nrtReplicas=1&action=CREATE&numShards=2&wt=javabin&version=2} status=0 QTime=1949
[junit4] 2> 365079 INFO (qtp1764231136-8673) [n:127.0.0.1:57307_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :clusterstatus with params action=CLUSTERSTATUS&collection=collection1&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 365081 INFO (qtp1764231136-8673) [n:127.0.0.1:57307_solr c:collection1 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=CLUSTERSTATUS&collection=collection1&wt=javabin&version=2} status=0 QTime=1
[junit4] 2> 365082 INFO (qtp1764231136-8674) [n:127.0.0.1:57307_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :clusterstatus with params action=CLUSTERSTATUS&collection=collection1&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 365084 INFO (qtp1764231136-8674) [n:127.0.0.1:57307_solr c:collection1 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=CLUSTERSTATUS&collection=collection1&wt=javabin&version=2} status=0 QTime=1
[junit4] 2> 365085 INFO (qtp1764231136-8675) [n:127.0.0.1:57307_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :listaliases with params action=LISTALIASES&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 365086 INFO (qtp1764231136-8675) [n:127.0.0.1:57307_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=LISTALIASES&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 365087 INFO (qtp1764231136-8696) [n:127.0.0.1:57307_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :clusterstatus with params action=CLUSTERSTATUS&collection=collection1&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 365088 INFO (qtp1764231136-8696) [n:127.0.0.1:57307_solr c:collection1 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=CLUSTERSTATUS&collection=collection1&wt=javabin&version=2} status=0 QTime=1
[junit4] 2> 365099 INFO (qtp700063528-8678) [n:127.0.0.1:57313_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.ZkShardTerms Successful update of terms at /collections/collection1/terms/shard1 to Terms{values={core_node3=1}, version=1}
[junit4] 2> 365099 INFO (qtp700063528-8678) [n:127.0.0.1:57313_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica_n1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[1 (1629832809442967552)]} 0 3
[junit4] 2> 365100 INFO (qtp1764231136-8695) [n:127.0.0.1:57307_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :clusterstatus with params action=CLUSTERSTATUS&collection=collection1&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 365102 INFO (qtp1764231136-8695) [n:127.0.0.1:57307_solr c:collection1 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=CLUSTERSTATUS&collection=collection1&wt=javabin&version=2} status=0 QTime=2
[junit4] 2> 365104 INFO (qtp1764231136-8676) [n:127.0.0.1:57307_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :clusterstatus with params action=CLUSTERSTATUS&collection=collection1&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 365106 INFO (qtp1764231136-8676) [n:127.0.0.1:57307_solr c:collection1 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=CLUSTERSTATUS&collection=collection1&wt=javabin&version=2} status=0 QTime=1
[junit4] 2> 365107 INFO (qtp1764231136-8670) [n:127.0.0.1:57307_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :clusterstatus with params action=CLUSTERSTATUS&collection=collection1&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 365108 INFO (qtp1764231136-8670) [n:127.0.0.1:57307_solr c:collection1 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=CLUSTERSTATUS&collection=collection1&wt=javabin&version=2} status=0 QTime=1
[junit4] 2> 365110 INFO (qtp1764231136-8672) [n:127.0.0.1:57307_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :clusterstatus with params action=CLUSTERSTATUS&collection=collection1&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 365111 INFO (qtp1764231136-8672) [n:127.0.0.1:57307_solr c:collection1 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=CLUSTERSTATUS&collection=collection1&wt=javabin&version=2} status=0 QTime=1
[junit4] 2> 365113 INFO (qtp1764231136-8673) [n:127.0.0.1:57307_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :clusterstatus with params action=CLUSTERSTATUS&collection=collection1&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 365114 INFO (qtp1764231136-8673) [n:127.0.0.1:57307_solr c:collection1 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=CLUSTERSTATUS&collection=collection1&wt=javabin&version=2} status=0 QTime=1
[junit4] 2> 365119 INFO (qtp1683059374-8671) [n:127.0.0.1:57310_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1629832809467084800,optimize=false,openSearch
[...truncated too long message...]
tMapTest, TestLang, FloorEvaluatorTest, HttpClientUtilTest, TestFastInputStream, CloudSolrClientBuilderTest, TestPolicy2, SolrDocumentTest, TestCollectionStateWatchers, ExclusiveOrEvaluatorTest, CommonAdminParamsTest, PowerEvaluatorTest, TestFastWriter, TestXMLEscaping, HttpSolrClientBuilderTest, UsingSolrJRefGuideExamplesTest, TestV1toV2ApiMapper, SolrParamTest, CloudHttp2SolrClientBadInputTest, JdbcTest, SolrQueryTest, SolrExampleEmbeddedTest, OperationsTest, HyperbolicSineEvaluatorTest, MultiplyEvaluatorTest, CosineEvaluatorTest, DirectJsonQueryRequestFacetingIntegrationTest, ConcurrentUpdateSolrClientMultiCollectionTest, ModifiableSolrParamsTest, CloudSolrClientTest, GetByIdTest, SolrExampleBinaryTest, SolrExceptionTest, TestBatchUpdate, TestLBHttpSolrClient, BasicHttpSolrClientTest, CloudHttp2SolrClientTest]
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=CloudHttp2SolrClientTest -Dtests.seed=7F9E81B62DB59F2C -Dtests.slow=true -Dtests.locale=ckb-IR -Dtests.timezone=Africa/Asmera -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
[junit4] ERROR 0.00s J0 | CloudHttp2SolrClientTest (suite) <<<
[junit4] > Throwable #1: java.lang.AssertionError: ObjectTracker found 2 object(s) that were not released!!! [SolrCore, MockDirectoryWrapper]
[junit4] > org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.solr.core.SolrCore
[junit4] > at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
[junit4] > at org.apache.solr.core.SolrCore.<init>(SolrCore.java:1063)
[junit4] > at org.apache.solr.core.SolrCore.<init>(SolrCore.java:883)
[junit4] > at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1193)
[junit4] > at org.apache.solr.core.CoreContainer.create(CoreContainer.java:1103)
[junit4] > at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:92)
[junit4] > at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:360)
[junit4] > at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:396)
[junit4] > at org.apache.solr.handler.admin.CoreAdminHandler.lambda$handleRequestBody$0(CoreAdminHandler.java:188)
[junit4] > at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:176)
[junit4] > at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209)
[junit4] > at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
[junit4] > at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
[junit4] > at java.base/java.lang.Thread.run(Thread.java:834)
[junit4] > org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MockDirectoryWrapper
[junit4] > at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
[junit4] > at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348)
[junit4] > at org.apache.solr.update.SolrIndexWriter.create(SolrIndexWriter.java:99)
[junit4] > at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:779)
[junit4] > at org.apache.solr.core.SolrCore.<init>(SolrCore.java:976)
[junit4] > at org.apache.solr.core.SolrCore.<init>(SolrCore.java:883)
[junit4] > at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1193)
[junit4] > at org.apache.solr.core.CoreContainer.create(CoreContainer.java:1103)
[junit4] > at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:92)
[junit4] > at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:360)
[junit4] > at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:396)
[junit4] > at org.apache.solr.handler.admin.CoreAdminHandler.lambda$handleRequestBody$0(CoreAdminHandler.java:188)
[junit4] > at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:176)
[junit4] > at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209)
[junit4] > at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
[junit4] > at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
[junit4] > at java.base/java.lang.Thread.run(Thread.java:834)
[junit4] > expected null, but was:<ObjectTracker found 2 object(s) that were not released!!! [SolrCore, MockDirectoryWrapper]
[junit4] > org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.solr.core.SolrCore
[junit4] > at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
[junit4] > at org.apache.solr.core.SolrCore.<init>(SolrCore.java:1063)
[junit4] > at org.apache.solr.core.SolrCore.<init>(SolrCore.java:883)
[junit4] > at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1193)
[junit4] > at org.apache.solr.core.CoreContainer.create(CoreContainer.java:1103)
[junit4] > at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:92)
[junit4] > at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:360)
[junit4] > at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:396)
[junit4] > at org.apache.solr.handler.admin.CoreAdminHandler.lambda$handleRequestBody$0(CoreAdminHandler.java:188)
[junit4] > at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:176)
[junit4] > at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209)
[junit4] > at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
[junit4] > at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
[junit4] > at java.base/java.lang.Thread.run(Thread.java:834)
[junit4] > org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MockDirectoryWrapper
[junit4] > at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
[junit4] > at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348)
[junit4] > at org.apache.solr.update.SolrIndexWriter.create(SolrIndexWriter.java:99)
[junit4] > at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:779)
[junit4] > at org.apache.solr.core.SolrCore.<init>(SolrCore.java:976)
[junit4] > at org.apache.solr.core.SolrCore.<init>(SolrCore.java:883)
[junit4] > at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1193)
[junit4] > at org.apache.solr.core.CoreContainer.create(CoreContainer.java:1103)
[junit4] > at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:92)
[junit4] > at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:360)
[junit4] > at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:396)
[junit4] > at org.apache.solr.handler.admin.CoreAdminHandler.lambda$handleRequestBody$0(CoreAdminHandler.java:188)
[junit4] > at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:176)
[junit4] > at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209)
[junit4] > at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
[junit4] > at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
[junit4] > at java.base/java.lang.Thread.run(Thread.java:834)
[junit4] > >
[junit4] > at __randomizedtesting.SeedInfo.seed([7F9E81B62DB59F2C]:0)
[junit4] > at org.apache.solr.SolrTestCaseJ4.teardownTestCases(SolrTestCaseJ4.java:325)
[junit4] > at jdk.internal.reflect.GeneratedMethodAccessor38.invoke(Unknown Source)
[junit4] > at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4] > at java.base/java.lang.reflect.Method.invoke(Method.java:566)
[junit4] > at java.base/java.lang.Thread.run(Thread.java:834)
[junit4] Completed [134/193 (1!)] on J0 in 147.70s, 16 tests, 1 failure <<< FAILURES!
[...truncated 41656 lines...]
[repro] Jenkins log URL: https://jenkins.thetaphi.de/job/Lucene-Solr-8.x-Windows/186/consoleText
[repro] Revision: 9f2e04b3f2367d0393a5515df9675faac1deafd0
[repro] Ant options: "-Dargs=-XX:+UseCompressedOops -XX:+UseG1GC"
[repro] ant clean
[...truncated 6 lines...]
[repro] Test suites by module:
[repro] solr\solrj
[repro] CloudHttp2SolrClientTest
[repro] ant compile-test
[...truncated 2737 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5 -Dtests.class="*.CloudHttp2SolrClientTest" -Dtests.showOutput=onerror "-Dargs=-XX:+UseCompressedOops -XX:+UseG1GC" -Dtests.seed=7F9E81B62DB59F2C -Dtests.slow=true -Dtests.locale=ckb-IR -Dtests.timezone=Africa/Asmera -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
[...truncated 148 lines...]
[repro] Failures:
[repro] 0/5 failed: org.apache.solr.client.solrj.impl.CloudHttp2SolrClientTest
[repro] Exiting with code 0
[...truncated 78 lines...]