You are viewing a plain text version of this content. The canonical link for it is here.
Posted to builds@lucene.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2021/07/28 15:54:01 UTC
[JENKINS] Lucene » Lucene-Solr-NightlyTests-8.x - Build # 343 - Unstable!
Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-Solr-NightlyTests-8.x/343/
2 tests failed.
FAILED: junit.framework.TestSuite.org.apache.solr.handler.TestReplicationHandler
Error Message:
ObjectTracker found 4 object(s) that were not released!!! [SolrCore, MockDirectoryWrapper, MockDirectoryWrapper, InternalHttpClient] 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:1092) at org.apache.solr.core.SolrCore.reload(SolrCore.java:708) at org.apache.solr.core.CoreContainer.reload(CoreContainer.java:1705) at org.apache.solr.handler.IndexFetcher.lambda$reloadCore$0(IndexFetcher.java:981) at java.lang.Thread.run(Thread.java:748) 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:362) at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:553) at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:384) at org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:458) at org.apache.solr.handler.ReplicationHandler.lambda$setupPolling$13(ReplicationHandler.java:1255) at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:308) at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:180) at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:294) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MockDirectoryWrapper at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:362) at org.apache.solr.update.SolrIndexWriter.create(SolrIndexWriter.java:98) at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:813) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:1003) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:921) at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1436) at org.apache.solr.core.CoreContainer.lambda$load$11(CoreContainer.java:863) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:202) at java.util.concurrent.FutureTask.run(FutureTask.java:266) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:218) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.http.impl.client.InternalHttpClient at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:339) at org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:348) at org.apache.solr.handler.IndexFetcher.createHttpClient(IndexFetcher.java:233) at org.apache.solr.handler.IndexFetcher.<init>(IndexFetcher.java:275) at org.apache.solr.handler.ReplicationHandler.inform(ReplicationHandler.java:1289) at org.apache.solr.core.SolrResourceLoader.inform(SolrResourceLoader.java:730) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:1037) at org.apache.solr.core.SolrCore.reload(SolrCore.java:708) at org.apache.solr.core.CoreContainer.reload(CoreContainer.java:1705) at org.apache.solr.handler.IndexFetcher.lambda$reloadCore$0(IndexFetcher.java:981) at java.lang.Thread.run(Thread.java:748) expected null, but was:<ObjectTracker found 4 object(s) that were not released!!! [SolrCore, MockDirectoryWrapper, MockDirectoryWrapper, InternalHttpClient] 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:1092) at org.apache.solr.core.SolrCore.reload(SolrCore.java:708) at org.apache.solr.core.CoreContainer.reload(CoreContainer.java:1705) at org.apache.solr.handler.IndexFetcher.lambda$reloadCore$0(IndexFetcher.java:981) at java.lang.Thread.run(Thread.java:748) 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:362) at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:553) at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:384) at org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:458) at org.apache.solr.handler.ReplicationHandler.lambda$setupPolling$13(ReplicationHandler.java:1255) at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:308) at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:180) at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:294) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MockDirectoryWrapper at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:362) at org.apache.solr.update.SolrIndexWriter.create(SolrIndexWriter.java:98) at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:813) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:1003) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:921) at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1436) at org.apache.solr.core.CoreContainer.lambda$load$11(CoreContainer.java:863) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:202) at java.util.concurrent.FutureTask.run(FutureTask.java:266) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:218) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.http.impl.client.InternalHttpClient at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:339) at org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:348) at org.apache.solr.handler.IndexFetcher.createHttpClient(IndexFetcher.java:233) at org.apache.solr.handler.IndexFetcher.<init>(IndexFetcher.java:275) at org.apache.solr.handler.ReplicationHandler.inform(ReplicationHandler.java:1289) at org.apache.solr.core.SolrResourceLoader.inform(SolrResourceLoader.java:730) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:1037) at org.apache.solr.core.SolrCore.reload(SolrCore.java:708) at org.apache.solr.core.CoreContainer.reload(CoreContainer.java:1705) at org.apache.solr.handler.IndexFetcher.lambda$reloadCore$0(IndexFetcher.java:981) at java.lang.Thread.run(Thread.java:748) >
Stack Trace:
java.lang.AssertionError: ObjectTracker found 4 object(s) that were not released!!! [SolrCore, MockDirectoryWrapper, MockDirectoryWrapper, InternalHttpClient]
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:1092)
at org.apache.solr.core.SolrCore.reload(SolrCore.java:708)
at org.apache.solr.core.CoreContainer.reload(CoreContainer.java:1705)
at org.apache.solr.handler.IndexFetcher.lambda$reloadCore$0(IndexFetcher.java:981)
at java.lang.Thread.run(Thread.java:748)
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:362)
at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:553)
at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:384)
at org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:458)
at org.apache.solr.handler.ReplicationHandler.lambda$setupPolling$13(ReplicationHandler.java:1255)
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:308)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:180)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:294)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MockDirectoryWrapper
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:362)
at org.apache.solr.update.SolrIndexWriter.create(SolrIndexWriter.java:98)
at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:813)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:1003)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:921)
at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1436)
at org.apache.solr.core.CoreContainer.lambda$load$11(CoreContainer.java:863)
at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:202)
at java.util.concurrent.FutureTask.run(FutureTask.java:266)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:218)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.http.impl.client.InternalHttpClient
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:339)
at org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:348)
at org.apache.solr.handler.IndexFetcher.createHttpClient(IndexFetcher.java:233)
at org.apache.solr.handler.IndexFetcher.<init>(IndexFetcher.java:275)
at org.apache.solr.handler.ReplicationHandler.inform(ReplicationHandler.java:1289)
at org.apache.solr.core.SolrResourceLoader.inform(SolrResourceLoader.java:730)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:1037)
at org.apache.solr.core.SolrCore.reload(SolrCore.java:708)
at org.apache.solr.core.CoreContainer.reload(CoreContainer.java:1705)
at org.apache.solr.handler.IndexFetcher.lambda$reloadCore$0(IndexFetcher.java:981)
at java.lang.Thread.run(Thread.java:748)
expected null, but was:<ObjectTracker found 4 object(s) that were not released!!! [SolrCore, MockDirectoryWrapper, MockDirectoryWrapper, InternalHttpClient]
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:1092)
at org.apache.solr.core.SolrCore.reload(SolrCore.java:708)
at org.apache.solr.core.CoreContainer.reload(CoreContainer.java:1705)
at org.apache.solr.handler.IndexFetcher.lambda$reloadCore$0(IndexFetcher.java:981)
at java.lang.Thread.run(Thread.java:748)
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:362)
at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:553)
at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:384)
at org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:458)
at org.apache.solr.handler.ReplicationHandler.lambda$setupPolling$13(ReplicationHandler.java:1255)
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:308)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:180)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:294)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MockDirectoryWrapper
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:362)
at org.apache.solr.update.SolrIndexWriter.create(SolrIndexWriter.java:98)
at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:813)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:1003)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:921)
at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1436)
at org.apache.solr.core.CoreContainer.lambda$load$11(CoreContainer.java:863)
at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:202)
at java.util.concurrent.FutureTask.run(FutureTask.java:266)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:218)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.http.impl.client.InternalHttpClient
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:339)
at org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:348)
at org.apache.solr.handler.IndexFetcher.createHttpClient(IndexFetcher.java:233)
at org.apache.solr.handler.IndexFetcher.<init>(IndexFetcher.java:275)
at org.apache.solr.handler.ReplicationHandler.inform(ReplicationHandler.java:1289)
at org.apache.solr.core.SolrResourceLoader.inform(SolrResourceLoader.java:730)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:1037)
at org.apache.solr.core.SolrCore.reload(SolrCore.java:708)
at org.apache.solr.core.CoreContainer.reload(CoreContainer.java:1705)
at org.apache.solr.handler.IndexFetcher.lambda$reloadCore$0(IndexFetcher.java:981)
at java.lang.Thread.run(Thread.java:748)
>
at __randomizedtesting.SeedInfo.seed([DA48D6027DDA6A31]:0)
at org.junit.Assert.fail(Assert.java:89)
at org.junit.Assert.failNotNull(Assert.java:756)
at org.junit.Assert.assertNull(Assert.java:738)
at org.apache.solr.SolrTestCaseJ4.teardownTestCases(SolrTestCaseJ4.java:330)
at sun.reflect.GeneratedMethodAccessor63.invoke(Unknown Source)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:901)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
FAILED: org.apache.solr.handler.component.TestDistributedStatsComponentCardinality.test
Error Message:
.responseHeader.status:200!=0
Stack Trace:
junit.framework.AssertionFailedError: .responseHeader.status:200!=0
at __randomizedtesting.SeedInfo.seed([DA48D6027DDA6A31:521CE9D8D32607C9]:0)
at junit.framework.Assert.fail(Assert.java:57)
at org.apache.solr.BaseDistributedSearchTestCase.compareSolrResponses(BaseDistributedSearchTestCase.java:1004)
at org.apache.solr.BaseDistributedSearchTestCase.compareResponses(BaseDistributedSearchTestCase.java:1031)
at org.apache.solr.BaseDistributedSearchTestCase.query(BaseDistributedSearchTestCase.java:677)
at org.apache.solr.BaseDistributedSearchTestCase.query(BaseDistributedSearchTestCase.java:640)
at org.apache.solr.handler.component.TestDistributedStatsComponentCardinality.test(TestDistributedStatsComponentCardinality.java:191)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:1088)
at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:1059)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
Build Log:
[...truncated 13898 lines...]
[junit4] Suite: org.apache.solr.handler.TestReplicationHandler
[junit4] 2> 499005 INFO (SUITE-TestReplicationHandler-seed#[DA48D6027DDA6A31]-worker) [ ] o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to test-framework derived value of '/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/server/solr/configsets/_default/conf'
[junit4] 2> 499005 INFO (SUITE-TestReplicationHandler-seed#[DA48D6027DDA6A31]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 499005 INFO (SUITE-TestReplicationHandler-seed#[DA48D6027DDA6A31]-worker) [ ] o.a.s.SolrTestCaseJ4 Created dataDir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.TestReplicationHandler_DA48D6027DDA6A31-001/data-dir-23-001
[junit4] 2> 499005 WARN (SUITE-TestReplicationHandler-seed#[DA48D6027DDA6A31]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=2 numCloses=2
[junit4] 2> 499005 INFO (SUITE-TestReplicationHandler-seed#[DA48D6027DDA6A31]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 499007 INFO (SUITE-TestReplicationHandler-seed#[DA48D6027DDA6A31]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl=None)
[junit4] 2> 499010 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testEmptyBackups
[junit4] 2> 499010 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.TestReplicationHandler_DA48D6027DDA6A31-001/solr-instance-001/collection1
[junit4] 2> 499014 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 499014 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 499014 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.e.j.s.Server jetty-9.4.41.v20210516; built: 2021-05-16T23:56:28.993Z; git: 98607f93c7833e7dc59489b13f3cb0a114fb9f4c; jvm 1.8.0_291-b10
[junit4] 2> 499014 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 499015 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 499015 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 499015 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@7f21e836{/solr,null,AVAILABLE}
[junit4] 2> 499015 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@1f59e287{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:43719}
[junit4] 2> 499015 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.e.j.s.Server Started @499051ms
[junit4] 2> 499015 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.TestReplicationHandler_DA48D6027DDA6A31-001/solr-instance-001/collection1/data, hostContext=/solr, hostPort=43719}
[junit4] 2> 499015 ERROR (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 499015 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 499015 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.10.0
[junit4] 2> 499015 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 499015 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr
[junit4] 2> 499015 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2021-07-28T14:22:32.637Z
[junit4] 2> 499015 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.TestReplicationHandler_DA48D6027DDA6A31-001/solr-instance-001/solr.xml
[junit4] 2> 499017 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 499017 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 499019 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@5863a788, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 499613 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 499614 WARN (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@4555aa4[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 499614 WARN (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@4555aa4[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 499622 WARN (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@2bda3941[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 499622 WARN (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@2bda3941[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 499624 WARN (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.c.CoreContainer Not all security plugins configured! authentication=disabled authorization=disabled. Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external. See https://s.apache.org/solrsecurity for more info
[junit4] 2> 499634 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient core cache for max 4 cores with initial capacity of 4
[junit4] 2> 499634 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 499652 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5863a788
[junit4] 2> 499658 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5863a788
[junit4] 2> 499658 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5863a788
[junit4] 2> 499660 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.TestReplicationHandler_DA48D6027DDA6A31-001/solr-instance-001
[junit4] 2> 499660 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 499668 INFO (coreLoadExecutor-5806-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.10.0
[junit4] 2> 499669 INFO (coreLoadExecutor-5806-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Schema name=test
[junit4] 2> 499669 INFO (coreLoadExecutor-5806-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
[junit4] 2> 499669 INFO (coreLoadExecutor-5806-thread-1) [ x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.TestReplicationHandler_DA48D6027DDA6A31-001/solr-instance-001/collection1, trusted=true
[junit4] 2> 499669 INFO (coreLoadExecutor-5806-thread-1) [ x:collection1 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5863a788
[junit4] 2> 499669 INFO (coreLoadExecutor-5806-thread-1) [ x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.TestReplicationHandler_DA48D6027DDA6A31-001/solr-instance-001/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.TestReplicationHandler_DA48D6027DDA6A31-001/solr-instance-001/collection1/data/]
[junit4] 2> 499671 INFO (coreLoadExecutor-5806-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=23, maxMergeAtOnceExplicit=38, maxMergedSegmentMB=37.6806640625, floorSegmentMB=1.431640625, forceMergeDeletesPctAllowed=5.640348856624547, segmentsPerTier=32.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0, deletesPctAllowed=38.13855711486421
[junit4] 2> 499707 INFO (coreLoadExecutor-5806-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 499707 INFO (coreLoadExecutor-5806-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 499708 INFO (coreLoadExecutor-5806-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=26, maxMergeAtOnceExplicit=16, maxMergedSegmentMB=65.11328125, floorSegmentMB=0.8837890625, forceMergeDeletesPctAllowed=7.210070776809792, segmentsPerTier=2.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0, deletesPctAllowed=26.098926925482786
[junit4] 2> 499708 INFO (coreLoadExecutor-5806-thread-1) [ x:collection1 ] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.TestReplicationHandler_DA48D6027DDA6A31-001/solr-instance-001/collection1/conf
[junit4] 2> 499709 INFO (coreLoadExecutor-5806-thread-1) [ x:collection1 ] o.a.s.h.ReplicationHandler Replication enabled for following config files: schema.xml,xslt/dummy.xsl
[junit4] 2> 499709 INFO (coreLoadExecutor-5806-thread-1) [ x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 499709 INFO (searcherExecutor-5808-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 499710 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.TestReplicationHandler_DA48D6027DDA6A31-001/solr-instance-002/collection1
[junit4] 2> 499712 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 499712 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 499713 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.e.j.s.Server jetty-9.4.41.v20210516; built: 2021-05-16T23:56:28.993Z; git: 98607f93c7833e7dc59489b13f3cb0a114fb9f4c; jvm 1.8.0_291-b10
[junit4] 2> 499713 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 499713 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 499713 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 499713 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@50356cda{/solr,null,AVAILABLE}
[junit4] 2> 499714 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@25ae763b{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:39631}
[junit4] 2> 499714 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.e.j.s.Server Started @499750ms
[junit4] 2> 499714 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.TestReplicationHandler_DA48D6027DDA6A31-001/solr-instance-002/collection1/data, hostContext=/solr, hostPort=39631}
[junit4] 2> 499714 ERROR (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 499714 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 499714 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.10.0
[junit4] 2> 499714 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 499714 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr
[junit4] 2> 499714 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2021-07-28T14:22:33.336Z
[junit4] 2> 499714 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.TestReplicationHandler_DA48D6027DDA6A31-001/solr-instance-002/solr.xml
[junit4] 2> 499716 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 499716 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 499718 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@5863a788, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 500126 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 500127 WARN (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@1a5d2446[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 500127 WARN (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@1a5d2446[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 500129 WARN (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@19f202b4[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 500129 WARN (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@19f202b4[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 500131 WARN (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.c.CoreContainer Not all security plugins configured! authentication=disabled authorization=disabled. Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external. See https://s.apache.org/solrsecurity for more info
[junit4] 2> 500141 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient core cache for max 4 cores with initial capacity of 4
[junit4] 2> 500142 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 500161 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5863a788
[junit4] 2> 500172 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5863a788
[junit4] 2> 500172 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5863a788
[junit4] 2> 500174 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.TestReplicationHandler_DA48D6027DDA6A31-001/solr-instance-002
[junit4] 2> 500174 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 500181 INFO (coreLoadExecutor-5824-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.10.0
[junit4] 2> 500182 INFO (coreLoadExecutor-5824-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Schema name=test
[junit4] 2> 500183 INFO (coreLoadExecutor-5824-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
[junit4] 2> 500183 INFO (coreLoadExecutor-5824-thread-1) [ x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.TestReplicationHandler_DA48D6027DDA6A31-001/solr-instance-002/collection1, trusted=true
[junit4] 2> 500183 INFO (coreLoadExecutor-5824-thread-1) [ x:collection1 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5863a788
[junit4] 2> 500183 INFO (coreLoadExecutor-5824-thread-1) [ x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.TestReplicationHandler_DA48D6027DDA6A31-001/solr-instance-002/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.TestReplicationHandler_DA48D6027DDA6A31-001/solr-instance-002/collection1/data/]
[junit4] 2> 500185 INFO (coreLoadExecutor-5824-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=23, maxMergeAtOnceExplicit=38, maxMergedSegmentMB=37.6806640625, floorSegmentMB=1.431640625, forceMergeDeletesPctAllowed=5.640348856624547, segmentsPerTier=32.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0, deletesPctAllowed=38.13855711486421
[junit4] 2> 500246 INFO (coreLoadExecutor-5824-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 500246 INFO (coreLoadExecutor-5824-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 500247 INFO (coreLoadExecutor-5824-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=26, maxMergeAtOnceExplicit=16, maxMergedSegmentMB=65.11328125, floorSegmentMB=0.8837890625, forceMergeDeletesPctAllowed=7.210070776809792, segmentsPerTier=2.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0, deletesPctAllowed=26.098926925482786
[junit4] 2> 500247 INFO (coreLoadExecutor-5824-thread-1) [ x:collection1 ] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.TestReplicationHandler_DA48D6027DDA6A31-001/solr-instance-002/collection1/conf
[junit4] 2> 500249 INFO (coreLoadExecutor-5824-thread-1) [ x:collection1 ] o.a.s.h.ReplicationHandler Poll scheduled at an interval of 1000ms
[junit4] 2> 500249 INFO (coreLoadExecutor-5824-thread-1) [ x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 500253 INFO (searcherExecutor-5826-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 500254 INFO (qtp2070759880-25533) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 QTime=0
[junit4] 2> 500254 INFO (indexFetcher-5830-thread-1) [ ] o.a.s.h.IndexFetcher Leader's generation: 1
[junit4] 2> 500254 INFO (indexFetcher-5830-thread-1) [ ] o.a.s.h.IndexFetcher Leader's version: 0
[junit4] 2> 500254 INFO (indexFetcher-5830-thread-1) [ ] o.a.s.h.IndexFetcher Follower's generation: 1
[junit4] 2> 500254 INFO (indexFetcher-5830-thread-1) [ ] o.a.s.h.IndexFetcher Follower's version: 0
[junit4] 2> 500254 INFO (indexFetcher-5830-thread-1) [ ] o.a.s.h.IndexFetcher New index in Leader. Deleting mine...
[junit4] 2> 500261 INFO (searcherExecutor-5826-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 500262 INFO (qtp2070759880-25531) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={name=empty_backup1&location=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.TestReplicationHandler_DA48D6027DDA6A31-001/tempDir-001&wt=javabin&version=2&command=backup} status=0 QTime=8
[junit4] 2> 500262 INFO (Thread-16895) [ ] o.a.s.h.SnapShooter Creating backup snapshot empty_backup1 at file:///home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.TestReplicationHandler_DA48D6027DDA6A31-001/tempDir-001/
[junit4] 2> 500263 INFO (Thread-16895) [ ] o.a.s.h.SnapShooter Done creating backup snapshot: empty_backup1 into file:///home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.TestReplicationHandler_DA48D6027DDA6A31-001/tempDir-001/snapshot.empty_backup1
[junit4] 2> 500264 INFO (qtp2070759880-25534) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={wt=javabin&version=2&command=details} status=0 QTime=1
[junit4] 2> 500265 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.h.BackupStatusChecker Checking Status of empty_backup1: {responseHeader={status=0,QTime=1},status=OK,details={indexSize=69 bytes,indexPath=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.TestReplicationHandler_DA48D6027DDA6A31-001/solr-instance-001/collection1/data/index/,commits=[{indexVersion=0,generation=1,filelist=[segments_1]}],isMaster=true,isSlave=false,indexVersion=0,generation=1,master={confFiles=schema.xml,xslt/dummy.xsl,replicateAfter=[commit],replicationEnabled=true},backup={startTime=Wed Jul 28 07:22:33 PDT 2021,fileCount=1,status=success,snapshotCompletedAt=Wed Jul 28 07:22:33 PDT 2021,snapshotName=empty_backup1,directoryName=snapshot.empty_backup1}}}
[junit4] 2> 500266 INFO (qtp2070759880-25530) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[1]} 0 1
[junit4] 2> 500267 INFO (qtp2070759880-25532) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={name=empty_backup2&location=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.TestReplicationHandler_DA48D6027DDA6A31-001/tempDir-001&wt=javabin&version=2&command=backup} status=0 QTime=0
[junit4] 2> 500268 INFO (Thread-16896) [ ] o.a.s.h.SnapShooter Creating backup snapshot empty_backup2 at file:///home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.TestReplicationHandler_DA48D6027DDA6A31-001/tempDir-001/
[junit4] 2> 500268 INFO (qtp2070759880-25533) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={wt=javabin&version=2&command=details} status=0 QTime=0
[junit4] 2> 500268 INFO (Thread-16896) [ ] o.a.s.h.SnapShooter Done creating backup snapshot: empty_backup2 into file:///home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.TestReplicationHandler_DA48D6027DDA6A31-001/tempDir-001/snapshot.empty_backup2
[junit4] 2> 500268 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.h.BackupStatusChecker Checking Status of empty_backup2: {responseHeader={status=0,QTime=0},status=OK,details={indexSize=69 bytes,indexPath=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.TestReplicationHandler_DA48D6027DDA6A31-001/solr-instance-001/collection1/data/index/,commits=[{indexVersion=0,generation=1,filelist=[segments_1]}],isMaster=true,isSlave=false,indexVersion=0,generation=1,master={confFiles=schema.xml,xslt/dummy.xsl,replicateAfter=[commit],replicationEnabled=true},backup={startTime=Wed Jul 28 07:22:33 PDT 2021,fileCount=1,status=success,snapshotCompletedAt=Wed Jul 28 07:22:33 PDT 2021,snapshotName=empty_backup1,directoryName=snapshot.empty_backup1}}}
[junit4] 2> 500319 INFO (qtp2070759880-25531) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={wt=javabin&version=2&command=details} status=0 QTime=0
[junit4] 2> 500319 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.h.BackupStatusChecker Checking Status of empty_backup2: {responseHeader={status=0,QTime=0},status=OK,details={indexSize=69 bytes,indexPath=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.TestReplicationHandler_DA48D6027DDA6A31-001/solr-instance-001/collection1/data/index/,commits=[{indexVersion=0,generation=1,filelist=[segments_1]}],isMaster=true,isSlave=false,indexVersion=0,generation=1,master={confFiles=schema.xml,xslt/dummy.xsl,replicateAfter=[commit],replicationEnabled=true},backup={startTime=Wed Jul 28 07:22:33 PDT 2021,fileCount=1,status=success,snapshotCompletedAt=Wed Jul 28 07:22:33 PDT 2021,snapshotName=empty_backup2,directoryName=snapshot.empty_backup2}}}
[junit4] 2> 500320 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testEmptyBackups
[junit4] 2> 500320 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1217310611
[junit4] 2> 500320 INFO (coreCloseExecutor-5833-thread-1) [ ] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@2ee9d4b3
[junit4] 2> 500320 INFO (coreCloseExecutor-5833-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1 tag=SolrCore@2ee9d4b3
[junit4] 2> 500320 INFO (coreCloseExecutor-5833-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@3edd05ba: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1/com.codahale.metrics.MetricRegistry@6e1748c
[junit4] 2> 500328 INFO (coreCloseExecutor-5833-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close() ... SKIPPED (unnecessary).
[junit4] 2> 500332 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node tag=null
[junit4] 2> 500332 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@3306c864: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node/com.codahale.metrics.MetricRegistry@3e18cca0
[junit4] 2> 500336 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm tag=null
[junit4] 2> 500336 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@400706fe: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm/com.codahale.metrics.MetricRegistry@31d933e2
[junit4] 2> 500339 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty tag=null
[junit4] 2> 500339 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@3ffa1d55: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty/com.codahale.metrics.MetricRegistry@5b060f48
[junit4] 2> 500340 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@1f59e287{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:0}
[junit4] 2> 500341 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@7f21e836{/solr,null,STOPPED}
[junit4] 2> 500341 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 500343 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=824303910
[junit4] 2> 500343 INFO (coreCloseExecutor-5837-thread-1) [ ] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@24d2e39e
[junit4] 2> 500343 INFO (coreCloseExecutor-5837-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1 tag=SolrCore@24d2e39e
[junit4] 2> 500343 INFO (coreCloseExecutor-5837-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@67bddddc: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1/com.codahale.metrics.MetricRegistry@a325d3e
[junit4] 2> 500354 INFO (coreCloseExecutor-5837-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close() ... SKIPPED (unnecessary).
[junit4] 2> 500356 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node tag=null
[junit4] 2> 500356 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@2f032912: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node/com.codahale.metrics.MetricRegistry@6ccb80fd
[junit4] 2> 500361 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm tag=null
[junit4] 2> 500361 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@13cc8928: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm/com.codahale.metrics.MetricRegistry@31d933e2
[junit4] 2> 500363 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty tag=null
[junit4] 2> 500363 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@26a352e: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty/com.codahale.metrics.MetricRegistry@5b060f48
[junit4] 2> 500365 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@25ae763b{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:0}
[junit4] 2> 500365 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@50356cda{/solr,null,STOPPED}
[junit4] 2> 500365 INFO (TEST-TestReplicationHandler.testEmptyBackups-seed#[DA48D6027DDA6A31]) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 500369 INFO (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testFetchIndexShouldReportErrorsWhenTheyOccur
[junit4] 2> 500370 INFO (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.TestReplicationHandler_DA48D6027DDA6A31-001/solr-instance-003/collection1
[junit4] 2> 500372 INFO (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 500372 INFO (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 500372 INFO (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.e.j.s.Server jetty-9.4.41.v20210516; built: 2021-05-16T23:56:28.993Z; git: 98607f93c7833e7dc59489b13f3cb0a114fb9f4c; jvm 1.8.0_291-b10
[junit4] 2> 500372 INFO (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 500372 INFO (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 500373 INFO (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 500373 INFO (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@493a867d{/solr,null,AVAILABLE}
[junit4] 2> 500373 INFO (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@4ca797b7{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:37933}
[junit4] 2> 500373 INFO (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.e.j.s.Server Started @500409ms
[junit4] 2> 500373 INFO (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.TestReplicationHandler_DA48D6027DDA6A31-001/solr-instance-003/collection1/data, hostContext=/solr, hostPort=37933}
[junit4] 2> 500373 ERROR (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 500373 INFO (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 500373 INFO (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.10.0
[junit4] 2> 500373 INFO (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 500373 INFO (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr
[junit4] 2> 500373 INFO (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2021-07-28T14:22:33.995Z
[junit4] 2> 500373 INFO (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.TestReplicationHandler_DA48D6027DDA6A31-001/solr-instance-003/solr.xml
[junit4] 2> 500376 INFO (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 500376 INFO (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 500377 INFO (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@5863a788, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 501138 INFO (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 501141 WARN (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@4fb769e9[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 501141 WARN (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@4fb769e9[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 501153 WARN (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@596c9d0d[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 501153 WARN (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@596c9d0d[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 501154 WARN (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.a.s.c.CoreContainer Not all security plugins configured! authentication=disabled authorization=disabled. Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external. See https://s.apache.org/solrsecurity for more info
[junit4] 2> 501171 INFO (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient core cache for max 4 cores with initial capacity of 4
[junit4] 2> 501171 INFO (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 501190 INFO (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5863a788
[junit4] 2> 501197 INFO (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5863a788
[junit4] 2> 501197 INFO (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5863a788
[junit4] 2> 501199 INFO (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.TestReplicationHandler_DA48D6027DDA6A31-001/solr-instance-003
[junit4] 2> 501199 INFO (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 501210 INFO (coreLoadExecutor-5851-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.10.0
[junit4] 2> 501211 INFO (coreLoadExecutor-5851-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Schema name=test
[junit4] 2> 501211 INFO (coreLoadExecutor-5851-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
[junit4] 2> 501211 INFO (coreLoadExecutor-5851-thread-1) [ x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.TestReplicationHandler_DA48D6027DDA6A31-001/solr-instance-003/collection1, trusted=true
[junit4] 2> 501211 INFO (coreLoadExecutor-5851-thread-1) [ x:collection1 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5863a788
[junit4] 2> 501211 INFO (coreLoadExecutor-5851-thread-1) [ x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.TestReplicationHandler_DA48D6027DDA6A31-001/solr-instance-003/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.TestReplicationHandler_DA48D6027DDA6A31-001/solr-instance-003/collection1/data/]
[junit4] 2> 501213 INFO (coreLoadExecutor-5851-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=23, maxMergeAtOnceExplicit=38, maxMergedSegmentMB=37.6806640625, floorSegmentMB=1.431640625, forceMergeDeletesPctAllowed=5.640348856624547, segmentsPerTier=32.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0, deletesPctAllowed=38.13855711486421
[junit4] 2> 501251 INFO (coreLoadExecutor-5851-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 501251 INFO (coreLoadExecutor-5851-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 501252 INFO (coreLoadExecutor-5851-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=26, maxMergeAtOnceExplicit=16, maxMergedSegmentMB=65.11328125, floorSegmentMB=0.8837890625, forceMergeDeletesPctAllowed=7.210070776809792, segmentsPerTier=2.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0, deletesPctAllowed=26.098926925482786
[junit4] 2> 501253 INFO (coreLoadExecutor-5851-thread-1) [ x:collection1 ] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.TestReplicationHandler_DA48D6027DDA6A31-001/solr-instance-003/collection1/conf
[junit4] 2> 501253 INFO (coreLoadExecutor-5851-thread-1) [ x:collection1 ] o.a.s.h.ReplicationHandler Replication enabled for following config files: schema.xml,xslt/dummy.xsl
[junit4] 2> 501253 INFO (coreLoadExecutor-5851-thread-1) [ x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 501254 INFO (searcherExecutor-5853-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 501255 INFO (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.TestReplicationHandler_DA48D6027DDA6A31-001/solr-instance-004/collection1
[junit4] 2> 501257 INFO (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 501257 INFO (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 501257 INFO (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.e.j.s.Server jetty-9.4.41.v20210516; built: 2021-05-16T23:56:28.993Z; git: 98607f93c7833e7dc59489b13f3cb0a114fb9f4c; jvm 1.8.0_291-b10
[junit4] 2> 501258 INFO (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 501258 INFO (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 501258 INFO (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 501258 INFO (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@3afe7334{/solr,null,AVAILABLE}
[junit4] 2> 501258 INFO (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@5881238c{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:33567}
[junit4] 2> 501258 INFO (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.e.j.s.Server Started @501294ms
[junit4] 2> 501258 INFO (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.TestReplicationHandler_DA48D6027DDA6A31-001/solr-instance-004/collection1/data, hostContext=/solr, hostPort=33567}
[junit4] 2> 501258 ERROR (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 501258 INFO (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 501259 INFO (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.10.0
[junit4] 2> 501259 INFO (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 501259 INFO (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr
[junit4] 2> 501259 INFO (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2021-07-28T14:22:34.881Z
[junit4] 2> 501259 INFO (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.TestReplicationHandler_DA48D6027DDA6A31-001/solr-instance-004/solr.xml
[junit4] 2> 501261 INFO (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 501261 INFO (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 501272 INFO (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@5863a788, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 501391 INFO (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 501392 WARN (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@4fa92817[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 501392 WARN (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@4fa92817[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 501394 WARN (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@3b8eee80[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 501394 WARN (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@3b8eee80[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 501395 WARN (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.a.s.c.CoreContainer Not all security plugins configured! authentication=disabled authorization=disabled. Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external. See https://s.apache.org/solrsecurity for more info
[junit4] 2> 501405 INFO (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient core cache for max 4 cores with initial capacity of 4
[junit4] 2> 501406 INFO (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 501424 INFO (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5863a788
[junit4] 2> 501435 INFO (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5863a788
[junit4] 2> 501435 INFO (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5863a788
[junit4] 2> 501437 INFO (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.TestReplicationHandler_DA48D6027DDA6A31-001/solr-instance-004
[junit4] 2> 501437 INFO (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 501445 INFO (coreLoadExecutor-5869-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.10.0
[junit4] 2> 501446 INFO (coreLoadExecutor-5869-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Schema name=test
[junit4] 2> 501446 INFO (coreLoadExecutor-5869-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
[junit4] 2> 501446 INFO (coreLoadExecutor-5869-thread-1) [ x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.TestReplicationHandler_DA48D6027DDA6A31-001/solr-instance-004/collection1, trusted=true
[junit4] 2> 501447 INFO (coreLoadExecutor-5869-thread-1) [ x:collection1 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5863a788
[junit4] 2> 501447 INFO (coreLoadExecutor-5869-thread-1) [ x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.TestReplicationHandler_DA48D6027DDA6A31-001/solr-instance-004/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.TestReplicationHandler_DA48D6027DDA6A31-001/solr-instance-004/collection1/data/]
[junit4] 2> 501449 INFO (coreLoadExecutor-5869-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=23, maxMergeAtOnceExplicit=38, maxMergedSegmentMB=37.6806640625, floorSegmentMB=1.431640625, forceMergeDeletesPctAllowed=5.640348856624547, segmentsPerTier=32.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0, deletesPctAllowed=38.13855711486421
[junit4] 2> 501489 INFO (coreLoadExecutor-5869-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 501489 INFO (coreLoadExecutor-5869-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 501490 INFO (coreLoadExecutor-5869-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=26, maxMergeAtOnceExplicit=16, maxMergedSegmentMB=65.11328125, floorSegmentMB=0.8837890625, forceMergeDeletesPctAllowed=7.210070776809792, segmentsPerTier=2.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0, deletesPctAllowed=26.098926925482786
[junit4] 2> 501490 INFO (coreLoadExecutor-5869-thread-1) [ x:collection1 ] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.TestReplicationHandler_DA48D6027DDA6A31-001/solr-instance-004/collection1/conf
[junit4] 2> 501492 INFO (coreLoadExecutor-5869-thread-1) [ x:collection1 ] o.a.s.h.ReplicationHandler Poll scheduled at an interval of 1000ms
[junit4] 2> 501492 INFO (coreLoadExecutor-5869-thread-1) [ x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 501492 INFO (TEST-TestReplicationHandler.testFetchIndexShouldReportErrorsWhenTheyOccur-seed#[DA48D6027DDA6A31]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1978792628
[junit4] 2> 501493 ERROR (qtp2086349993-25585) [ ] o.a.s.s.SolrDispatchFilter Error processing the request. CoreContainer is either not initialized or shutting down.
[junit4] 2> 501493 INFO (coreCloseExecutor-5878-thread-1) [ ] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@3ee5e3b4
[junit4] 2> 501493 INFO (coreCloseExecutor-5878-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1 tag=SolrCore@3ee5e3b4
[junit4] 2> 501493 INFO (coreCloseExecutor-5878-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@5f0411af: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1/com.codahale.metrics.MetricRegistry@2ee18f6b
[junit4] 2> 501493 WARN (qtp2086349993-25585) [ ] o.e.j.s.HttpChannel /solr/collection1/replication
[junit4] 2> => javax.servlet.UnavailableException: Error processing the request. CoreContainer is either not initialized or shutting down.
[junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:376)
[junit4] 2> javax.servlet.UnavailableException: Error processing the request. CoreContainer is either not initialized or shutting down.
[junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.doFi
[...truncated too long message...]
3679155 INFO (closeThreadPool-27408-thread-13) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 3679158 INFO (closeThreadPool-27408-thread-1) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@779706b7{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:0}
[junit4] 2> 3679159 INFO (closeThreadPool-27408-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@4f1a58b7{/,null,STOPPED}
[junit4] 2> 3679159 INFO (closeThreadPool-27408-thread-1) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 3679161 INFO (closeThreadPool-27408-thread-11) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@47438d8b{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:0}
[junit4] 2> 3679165 INFO (closeThreadPool-27408-thread-11) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@b52635{/,null,STOPPED}
[junit4] 2> 3679165 INFO (closeThreadPool-27408-thread-11) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 3679165 INFO (closeThreadPool-27408-thread-7) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@4afda0b0{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:0}
[junit4] 2> 3679173 INFO (closeThreadPool-27408-thread-12) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@5b26b4cd{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:0}
[junit4] 2> 3679173 INFO (closeThreadPool-27408-thread-7) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@1bd6e3d0{/,null,STOPPED}
[junit4] 2> 3679173 INFO (closeThreadPool-27408-thread-7) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 3679173 INFO (closeThreadPool-27408-thread-12) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@60a2b7cb{/,null,STOPPED}
[junit4] 2> 3679173 INFO (closeThreadPool-27408-thread-12) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 3679174 INFO (closeThreadPool-27408-thread-6) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node tag=null
[junit4] 2> 3679174 INFO (closeThreadPool-27408-thread-6) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@4053bdd4: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node/com.codahale.metrics.MetricRegistry@2f353dd4
[junit4] 2> 3679178 INFO (closeThreadPool-27408-thread-6) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm tag=null
[junit4] 2> 3679178 INFO (closeThreadPool-27408-thread-6) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@28df1983: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm/com.codahale.metrics.MetricRegistry@31d933e2
[junit4] 2> 3679180 INFO (closeThreadPool-27408-thread-6) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty tag=null
[junit4] 2> 3679180 INFO (closeThreadPool-27408-thread-6) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@5c50d74: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty/com.codahale.metrics.MetricRegistry@5b060f48
[junit4] 2> 3679188 INFO (closeThreadPool-27408-thread-6) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@3c8a0705{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:0}
[junit4] 2> 3679188 INFO (closeThreadPool-27408-thread-6) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@7afb483a{/,null,STOPPED}
[junit4] 2> 3679188 INFO (closeThreadPool-27408-thread-6) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> NOTE: download the large Jenkins line-docs file by running 'ant get-jenkins-line-docs' in the lucene directory.
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestDistributedStatsComponentCardinality -Dtests.method=test -Dtests.seed=DA48D6027DDA6A31 -Dtests.multiplier=2 -Dtests.nightly=true -Dtests.slow=true -Dtests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/test-data/enwiki.random.lines.txt -Dtests.locale=he -Dtests.timezone=Canada/Mountain -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] FAILURE 116s J3 | TestDistributedStatsComponentCardinality.test <<<
[junit4] > Throwable #1: junit.framework.AssertionFailedError: .responseHeader.status:200!=0
[junit4] > at __randomizedtesting.SeedInfo.seed([DA48D6027DDA6A31:521CE9D8D32607C9]:0)
[junit4] > at junit.framework.Assert.fail(Assert.java:57)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase.compareSolrResponses(BaseDistributedSearchTestCase.java:1004)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase.compareResponses(BaseDistributedSearchTestCase.java:1031)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase.query(BaseDistributedSearchTestCase.java:677)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase.query(BaseDistributedSearchTestCase.java:640)
[junit4] > at org.apache.solr.handler.component.TestDistributedStatsComponentCardinality.test(TestDistributedStatsComponentCardinality.java:191)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:1088)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:1059)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.component.TestDistributedStatsComponentCardinality_DA48D6027DDA6A31-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene87), sim=Asserting(RandomSimilarity(queryNorm=false): {}), locale=he, timezone=Canada/Mountain
[junit4] 2> NOTE: Linux 4.15.0-147-generic amd64/Oracle Corporation 1.8.0_291 (64-bit)/cpus=4,threads=1,free=255692408,total=531103744
[junit4] 2> NOTE: All tests run in this JVM: [OverseerRolesTest, DeleteStatusTest, TestComponentsName, ImplicitSnitchTest, CursorPagingTest, TestSmileRequest, TransactionLogTest, Tagger2Test, TestManagedStopFilterFactory, TestConfigSetsAPIExclusivity, DistributedQueryComponentCustomSortTest, HdfsTlogReplayBufferedWhileIndexingTest, TestSolrCloudWithSecureImpersonation, CloudMLTQParserTest, RecoveryAfterSoftCommitTest, TriggerIntegrationTest, TestFieldCacheSort, TestQueryingOnDownCollection, SmileWriterTest, HdfsChaosMonkeyNothingIsSafeTest, SolrXmlInZkTest, DistributedFacetPivotSmallAdvancedTest, CollectionsAPIDistributedZkTest, SOLR749Test, TestReplicationHandler, TestHdfsUpdateLog, HdfsBackupRepositoryIntegrationTest, TestCloudRecovery2, AlternateDirectoryTest, DaemonStreamApiTest, TestTermsQParserPlugin, PeerSyncWithBufferUpdatesTest, SolrIndexMetricsTest, TestHttpServletCarrier, TestScoreJoinQPNoScore, LoggingHandlerTest, IndexSchemaRuntimeFieldTest, TestInfoStreamLogging, UUIDFieldTest, TestStressReorder, ComputePlanActionTest, TestDeprecatedFilters, TestSha256AuthenticationProvider, DefaultValueUpdateProcessorTest, TestLeaderElectionZkExpiry, TestMergePolicyConfig, NumberUtilsTest, RollingRestartTest, TestPointFields, HdfsCloudIncrementalBackupTest, BadIndexSchemaTest, TestNumericRangeQuery64, CloudExitableDirectoryReaderTest, BackupRestoreApiErrorConditionsTest, NumericFieldsTest, TestCoreContainer, RequestLoggingTest, ExplicitHLLTest, TestPayloadScoreQParserPlugin, SystemInfoHandlerTest, TestSafeXMLParsing, TestPushWriter, TestExtendedDismaxParser, TestBadConfig, TestFastOutputStream, ConnectionManagerTest, ForceLeaderWithTlogReplicasTest, LeaderFailoverAfterPartitionTest, AddSchemaFieldsUpdateProcessorFactoryTest, TestDocTermOrds, CdcrOpsAndBoundariesTest, TestSimGenericDistributedQueue, TestCoreAdminApis, TestDynamicFieldCollectionResource, CachingDirectoryFactoryTest, TestCloudPhrasesIdentificationComponent, OutOfBoxZkACLAndCredentialsProvidersTest, TestDynamicLoading, TestFieldTypeCollectionResource, SimpleFacetsTest, SolrLogAuditLoggerPluginTest, DocValuesMultiTest, JavabinLoaderTest, CdcrWithNodesRestartsTest, HttpPartitionWithTlogReplicasTest, TestSlowCompositeReaderWrapper, TestLMDirichletSimilarityFactory, TestConfigOverlay, DistributedQueueTest, TestSnapshotCloudManager, TestRequestStatusCollectionAPI, DateMathParserTest, AddBlockUpdateTest, TestSimDistribStateManager, TermVectorComponentTest, TestSolrXml, TestSchemaSimilarityResource, TestPerFieldSimilarity, TestPrepRecovery, TestSolrQueryResponse, SolrLogPostToolTest, TestCaffeineCache, BasicAuthOnSingleNodeTest, JWTIssuerConfigTest, TestCloudJSONFacetJoinDomain, SolrTestCaseJ4DeleteCoreTest, MoreLikeThisComponentTest, SolrRrdBackendFactoryTest, SharedFSAutoReplicaFailoverTest, MissingSegmentRecoveryTest, TestGroupingSearch, ClassificationUpdateProcessorFactoryTest, HdfsWriteToMultipleCollectionsTest, TestClusterStateMutator, ConfigureRecoveryStrategyTest, CoreSorterTest, DirectoryFactoriesTest, DirectoryFactoryTest, ExitableDirectoryReaderTest, HdfsDirectoryFactoryTest, PluginInfoTest, QueryResultKeyTest, TestSolrCoreSnapshots, BinaryUpdateRequestHandlerTest, CSVRequestHandlerTest, DocumentAnalysisRequestHandlerTest, FieldAnalysisRequestHandlerTest, SearchHandlerTest, TestBlobHandler, TestRestoreCore, TestSolrConfigHandlerConcurrent, TestStressThreadBackup, XsltUpdateRequestHandlerTest, AdminHandlersProxyTest, MBeansHandlerTest, DebugComponentTest, DistributedDebugComponentTest, DistributedQueryComponentOptimizationTest, DistributedSuggestComponentTest, ResponseBuilderTest, SearchHandlerTest, TestDistributedStatsComponentCardinality]
[junit4] Completed [743/940 (2!)] on J3 in 115.93s, 1 test, 1 failure <<< FAILURES!
[...truncated 53265 lines...]
[JENKINS] Lucene » Lucene-Solr-NightlyTests-8.x - Build # 344 - Still Unstable!
Posted by Apache Jenkins Server <je...@builds.apache.org>.
Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-Solr-NightlyTests-8.x/344/
2 tests failed.
FAILED: org.apache.solr.cloud.RollingRestartTest.test
Error Message:
Timeout occurred while waiting response from server at: http://127.0.0.1:38899
Stack Trace:
org.apache.solr.client.solrj.SolrServerException: Timeout occurred while waiting response from server at: http://127.0.0.1:38899
at __randomizedtesting.SeedInfo.seed([D5537BAA8C294D6:85010860063EF92E]:0)
at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:692)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:266)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:248)
at org.apache.solr.client.solrj.impl.LBSolrClient.doRequest(LBSolrClient.java:369)
at org.apache.solr.client.solrj.impl.LBSolrClient.request(LBSolrClient.java:297)
at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.sendRequest(BaseCloudSolrClient.java:1171)
at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.requestWithRetryOnStaleState(BaseCloudSolrClient.java:934)
at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.request(BaseCloudSolrClient.java:866)
at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:214)
at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:231)
at org.apache.solr.cloud.RollingRestartTest.restartWithRolesTest(RollingRestartTest.java:74)
at org.apache.solr.cloud.RollingRestartTest.test(RollingRestartTest.java:53)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:1088)
at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:1059)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
Caused by: java.net.SocketTimeoutException: Read timed out
at java.net.SocketInputStream.socketRead0(Native Method)
at java.net.SocketInputStream.socketRead(SocketInputStream.java:116)
at java.net.SocketInputStream.read(SocketInputStream.java:171)
at java.net.SocketInputStream.read(SocketInputStream.java:141)
at org.apache.http.impl.io.SessionInputBufferImpl.streamRead(SessionInputBufferImpl.java:137)
at org.apache.http.impl.io.SessionInputBufferImpl.fillBuffer(SessionInputBufferImpl.java:153)
at org.apache.http.impl.io.SessionInputBufferImpl.readLine(SessionInputBufferImpl.java:280)
at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:138)
at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:56)
at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:259)
at org.apache.http.impl.DefaultBHttpClientConnection.receiveResponseHeader(DefaultBHttpClientConnection.java:163)
at org.apache.http.impl.conn.CPoolProxy.receiveResponseHeader(CPoolProxy.java:157)
at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:273)
at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:125)
at org.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:272)
at org.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:186)
at org.apache.http.impl.execchain.RetryExec.execute(RetryExec.java:89)
at org.apache.http.impl.execchain.RedirectExec.execute(RedirectExec.java:110)
at org.apache.http.impl.client.InternalHttpClient.doExecute(InternalHttpClient.java:185)
at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:83)
at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:56)
at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:571)
... 56 more
FAILED: org.apache.solr.cloud.hdfs.HdfsBasicDistributedZk2Test.test
Error Message:
Backup failure: the_backup expected null, but was:<codec footer mismatch (file truncated?): actual footer=808464432 vs expected footer=-1071082520 (resource=BufferedChecksumIndexInput(_1.inf))>
Stack Trace:
java.lang.AssertionError: Backup failure: the_backup expected null, but was:<codec footer mismatch (file truncated?): actual footer=808464432 vs expected footer=-1071082520 (resource=BufferedChecksumIndexInput(_1.inf))>
at __randomizedtesting.SeedInfo.seed([D5537BAA8C294D6:85010860063EF92E]:0)
at org.junit.Assert.fail(Assert.java:89)
at org.junit.Assert.failNotNull(Assert.java:756)
at org.junit.Assert.assertNull(Assert.java:738)
at org.apache.solr.handler.BackupStatusChecker._checkBackupSuccess(BackupStatusChecker.java:208)
at org.apache.solr.handler.BackupStatusChecker.checkBackupSuccess(BackupStatusChecker.java:187)
at org.apache.solr.handler.BackupStatusChecker.waitForBackupSuccess(BackupStatusChecker.java:96)
at org.apache.solr.handler.BackupStatusChecker.waitForBackupSuccess(BackupStatusChecker.java:72)
at org.apache.solr.cloud.BasicDistributedZk2Test.brindDownShardIndexSomeDocsAndRecover(BasicDistributedZk2Test.java:417)
at org.apache.solr.cloud.BasicDistributedZk2Test.test(BasicDistributedZk2Test.java:102)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:1088)
at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:1059)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
Build Log:
[...truncated 14302 lines...]
[junit4] Suite: org.apache.solr.cloud.RollingRestartTest
[junit4] 2> 1103043 INFO (SUITE-RollingRestartTest-seed#[D5537BAA8C294D6]-worker) [ ] o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to test-framework derived value of '/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/server/solr/configsets/_default/conf'
[junit4] 2> 1103043 INFO (SUITE-RollingRestartTest-seed#[D5537BAA8C294D6]-worker) [ ] o.a.s.SolrTestCaseJ4 Created dataDir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.cloud.RollingRestartTest_D5537BAA8C294D6-001/data-dir-53-001
[junit4] 2> 1103043 WARN (SUITE-RollingRestartTest-seed#[D5537BAA8C294D6]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=124 numCloses=124
[junit4] 2> 1103043 INFO (SUITE-RollingRestartTest-seed#[D5537BAA8C294D6]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 1103045 INFO (SUITE-RollingRestartTest-seed#[D5537BAA8C294D6]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
[junit4] 2> 1103045 INFO (SUITE-RollingRestartTest-seed#[D5537BAA8C294D6]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 1103045 INFO (SUITE-RollingRestartTest-seed#[D5537BAA8C294D6]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /
[junit4] 2> 1103051 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1103052 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer client port: 0.0.0.0/0.0.0.0:0
[junit4] 2> 1103052 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 1103052 WARN (ZkTestServer Run Thread) [ ] o.a.z.s.ServerCnxnFactory maxCnxns is not configured, using default value 0.
[junit4] 2> 1103152 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.c.ZkTestServer start zk server on port: 44039
[junit4] 2> 1103152 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:44039
[junit4] 2> 1103152 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:44039
[junit4] 2> 1103152 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 44039
[junit4] 2> 1103154 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1103163 INFO (zkConnectionManagerCallback-8783-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1103163 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1103182 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1103213 INFO (zkConnectionManagerCallback-8785-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1103213 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1103215 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml to /configs/conf1/solrconfig.xml
[junit4] 2> 1103218 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1/conf/schema.xml to /configs/conf1/schema.xml
[junit4] 2> 1103221 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 1103223 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1/conf/stopwords.txt to /configs/conf1/stopwords.txt
[junit4] 2> 1103224 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1/conf/protwords.txt to /configs/conf1/protwords.txt
[junit4] 2> 1103225 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1/conf/currency.xml to /configs/conf1/currency.xml
[junit4] 2> 1103227 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml to /configs/conf1/enumsConfig.xml
[junit4] 2> 1103232 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json to /configs/conf1/open-exchange-rates.json
[junit4] 2> 1103238 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 1103239 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt to /configs/conf1/old_synonyms.txt
[junit4] 2> 1103243 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1/conf/synonyms.txt to /configs/conf1/synonyms.txt
[junit4] 2> 1103244 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.c.AbstractFullDistribZkTestBase Will use NRT replicas unless explicitly asked otherwise
[junit4] 2> 1103352 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 1103352 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 1103352 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.e.j.s.Server jetty-9.4.41.v20210516; built: 2021-05-16T23:56:28.993Z; git: 98607f93c7833e7dc59489b13f3cb0a114fb9f4c; jvm 1.8.0_291-b10
[junit4] 2> 1103567 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1103567 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1103567 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 1103580 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@44a5e99d{/,null,AVAILABLE}
[junit4] 2> 1103580 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@298488d4{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:43021}
[junit4] 2> 1103580 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.e.j.s.Server Started @1103619ms
[junit4] 2> 1103580 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.cloud.RollingRestartTest_D5537BAA8C294D6-001/tempDir-001/control/data, replicaType=NRT, hostContext=/, hostPort=43021, coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.cloud.RollingRestartTest_D5537BAA8C294D6-001/control-001/cores}
[junit4] 2> 1103580 ERROR (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1103580 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1103580 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.10.0
[junit4] 2> 1103580 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1103580 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr
[junit4] 2> 1103580 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2021-07-29T14:27:31.080Z
[junit4] 2> 1103585 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1103588 INFO (zkConnectionManagerCallback-8787-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1103588 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1103690 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper)
[junit4] 2> 1103690 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.cloud.RollingRestartTest_D5537BAA8C294D6-001/control-001/solr.xml
[junit4] 2> 1103693 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 1103693 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 1103694 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@58c5691f, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 1103858 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 1103858 WARN (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@62016d93[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1103859 WARN (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@62016d93[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1103876 WARN (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@66f61d17[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1103876 WARN (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@66f61d17[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1103877 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:44039/solr
[junit4] 2> 1103879 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1103880 INFO (zkConnectionManagerCallback-8798-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1103880 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1103881 WARN (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]-SendThread(127.0.0.1:44039)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x1004c30228c0003.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x1004c30228c0003, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x1004c30228c0003, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) [zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> 1103990 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [n:127.0.0.1:43021_ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1104010 INFO (zkConnectionManagerCallback-8800-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1104011 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [n:127.0.0.1:43021_ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1104422 WARN (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [n:127.0.0.1:43021_ ] o.a.s.c.ZkController Contents of zookeeper /security.json are world-readable; consider setting up ACLs as described in https://solr.apache.org/guide/zookeeper-access-control.html
[junit4] 2> 1104439 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [n:127.0.0.1:43021_ ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:43021_
[junit4] 2> 1104443 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [n:127.0.0.1:43021_ ] o.a.s.c.Overseer Overseer (id=72141363659669508-127.0.0.1:43021_-n_0000000000) starting
[junit4] 2> 1104473 INFO (OverseerStateUpdate-72141363659669508-127.0.0.1:43021_-n_0000000000) [n:127.0.0.1:43021_ ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:43021_
[junit4] 2> 1104479 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [n:127.0.0.1:43021_ ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:43021_
[junit4] 2> 1104483 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [n:127.0.0.1:43021_ ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 1104483 WARN (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [n:127.0.0.1:43021_ ] o.a.s.c.CoreContainer Not all security plugins configured! authentication=disabled authorization=disabled. Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external. See https://s.apache.org/solrsecurity for more info
[junit4] 2> 1104491 INFO (zkCallback-8799-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1104550 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [n:127.0.0.1:43021_ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 1104587 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [n:127.0.0.1:43021_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@58c5691f
[junit4] 2> 1104599 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [n:127.0.0.1:43021_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@58c5691f
[junit4] 2> 1104599 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [n:127.0.0.1:43021_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@58c5691f
[junit4] 2> 1104601 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [n:127.0.0.1:43021_ ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.cloud.RollingRestartTest_D5537BAA8C294D6-001/control-001/cores
[junit4] 2> 1104655 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1104655 INFO (zkConnectionManagerCallback-8817-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1104655 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1104657 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1104658 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:44039/solr ready
[junit4] 2> 1104871 INFO (OverseerThreadFactory-8807-thread-1-processing-n:127.0.0.1:43021_) [n:127.0.0.1:43021_ ] o.a.s.c.a.c.CreateCollectionCmd Create collection control_collection
[junit4] 2> 1105005 INFO (qtp1745761995-46457) [n:127.0.0.1:43021_ x:control_collection_shard1_replica_n1 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=conf1&newCollection=true&name=control_collection_shard1_replica_n1&action=CREATE&numShards=1&collection=control_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1105005 INFO (qtp1745761995-46457) [n:127.0.0.1:43021_ x:control_collection_shard1_replica_n1 ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient core cache for max 4 cores with initial capacity of 4
[junit4] 2> 1106037 INFO (qtp1745761995-46457) [n:127.0.0.1:43021_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.10.0
[junit4] 2> 1106037 WARN (qtp1745761995-46457) [n:127.0.0.1:43021_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.SolrConfig solrconfig.xml: <jmx> is no longer supported, use solr.xml:/metrics/reporter section instead
[junit4] 2> 1106044 INFO (qtp1745761995-46457) [n:127.0.0.1:43021_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.s.IndexSchema Schema name=test
[junit4] 2> 1106054 INFO (qtp1745761995-46457) [n:127.0.0.1:43021_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1106090 INFO (qtp1745761995-46457) [n:127.0.0.1:43021_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.CoreContainer Creating SolrCore 'control_collection_shard1_replica_n1' using configuration from configset conf1, trusted=true
[junit4] 2> 1106091 INFO (qtp1745761995-46457) [n:127.0.0.1:43021_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.control_collection.shard1.replica_n1' (registry 'solr.core.control_collection.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@58c5691f
[junit4] 2> 1106091 INFO (qtp1745761995-46457) [n:127.0.0.1:43021_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.SolrCore [[control_collection_shard1_replica_n1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.cloud.RollingRestartTest_D5537BAA8C294D6-001/control-001/cores/control_collection_shard1_replica_n1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.cloud.RollingRestartTest_D5537BAA8C294D6-001/control-001/cores/control_collection_shard1_replica_n1/data/]
[junit4] 2> 1106096 INFO (qtp1745761995-46457) [n:127.0.0.1:43021_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=20, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
[junit4] 2> 1106104 WARN (qtp1745761995-46457) [n:127.0.0.1:43021_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,attributes = {initParams=a, name=/dump, class=DumpRequestHandler},args = {defaults={a=A,b=B}}}
[junit4] 2> 1106146 INFO (qtp1745761995-46457) [n:127.0.0.1:43021_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1106146 INFO (qtp1745761995-46457) [n:127.0.0.1:43021_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1106147 INFO (qtp1745761995-46457) [n:127.0.0.1:43021_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1106148 INFO (qtp1745761995-46457) [n:127.0.0.1:43021_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1106148 INFO (qtp1745761995-46457) [n:127.0.0.1:43021_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=23, maxMergeAtOnceExplicit=39, maxMergedSegmentMB=34.5029296875, floorSegmentMB=0.283203125, forceMergeDeletesPctAllowed=23.52749948051601, segmentsPerTier=3.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1380665507534068, deletesPctAllowed=35.03980881584197
[junit4] 2> 1106152 INFO (qtp1745761995-46457) [n:127.0.0.1:43021_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 1106153 INFO (qtp1745761995-46457) [n:127.0.0.1:43021_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 1106153 INFO (qtp1745761995-46457) [n:127.0.0.1:43021_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 1106153 INFO (qtp1745761995-46457) [n:127.0.0.1:43021_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1706629638288048128
[junit4] 2> 1106159 INFO (searcherExecutor-8819-thread-1-processing-n:127.0.0.1:43021_ x:control_collection_shard1_replica_n1 c:control_collection s:shard1) [n:127.0.0.1:43021_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.SolrCore [control_collection_shard1_replica_n1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 1106171 INFO (qtp1745761995-46457) [n:127.0.0.1:43021_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.ZkShardTerms Successful update of terms at /collections/control_collection/terms/shard1 to Terms{values={core_node2=0}, version=0}
[junit4] 2> 1106171 INFO (qtp1745761995-46457) [n:127.0.0.1:43021_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/control_collection/leaders/shard1
[junit4] 2> 1106175 INFO (qtp1745761995-46457) [n:127.0.0.1:43021_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 1106175 INFO (qtp1745761995-46457) [n:127.0.0.1:43021_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 1106175 INFO (qtp1745761995-46457) [n:127.0.0.1:43021_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:43021/control_collection_shard1_replica_n1/
[junit4] 2> 1106175 INFO (qtp1745761995-46457) [n:127.0.0.1:43021_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 1106176 INFO (qtp1745761995-46457) [n:127.0.0.1:43021_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.SyncStrategy http://127.0.0.1:43021/control_collection_shard1_replica_n1/ has no replicas
[junit4] 2> 1106193 INFO (qtp1745761995-46457) [n:127.0.0.1:43021_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/control_collection/leaders/shard1/leader after winning as /collections/control_collection/leader_elect/shard1/election/72141363659669508-core_node2-n_0000000000
[junit4] 2> 1106198 INFO (qtp1745761995-46457) [n:127.0.0.1:43021_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:43021/control_collection_shard1_replica_n1/ shard1
[junit4] 2> 1106301 INFO (zkCallback-8799-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/control_collection/state.json] for collection [control_collection] has occurred - updating... (live nodes size: [1])
[junit4] 2> 1106301 INFO (zkCallback-8799-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/control_collection/state.json] for collection [control_collection] has occurred - updating... (live nodes size: [1])
[junit4] 2> 1106306 INFO (qtp1745761995-46457) [n:127.0.0.1:43021_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 1106322 INFO (qtp1745761995-46457) [n:127.0.0.1:43021_ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&collection.configName=conf1&newCollection=true&name=control_collection_shard1_replica_n1&action=CREATE&numShards=1&collection=control_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=1317
[junit4] 2> 1106324 INFO (qtp1745761995-46455) [n:127.0.0.1:43021_ ] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 45 seconds. Check all shard replicas
[junit4] 2> 1106413 INFO (zkCallback-8799-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/control_collection/state.json] for collection [control_collection] has occurred - updating... (live nodes size: [1])
[junit4] 2> 1106413 INFO (zkCallback-8799-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/control_collection/state.json] for collection [control_collection] has occurred - updating... (live nodes size: [1])
[junit4] 2> 1106413 INFO (zkCallback-8799-thread-3) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/control_collection/state.json] for collection [control_collection] has occurred - updating... (live nodes size: [1])
[junit4] 2> 1106414 INFO (qtp1745761995-46455) [n:127.0.0.1:43021_ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={collection.configName=conf1&name=control_collection&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=127.0.0.1:43021_&wt=javabin&version=2} status=0 QTime=1550
[junit4] 2> 1106414 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.c.AbstractFullDistribZkTestBase Waiting to see 1 active replicas in collection: control_collection
[junit4] 2> 1106418 WARN (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]-SendThread(127.0.0.1:44039)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x1004c30228c0005.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x1004c30228c0005, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x1004c30228c0005, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) [zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> 1106535 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1106536 INFO (zkConnectionManagerCallback-8828-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1106536 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1106537 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1106540 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:44039/solr ready
[junit4] 2> 1106541 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection loss:false
[junit4] 2> 1106551 INFO (OverseerThreadFactory-8807-thread-2-processing-n:127.0.0.1:43021_) [n:127.0.0.1:43021_ ] o.a.s.c.a.c.CreateCollectionCmd Create collection collection1
[junit4] 2> 1106552 INFO (OverseerCollectionConfigSetProcessor-72141363659669508-127.0.0.1:43021_-n_0000000000) [n:127.0.0.1:43021_ ] 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> 1106761 WARN (OverseerThreadFactory-8807-thread-2-processing-n:127.0.0.1:43021_) [n:127.0.0.1:43021_ ] o.a.s.c.a.c.CreateCollectionCmd It is unusual to create a collection (collection1) without cores.
[junit4] 2> 1106762 INFO (qtp1745761995-46457) [n:127.0.0.1:43021_ ] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 45 seconds. Check all shard replicas
[junit4] 2> 1106765 INFO (qtp1745761995-46457) [n:127.0.0.1:43021_ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={collection.configName=conf1&name=collection1&nrtReplicas=1&action=CREATE&numShards=2&createNodeSet=&stateFormat=2&wt=javabin&version=2} status=0 QTime=223
[junit4] 2> 1106766 INFO (watches-8825-thread-1) [ ] o.a.s.c.SolrCloudTestCase active slice count: 2 expected: 2
[junit4] 2> 1106766 INFO (watches-8825-thread-1) [ ] o.a.s.c.SolrCloudTestCase active replica count: 0 expected replica count: 0
[junit4] 2> 1106767 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.c.SolrCloudTestCase active slice count: 2 expected: 2
[junit4] 2> 1106767 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.c.SolrCloudTestCase active replica count: 0 expected replica count: 0
[junit4] 2> 1106767 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.c.SolrCloudTestCase active slice count: 2 expected: 2
[junit4] 2> 1106767 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.c.SolrCloudTestCase active replica count: 0 expected replica count: 0
[junit4] 2> 1106768 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.c.SolrCloudTestCase active slice count: 2 expected: 2
[junit4] 2> 1106768 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.c.SolrCloudTestCase active replica count: 0 expected replica count: 0
[junit4] 2> 1106768 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.c.AbstractFullDistribZkTestBase Creating jetty instances pullReplicaCount=0 numOtherReplicas=16
[junit4] 2> 1106881 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.cloud.RollingRestartTest_D5537BAA8C294D6-001/shard-1-001 of type NRT for shard2
[junit4] 2> 1106894 INFO (closeThreadPool-8829-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 1106895 INFO (closeThreadPool-8829-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 1106895 INFO (closeThreadPool-8829-thread-1) [ ] o.e.j.s.Server jetty-9.4.41.v20210516; built: 2021-05-16T23:56:28.993Z; git: 98607f93c7833e7dc59489b13f3cb0a114fb9f4c; jvm 1.8.0_291-b10
[junit4] 2> 1107015 INFO (closeThreadPool-8829-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1107015 INFO (closeThreadPool-8829-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1107015 INFO (closeThreadPool-8829-thread-1) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 1107015 INFO (closeThreadPool-8829-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@4fe6a9a9{/,null,AVAILABLE}
[junit4] 2> 1107028 INFO (closeThreadPool-8829-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@5f12d1e{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:40301}
[junit4] 2> 1107028 INFO (closeThreadPool-8829-thread-1) [ ] o.e.j.s.Server Started @1107067ms
[junit4] 2> 1107028 INFO (closeThreadPool-8829-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.cloud.RollingRestartTest_D5537BAA8C294D6-001/tempDir-001/jetty1, solrconfig=solrconfig.xml, hostContext=/, hostPort=40301, coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.cloud.RollingRestartTest_D5537BAA8C294D6-001/shard-1-001/cores}
[junit4] 2> 1107028 ERROR (closeThreadPool-8829-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1107028 INFO (closeThreadPool-8829-thread-1) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1107028 INFO (closeThreadPool-8829-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.10.0
[junit4] 2> 1107028 INFO (closeThreadPool-8829-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1107028 INFO (closeThreadPool-8829-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr
[junit4] 2> 1107028 INFO (closeThreadPool-8829-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2021-07-29T14:27:34.528Z
[junit4] 2> 1107034 INFO (closeThreadPool-8829-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1107036 INFO (zkConnectionManagerCallback-8831-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1107036 INFO (closeThreadPool-8829-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1107041 WARN (closeThreadPool-8829-thread-1-SendThread(127.0.0.1:44039)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x1004c30228c0007.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x1004c30228c0007, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x1004c30228c0007, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) [zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> 1107135 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 2 in directory /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.cloud.RollingRestartTest_D5537BAA8C294D6-001/shard-2-001 of type NRT for shard1
[junit4] 2> 1107142 INFO (closeThreadPool-8829-thread-1) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper)
[junit4] 2> 1107142 INFO (closeThreadPool-8829-thread-1) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.cloud.RollingRestartTest_D5537BAA8C294D6-001/shard-1-001/solr.xml
[junit4] 2> 1107145 INFO (closeThreadPool-8829-thread-1) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 1107145 INFO (closeThreadPool-8829-thread-1) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 1107146 INFO (closeThreadPool-8829-thread-1) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@58c5691f, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 1107151 INFO (closeThreadPool-8829-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 1107151 INFO (closeThreadPool-8829-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 1107151 INFO (closeThreadPool-8829-thread-2) [ ] o.e.j.s.Server jetty-9.4.41.v20210516; built: 2021-05-16T23:56:28.993Z; git: 98607f93c7833e7dc59489b13f3cb0a114fb9f4c; jvm 1.8.0_291-b10
[junit4] 2> 1107239 INFO (closeThreadPool-8829-thread-2) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1107239 INFO (closeThreadPool-8829-thread-2) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1107239 INFO (closeThreadPool-8829-thread-2) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 1107242 INFO (closeThreadPool-8829-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@64a4431e{/,null,AVAILABLE}
[junit4] 2> 1107242 INFO (closeThreadPool-8829-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@7295166{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:45023}
[junit4] 2> 1107242 INFO (closeThreadPool-8829-thread-2) [ ] o.e.j.s.Server Started @1107282ms
[junit4] 2> 1107242 INFO (closeThreadPool-8829-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.cloud.RollingRestartTest_D5537BAA8C294D6-001/tempDir-001/jetty2, solrconfig=solrconfig.xml, hostContext=/, hostPort=45023, coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.cloud.RollingRestartTest_D5537BAA8C294D6-001/shard-2-001/cores}
[junit4] 2> 1107242 ERROR (closeThreadPool-8829-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1107243 INFO (closeThreadPool-8829-thread-2) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1107243 INFO (closeThreadPool-8829-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.10.0
[junit4] 2> 1107243 INFO (closeThreadPool-8829-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1107243 INFO (closeThreadPool-8829-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr
[junit4] 2> 1107243 INFO (closeThreadPool-8829-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2021-07-29T14:27:34.743Z
[junit4] 2> 1107244 INFO (closeThreadPool-8829-thread-2) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1107249 INFO (zkConnectionManagerCallback-8836-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1107249 INFO (closeThreadPool-8829-thread-2) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1107259 WARN (closeThreadPool-8829-thread-2-SendThread(127.0.0.1:44039)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x1004c30228c0008.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x1004c30228c0008, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x1004c30228c0008, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) [zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> 1107270 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 3 in directory /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.cloud.RollingRestartTest_D5537BAA8C294D6-001/shard-3-001 of type NRT for shard2
[junit4] 2> 1107270 INFO (closeThreadPool-8829-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 1107270 INFO (closeThreadPool-8829-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 1107271 INFO (closeThreadPool-8829-thread-3) [ ] o.e.j.s.Server jetty-9.4.41.v20210516; built: 2021-05-16T23:56:28.993Z; git: 98607f93c7833e7dc59489b13f3cb0a114fb9f4c; jvm 1.8.0_291-b10
[junit4] 2> 1107271 INFO (closeThreadPool-8829-thread-3) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1107271 INFO (closeThreadPool-8829-thread-3) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1107271 INFO (closeThreadPool-8829-thread-3) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 1107271 INFO (closeThreadPool-8829-thread-3) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@6354f0b3{/,null,AVAILABLE}
[junit4] 2> 1107272 INFO (closeThreadPool-8829-thread-3) [ ] o.e.j.s.AbstractConnector Started ServerConnector@581496f{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:44677}
[junit4] 2> 1107272 INFO (closeThreadPool-8829-thread-3) [ ] o.e.j.s.Server Started @1107311ms
[junit4] 2> 1107272 INFO (closeThreadPool-8829-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.cloud.RollingRestartTest_D5537BAA8C294D6-001/tempDir-001/jetty3, solrconfig=solrconfig.xml, hostContext=/, hostPort=44677, coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.cloud.RollingRestartTest_D5537BAA8C294D6-001/shard-3-001/cores}
[junit4] 2> 1107272 ERROR (closeThreadPool-8829-thread-3) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1107272 INFO (closeThreadPool-8829-thread-3) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1107272 INFO (closeThreadPool-8829-thread-3) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.10.0
[junit4] 2> 1107272 INFO (closeThreadPool-8829-thread-3) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1107272 INFO (closeThreadPool-8829-thread-3) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr
[junit4] 2> 1107272 INFO (closeThreadPool-8829-thread-3) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2021-07-29T14:27:34.772Z
[junit4] 2> 1107278 INFO (closeThreadPool-8829-thread-3) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1107281 INFO (zkConnectionManagerCallback-8838-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1107281 INFO (closeThreadPool-8829-thread-3) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1107413 INFO (closeThreadPool-8829-thread-2) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper)
[junit4] 2> 1107413 INFO (closeThreadPool-8829-thread-2) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.cloud.RollingRestartTest_D5537BAA8C294D6-001/shard-2-001/solr.xml
[junit4] 2> 1107415 INFO (closeThreadPool-8829-thread-2) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 1107415 INFO (closeThreadPool-8829-thread-2) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 1107417 INFO (closeThreadPool-8829-thread-2) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@58c5691f, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 1107520 INFO (closeThreadPool-8829-thread-3) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper)
[junit4] 2> 1107520 INFO (closeThreadPool-8829-thread-3) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.cloud.RollingRestartTest_D5537BAA8C294D6-001/shard-3-001/solr.xml
[junit4] 2> 1107523 INFO (closeThreadPool-8829-thread-3) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 1107523 INFO (closeThreadPool-8829-thread-3) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 1107524 INFO (closeThreadPool-8829-thread-3) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@58c5691f, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 1107586 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 4 in directory /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.cloud.RollingRestartTest_D5537BAA8C294D6-001/shard-4-001 of type NRT for shard1
[junit4] 2> 1107604 INFO (closeThreadPool-8829-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 1107604 INFO (closeThreadPool-8829-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 1107604 INFO (closeThreadPool-8829-thread-4) [ ] o.e.j.s.Server jetty-9.4.41.v20210516; built: 2021-05-16T23:56:28.993Z; git: 98607f93c7833e7dc59489b13f3cb0a114fb9f4c; jvm 1.8.0_291-b10
[junit4] 2> 1107855 INFO (closeThreadPool-8829-thread-4) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1107855 INFO (closeThreadPool-8829-thread-4) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1107855 INFO (closeThreadPool-8829-thread-4) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 1107856 INFO (closeThreadPool-8829-thread-4) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@3171d760{/,null,AVAILABLE}
[junit4] 2> 1107860 INFO (closeThreadPool-8829-thread-4) [ ] o.e.j.s.AbstractConnector Started ServerConnector@4bc60ee0{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:46765}
[junit4] 2> 1107860 INFO (closeThreadPool-8829-thread-4) [ ] o.e.j.s.Server Started @1107899ms
[junit4] 2> 1107860 INFO (closeThreadPool-8829-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.cloud.RollingRestartTest_D5537BAA8C294D6-001/tempDir-001/jetty4, solrconfig=solrconfig.xml, hostContext=/, hostPort=46765, coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.cloud.RollingRestartTest_D5537BAA8C294D6-001/shard-4-001/cores}
[junit4] 2> 1107860 ERROR (closeThreadPool-8829-thread-4) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1107860 INFO (closeThreadPool-8829-thread-4) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1107860 INFO (closeThreadPool-8829-thread-4) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.10.0
[junit4] 2> 1107860 INFO (closeThreadPool-8829-thread-4) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1107860 INFO (closeThreadPool-8829-thread-4) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr
[junit4] 2> 1107860 INFO (closeThreadPool-8829-thread-4) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2021-07-29T14:27:35.360Z
[junit4] 2> 1107882 INFO (closeThreadPool-8829-thread-4) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1107893 INFO (zkConnectionManagerCallback-8846-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1107893 INFO (closeThreadPool-8829-thread-4) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1107921 WARN (closeThreadPool-8829-thread-4-SendThread(127.0.0.1:44039)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x1004c30228c000a.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x1004c30228c000a, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x1004c30228c000a, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) [zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> 1107997 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 5 in directory /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.cloud.RollingRestartTest_D5537BAA8C294D6-001/shard-5-001 of type NRT for shard2
[junit4] 2> 1108008 INFO (closeThreadPool-8829-thread-5) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 1108008 INFO (closeThreadPool-8829-thread-5) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 1108009 INFO (closeThreadPool-8829-thread-5) [ ] o.e.j.s.Server jetty-9.4.41.v20210516; built: 2021-05-16T23:56:28.993Z; git: 98607f93c7833e7dc59489b13f3cb0a114fb9f4c; jvm 1.8.0_291-b10
[junit4] 2> 1108022 INFO (closeThreadPool-8829-thread-4) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper)
[junit4] 2> 1108022 INFO (closeThreadPool-8829-thread-4) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.cloud.RollingRestartTest_D5537BAA8C294D6-001/shard-4-001/solr.xml
[junit4] 2> 1108024 INFO (closeThreadPool-8829-thread-4) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 1108024 INFO (closeThreadPool-8829-thread-4) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 1108026 INFO (closeThreadPool-8829-thread-4) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@58c5691f, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 1108079 INFO (closeThreadPool-8829-thread-5) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1108079 INFO (closeThreadPool-8829-thread-5) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1108080 INFO (closeThreadPool-8829-thread-5) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 1108089 INFO (closeThreadPool-8829-thread-5) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@965e15c{/,null,AVAILABLE}
[junit4] 2> 1108090 INFO (closeThreadPool-8829-thread-5) [ ] o.e.j.s.AbstractConnector Started ServerConnector@716122bf{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:45705}
[junit4] 2> 1108090 INFO (closeThreadPool-8829-thread-5) [ ] o.e.j.s.Server Started @1108129ms
[junit4] 2> 1108090 INFO (closeThreadPool-8829-thread-5) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.cloud.RollingRestartTest_D5537BAA8C294D6-001/tempDir-001/jetty5, solrconfig=solrconfig.xml, hostContext=/, hostPort=45705, coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.cloud.RollingRestartTest_D5537BAA8C294D6-001/shard-5-001/cores}
[junit4] 2> 1108090 ERROR (closeThreadPool-8829-thread-5) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1108090 INFO (closeThreadPool-8829-thread-5) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1108090 INFO (closeThreadPool-8829-thread-5) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.10.0
[junit4] 2> 1108090 INFO (closeThreadPool-8829-thread-5) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1108090 INFO (closeThreadPool-8829-thread-5) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr
[junit4] 2> 1108090 INFO (closeThreadPool-8829-thread-5) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2021-07-29T14:27:35.590Z
[junit4] 2> 1108103 INFO (closeThreadPool-8829-thread-5) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1108114 INFO (zkConnectionManagerCallback-8851-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1108115 INFO (closeThreadPool-8829-thread-5) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1108217 INFO (closeThreadPool-8829-thread-5) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper)
[junit4] 2> 1108217 INFO (closeThreadPool-8829-thread-5) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.cloud.RollingRestartTest_D5537BAA8C294D6-001/shard-5-001/solr.xml
[junit4] 2> 1108219 INFO (closeThreadPool-8829-thread-5) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 1108219 INFO (closeThreadPool-8829-thread-5) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 1108221 INFO (closeThreadPool-8829-thread-5) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@58c5691f, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 1108664 INFO (OverseerCollectionConfigSetProcessor-72141363659669508-127.0.0.1:43021_-n_0000000000) [n:127.0.0.1:43021_ ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000002 doesn't exist. Requestor may have disconnected from ZooKeeper
[junit4] 2> 1108696 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 6 in directory /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.cloud.RollingRestartTest_D5537BAA8C294D6-001/shard-6-001 of type NRT for shard1
[junit4] 2> 1108709 INFO (closeThreadPool-8829-thread-6) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 1108709 INFO (closeThreadPool-8829-thread-6) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 1108710 INFO (closeThreadPool-8829-thread-6) [ ] o.e.j.s.Server jetty-9.4.41.v20210516; built: 2021-05-16T23:56:28.993Z; git: 98607f93c7833e7dc59489b13f3cb0a114fb9f4c; jvm 1.8.0_291-b10
[junit4] 2> 1108767 INFO (closeThreadPool-8829-thread-6) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1108767 INFO (closeThreadPool-8829-thread-6) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1108767 INFO (closeThreadPool-8829-thread-6) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 1108775 INFO (closeThreadPool-8829-thread-6) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@6eafd6a3{/,null,AVAILABLE}
[junit4] 2> 1108775 INFO (closeThreadPool-8829-thread-6) [ ] o.e.j.s.AbstractConnector Started ServerConnector@4d42826a{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:45599}
[junit4] 2> 1108775 INFO (closeThreadPool-8829-thread-6) [ ] o.e.j.s.Server Started @1108814ms
[junit4] 2> 1108775 INFO (closeThreadPool-8829-thread-6) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.cloud.RollingRestartTest_D5537BAA8C294D6-001/tempDir-001/jetty6, solrconfig=solrconfig.xml, hostContext=/, hostPort=45599, coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.cloud.RollingRestartTest_D5537BAA8C294D6-001/shard-6-001/cores}
[junit4] 2> 1108775 ERROR (closeThreadPool-8829-thread-6) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1108775 INFO (closeThreadPool-8829-thread-6) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1108775 INFO (closeThreadPool-8829-thread-6) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.10.0
[junit4] 2> 1108775 INFO (closeThreadPool-8829-thread-6) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1108775 INFO (closeThreadPool-8829-thread-6) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr
[junit4] 2> 1108775 INFO (closeThreadPool-8829-thread-6) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2021-07-29T14:27:36.275Z
[junit4] 2> 1108788 INFO (closeThreadPool-8829-thread-6) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1108800 INFO (zkConnectionManagerCallback-8856-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1108800 INFO (closeThreadPool-8829-thread-6) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1108801 WARN (closeThreadPool-8829-thread-6-SendThread(127.0.0.1:44039)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x1004c30228c000c.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x1004c30228c000c, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x1004c30228c000c, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) [zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> 1108903 INFO (closeThreadPool-8829-thread-6) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper)
[junit4] 2> 1108903 INFO (closeThreadPool-8829-thread-6) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.cloud.RollingRestartTest_D5537BAA8C294D6-001/shard-6-001/solr.xml
[junit4] 2> 1108905 INFO (closeThreadPool-8829-thread-6) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 1108905 INFO (closeThreadPool-8829-thread-6) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 1108907 INFO (closeThreadPool-8829-thread-6) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@58c5691f, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 1108938 INFO (TEST-RollingRestartTest.test-seed#[D5537BAA8C294D6]) [ ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 7 in directory /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.cloud.RollingRestartTest_D5537BAA8C294D6-001/shard-7-001 of type NRT for shard2
[junit4] 2> 1108971 INFO (closeThreadPool-8829-thread-7) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 1108971 INFO (closeThreadPool-8829-thread-7) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 1108971 INFO (closeThreadPool-8829-thread-7) [ ] o.e.j.s.Server jetty-9.4.41.v20210516; built: 2021-05-16T23:56:28.993Z; git: 98607f93c7833e7dc59489b13f3cb0a114fb9f4c; jvm 1.8.0_291-b10
[junit4] 2> 1109079 INFO (closeThreadPool-8829-thread-7) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1109079 INFO (closeThreadPool-8829-thread-7) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1109079 INFO (closeThreadPool-8829-thread-7) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 1109094 INFO (closeThreadPool-8829-thread-7) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@6c6795b{/,null,AVAILABLE}
[junit4] 2> 1109094 INFO (closeThreadPool-8829-thread-7) [ ] o.e.j.s.AbstractConnector Started ServerConnector@77e698d6{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:38899}
[junit4] 2> 1109094 INFO (closeThreadPool-8829-thread-7) [ ] o.e.j.s.Server Started @1109133ms
[junit4] 2> 1109094 INFO (closeThreadPool-8829-thread-7) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.cloud.RollingRestartTest_D5537BAA8C294D6-001/tempDir-001/jetty7, solrconfig=solrconfig.xml, hostContext=/, hostPort=38899, coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.cloud.RollingRestartTest_D5537BAA8C294D6-001/shard-7-001/cores}
[junit4] 2> 1109094 ERROR (closeThreadPool-8829-thread-7) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1109094 INFO (closeThreadPool-8829-thread-7) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1109094 INFO (closeThreadPool-8829-thread-7) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.10.0
[junit4] 2> 1109094 INFO (closeThreadPool-8829-thread-7) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1109094 INFO (closeThreadPool-8829-thread-7) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr
[junit4] 2> 1109094 INFO (closeThreadPool-8829-thread-7) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2021-07-29T14:27:36.594Z
[junit4] 2> 1109122 INFO (closeThreadPool-8829-thread-7) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1109147 INFO (zkConnectionManagerCallback-8861-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1109148 INFO (closeThreadPool-8829-thread-7) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1109461 WARN (closeThreadPool-8829-thread-7-SendThread(127.0.0.1:44039)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x1004c30228c000d.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x1004c30228c000d, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x1004c30228c000d, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) [zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> 1109561 INFO (closeThreadPool-8829-thread-7) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper)
[junit4] 2> 1109561 INFO (closeThreadPool-8829-thread-7) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.cloud.RollingRestartTest_D5537BAA8C294D6-001/shard-7-001/solr.xml
[junit4] 2> 1109564 INFO (closeThreadPool-8829-thread-7) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 1109564 INFO (closeThreadPool-8829-thread-7) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 1109565 INFO (closeThreadPool-8829-thread-7) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@58c5691f, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 1109614 INFO (closeThreadPool-8829-thread-5) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 1109624 WARN (closeThreadPool-8829-thread-5) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@4a0cb908[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1109624 WARN (closeThreadPool-8829-thread-5) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@4a0cb908[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1109847 WARN (closeThreadPool-8829-thread-5) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@6f1484bf[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1109847 WARN (closeThreadPool-8829-thread-5) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@6f1484bf[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1109848 INFO (closeThreadPool-8829-thread-5) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:44039/solr
[junit4] 2> 1109859 INFO (closeThreadPool-8829-thread-5) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1109866 INFO (zkConnectionManagerCallback-8872-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1109866 INFO (closeThreadPool-8829-thread-5) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1109867 WARN (closeThreadPool-8829-thread-5-SendThread(127.0.0.1:44039)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x1004c30228c000e.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x1004c30228c000e, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x1004c30228c000e, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) [zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> 1109994 INFO (closeThreadPool-8829-thread-5) [n:127.0.0.1:45705_ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1110002 INFO (z
[...truncated too long message...]
Checker._checkBackupSuccess(BackupStatusChecker.java:208)
[junit4] > at org.apache.solr.handler.BackupStatusChecker.checkBackupSuccess(BackupStatusChecker.java:187)
[junit4] > at org.apache.solr.handler.BackupStatusChecker.waitForBackupSuccess(BackupStatusChecker.java:96)
[junit4] > at org.apache.solr.handler.BackupStatusChecker.waitForBackupSuccess(BackupStatusChecker.java:72)
[junit4] > at org.apache.solr.cloud.BasicDistributedZk2Test.brindDownShardIndexSomeDocsAndRecover(BasicDistributedZk2Test.java:417)
[junit4] > at org.apache.solr.cloud.BasicDistributedZk2Test.test(BasicDistributedZk2Test.java:102)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:1088)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:1059)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 3476449 WARN (Listener at localhost.localdomain/36431) [ ] o.a.h.h.s.d.DirectoryScanner DirectoryScanner: shutdown has been called
[junit4] 2> 3476456 INFO (Listener at localhost.localdomain/36431) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.w.WebAppContext@269de2f9{datanode,/,null,STOPPED}{jar:file:/home/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-3.2.2-tests.jar!/webapps/datanode}
[junit4] 2> 3476456 INFO (Listener at localhost.localdomain/36431) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@7419c68a{HTTP/1.1, (http/1.1)}{localhost:0}
[junit4] 2> 3476457 INFO (Listener at localhost.localdomain/36431) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 3476457 INFO (Listener at localhost.localdomain/36431) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@2e58f801{static,/static,jar:file:/home/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-3.2.2-tests.jar!/webapps/static,STOPPED}
[junit4] 2> 3476463 WARN (BP-306641039-127.0.0.1-1627571193807 heartbeating to localhost.localdomain/127.0.0.1:42801) [ ] o.a.h.h.s.d.IncrementalBlockReportManager IncrementalBlockReportManager interrupted
[junit4] 2> 3476463 WARN (BP-306641039-127.0.0.1-1627571193807 heartbeating to localhost.localdomain/127.0.0.1:42801) [ ] o.a.h.h.s.d.DataNode Ending block pool service for: Block pool BP-306641039-127.0.0.1-1627571193807 (Datanode Uuid 047a824e-d91a-47d2-81a1-c46941b7514a) service to localhost.localdomain/127.0.0.1:42801
[junit4] 2> 3476466 WARN (Listener at localhost.localdomain/36431) [ ] o.a.h.h.s.d.DirectoryScanner DirectoryScanner: shutdown has been called
[junit4] 2> 3476471 INFO (Listener at localhost.localdomain/36431) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.w.WebAppContext@474f2b0d{datanode,/,null,STOPPED}{jar:file:/home/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-3.2.2-tests.jar!/webapps/datanode}
[junit4] 2> 3476471 INFO (Listener at localhost.localdomain/36431) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@6ea0fb74{HTTP/1.1, (http/1.1)}{localhost:0}
[junit4] 2> 3476471 INFO (Listener at localhost.localdomain/36431) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 3476471 INFO (Listener at localhost.localdomain/36431) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@74cdfb0b{static,/static,jar:file:/home/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-3.2.2-tests.jar!/webapps/static,STOPPED}
[junit4] 2> 3476475 WARN (BP-306641039-127.0.0.1-1627571193807 heartbeating to localhost.localdomain/127.0.0.1:42801) [ ] o.a.h.h.s.d.IncrementalBlockReportManager IncrementalBlockReportManager interrupted
[junit4] 2> 3476475 WARN (BP-306641039-127.0.0.1-1627571193807 heartbeating to localhost.localdomain/127.0.0.1:42801) [ ] o.a.h.h.s.d.DataNode Ending block pool service for: Block pool BP-306641039-127.0.0.1-1627571193807 (Datanode Uuid e73d7b41-520d-4edb-a707-8db3684bf01b) service to localhost.localdomain/127.0.0.1:42801
[junit4] 2> 3476482 INFO (Listener at localhost.localdomain/36431) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.w.WebAppContext@2e74d1e4{hdfs,/,null,STOPPED}{jar:file:/home/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-3.2.2-tests.jar!/webapps/hdfs}
[junit4] 2> 3476482 INFO (Listener at localhost.localdomain/36431) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@1c1959c{HTTP/1.1, (http/1.1)}{localhost.localdomain:0}
[junit4] 2> 3476482 INFO (Listener at localhost.localdomain/36431) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 3476482 INFO (Listener at localhost.localdomain/36431) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@d992dab{static,/static,jar:file:/home/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-3.2.2-tests.jar!/webapps/static,STOPPED}
[junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsBasicDistributedZk2Test_D5537BAA8C294D6-001
[junit4] 2> Jul 29, 2021 3:07:04 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 33 leaked thread(s).
[junit4] 2> NOTE: test params are: codec=SimpleText, sim=Asserting(RandomSimilarity(queryNorm=true): {}), locale=es-BO, timezone=ROK
[junit4] 2> NOTE: Linux 4.15.0-147-generic amd64/Oracle Corporation 1.8.0_291 (64-bit)/cpus=4,threads=5,free=234186512,total=503316480
[junit4] 2> NOTE: All tests run in this JVM: [TestSolrCLIRunExample, ZkSolrClientTest, RecoveryZkTest, TestAuthorizationFramework, ShardRoutingCustomTest, TestInitParams, TestRandomCollapseQParserPlugin, TestInitQParser, TestCloudPivotFacet, TestReplicationHandlerBackup, TestJsonFacets, SimpleCollectionCreateDeleteTest, TestSuggestSpellingConverter, ExitableDirectoryReaderTest, TestCodecSupport, TestContainerPlugin, AggValueSourceTest, FullHLLTest, BufferStoreTest, TestSolr4Spatial, PrimitiveFieldTypeTest, TestConfigSetImmutable, HdfsUnloadDistributedZkTest, OrderedExecutorTest, TriLevelCompositeIdRoutingTest, SoftAutoCommitTest, GraphQueryTest, ReturnFieldsTest, HealthCheckHandlerTest, PropertiesRequestHandlerTest, AnalyticsMergeStrategyTest, BigEndianAscendingWordDeserializerTest, TestBinaryField, TestPullReplica, OutputWriterTest, ZkCollectionPropsCachingTest, TriggerSetPropertiesIntegrationTest, LeaderFailureAfterFreshStartTest, TestJettySolrRunner, ClassificationUpdateProcessorIntegrationTest, TestReloadAndDeleteDocs, JWTVerificationkeyResolverTest, SQLWithAuthzEnabledTest, DimensionalRoutedAliasUpdateProcessorTest, DistributedQueryComponentOptimizationTest, CollectionReloadTest, ZookeeperStatusHandlerTest, TestLuceneMatchVersion, AdminHandlersProxyTest, HdfsRestartWhileUpdatingTest, UninvertDocValuesMergePolicyTest, ReplaceNodeTest, TestLMJelinekMercerSimilarityFactory, TestManagedSchemaAPI, TestBlendedInfixSuggestions, TestFastLRUCache, TestSimDistributedQueue, TestPivotHelperCode, OpenExchangeRatesOrgProviderTest, TestSimScenario, DistributedFacetExistsSmallTest, ConfigureRecoveryStrategyTest, TestCollapseQParserPlugin, TestMacroExpander, AtomicUpdateProcessorFactoryTest, DistanceUnitsTest, IndexSizeTriggerSizeEstimationTest, DateFieldTest, HighlighterConfigTest, SparseHLLTest, OverseerSolrResponseTest, PathHierarchyTokenizerFactoryTest, TestPseudoReturnFields, DocValuesTest, FullSolrCloudDistribCmdsTest, PhrasesIdentificationComponentTest, TestOrdValues, BasicZkTest, AuditLoggerIntegrationTest, MoveReplicaHDFSFailoverTest, TestCollationField, TestSearchPerf, TestDocTermOrdsUninvertLimit, SpatialFilterTest, UpdateLogTest, TestSimLargeCluster, BaseCdcrDistributedZkTest, TestCloudJSONFacetSKG, SimpleMLTQParserTest, TestHighFrequencyDictionaryFactory, V2ApiIntegrationTest, TestStressUserVersions, TestTlogReplica, TestDFISimilarityFactory, TestRemoteStreaming, AnalysisErrorHandlingTest, TestZkAclsWithHadoopAuth, MultiThreadedOCPTest, SearchHandlerTest, ConjunctionSolrSpellCheckerTest, IgnoreCommitOptimizeUpdateProcessorFactoryTest, TestConfigSetsAPIShareSchema, NodeMarkersRegistrationTest, TestApiFramework, TestCloudConsistency, CreateCollectionCleanupTest, TestPostingsSolrHighlighter, TestStressCloudBlindAtomicUpdates, SuggesterTest, TestRawResponseWriter, TestNoOpRegenerator, ExecutePlanActionTest, DistribCursorPagingTest, BasicDistributedZkTest, CleanupOldIndexTest, ClusterStateMockUtilTest, ClusterStateTest, ClusterStateUpdateTest, CollectionStateFormat2Test, CollectionsAPISolrJTest, LeaderElectionContextKeyTest, LeaderElectionTest, MissingSegmentRecoveryTest, OverriddenZkACLAndCredentialsProvidersTest, OverseerModifyCollectionTest, OverseerTest, RecoveryAfterSoftCommitTest, RouteFieldTest, RoutingToNodesWithPropertiesTest, SSLMigrationTest, SaslZkACLProviderTest, SliceStateTest, SolrCLIZkUtilsTest, SolrXmlInZkTest, SplitShardTest, TestAuthenticationFramework, TestClusterProperties, TestConfigSetsAPI, TestConfigSetsAPIExclusivity, TestDistribDocBasedVersion, TestDistributedMap, TestDownShardTolerantSearch, TestDynamicFieldNamesIndexCorrectly, TestLeaderElectionZkExpiry, TestOnReconnectListenerSupport, TestRandomFlRTGCloud, LocalFSCloudIncrementalBackupTest, TestHdfsCloudBackupRestore, TestReplicaProperties, AutoAddReplicasIntegrationTest, NodeAddedTriggerIntegrationTest, NodeAddedTriggerTest, NodeLostTriggerIntegrationTest, NodeLostTriggerTest, SearchRateTriggerTest, SystemLogListenerTest, TestPolicyCloud, TriggerEventQueueTest, TriggerIntegrationTest, CdcrRequestHandlerTest, HDFSCollectionsAPITest, HdfsBasicDistributedZk2Test]
[junit4] Completed [614/940 (2!)] on J0 in 32.50s, 1 test, 1 failure <<< FAILURES!
[...truncated 53672 lines...]