Build: https://builds.apache.org/job/Lucene-Solr-Tests-7.x/189/
6 tests failed.
FAILED: org.apache.solr.cloud.CdcrBootstrapTest.testBootstrapWithSourceCluster
Error Message:
Captured an uncaught exception in thread: Thread[id=848, name=Thread-154,
state=RUNNABLE, group=TGRP-CdcrBootstrapTest]
Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught
exception in thread: Thread[id=848, name=Thread-154, state=RUNNABLE,
group=TGRP-CdcrBootstrapTest]
at
__randomizedtesting.SeedInfo.seed([3D43DFAB320A40C4:E4158E6F316E538E]:0)
Caused by: java.lang.AssertionError: 1
at __randomizedtesting.SeedInfo.seed([3D43DFAB320A40C4]:0)
at
org.apache.solr.core.CachingDirectoryFactory.close(CachingDirectoryFactory.java:192)
at org.apache.solr.core.SolrCore.close(SolrCore.java:1614)
at
org.apache.solr.core.CoreContainer.registerCore(CoreContainer.java:870)
at org.apache.solr.core.CoreContainer.reload(CoreContainer.java:1285)
at
org.apache.solr.handler.IndexFetcher.lambda$reloadCore$0(IndexFetcher.java:910)
at java.lang.Thread.run(Thread.java:748)
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.CdcrBootstrapTest
Error Message:
ObjectTracker found 3 object(s) that were not released!!! [SolrCore,
MockDirectoryWrapper, RawDirectoryWrapper]
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:1020) at
org.apache.solr.core.SolrCore.reload(SolrCore.java:637) at
org.apache.solr.core.CoreContainer.reload(CoreContainer.java:1284) at
org.apache.solr.handler.IndexFetcher.lambda$reloadCore$0(IndexFetcher.java:910)
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:348)
at
org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:494)
at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:338)
at
org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:421)
at
org.apache.solr.handler.CdcrRequestHandler$BootstrapCallable.call(CdcrRequestHandler.java:768)
at
org.apache.solr.handler.CdcrRequestHandler$BootstrapCallable.call(CdcrRequestHandler.java:723)
at
com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:197)
at java.util.concurrent.FutureTask.run(FutureTask.java:266) at
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:188)
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.RawDirectoryWrapper at
org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at
org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348)
at org.apache.solr.update.SolrIndexWriter.create(SolrIndexWriter.java:92) at
org.apache.solr.core.SolrCore.initIndex(SolrCore.java:742) at
org.apache.solr.core.SolrCore.<init>(SolrCore.java:935) at
org.apache.solr.core.SolrCore.<init>(SolrCore.java:844) at
org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1036)
at org.apache.solr.core.CoreContainer.create(CoreContainer.java:948) at
org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:91)
at
org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:384)
at
org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:389)
at
org.apache.solr.handler.admin.CoreAdminHandler.handleRequestBody(CoreAdminHandler.java:174)
at
org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:177)
at org.apache.solr.servlet.HttpSolrCall.handleAdmin(HttpSolrCall.java:735)
at
org.apache.solr.servlet.HttpSolrCall.handleAdminRequest(HttpSolrCall.java:716)
at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:497) at
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:382)
at
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:326)
at
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1759)
at
org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:139)
at
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1759)
at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:582)
at
org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:224)
at
org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180)
at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512)
at
org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
at
org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112)
at
org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
at
org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:426)
at
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134)
at org.eclipse.jetty.server.Server.handle(Server.java:534) at
org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:320) at
org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251) at
org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:283)
at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:108) at
org.eclipse.jetty.io.ssl.SslConnection.onFillable(SslConnection.java:251) at
org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:283)
at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:108) at
org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93)
at
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303)
at
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148)
at
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136)
at
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671)
at
org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589)
at java.lang.Thread.run(Thread.java:748)
Stack Trace:
java.lang.AssertionError: ObjectTracker found 3 object(s) that were not
released!!! [SolrCore, MockDirectoryWrapper, RawDirectoryWrapper]
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:1020)
at org.apache.solr.core.SolrCore.reload(SolrCore.java:637)
at org.apache.solr.core.CoreContainer.reload(CoreContainer.java:1284)
at
org.apache.solr.handler.IndexFetcher.lambda$reloadCore$0(IndexFetcher.java:910)
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:348)
at
org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:494)
at
org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:338)
at
org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:421)
at
org.apache.solr.handler.CdcrRequestHandler$BootstrapCallable.call(CdcrRequestHandler.java:768)
at
org.apache.solr.handler.CdcrRequestHandler$BootstrapCallable.call(CdcrRequestHandler.java:723)
at
com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:197)
at java.util.concurrent.FutureTask.run(FutureTask.java:266)
at
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:188)
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.RawDirectoryWrapper
at
org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at
org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348)
at
org.apache.solr.update.SolrIndexWriter.create(SolrIndexWriter.java:92)
at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:742)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:935)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:844)
at
org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1036)
at org.apache.solr.core.CoreContainer.create(CoreContainer.java:948)
at
org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:91)
at
org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:384)
at
org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:389)
at
org.apache.solr.handler.admin.CoreAdminHandler.handleRequestBody(CoreAdminHandler.java:174)
at
org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:177)
at
org.apache.solr.servlet.HttpSolrCall.handleAdmin(HttpSolrCall.java:735)
at
org.apache.solr.servlet.HttpSolrCall.handleAdminRequest(HttpSolrCall.java:716)
at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:497)
at
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:382)
at
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:326)
at
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1759)
at
org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:139)
at
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1759)
at
org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:582)
at
org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:224)
at
org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180)
at
org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512)
at
org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
at
org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112)
at
org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
at
org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:426)
at
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134)
at org.eclipse.jetty.server.Server.handle(Server.java:534)
at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:320)
at
org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251)
at
org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:283)
at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:108)
at
org.eclipse.jetty.io.ssl.SslConnection.onFillable(SslConnection.java:251)
at
org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:283)
at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:108)
at
org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93)
at
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303)
at
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148)
at
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136)
at
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671)
at
org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589)
at java.lang.Thread.run(Thread.java:748)
at __randomizedtesting.SeedInfo.seed([3D43DFAB320A40C4]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.junit.Assert.assertNull(Assert.java:551)
at
org.apache.solr.SolrTestCaseJ4.teardownTestCases(SolrTestCaseJ4.java:295)
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:1737)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:897)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
FAILED: org.apache.solr.cloud.TestHdfsCloudBackupRestore.test
Error Message:
expected:<COMPLETED> but was:<RUNNING>
Stack Trace:
java.lang.AssertionError: expected:<COMPLETED> but was:<RUNNING>
at
__randomizedtesting.SeedInfo.seed([3D43DFAB320A40C4:B517E0719CF62D3C]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.failNotEquals(Assert.java:647)
at org.junit.Assert.assertEquals(Assert.java:128)
at org.junit.Assert.assertEquals(Assert.java:147)
at
org.apache.solr.cloud.AbstractCloudBackupRestoreTestCase.testBackupAndRestore(AbstractCloudBackupRestoreTestCase.java:277)
at
org.apache.solr.cloud.AbstractCloudBackupRestoreTestCase.test(AbstractCloudBackupRestoreTestCase.java:136)
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:1737)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
FAILED: org.apache.solr.cloud.TestMiniSolrCloudClusterSSL.testSslAndClientAuth
Error Message:
Could not find collection:first_collection
Stack Trace:
java.lang.AssertionError: Could not find collection:first_collection
at
__randomizedtesting.SeedInfo.seed([3D43DFAB320A40C4:EEC73666A0C71B38]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.junit.Assert.assertNotNull(Assert.java:526)
at
org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:155)
at
org.apache.solr.cloud.TestMiniSolrCloudClusterSSL.checkCreateCollection(TestMiniSolrCloudClusterSSL.java:202)
at
org.apache.solr.cloud.TestMiniSolrCloudClusterSSL.checkClusterWithCollectionCreations(TestMiniSolrCloudClusterSSL.java:172)
at
org.apache.solr.cloud.TestMiniSolrCloudClusterSSL.checkClusterWithNodeReplacement(TestMiniSolrCloudClusterSSL.java:138)
at
org.apache.solr.cloud.TestMiniSolrCloudClusterSSL.testSslAndClientAuth(TestMiniSolrCloudClusterSSL.java:120)
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:1737)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
FAILED:
junit.framework.TestSuite.org.apache.solr.cloud.TestMiniSolrCloudClusterSSL
Error Message:
9 threads leaked from SUITE scope at
org.apache.solr.cloud.TestMiniSolrCloudClusterSSL: 1) Thread[id=9145,
name=OverseerAutoScalingTriggerThread-98863861775663115-127.0.0.1:55856_solr-n_0000000003,
state=WAITING, group=Overseer autoscaling triggers] at
sun.misc.Unsafe.park(Native Method) at
java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
at
org.apache.solr.cloud.autoscaling.OverseerTriggerThread.run(OverseerTriggerThread.java:161)
at java.lang.Thread.run(Thread.java:748) 2) Thread[id=9053,
name=Connection evictor, state=TIMED_WAITING,
group=TGRP-TestMiniSolrCloudClusterSSL] at
java.lang.Thread.sleep(Native Method) at
org.apache.http.impl.client.IdleConnectionEvictor$1.run(IdleConnectionEvictor.java:66)
at java.lang.Thread.run(Thread.java:748) 3) Thread[id=9146,
name=ScheduledTrigger-4119-thread-1, state=TIMED_WAITING,
group=TGRP-TestMiniSolrCloudClusterSSL] at
java.lang.Thread.sleep(Native Method) at
org.apache.solr.common.cloud.ZkCmdExecutor.retryDelay(ZkCmdExecutor.java:111)
at
org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:70)
at
org.apache.solr.common.cloud.SolrZkClient.create(SolrZkClient.java:389)
at org.apache.solr.cloud.ZkDistributedQueue.offer(ZkDistributedQueue.java:293)
at
org.apache.solr.cloud.autoscaling.TriggerEventQueue.offerEvent(TriggerEventQueue.java:58)
at
org.apache.solr.cloud.autoscaling.ScheduledTriggers$ScheduledTrigger.enqueue(ScheduledTriggers.java:411)
at
org.apache.solr.cloud.autoscaling.ScheduledTriggers.lambda$add$3(ScheduledTriggers.java:205)
at
org.apache.solr.cloud.autoscaling.ScheduledTriggers$$Lambda$237/524708820.process(Unknown
Source) at
org.apache.solr.cloud.autoscaling.NodeLostTrigger.run(NodeLostTrigger.java:163)
at
org.apache.solr.cloud.autoscaling.ScheduledTriggers$ScheduledTrigger.run(ScheduledTriggers.java:453)
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) 4) Thread[id=9076,
name=Connection evictor, state=TIMED_WAITING,
group=TGRP-TestMiniSolrCloudClusterSSL] at
java.lang.Thread.sleep(Native Method) at
org.apache.http.impl.client.IdleConnectionEvictor$1.run(IdleConnectionEvictor.java:66)
at java.lang.Thread.run(Thread.java:748) 5) Thread[id=9143,
name=OverseerStateUpdate-98863861775663115-127.0.0.1:55856_solr-n_0000000003,
state=TIMED_WAITING, group=Overseer state updater.] at
sun.misc.Unsafe.park(Native Method) at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
at
org.apache.solr.cloud.ZkDistributedQueue.peekElements(ZkDistributedQueue.java:435)
at
org.apache.solr.cloud.Overseer$ClusterStateUpdater.run(Overseer.java:202)
at java.lang.Thread.run(Thread.java:748) 6) Thread[id=9144,
name=OverseerCollectionConfigSetProcessor-98863861775663115-127.0.0.1:55856_solr-n_0000000003,
state=TIMED_WAITING, group=Overseer collection creation process.] at
java.lang.Thread.sleep(Native Method) at
org.apache.solr.common.cloud.ZkCmdExecutor.retryDelay(ZkCmdExecutor.java:111)
at
org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:70)
at
org.apache.solr.common.cloud.SolrZkClient.getData(SolrZkClient.java:354)
at
org.apache.solr.cloud.OverseerTaskProcessor.amILeader(OverseerTaskProcessor.java:387)
at
org.apache.solr.cloud.OverseerTaskProcessor.run(OverseerTaskProcessor.java:193)
at java.lang.Thread.run(Thread.java:748) 7) Thread[id=9108,
name=zkCallback-1345-thread-2-processing-n:127.0.0.1:55856_solr-EventThread,
state=WAITING, group=TGRP-TestMiniSolrCloudClusterSSL] at
sun.misc.Unsafe.park(Native Method) at
java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:501)
8) Thread[id=9054, name=Connection evictor, state=TIMED_WAITING,
group=TGRP-TestMiniSolrCloudClusterSSL] at
java.lang.Thread.sleep(Native Method) at
org.apache.http.impl.client.IdleConnectionEvictor$1.run(IdleConnectionEvictor.java:66)
at java.lang.Thread.run(Thread.java:748) 9) Thread[id=9107,
name=zkCallback-1345-thread-2-processing-n:127.0.0.1:55856_solr-SendThread(127.0.0.1:48343),
state=TIMED_WAITING, group=TGRP-TestMiniSolrCloudClusterSSL] at
java.lang.Thread.sleep(Native Method) at
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1051)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 9 threads leaked from SUITE
scope at org.apache.solr.cloud.TestMiniSolrCloudClusterSSL:
1) Thread[id=9145,
name=OverseerAutoScalingTriggerThread-98863861775663115-127.0.0.1:55856_solr-n_0000000003,
state=WAITING, group=Overseer autoscaling triggers]
at sun.misc.Unsafe.park(Native Method)
at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
at
org.apache.solr.cloud.autoscaling.OverseerTriggerThread.run(OverseerTriggerThread.java:161)
at java.lang.Thread.run(Thread.java:748)
2) Thread[id=9053, name=Connection evictor, state=TIMED_WAITING,
group=TGRP-TestMiniSolrCloudClusterSSL]
at java.lang.Thread.sleep(Native Method)
at
org.apache.http.impl.client.IdleConnectionEvictor$1.run(IdleConnectionEvictor.java:66)
at java.lang.Thread.run(Thread.java:748)
3) Thread[id=9146, name=ScheduledTrigger-4119-thread-1, state=TIMED_WAITING,
group=TGRP-TestMiniSolrCloudClusterSSL]
at java.lang.Thread.sleep(Native Method)
at
org.apache.solr.common.cloud.ZkCmdExecutor.retryDelay(ZkCmdExecutor.java:111)
at
org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:70)
at
org.apache.solr.common.cloud.SolrZkClient.create(SolrZkClient.java:389)
at
org.apache.solr.cloud.ZkDistributedQueue.offer(ZkDistributedQueue.java:293)
at
org.apache.solr.cloud.autoscaling.TriggerEventQueue.offerEvent(TriggerEventQueue.java:58)
at
org.apache.solr.cloud.autoscaling.ScheduledTriggers$ScheduledTrigger.enqueue(ScheduledTriggers.java:411)
at
org.apache.solr.cloud.autoscaling.ScheduledTriggers.lambda$add$3(ScheduledTriggers.java:205)
at
org.apache.solr.cloud.autoscaling.ScheduledTriggers$$Lambda$237/524708820.process(Unknown
Source)
at
org.apache.solr.cloud.autoscaling.NodeLostTrigger.run(NodeLostTrigger.java:163)
at
org.apache.solr.cloud.autoscaling.ScheduledTriggers$ScheduledTrigger.run(ScheduledTriggers.java:453)
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)
4) Thread[id=9076, name=Connection evictor, state=TIMED_WAITING,
group=TGRP-TestMiniSolrCloudClusterSSL]
at java.lang.Thread.sleep(Native Method)
at
org.apache.http.impl.client.IdleConnectionEvictor$1.run(IdleConnectionEvictor.java:66)
at java.lang.Thread.run(Thread.java:748)
5) Thread[id=9143,
name=OverseerStateUpdate-98863861775663115-127.0.0.1:55856_solr-n_0000000003,
state=TIMED_WAITING, group=Overseer state updater.]
at sun.misc.Unsafe.park(Native Method)
at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
at
org.apache.solr.cloud.ZkDistributedQueue.peekElements(ZkDistributedQueue.java:435)
at
org.apache.solr.cloud.Overseer$ClusterStateUpdater.run(Overseer.java:202)
at java.lang.Thread.run(Thread.java:748)
6) Thread[id=9144,
name=OverseerCollectionConfigSetProcessor-98863861775663115-127.0.0.1:55856_solr-n_0000000003,
state=TIMED_WAITING, group=Overseer collection creation process.]
at java.lang.Thread.sleep(Native Method)
at
org.apache.solr.common.cloud.ZkCmdExecutor.retryDelay(ZkCmdExecutor.java:111)
at
org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:70)
at
org.apache.solr.common.cloud.SolrZkClient.getData(SolrZkClient.java:354)
at
org.apache.solr.cloud.OverseerTaskProcessor.amILeader(OverseerTaskProcessor.java:387)
at
org.apache.solr.cloud.OverseerTaskProcessor.run(OverseerTaskProcessor.java:193)
at java.lang.Thread.run(Thread.java:748)
7) Thread[id=9108,
name=zkCallback-1345-thread-2-processing-n:127.0.0.1:55856_solr-EventThread,
state=WAITING, group=TGRP-TestMiniSolrCloudClusterSSL]
at sun.misc.Unsafe.park(Native Method)
at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:501)
8) Thread[id=9054, name=Connection evictor, state=TIMED_WAITING,
group=TGRP-TestMiniSolrCloudClusterSSL]
at java.lang.Thread.sleep(Native Method)
at
org.apache.http.impl.client.IdleConnectionEvictor$1.run(IdleConnectionEvictor.java:66)
at java.lang.Thread.run(Thread.java:748)
9) Thread[id=9107,
name=zkCallback-1345-thread-2-processing-n:127.0.0.1:55856_solr-SendThread(127.0.0.1:48343),
state=TIMED_WAITING, group=TGRP-TestMiniSolrCloudClusterSSL]
at java.lang.Thread.sleep(Native Method)
at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1051)
at __randomizedtesting.SeedInfo.seed([3D43DFAB320A40C4]:0)
FAILED:
junit.framework.TestSuite.org.apache.solr.cloud.TestMiniSolrCloudClusterSSL
Error Message:
There are still zombie threads that couldn't be terminated: 1)
Thread[id=9146, name=ScheduledTrigger-4119-thread-1, state=WAITING,
group=TGRP-TestMiniSolrCloudClusterSSL] at sun.misc.Unsafe.park(Native
Method) at
java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
at
java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1088)
at
java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:809)
at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748) 2) Thread[id=9107,
name=zkCallback-1345-thread-2-processing-n:127.0.0.1:55856_solr-SendThread(127.0.0.1:48343),
state=TIMED_WAITING, group=TGRP-TestMiniSolrCloudClusterSSL] at
java.lang.Thread.sleep(Native Method) at
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1051)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie
threads that couldn't be terminated:
1) Thread[id=9146, name=ScheduledTrigger-4119-thread-1, state=WAITING,
group=TGRP-TestMiniSolrCloudClusterSSL]
at sun.misc.Unsafe.park(Native Method)
at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
at
java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1088)
at
java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:809)
at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
2) Thread[id=9107,
name=zkCallback-1345-thread-2-processing-n:127.0.0.1:55856_solr-SendThread(127.0.0.1:48343),
state=TIMED_WAITING, group=TGRP-TestMiniSolrCloudClusterSSL]
at java.lang.Thread.sleep(Native Method)
at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1051)
at __randomizedtesting.SeedInfo.seed([3D43DFAB320A40C4]:0)
Build Log:
[...truncated 11625 lines...]
[junit4] Suite: org.apache.solr.cloud.CdcrBootstrapTest
[junit4] 2> 268050 INFO
(SUITE-CdcrBootstrapTest-seed#[3D43DFAB320A40C4]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> Creating dataDir:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.cloud.CdcrBootstrapTest_3D43DFAB320A40C4-001/init-core-data-001
[junit4] 2> 268050 WARN
(SUITE-CdcrBootstrapTest-seed#[3D43DFAB320A40C4]-worker) [ ]
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=1 numCloses=1
[junit4] 2> 268050 INFO
(SUITE-CdcrBootstrapTest-seed#[3D43DFAB320A40C4]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 268072 INFO
(SUITE-CdcrBootstrapTest-seed#[3D43DFAB320A40C4]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via:
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 268104 INFO
(TEST-CdcrBootstrapTest.testBootstrapWithContinousIndexingOnSourceCluster-seed#[3D43DFAB320A40C4])
[ ] o.a.s.SolrTestCaseJ4 ###Starting
testBootstrapWithContinousIndexingOnSourceCluster
[junit4] 2> 268105 INFO
(TEST-CdcrBootstrapTest.testBootstrapWithContinousIndexingOnSourceCluster-seed#[3D43DFAB320A40C4])
[ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 1 servers in
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.cloud.CdcrBootstrapTest_3D43DFAB320A40C4-001/cdcr-target-001
[junit4] 2> 268106 INFO
(TEST-CdcrBootstrapTest.testBootstrapWithContinousIndexingOnSourceCluster-seed#[3D43DFAB320A40C4])
[ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 268124 INFO (Thread-73) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 268124 INFO (Thread-73) [ ] o.a.s.c.ZkTestServer Starting
server
[junit4] 2> 268197 ERROR (Thread-73) [ ] o.a.z.s.ZooKeeperServer
ZKShutdownHandler is not registered, so ZooKeeper server won't take any action
on ERROR or SHUTDOWN server state changes
[junit4] 2> 268421 INFO
(TEST-CdcrBootstrapTest.testBootstrapWithContinousIndexingOnSourceCluster-seed#[3D43DFAB320A40C4])
[ ] o.a.s.c.ZkTestServer start zk server on port:60334
[junit4] 2> 268532 INFO (jetty-launcher-60-thread-1) [ ]
o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 268701 INFO (jetty-launcher-60-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@1075f419{/solr,null,AVAILABLE}
[junit4] 2> 269676 INFO (jetty-launcher-60-thread-1) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@4046fad4{SSL,[ssl,
http/1.1]}{127.0.0.1:37550}
[junit4] 2> 269676 INFO (jetty-launcher-60-thread-1) [ ]
o.e.j.s.Server Started @288801ms
[junit4] 2> 269676 INFO (jetty-launcher-60-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=37550}
[junit4] 2> 269676 ERROR (jetty-launcher-60-thread-1) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 269676 INFO (jetty-launcher-60-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
7.2.0
[junit4] 2> 269677 INFO (jetty-launcher-60-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 269677 INFO (jetty-launcher-60-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null, Default config
dir: null
[junit4] 2> 269677 INFO (jetty-launcher-60-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-10-20T22:31:23.523Z
[junit4] 2> 269928 INFO (jetty-launcher-60-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 269978 INFO (jetty-launcher-60-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:60334/solr
[junit4] 2> 270935 INFO (jetty-launcher-60-thread-1)
[n:127.0.0.1:37550_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 270936 INFO (jetty-launcher-60-thread-1)
[n:127.0.0.1:37550_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:37550_solr
[junit4] 2> 270955 INFO (jetty-launcher-60-thread-1)
[n:127.0.0.1:37550_solr ] o.a.s.c.Overseer Overseer
(id=98863591063945219-127.0.0.1:37550_solr-n_0000000000) starting
[junit4] 2> 271128 INFO (jetty-launcher-60-thread-1)
[n:127.0.0.1:37550_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:37550_solr
[junit4] 2> 271154 INFO
(OverseerStateUpdate-98863591063945219-127.0.0.1:37550_solr-n_0000000000)
[n:127.0.0.1:37550_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 273473 INFO (jetty-launcher-60-thread-1)
[n:127.0.0.1:37550_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_37550.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3e79c86e
[junit4] 2> 273535 INFO (jetty-launcher-60-thread-1)
[n:127.0.0.1:37550_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_37550.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3e79c86e
[junit4] 2> 273536 INFO (jetty-launcher-60-thread-1)
[n:127.0.0.1:37550_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_37550.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3e79c86e
[junit4] 2> 273576 INFO (jetty-launcher-60-thread-1)
[n:127.0.0.1:37550_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.cloud.CdcrBootstrapTest_3D43DFAB320A40C4-001/cdcr-target-001/node1/.
[junit4] 1> Target zkHost = 127.0.0.1:60334/solr
[junit4] 2> 274166 INFO
(TEST-CdcrBootstrapTest.testBootstrapWithContinousIndexingOnSourceCluster-seed#[3D43DFAB320A40C4])
[ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 1 servers in
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.cloud.CdcrBootstrapTest_3D43DFAB320A40C4-001/cdcr-source-001
[junit4] 2> 274166 INFO
(TEST-CdcrBootstrapTest.testBootstrapWithContinousIndexingOnSourceCluster-seed#[3D43DFAB320A40C4])
[ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 274184 INFO (Thread-83) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 274184 INFO (Thread-83) [ ] o.a.s.c.ZkTestServer Starting
server
[junit4] 2> 274264 ERROR (Thread-83) [ ] o.a.z.s.ZooKeeperServer
ZKShutdownHandler is not registered, so ZooKeeper server won't take any action
on ERROR or SHUTDOWN server state changes
[junit4] 2> 274437 INFO
(TEST-CdcrBootstrapTest.testBootstrapWithContinousIndexingOnSourceCluster-seed#[3D43DFAB320A40C4])
[ ] o.a.s.c.ZkTestServer start zk server on port:59846
[junit4] 2> 274522 INFO (jetty-launcher-73-thread-1) [ ]
o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 274605 INFO (jetty-launcher-73-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@21592feb{/solr,null,AVAILABLE}
[junit4] 2> 274606 INFO (jetty-launcher-73-thread-1) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@24a4020f{SSL,[ssl,
http/1.1]}{127.0.0.1:60685}
[junit4] 2> 274606 INFO (jetty-launcher-73-thread-1) [ ]
o.e.j.s.Server Started @293731ms
[junit4] 2> 274606 INFO (jetty-launcher-73-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=60685}
[junit4] 2> 274606 ERROR (jetty-launcher-73-thread-1) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 274684 INFO (jetty-launcher-73-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
7.2.0
[junit4] 2> 274684 INFO (jetty-launcher-73-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 274684 INFO (jetty-launcher-73-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null, Default config
dir: null
[junit4] 2> 274684 INFO (jetty-launcher-73-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-10-20T22:31:28.530Z
[junit4] 2> 274724 INFO (jetty-launcher-73-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 275156 INFO (jetty-launcher-73-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:59846/solr
[junit4] 2> 277452 INFO (jetty-launcher-73-thread-1)
[n:127.0.0.1:60685_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 277452 INFO (jetty-launcher-73-thread-1)
[n:127.0.0.1:60685_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:60685_solr
[junit4] 2> 277453 INFO (jetty-launcher-73-thread-1)
[n:127.0.0.1:60685_solr ] o.a.s.c.Overseer Overseer
(id=98863591460044803-127.0.0.1:60685_solr-n_0000000000) starting
[junit4] 2> 277584 INFO (jetty-launcher-73-thread-1)
[n:127.0.0.1:60685_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:60685_solr
[junit4] 2> 277623 INFO
(zkCallback-80-thread-1-processing-n:127.0.0.1:60685_solr)
[n:127.0.0.1:60685_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 278718 INFO (jetty-launcher-73-thread-1)
[n:127.0.0.1:60685_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_60685.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3e79c86e
[junit4] 2> 278925 INFO (jetty-launcher-73-thread-1)
[n:127.0.0.1:60685_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_60685.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3e79c86e
[junit4] 2> 278925 INFO (jetty-launcher-73-thread-1)
[n:127.0.0.1:60685_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_60685.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3e79c86e
[junit4] 2> 278926 INFO (jetty-launcher-73-thread-1)
[n:127.0.0.1:60685_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.cloud.CdcrBootstrapTest_3D43DFAB320A40C4-001/cdcr-source-001/node1/.
[junit4] 2> 279957 INFO
(TEST-CdcrBootstrapTest.testBootstrapWithContinousIndexingOnSourceCluster-seed#[3D43DFAB320A40C4])
[ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 279958 INFO
(TEST-CdcrBootstrapTest.testBootstrapWithContinousIndexingOnSourceCluster-seed#[3D43DFAB320A40C4])
[ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at
127.0.0.1:59846/solr ready
[junit4] 2> 280513 INFO (qtp183448557-392) [n:127.0.0.1:60685_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
replicationFactor=1&collection.configName=cdcr-source&name=cdcr-source&nrtReplicas=1&action=CREATE&numShards=1&property.solr.directoryFactory=solr.StandardDirectoryFactory&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 280523 INFO
(OverseerThreadFactory-145-thread-1-processing-n:127.0.0.1:60685_solr)
[n:127.0.0.1:60685_solr ] o.a.s.c.CreateCollectionCmd Create collection
cdcr-source
[junit4] 2> 280846 INFO
(OverseerStateUpdate-98863591460044803-127.0.0.1:60685_solr-n_0000000000)
[n:127.0.0.1:60685_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"cdcr-source",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"cdcr-source_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:60685/solr";,
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 281073 INFO (qtp183448557-398) [n:127.0.0.1:60685_solr ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&collection.configName=cdcr-source&newCollection=true&collection=cdcr-source&version=2&replicaType=NRT&coreNodeName=core_node2&name=cdcr-source_shard1_replica_n1&action=CREATE&numShards=1&shard=shard1&property.solr.directoryFactory=solr.StandardDirectoryFactory&wt=javabin
[junit4] 2> 281074 INFO (qtp183448557-398) [n:127.0.0.1:60685_solr ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 281249 INFO
(zkCallback-80-thread-1-processing-n:127.0.0.1:60685_solr)
[n:127.0.0.1:60685_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/cdcr-source/state.json] for collection [cdcr-source] has
occurred - updating... (live nodes size: [1])
[junit4] 2> 281269 INFO
(zkCallback-80-thread-2-processing-n:127.0.0.1:60685_solr)
[n:127.0.0.1:60685_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/cdcr-source/state.json] for collection [cdcr-source] has
occurred - updating... (live nodes size: [1])
[junit4] 2> 282374 INFO (qtp183448557-398) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.2.0
[junit4] 2> 282471 INFO (qtp183448557-398) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.s.ManagedIndexSchemaFactory The schema is configured as managed, but
managed schema resource managed-schema not found - loading non-managed schema
schema.xml instead
[junit4] 2> 282495 INFO (qtp183448557-398) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.s.IndexSchema [cdcr-source_shard1_replica_n1] Schema name=minimal
[junit4] 2> 282569 INFO (qtp183448557-398) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 282920 INFO (qtp183448557-398) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.s.ManagedIndexSchema Created and persisted managed schema znode at
/configs/cdcr-source/managed-schema
[junit4] 2> 282924 INFO (qtp183448557-398) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.s.ManagedIndexSchemaFactory After upgrading to managed schema in
ZooKeeper, renamed the non-managed schema /configs/cdcr-source/schema.xml to
/configs/cdcr-source/schema.xml.bak
[junit4] 2> 282924 INFO (qtp183448557-398) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.c.CoreContainer Creating SolrCore 'cdcr-source_shard1_replica_n1' using
configuration from collection cdcr-source, trusted=true
[junit4] 2> 282925 INFO (qtp183448557-398) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_60685.solr.core.cdcr-source.shard1.replica_n1' (registry
'solr.core.cdcr-source.shard1.replica_n1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3e79c86e
[junit4] 2> 282925 INFO (qtp183448557-398) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 282925 INFO (qtp183448557-398) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.c.SolrCore [[cdcr-source_shard1_replica_n1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.cloud.CdcrBootstrapTest_3D43DFAB320A40C4-001/cdcr-source-001/node1/cdcr-source_shard1_replica_n1],
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.cloud.CdcrBootstrapTest_3D43DFAB320A40C4-001/cdcr-source-001/node1/./cdcr-source_shard1_replica_n1/data/]
[junit4] 2> 284148 INFO (qtp183448557-398) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.CdcrUpdateLog
[junit4] 2> 284148 INFO (qtp183448557-398) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 284150 INFO (qtp183448557-398) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 284150 INFO (qtp183448557-398) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 284260 INFO (qtp183448557-398) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@510baeec[cdcr-source_shard1_replica_n1] main]
[junit4] 2> 284261 INFO (qtp183448557-398) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/cdcr-source
[junit4] 2> 284262 INFO (qtp183448557-398) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/cdcr-source
[junit4] 2> 284264 INFO (qtp183448557-398) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at
/configs/cdcr-source/managed-schema
[junit4] 2> 284282 INFO (qtp183448557-398) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
[junit4] 2> 284283 INFO (qtp183448557-398) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 284400 INFO (qtp183448557-398) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.h.CdcrBufferStateManager Created znode
/collections/cdcr-source/cdcr/state/buffer
[junit4] 2> 284413 INFO (qtp183448557-398) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.h.CdcrProcessStateManager Created znode
/collections/cdcr-source/cdcr/state/process
[junit4] 2> 285240 INFO (qtp183448557-398) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1581817474932801536
[junit4] 2> 285297 INFO
(searcherExecutor-148-thread-1-processing-n:127.0.0.1:60685_solr
x:cdcr-source_shard1_replica_n1 s:shard1 c:cdcr-source r:core_node2)
[n:127.0.0.1:60685_solr c:cdcr-source s:shard1 r:core_node2
x:cdcr-source_shard1_replica_n1] o.a.s.c.SolrCore
[cdcr-source_shard1_replica_n1] Registered new searcher
Searcher@510baeec[cdcr-source_shard1_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 285301 INFO (qtp183448557-398) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 285301 INFO (qtp183448557-398) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 285301 INFO (qtp183448557-398) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.c.SyncStrategy Sync replicas to
https://127.0.0.1:60685/solr/cdcr-source_shard1_replica_n1/
[junit4] 2> 285301 INFO (qtp183448557-398) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 285301 INFO (qtp183448557-398) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.c.SyncStrategy
https://127.0.0.1:60685/solr/cdcr-source_shard1_replica_n1/ has no replicas
[junit4] 2> 285301 INFO (qtp183448557-398) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in
election, clear LIR
[junit4] 2> 285333 INFO
(zkCallback-80-thread-3-processing-n:127.0.0.1:60685_solr)
[n:127.0.0.1:60685_solr ] o.a.s.h.CdcrLeaderStateManager Received new leader
state @ cdcr-source:shard1
[junit4] 2> 285353 INFO
(zkCallback-80-thread-2-processing-n:127.0.0.1:60685_solr)
[n:127.0.0.1:60685_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/cdcr-source/state.json] for collection [cdcr-source] has
occurred - updating... (live nodes size: [1])
[junit4] 2> 285353 INFO
(zkCallback-80-thread-3-processing-n:127.0.0.1:60685_solr)
[n:127.0.0.1:60685_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/cdcr-source/state.json] for collection [cdcr-source] has
occurred - updating... (live nodes size: [1])
[junit4] 2> 285355 INFO (qtp183448557-398) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
https://127.0.0.1:60685/solr/cdcr-source_shard1_replica_n1/ shard1
[junit4] 2> 285355 INFO (qtp183448557-398) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 285366 INFO (qtp183448557-398) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&collection.configName=cdcr-source&newCollection=true&collection=cdcr-source&version=2&replicaType=NRT&coreNodeName=core_node2&name=cdcr-source_shard1_replica_n1&action=CREATE&numShards=1&shard=shard1&property.solr.directoryFactory=solr.StandardDirectoryFactory&wt=javabin}
status=0 QTime=4292
[junit4] 2> 285405 INFO (qtp183448557-392) [n:127.0.0.1:60685_solr ]
o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most
30 seconds. Check all shard replicas
[junit4] 2> 285485 INFO
(zkCallback-80-thread-2-processing-n:127.0.0.1:60685_solr)
[n:127.0.0.1:60685_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/cdcr-source/state.json] for collection [cdcr-source] has
occurred - updating... (live nodes size: [1])
[junit4] 2> 285485 INFO
(zkCallback-80-thread-3-processing-n:127.0.0.1:60685_solr)
[n:127.0.0.1:60685_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/cdcr-source/state.json] for collection [cdcr-source] has
occurred - updating... (live nodes size: [1])
[junit4] 2> 286428 INFO (qtp183448557-392) [n:127.0.0.1:60685_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={replicationFactor=1&collection.configName=cdcr-source&name=cdcr-source&nrtReplicas=1&action=CREATE&numShards=1&property.solr.directoryFactory=solr.StandardDirectoryFactory&wt=javabin&version=2}
status=0 QTime=5915
[junit4] 1> Adding 10 docs with commit=true, numDocs=100
[junit4] 2> 286549 INFO
(OverseerCollectionConfigSetProcessor-98863591460044803-127.0.0.1:60685_solr-n_0000000000)
[n:127.0.0.1:60685_solr ] o.a.s.c.OverseerTaskQueue Response ZK path:
/overseer/collection-queue-work/qnr-0000000000 doesn't exist. Requestor may
have disconnected from ZooKeeper
[junit4] 2> 287011 INFO (qtp183448557-395) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1] webapp=/solr path=/update
params={_stateVer_=cdcr-source:4&wt=javabin&version=2} status=0 QTime=494
[junit4] 2> 287064 INFO (qtp183448557-395) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1581817476845404160,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 287065 INFO (qtp183448557-395) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@16d636e5
commitCommandVersion:1581817476845404160
[junit4] 2> 287544 INFO (qtp183448557-395) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@4422f037[cdcr-source_shard1_replica_n1] main]
[junit4] 2> 287546 INFO
(searcherExecutor-148-thread-1-processing-n:127.0.0.1:60685_solr
x:cdcr-source_shard1_replica_n1 s:shard1 c:cdcr-source r:core_node2)
[n:127.0.0.1:60685_solr c:cdcr-source s:shard1 r:core_node2
x:cdcr-source_shard1_replica_n1] o.a.s.c.SolrCore
[cdcr-source_shard1_replica_n1] Registered new searcher
Searcher@4422f037[cdcr-source_shard1_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.2.0):C100)))}
[junit4] 2> 287547 INFO (qtp183448557-395) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 287547 INFO (qtp183448557-395) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1] webapp=/solr path=/update
params={_stateVer_=cdcr-source:4&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}
status=0 QTime=482
[junit4] 1> Adding 10 docs with commit=true, numDocs=200
[junit4] 2> 287778 INFO (qtp183448557-395) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1] webapp=/solr path=/update
params={_stateVer_=cdcr-source:4&wt=javabin&version=2} status=0 QTime=229
[junit4] 2> 287800 INFO (qtp183448557-395) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1581817477617156096,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 287800 INFO (qtp183448557-395) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@16d636e5
commitCommandVersion:1581817477617156096
[junit4] 2> 288412 INFO (qtp183448557-395) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@44c22b12[cdcr-source_shard1_replica_n1] main]
[junit4] 2> 288413 INFO (qtp183448557-395) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 288414 INFO
(searcherExecutor-148-thread-1-processing-n:127.0.0.1:60685_solr
x:cdcr-source_shard1_replica_n1 s:shard1 c:cdcr-source r:core_node2)
[n:127.0.0.1:60685_solr c:cdcr-source s:shard1 r:core_node2
x:cdcr-source_shard1_replica_n1] o.a.s.c.SolrCore
[cdcr-source_shard1_replica_n1] Registered new searcher
Searcher@44c22b12[cdcr-source_shard1_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.2.0):C100)
Uninverting(_1(7.2.0):C100)))}
[junit4] 2> 288415 INFO (qtp183448557-395) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1] webapp=/solr path=/update
params={_stateVer_=cdcr-source:4&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}
status=0 QTime=615
[junit4] 1> Adding 10 docs with commit=true, numDocs=300
[junit4] 2> 288684 INFO (qtp183448557-397) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1] webapp=/solr path=/update
params={_stateVer_=cdcr-source:4&wt=javabin&version=2} status=0 QTime=266
[junit4] 2> 288685 INFO (qtp183448557-397) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1581817478545145856,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 288744 INFO (qtp183448557-397) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@16d636e5
commitCommandVersion:1581817478545145856
[junit4] 2> 289112 INFO (qtp183448557-397) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@404f72e6[cdcr-source_shard1_replica_n1] main]
[junit4] 2> 289114 INFO
(searcherExecutor-148-thread-1-processing-n:127.0.0.1:60685_solr
x:cdcr-source_shard1_replica_n1 s:shard1 c:cdcr-source r:core_node2)
[n:127.0.0.1:60685_solr c:cdcr-source s:shard1 r:core_node2
x:cdcr-source_shard1_replica_n1] o.a.s.c.SolrCore
[cdcr-source_shard1_replica_n1] Registered new searcher
Searcher@404f72e6[cdcr-source_shard1_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.2.0):C100)
Uninverting(_1(7.2.0):C100) Uninverting(_2(7.2.0):C100)))}
[junit4] 2> 289114 INFO (qtp183448557-397) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 289115 INFO (qtp183448557-397) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1] webapp=/solr path=/update
params={_stateVer_=cdcr-source:4&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}
status=0 QTime=429
[junit4] 1> Adding 10 docs with commit=true, numDocs=400
[junit4] 2> 289357 INFO (qtp183448557-397) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1] webapp=/solr path=/update
params={_stateVer_=cdcr-source:4&wt=javabin&version=2} status=0 QTime=239
[junit4] 2> 289385 INFO (qtp183448557-397) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1581817479279149056,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 289385 INFO (qtp183448557-397) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@16d636e5
commitCommandVersion:1581817479279149056
[junit4] 2> 289684 INFO (qtp183448557-397) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@7056aaf3[cdcr-source_shard1_replica_n1] main]
[junit4] 2> 289685 INFO (qtp183448557-397) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 289686 INFO
(searcherExecutor-148-thread-1-processing-n:127.0.0.1:60685_solr
x:cdcr-source_shard1_replica_n1 s:shard1 c:cdcr-source r:core_node2)
[n:127.0.0.1:60685_solr c:cdcr-source s:shard1 r:core_node2
x:cdcr-source_shard1_replica_n1] o.a.s.c.SolrCore
[cdcr-source_shard1_replica_n1] Registered new searcher
Searcher@7056aaf3[cdcr-source_shard1_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.2.0):C100)
Uninverting(_1(7.2.0):C100) Uninverting(_2(7.2.0):C100)
Uninverting(_3(7.2.0):C100)))}
[junit4] 2> 289687 INFO (qtp183448557-397) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1] webapp=/solr path=/update
params={_stateVer_=cdcr-source:4&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}
status=0 QTime=301
[junit4] 1> Adding 10 docs with commit=true, numDocs=500
[junit4] 2> 289790 INFO (qtp183448557-393) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1] webapp=/solr path=/update
params={_stateVer_=cdcr-source:4&wt=javabin&version=2} status=0 QTime=101
[junit4] 2> 289805 INFO (qtp183448557-393) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1581817479719550976,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 289805 INFO (qtp183448557-393) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@16d636e5
commitCommandVersion:1581817479719550976
[junit4] 2> 290089 INFO (qtp183448557-393) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@5d1d5a6d[cdcr-source_shard1_replica_n1] main]
[junit4] 2> 290089 INFO (qtp183448557-393) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 290091 INFO
(searcherExecutor-148-thread-1-processing-n:127.0.0.1:60685_solr
x:cdcr-source_shard1_replica_n1 s:shard1 c:cdcr-source r:core_node2)
[n:127.0.0.1:60685_solr c:cdcr-source s:shard1 r:core_node2
x:cdcr-source_shard1_replica_n1] o.a.s.c.SolrCore
[cdcr-source_shard1_replica_n1] Registered new searcher
Searcher@5d1d5a6d[cdcr-source_shard1_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.2.0):C100)
Uninverting(_1(7.2.0):C100) Uninverting(_2(7.2.0):C100)
Uninverting(_3(7.2.0):C100) Uninverting(_4(7.2.0):C100)))}
[junit4] 2> 290091 INFO (qtp183448557-393) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1] webapp=/solr path=/update
params={_stateVer_=cdcr-source:4&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}
status=0 QTime=286
[junit4] 1> Adding 10 docs with commit=true, numDocs=600
[junit4] 2> 290184 INFO (qtp183448557-393) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1] webapp=/solr path=/update
params={_stateVer_=cdcr-source:4&wt=javabin&version=2} status=0 QTime=91
[junit4] 2> 290220 INFO (qtp183448557-393) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1581817480154710016,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 290221 INFO (qtp183448557-393) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@16d636e5
commitCommandVersion:1581817480154710016
[junit4] 2> 292633 INFO (qtp183448557-393) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@49e4bdd5[cdcr-source_shard1_replica_n1] main]
[junit4] 2> 292633 INFO (qtp183448557-393) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 292635 INFO
(searcherExecutor-148-thread-1-processing-n:127.0.0.1:60685_solr
x:cdcr-source_shard1_replica_n1 s:shard1 c:cdcr-source r:core_node2)
[n:127.0.0.1:60685_solr c:cdcr-source s:shard1 r:core_node2
x:cdcr-source_shard1_replica_n1] o.a.s.c.SolrCore
[cdcr-source_shard1_replica_n1] Registered new searcher
Searcher@49e4bdd5[cdcr-source_shard1_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.2.0):C100)
Uninverting(_1(7.2.0):C100) Uninverting(_2(7.2.0):C100)
Uninverting(_3(7.2.0):C100) Uninverting(_4(7.2.0):C100)
Uninverting(_5(7.2.0):C100)))}
[junit4] 2> 292635 INFO (qtp183448557-393) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1] webapp=/solr path=/update
params={_stateVer_=cdcr-source:4&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}
status=0 QTime=2415
[junit4] 1> Adding 10 docs with commit=true, numDocs=700
[junit4] 2> 292674 INFO (qtp183448557-396) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1] webapp=/solr path=/update
params={_stateVer_=cdcr-source:4&wt=javabin&version=2} status=0 QTime=37
[junit4] 2> 292704 INFO (qtp183448557-396) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1581817482759372800,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 292704 INFO (qtp183448557-396) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@16d636e5
commitCommandVersion:1581817482759372800
[junit4] 2> 293037 INFO (qtp183448557-396) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@3f062990[cdcr-source_shard1_replica_n1] main]
[junit4] 2> 293037 INFO (qtp183448557-396) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 293039 INFO
(searcherExecutor-148-thread-1-processing-n:127.0.0.1:60685_solr
x:cdcr-source_shard1_replica_n1 s:shard1 c:cdcr-source r:core_node2)
[n:127.0.0.1:60685_solr c:cdcr-source s:shard1 r:core_node2
x:cdcr-source_shard1_replica_n1] o.a.s.c.SolrCore
[cdcr-source_shard1_replica_n1] Registered new searcher
Searcher@3f062990[cdcr-source_shard1_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.2.0):C100)
Uninverting(_1(7.2.0):C100) Uninverting(_2(7.2.0):C100)
Uninverting(_3(7.2.0):C100) Uninverting(_4(7.2.0):C100)
Uninverting(_5(7.2.0):C100) Uninverting(_6(7.2.0):C100)))}
[junit4] 2> 293039 INFO (qtp183448557-396) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1] webapp=/solr path=/update
params={_stateVer_=cdcr-source:4&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}
status=0 QTime=334
[junit4] 1> Adding 10 docs with commit=true, numDocs=800
[junit4] 2> 293125 INFO (qtp183448557-398) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1] webapp=/solr path=/update
params={_stateVer_=cdcr-source:4&wt=javabin&version=2} status=0 QTime=68
[junit4] 2> 293126 INFO (qtp183448557-398) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1581817483201871872,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 293126 INFO (qtp183448557-398) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@16d636e5
commitCommandVersion:1581817483201871872
[junit4] 2> 293442 INFO (qtp183448557-398) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@468a5fd[cdcr-source_shard1_replica_n1] main]
[junit4] 2> 293444 INFO
(searcherExecutor-148-thread-1-processing-n:127.0.0.1:60685_solr
x:cdcr-source_shard1_replica_n1 s:shard1 c:cdcr-source r:core_node2)
[n:127.0.0.1:60685_solr c:cdcr-source s:shard1 r:core_node2
x:cdcr-source_shard1_replica_n1] o.a.s.c.SolrCore
[cdcr-source_shard1_replica_n1] Registered new searcher
Searcher@468a5fd[cdcr-source_shard1_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.2.0):C100)
Uninverting(_1(7.2.0):C100) Uninverting(_2(7.2.0):C100)
Uninverting(_3(7.2.0):C100) Uninverting(_4(7.2.0):C100)
Uninverting(_5(7.2.0):C100) Uninverting(_6(7.2.0):C100)
Uninverting(_7(7.2.0):C100)))}
[junit4] 2> 293445 INFO (qtp183448557-398) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 293445 INFO (qtp183448557-398) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1] webapp=/solr path=/update
params={_stateVer_=cdcr-source:4&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}
status=0 QTime=318
[junit4] 1> Adding 10 docs with commit=true, numDocs=900
[junit4] 2> 293469 INFO (qtp183448557-398) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1] webapp=/solr path=/update
params={_stateVer_=cdcr-source:4&wt=javabin&version=2} status=0 QTime=22
[junit4] 2> 293471 INFO (qtp183448557-398) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1581817483563630592,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 293471 INFO (qtp183448557-398) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@16d636e5
commitCommandVersion:1581817483563630592
[junit4] 2> 293720 INFO (qtp183448557-398) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@76d345f4[cdcr-source_shard1_replica_n1] main]
[junit4] 2> 293723 INFO
(searcherExecutor-148-thread-1-processing-n:127.0.0.1:60685_solr
x:cdcr-source_shard1_replica_n1 s:shard1 c:cdcr-source r:core_node2)
[n:127.0.0.1:60685_solr c:cdcr-source s:shard1 r:core_node2
x:cdcr-source_shard1_replica_n1] o.a.s.c.SolrCore
[cdcr-source_shard1_replica_n1] Registered new searcher
Searcher@76d345f4[cdcr-source_shard1_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.2.0):C100)
Uninverting(_1(7.2.0):C100) Uninverting(_2(7.2.0):C100)
Uninverting(_3(7.2.0):C100) Uninverting(_4(7.2.0):C100)
Uninverting(_5(7.2.0):C100) Uninverting(_6(7.2.0):C100)
Uninverting(_7(7.2.0):C100) Uninverting(_8(7.2.0):C100)))}
[junit4] 2> 293723 INFO (qtp183448557-398) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 293723 INFO (qtp183448557-398) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1] webapp=/solr path=/update
params={_stateVer_=cdcr-source:4&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}
status=0 QTime=252
[junit4] 1> Adding 10 docs with commit=true, numDocs=1000
[junit4] 2> 293755 INFO (qtp183448557-398) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1] webapp=/solr path=/update
params={_stateVer_=cdcr-source:4&wt=javabin&version=2} status=0 QTime=29
[junit4] 2> 293800 INFO (qtp183448557-398) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1581817483908612096,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 293800 INFO (qtp183448557-398) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@16d636e5
commitCommandVersion:1581817483908612096
[junit4] 2> 294168 INFO (qtp183448557-398) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@3be019f2[cdcr-source_shard1_replica_n1] main]
[junit4] 2> 294170 INFO
(searcherExecutor-148-thread-1-processing-n:127.0.0.1:60685_solr
x:cdcr-source_shard1_replica_n1 s:shard1 c:cdcr-source r:core_node2)
[n:127.0.0.1:60685_solr c:cdcr-source s:shard1 r:core_node2
x:cdcr-source_shard1_replica_n1] o.a.s.c.SolrCore
[cdcr-source_shard1_replica_n1] Registered new searcher
Searcher@3be019f2[cdcr-source_shard1_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.2.0):C100)
Uninverting(_1(7.2.0):C100) Uninverting(_2(7.2.0):C100)
Uninverting(_3(7.2.0):C100) Uninverting(_4(7.2.0):C100)
Uninverting(_5(7.2.0):C100) Uninverting(_6(7.2.0):C100)
Uninverting(_7(7.2.0):C100) Uninverting(_8(7.2.0):C100)
Uninverting(_9(7.2.0):C100)))}
[junit4] 2> 294170 INFO (qtp183448557-398) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 294171 INFO (qtp183448557-398) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1] webapp=/solr path=/update
params={_stateVer_=cdcr-source:4&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}
status=0 QTime=370
[junit4] 2> 294173 INFO (qtp183448557-398) [n:127.0.0.1:60685_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1]
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1] webapp=/solr path=/select
params={q=*:*&_stateVer_=cdcr-source:4&wt=javabin&version=2} hits=1000 status=0
QTime=0
[junit4] 2> 295013 INFO
(TEST-CdcrBootstrapTest.testBootstrapWithContinousIndexingOnSourceCluster-seed#[3D43DFAB320A40C4])
[ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 295014 INFO
(TEST-CdcrBootstrapTest.testBootstrapWithContinousIndexingOnSourceCluster-seed#[3D43DFAB320A40C4])
[ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at
127.0.0.1:60334/solr ready
[junit4] 2> 296302 INFO (qtp547630103-352) [n:127.0.0.1:37550_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
replicationFactor=1&collection.configName=cdcr-target&name=cdcr-target&nrtReplicas=1&action=CREATE&numShards=1&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 296322 INFO
(OverseerThreadFactory-135-thread-1-processing-n:127.0.0.1:37550_solr)
[n:127.0.0.1:37550_solr ] o.a.s.c.CreateCollectionCmd Create collection
cdcr-target
[junit4] 2> 296516 INFO
(OverseerStateUpdate-98863591063945219-127.0.0.1:37550_solr-n_0000000000)
[n:127.0.0.1:37550_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"cdcr-target",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"cdcr-target_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:37550/solr";,
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 297028 INFO (qtp547630103-349) [n:127.0.0.1:37550_solr ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node2&collection.configName=cdcr-target&newCollection=true&name=cdcr-target_shard1_replica_n1&action=CREATE&numShards=1&collection=cdcr-target&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 297029 INFO (qtp547630103-349) [n:127.0.0.1:37550_solr ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 297293 INFO
(zkCallback-67-thread-1-processing-n:127.0.0.1:37550_solr)
[n:127.0.0.1:37550_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/cdcr-target/state.json] for collection [cdcr-target] has
occurred - updating... (live nodes size: [1])
[junit4] 2> 297333 INFO
(zkCallback-67-thread-2-processing-n:127.0.0.1:37550_solr)
[n:127.0.0.1:37550_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/cdcr-target/state.json] for collection [cdcr-target] has
occurred - updating... (live nodes size: [1])
[junit4] 2> 298214 INFO (qtp547630103-349) [n:127.0.0.1:37550_solr
c:cdcr-target s:shard1 r:core_node2 x:cdcr-target_shard1_replica_n1]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.2.0
[junit4] 2> 298272 INFO (qtp547630103-349) [n:127.0.0.1:37550_solr
c:cdcr-target s:shard1 r:core_node2 x:cdcr-target_shard1_replica_n1]
o.a.s.s.ManagedIndexSchemaFactory The schema is configured as managed, but
managed sche
[...truncated too long message...]
questHandlerTest, SolrCloudExampleTest, HighlighterConfigTest,
DocValuesMultiTest, DeleteLastCustomShardedReplicaTest,
TestDelegationWithHadoopAuth, TestCustomStream, TestSearcherReuse,
TestConfigSetsAPIZkFailure, TestDefaultStatsCache, TestPerFieldSimilarity,
HdfsChaosMonkeySafeLeaderTest, VMParamsZkACLAndCredentialsProvidersTest,
SuggesterTSTTest, ClassificationUpdateProcessorFactoryTest, DebugComponentTest,
TestDocTermOrds, OpenCloseCoreStressTest, CollectionTooManyReplicasTest,
OutputWriterTest, BadIndexSchemaTest, HdfsBasicDistributedZk2Test,
TestFastWriter, CloudExitableDirectoryReaderTest, SolrIndexConfigTest,
SchemaVersionSpecificBehaviorTest, TestAnalyzedSuggestions,
TestExceedMaxTermLength, HdfsUnloadDistributedZkTest, NotRequiredUniqueKeyTest,
SystemLogListenerTest, MergeStrategyTest, SpatialRPTFieldTypeTest,
TestSolrCoreSnapshots, MBeansHandlerTest, MigrateRouteKeyTest,
TestSegmentSorting, TestBackupRepositoryFactory,
BinaryUpdateRequestHandlerTest, SharedFSAutoReplicaFailoverTest,
TestCollectionAPIs, BufferStoreTest, TestMiniSolrCloudClusterSSL]
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=TestMiniSolrCloudClusterSSL -Dtests.seed=3D43DFAB320A40C4
-Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=es-MX
-Dtests.timezone=Pacific/Port_Moresby -Dtests.asserts=true
-Dtests.file.encoding=US-ASCII
[junit4] ERROR 0.00s J1 | TestMiniSolrCloudClusterSSL (suite) <<<
[junit4] > Throwable #1:
com.carrotsearch.randomizedtesting.ThreadLeakError: 9 threads leaked from SUITE
scope at org.apache.solr.cloud.TestMiniSolrCloudClusterSSL:
[junit4] > 1) Thread[id=9145,
name=OverseerAutoScalingTriggerThread-98863861775663115-127.0.0.1:55856_solr-n_0000000003,
state=WAITING, group=Overseer autoscaling triggers]
[junit4] > at sun.misc.Unsafe.park(Native Method)
[junit4] > at
java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
[junit4] > at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
[junit4] > at
org.apache.solr.cloud.autoscaling.OverseerTriggerThread.run(OverseerTriggerThread.java:161)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] > 2) Thread[id=9053, name=Connection evictor,
state=TIMED_WAITING, group=TGRP-TestMiniSolrCloudClusterSSL]
[junit4] > at java.lang.Thread.sleep(Native Method)
[junit4] > at
org.apache.http.impl.client.IdleConnectionEvictor$1.run(IdleConnectionEvictor.java:66)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] > 3) Thread[id=9146, name=ScheduledTrigger-4119-thread-1,
state=TIMED_WAITING, group=TGRP-TestMiniSolrCloudClusterSSL]
[junit4] > at java.lang.Thread.sleep(Native Method)
[junit4] > at
org.apache.solr.common.cloud.ZkCmdExecutor.retryDelay(ZkCmdExecutor.java:111)
[junit4] > at
org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:70)
[junit4] > at
org.apache.solr.common.cloud.SolrZkClient.create(SolrZkClient.java:389)
[junit4] > at
org.apache.solr.cloud.ZkDistributedQueue.offer(ZkDistributedQueue.java:293)
[junit4] > at
org.apache.solr.cloud.autoscaling.TriggerEventQueue.offerEvent(TriggerEventQueue.java:58)
[junit4] > at
org.apache.solr.cloud.autoscaling.ScheduledTriggers$ScheduledTrigger.enqueue(ScheduledTriggers.java:411)
[junit4] > at
org.apache.solr.cloud.autoscaling.ScheduledTriggers.lambda$add$3(ScheduledTriggers.java:205)
[junit4] > at
org.apache.solr.cloud.autoscaling.ScheduledTriggers$$Lambda$237/524708820.process(Unknown
Source)
[junit4] > at
org.apache.solr.cloud.autoscaling.NodeLostTrigger.run(NodeLostTrigger.java:163)
[junit4] > at
org.apache.solr.cloud.autoscaling.ScheduledTriggers$ScheduledTrigger.run(ScheduledTriggers.java:453)
[junit4] > at
java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
[junit4] > at
java.util.concurrent.FutureTask.runAndReset(FutureTask.java:308)
[junit4] > at
java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:180)
[junit4] > at
java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:294)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] > 4) Thread[id=9076, name=Connection evictor,
state=TIMED_WAITING, group=TGRP-TestMiniSolrCloudClusterSSL]
[junit4] > at java.lang.Thread.sleep(Native Method)
[junit4] > at
org.apache.http.impl.client.IdleConnectionEvictor$1.run(IdleConnectionEvictor.java:66)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] > 5) Thread[id=9143,
name=OverseerStateUpdate-98863861775663115-127.0.0.1:55856_solr-n_0000000003,
state=TIMED_WAITING, group=Overseer state updater.]
[junit4] > at sun.misc.Unsafe.park(Native Method)
[junit4] > at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
[junit4] > at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
[junit4] > at
org.apache.solr.cloud.ZkDistributedQueue.peekElements(ZkDistributedQueue.java:435)
[junit4] > at
org.apache.solr.cloud.Overseer$ClusterStateUpdater.run(Overseer.java:202)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] > 6) Thread[id=9144,
name=OverseerCollectionConfigSetProcessor-98863861775663115-127.0.0.1:55856_solr-n_0000000003,
state=TIMED_WAITING, group=Overseer collection creation process.]
[junit4] > at java.lang.Thread.sleep(Native Method)
[junit4] > at
org.apache.solr.common.cloud.ZkCmdExecutor.retryDelay(ZkCmdExecutor.java:111)
[junit4] > at
org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:70)
[junit4] > at
org.apache.solr.common.cloud.SolrZkClient.getData(SolrZkClient.java:354)
[junit4] > at
org.apache.solr.cloud.OverseerTaskProcessor.amILeader(OverseerTaskProcessor.java:387)
[junit4] > at
org.apache.solr.cloud.OverseerTaskProcessor.run(OverseerTaskProcessor.java:193)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] > 7) Thread[id=9108,
name=zkCallback-1345-thread-2-processing-n:127.0.0.1:55856_solr-EventThread,
state=WAITING, group=TGRP-TestMiniSolrCloudClusterSSL]
[junit4] > at sun.misc.Unsafe.park(Native Method)
[junit4] > at
java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
[junit4] > at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
[junit4] > at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
[junit4] > at
org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:501)
[junit4] > 8) Thread[id=9054, name=Connection evictor,
state=TIMED_WAITING, group=TGRP-TestMiniSolrCloudClusterSSL]
[junit4] > at java.lang.Thread.sleep(Native Method)
[junit4] > at
org.apache.http.impl.client.IdleConnectionEvictor$1.run(IdleConnectionEvictor.java:66)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] > 9) Thread[id=9107,
name=zkCallback-1345-thread-2-processing-n:127.0.0.1:55856_solr-SendThread(127.0.0.1:48343),
state=TIMED_WAITING, group=TGRP-TestMiniSolrCloudClusterSSL]
[junit4] > at java.lang.Thread.sleep(Native Method)
[junit4] > at
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1051)
[junit4] > at
__randomizedtesting.SeedInfo.seed([3D43DFAB320A40C4]:0)Throwable #2:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie
threads that couldn't be terminated:
[junit4] > 1) Thread[id=9146, name=ScheduledTrigger-4119-thread-1,
state=WAITING, group=TGRP-TestMiniSolrCloudClusterSSL]
[junit4] > at sun.misc.Unsafe.park(Native Method)
[junit4] > at
java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
[junit4] > at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
[junit4] > at
java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1088)
[junit4] > at
java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:809)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] > 2) Thread[id=9107,
name=zkCallback-1345-thread-2-processing-n:127.0.0.1:55856_solr-SendThread(127.0.0.1:48343),
state=TIMED_WAITING, group=TGRP-TestMiniSolrCloudClusterSSL]
[junit4] > at java.lang.Thread.sleep(Native Method)
[junit4] > at
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1051)
[junit4] > at
__randomizedtesting.SeedInfo.seed([3D43DFAB320A40C4]:0)
[junit4] Completed [310/744 (3!)] on J1 in 255.65s, 4 tests, 1 failure, 2
errors <<< FAILURES!
[...truncated 48579 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
