You are viewing a plain text version of this content. The canonical link for it is here.
Posted to builds@lucene.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2020/04/30 09:51:43 UTC
[JENKINS] Lucene-Solr-NightlyTests-master - Build # 2178 - Still
Unstable
Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-master/2178/
2 tests failed.
FAILED: org.apache.solr.cloud.hdfs.StressHdfsTest.test
Error Message:
Error from server at http://127.0.0.1:41641/delete_data_dir: java.lang.NullPointerException at org.apache.solr.handler.admin.SystemInfoHandler.getSecurityInfo(SystemInfoHandler.java:326) at org.apache.solr.handler.admin.SystemInfoHandler.handleRequestBody(SystemInfoHandler.java:146) at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:209) at org.apache.solr.core.SolrCore.execute(SolrCore.java:2586) at org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:803) at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:582) at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:432) at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:362) at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1604) at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:166) at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1604) at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:545) at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:233) at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:1610) at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:233) at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1300) at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:188) at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:485) at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:1580) at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:186) at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1215) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141) at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127) at org.eclipse.jetty.rewrite.handler.RewriteHandler.handle(RewriteHandler.java:322) at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:767) at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127) at org.eclipse.jetty.server.Server.handle(Server.java:500) at org.eclipse.jetty.server.HttpChannel.lambda$handle$1(HttpChannel.java:383) at org.eclipse.jetty.server.HttpChannel.dispatch(HttpChannel.java:547) at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:375) at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:273) at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:311) at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:103) at org.eclipse.jetty.io.ChannelEndPoint$2.run(ChannelEndPoint.java:117) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:806) at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:938) at java.base/java.lang.Thread.run(Thread.java:834)
Stack Trace:
org.apache.solr.client.solrj.impl.BaseHttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:41641/delete_data_dir: java.lang.NullPointerException
at org.apache.solr.handler.admin.SystemInfoHandler.getSecurityInfo(SystemInfoHandler.java:326)
at org.apache.solr.handler.admin.SystemInfoHandler.handleRequestBody(SystemInfoHandler.java:146)
at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:209)
at org.apache.solr.core.SolrCore.execute(SolrCore.java:2586)
at org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:803)
at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:582)
at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:432)
at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:362)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1604)
at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:166)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1604)
at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:545)
at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:233)
at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:1610)
at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:233)
at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1300)
at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:188)
at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:485)
at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:1580)
at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:186)
at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1215)
at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127)
at org.eclipse.jetty.rewrite.handler.RewriteHandler.handle(RewriteHandler.java:322)
at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:767)
at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127)
at org.eclipse.jetty.server.Server.handle(Server.java:500)
at org.eclipse.jetty.server.HttpChannel.lambda$handle$1(HttpChannel.java:383)
at org.eclipse.jetty.server.HttpChannel.dispatch(HttpChannel.java:547)
at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:375)
at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:273)
at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:311)
at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:103)
at org.eclipse.jetty.io.ChannelEndPoint$2.run(ChannelEndPoint.java:117)
at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:806)
at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:938)
at java.base/java.lang.Thread.run(Thread.java:834)
at __randomizedtesting.SeedInfo.seed([5C7437DC6E97098B:D4200806C06B6473]:0)
at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:665)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:265)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:248)
at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:207)
at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:1004)
at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:1019)
at org.apache.solr.cloud.hdfs.StressHdfsTest.createAndDeleteCollection(StressHdfsTest.java:194)
at org.apache.solr.cloud.hdfs.StressHdfsTest.test(StressHdfsTest.java:103)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:566)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1754)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:942)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:978)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:992)
at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:1081)
at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:1053)
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:370)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:819)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:470)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:951)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:836)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:887)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:898)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:370)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.lambda$forkTimeoutingTask$0(ThreadLeakControl.java:826)
at java.base/java.lang.Thread.run(Thread.java:834)
FAILED: org.apache.solr.index.hdfs.CheckHdfsIndexTest.doTest
Error Message:
Error from server at http://127.0.0.1:39307/k_ncz/co/collection1: java.lang.NullPointerException at org.apache.solr.handler.admin.SystemInfoHandler.getSecurityInfo(SystemInfoHandler.java:326) at org.apache.solr.handler.admin.SystemInfoHandler.handleRequestBody(SystemInfoHandler.java:146) at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:209) at org.apache.solr.core.SolrCore.execute(SolrCore.java:2586) at org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:803) at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:582) at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:432) at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:362) at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1604) at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:166) at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1604) at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:545) at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:233) at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:1610) at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:233) at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1300) at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:188) at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:485) at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:1580) at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:186) at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1215) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141) at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127) at org.eclipse.jetty.rewrite.handler.RewriteHandler.handle(RewriteHandler.java:322) at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:767) at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127) at org.eclipse.jetty.server.Server.handle(Server.java:500) at org.eclipse.jetty.server.HttpChannel.lambda$handle$1(HttpChannel.java:383) at org.eclipse.jetty.server.HttpChannel.dispatch(HttpChannel.java:547) at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:375) at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:273) at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:311) at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:103) at org.eclipse.jetty.io.ChannelEndPoint$2.run(ChannelEndPoint.java:117) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:806) at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:938) at java.base/java.lang.Thread.run(Thread.java:834)
Stack Trace:
org.apache.solr.client.solrj.impl.BaseHttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:39307/k_ncz/co/collection1: java.lang.NullPointerException
at org.apache.solr.handler.admin.SystemInfoHandler.getSecurityInfo(SystemInfoHandler.java:326)
at org.apache.solr.handler.admin.SystemInfoHandler.handleRequestBody(SystemInfoHandler.java:146)
at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:209)
at org.apache.solr.core.SolrCore.execute(SolrCore.java:2586)
at org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:803)
at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:582)
at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:432)
at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:362)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1604)
at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:166)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1604)
at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:545)
at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:233)
at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:1610)
at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:233)
at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1300)
at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:188)
at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:485)
at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:1580)
at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:186)
at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1215)
at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127)
at org.eclipse.jetty.rewrite.handler.RewriteHandler.handle(RewriteHandler.java:322)
at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:767)
at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127)
at org.eclipse.jetty.server.Server.handle(Server.java:500)
at org.eclipse.jetty.server.HttpChannel.lambda$handle$1(HttpChannel.java:383)
at org.eclipse.jetty.server.HttpChannel.dispatch(HttpChannel.java:547)
at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:375)
at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:273)
at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:311)
at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:103)
at org.eclipse.jetty.io.ChannelEndPoint$2.run(ChannelEndPoint.java:117)
at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:806)
at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:938)
at java.base/java.lang.Thread.run(Thread.java:834)
at __randomizedtesting.SeedInfo.seed([5C7437DC6E97098B:FB308F78032C1A32]:0)
at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:665)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:265)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:248)
at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:207)
at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:1004)
at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:1019)
at org.apache.solr.index.hdfs.CheckHdfsIndexTest.doTest(CheckHdfsIndexTest.java:120)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:566)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1754)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:942)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:978)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:992)
at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:1081)
at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:1053)
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:370)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:819)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:470)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:951)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:836)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:887)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:898)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:370)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.lambda$forkTimeoutingTask$0(ThreadLeakControl.java:826)
at java.base/java.lang.Thread.run(Thread.java:834)
Build Log:
[...truncated 13797 lines...]
[junit4] Suite: org.apache.solr.index.hdfs.CheckHdfsIndexTest
[junit4] 2> 1436425 INFO (SUITE-CheckHdfsIndexTest-seed#[5C7437DC6E97098B]-worker) [ ] o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to test-framework derived value of '/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/server/solr/configsets/_default/conf'
[junit4] 2> 1436426 INFO (SUITE-CheckHdfsIndexTest-seed#[5C7437DC6E97098B]-worker) [ ] o.a.s.SolrTestCaseJ4 Created dataDir: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J0/temp/solr.index.hdfs.CheckHdfsIndexTest_5C7437DC6E97098B-001/data-dir-121-001
[junit4] 2> 1436426 WARN (SUITE-CheckHdfsIndexTest-seed#[5C7437DC6E97098B]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=6 numCloses=6
[junit4] 2> 1436426 INFO (SUITE-CheckHdfsIndexTest-seed#[5C7437DC6E97098B]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 1436427 INFO (SUITE-CheckHdfsIndexTest-seed#[5C7437DC6E97098B]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason="", ssl=0.0/0.0, value=0.0/0.0, clientAuth=0.0/0.0)
[junit4] 2> 1436427 INFO (SUITE-CheckHdfsIndexTest-seed#[5C7437DC6E97098B]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 1436429 INFO (SUITE-CheckHdfsIndexTest-seed#[5C7437DC6E97098B]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /k_ncz/co
[junit4] 1> Formatting using clusterid: testClusterID
[junit4] 2> 1436515 WARN (SUITE-CheckHdfsIndexTest-seed#[5C7437DC6E97098B]-worker) [ ] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
[junit4] 2> 1436517 INFO (SUITE-CheckHdfsIndexTest-seed#[5C7437DC6E97098B]-worker) [ ] o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git: a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 11.0.4+10-LTS
[junit4] 2> 1436517 INFO (SUITE-CheckHdfsIndexTest-seed#[5C7437DC6E97098B]-worker) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1436517 INFO (SUITE-CheckHdfsIndexTest-seed#[5C7437DC6E97098B]-worker) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1436517 INFO (SUITE-CheckHdfsIndexTest-seed#[5C7437DC6E97098B]-worker) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 1436518 INFO (SUITE-CheckHdfsIndexTest-seed#[5C7437DC6E97098B]-worker) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@507d48b8{static,/static,jar:file:/home/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-3.2.0-tests.jar!/webapps/static,AVAILABLE}
[junit4] 2> 1436691 INFO (SUITE-CheckHdfsIndexTest-seed#[5C7437DC6E97098B]-worker) [ ] o.e.j.s.h.ContextHandler Started o.e.j.w.WebAppContext@2bee0356{hdfs,/,file:///home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J0/temp/jetty-localhost_localdomain-43285-hadoop-hdfs-3_2_0-tests_jar-_-any-12314788850132926623.dir/webapp/,AVAILABLE}{jar:file:/home/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-3.2.0-tests.jar!/webapps/hdfs}
[junit4] 2> 1436692 INFO (SUITE-CheckHdfsIndexTest-seed#[5C7437DC6E97098B]-worker) [ ] o.e.j.s.AbstractConnector Started ServerConnector@42e6d8fb{HTTP/1.1, (http/1.1)}{localhost.localdomain:43285}
[junit4] 2> 1436692 INFO (SUITE-CheckHdfsIndexTest-seed#[5C7437DC6E97098B]-worker) [ ] o.e.j.s.Server Started @1436725ms
[junit4] 2> 1436766 WARN (SUITE-CheckHdfsIndexTest-seed#[5C7437DC6E97098B]-worker) [ ] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
[junit4] 2> 1436767 INFO (SUITE-CheckHdfsIndexTest-seed#[5C7437DC6E97098B]-worker) [ ] o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git: a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 11.0.4+10-LTS
[junit4] 2> 1436770 INFO (SUITE-CheckHdfsIndexTest-seed#[5C7437DC6E97098B]-worker) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1436770 INFO (SUITE-CheckHdfsIndexTest-seed#[5C7437DC6E97098B]-worker) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1436770 INFO (SUITE-CheckHdfsIndexTest-seed#[5C7437DC6E97098B]-worker) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 1436771 INFO (SUITE-CheckHdfsIndexTest-seed#[5C7437DC6E97098B]-worker) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@79d11e1c{static,/static,jar:file:/home/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-3.2.0-tests.jar!/webapps/static,AVAILABLE}
[junit4] 2> 1436899 INFO (SUITE-CheckHdfsIndexTest-seed#[5C7437DC6E97098B]-worker) [ ] o.e.j.s.h.ContextHandler Started o.e.j.w.WebAppContext@4a821b42{datanode,/,file:///home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J0/temp/jetty-localhost-32973-hadoop-hdfs-3_2_0-tests_jar-_-any-16906975591835231328.dir/webapp/,AVAILABLE}{jar:file:/home/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-3.2.0-tests.jar!/webapps/datanode}
[junit4] 2> 1436899 INFO (SUITE-CheckHdfsIndexTest-seed#[5C7437DC6E97098B]-worker) [ ] o.e.j.s.AbstractConnector Started ServerConnector@49ea2cff{HTTP/1.1, (http/1.1)}{localhost:32973}
[junit4] 2> 1436899 INFO (SUITE-CheckHdfsIndexTest-seed#[5C7437DC6E97098B]-worker) [ ] o.e.j.s.Server Started @1436933ms
[junit4] 2> 1437064 INFO (Block report processor) [ ] BlockStateChange BLOCK* processReport 0xd77e6dfbf40a32: Processing first storage report for DS-7a488e5a-c7e8-4332-84e3-2ee7c4e24833 from datanode efb76e04-979c-4316-a409-42613e2b33b8
[junit4] 2> 1437064 INFO (Block report processor) [ ] BlockStateChange BLOCK* processReport 0xd77e6dfbf40a32: from storage DS-7a488e5a-c7e8-4332-84e3-2ee7c4e24833 node DatanodeRegistration(127.0.0.1:35027, datanodeUuid=efb76e04-979c-4316-a409-42613e2b33b8, infoPort=40177, infoSecurePort=0, ipcPort=43965, storageInfo=lv=-57;cid=testClusterID;nsid=2121503502;c=1588234763986), blocks: 0, hasStaleStorage: true, processing time: 0 msecs, invalidatedBlocks: 0
[junit4] 2> 1437065 INFO (Block report processor) [ ] BlockStateChange BLOCK* processReport 0xd77e6dfbf40a32: Processing first storage report for DS-e345eb1f-e8a0-4009-9ac9-bf891099a926 from datanode efb76e04-979c-4316-a409-42613e2b33b8
[junit4] 2> 1437065 INFO (Block report processor) [ ] BlockStateChange BLOCK* processReport 0xd77e6dfbf40a32: from storage DS-e345eb1f-e8a0-4009-9ac9-bf891099a926 node DatanodeRegistration(127.0.0.1:35027, datanodeUuid=efb76e04-979c-4316-a409-42613e2b33b8, infoPort=40177, infoSecurePort=0, ipcPort=43965, storageInfo=lv=-57;cid=testClusterID;nsid=2121503502;c=1588234763986), blocks: 0, hasStaleStorage: false, processing time: 0 msecs, invalidatedBlocks: 0
[junit4] 2> 1437136 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1437137 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1437137 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 1437237 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.a.s.c.ZkTestServer start zk server on port:45553
[junit4] 2> 1437237 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:45553
[junit4] 2> 1437237 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:45553
[junit4] 2> 1437237 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 45553
[junit4] 2> 1437239 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1437241 INFO (zkConnectionManagerCallback-10739-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1437241 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1437243 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1437244 INFO (zkConnectionManagerCallback-10741-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1437244 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1437245 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml to /configs/conf1/solrconfig.xml
[junit4] 2> 1437247 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/schema.xml to /configs/conf1/schema.xml
[junit4] 2> 1437248 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 1437249 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/stopwords.txt to /configs/conf1/stopwords.txt
[junit4] 2> 1437250 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/protwords.txt to /configs/conf1/protwords.txt
[junit4] 2> 1437251 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/currency.xml to /configs/conf1/currency.xml
[junit4] 2> 1437252 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml to /configs/conf1/enumsConfig.xml
[junit4] 2> 1437253 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json to /configs/conf1/open-exchange-rates.json
[junit4] 2> 1437254 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 1437256 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt to /configs/conf1/old_synonyms.txt
[junit4] 2> 1437257 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/synonyms.txt to /configs/conf1/synonyms.txt
[junit4] 2> 1437257 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.a.s.c.AbstractFullDistribZkTestBase Will use NRT replicas unless explicitly asked otherwise
[junit4] 2> 1437470 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 1437470 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 1437470 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git: a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 11.0.4+10-LTS
[junit4] 2> 1437474 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1437474 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1437474 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 1437475 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@791b8e9a{/k_ncz/co,null,AVAILABLE}
[junit4] 2> 1437476 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@19d16d6d{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:44863}
[junit4] 2> 1437476 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.e.j.s.Server Started @1437509ms
[junit4] 2> 1437476 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/k_ncz/co, solr.data.dir=hdfs://localhost.localdomain:44959/hdfs__localhost.localdomain_44959__home_jenkins_jenkins-slave_workspace_Lucene-Solr-NightlyTests-master_checkout_solr_build_solr-core_test_J0_temp_solr.index.hdfs.CheckHdfsIndexTest_5C7437DC6E97098B-001_tempDir-002_control_data, hostPort=44863, coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J0/temp/solr.index.hdfs.CheckHdfsIndexTest_5C7437DC6E97098B-001/control-001/cores}
[junit4] 2> 1437476 ERROR (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1437476 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1437476 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 9.0.0
[junit4] 2> 1437476 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1437476 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr
[junit4] 2> 1437476 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-04-30T08:19:25.009825Z
[junit4] 2> 1437478 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1437478 INFO (zkConnectionManagerCallback-10743-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1437478 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1437580 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper)
[junit4] 2> 1437580 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J0/temp/solr.index.hdfs.CheckHdfsIndexTest_5C7437DC6E97098B-001/control-001/solr.xml
[junit4] 2> 1437585 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@4c0885a2, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 1438723 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 1438724 WARN (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@6e371a4c[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1438724 WARN (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@6e371a4c[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1438727 WARN (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@582783d6[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1438727 WARN (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@582783d6[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1438729 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:45553/solr
[junit4] 2> 1438730 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1438731 INFO (zkConnectionManagerCallback-10754-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1438731 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1438833 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [n:127.0.0.1:44863_k_ncz%2Fco ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1438834 INFO (zkConnectionManagerCallback-10756-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1438834 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [n:127.0.0.1:44863_k_ncz%2Fco ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1438924 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [n:127.0.0.1:44863_k_ncz%2Fco ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:44863_k_ncz%2Fco
[junit4] 2> 1438925 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [n:127.0.0.1:44863_k_ncz%2Fco ] o.a.s.c.Overseer Overseer (id=73673473110310916-127.0.0.1:44863_k_ncz%2Fco-n_0000000000) starting
[junit4] 2> 1438929 INFO (OverseerStateUpdate-73673473110310916-127.0.0.1:44863_k_ncz%2Fco-n_0000000000) [n:127.0.0.1:44863_k_ncz%2Fco ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:44863_k_ncz%2Fco
[junit4] 2> 1438929 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [n:127.0.0.1:44863_k_ncz%2Fco ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:44863_k_ncz%2Fco
[junit4] 2> 1438930 INFO (OverseerStateUpdate-73673473110310916-127.0.0.1:44863_k_ncz%2Fco-n_0000000000) [n:127.0.0.1:44863_k_ncz%2Fco ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1438932 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [n:127.0.0.1:44863_k_ncz%2Fco ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 1438932 WARN (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [n:127.0.0.1:44863_k_ncz%2Fco ] o.a.s.c.CoreContainer Not all security plugins configured! authentication=you make it. Consider configuring authentication/authorization before exposing Solr to users internal or authorization=external. See https://s.apache.org/solrsecurity for more info. Solr is only as secure as disableddisabled
[junit4] 2> 1438951 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [n:127.0.0.1:44863_k_ncz%2Fco ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 1438977 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [n:127.0.0.1:44863_k_ncz%2Fco ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4c0885a2
[junit4] 2> 1438989 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [n:127.0.0.1:44863_k_ncz%2Fco ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4c0885a2
[junit4] 2> 1438989 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [n:127.0.0.1:44863_k_ncz%2Fco ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4c0885a2
[junit4] 2> 1438991 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [n:127.0.0.1:44863_k_ncz%2Fco ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J0/temp/solr.index.hdfs.CheckHdfsIndexTest_5C7437DC6E97098B-001/control-001/cores
[junit4] 2> 1438999 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1439001 INFO (zkConnectionManagerCallback-10773-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1439001 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1439002 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1439003 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45553/solr ready
[junit4] 2> 1439004 INFO (qtp449352999-24550) [n:127.0.0.1:44863_k_ncz%2Fco ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params collection.configName=conf1&name=control_collection&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=127.0.0.1:44863_k_ncz%252Fco&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 1439007 INFO (OverseerThreadFactory-10763-thread-1-processing-n:127.0.0.1:44863_k_ncz%2Fco) [n:127.0.0.1:44863_k_ncz%2Fco ] o.a.s.c.a.c.CreateCollectionCmd Create collection control_collection
[junit4] 2> 1439121 INFO (qtp449352999-24553) [n:127.0.0.1:44863_k_ncz%2Fco ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=1
[junit4] 2> 1439124 INFO (qtp449352999-24552) [n:127.0.0.1:44863_k_ncz%2Fco ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=0
[junit4] 2> 1439127 INFO (qtp449352999-24549) [n:127.0.0.1:44863_k_ncz%2Fco x:control_collection_shard1_replica_n1 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=conf1&newCollection=true&name=control_collection_shard1_replica_n1&action=CREATE&numShards=1&collection=control_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1439127 INFO (qtp449352999-24549) [n:127.0.0.1:44863_k_ncz%2Fco x:control_collection_shard1_replica_n1 ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 1440138 INFO (qtp449352999-24549) [n:127.0.0.1:44863_k_ncz%2Fco c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0
[junit4] 2> 1440156 INFO (qtp449352999-24549) [n:127.0.0.1:44863_k_ncz%2Fco c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.s.IndexSchema Schema name=test
[junit4] 2> 1440257 INFO (qtp449352999-24549) [n:127.0.0.1:44863_k_ncz%2Fco c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1440282 INFO (qtp449352999-24549) [n:127.0.0.1:44863_k_ncz%2Fco c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.CoreContainer Creating SolrCore 'control_collection_shard1_replica_n1' using configuration from configset conf1, trusted=true
[junit4] 2> 1440283 INFO (qtp449352999-24549) [n:127.0.0.1:44863_k_ncz%2Fco c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.control_collection.shard1.replica_n1' (registry 'solr.core.control_collection.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4c0885a2
[junit4] 2> 1440283 INFO (qtp449352999-24549) [n:127.0.0.1:44863_k_ncz%2Fco c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.HdfsDirectoryFactory solr.hdfs.home=hdfs://localhost.localdomain:44959/solr_hdfs_home
[junit4] 2> 1440283 INFO (qtp449352999-24549) [n:127.0.0.1:44863_k_ncz%2Fco c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.HdfsDirectoryFactory Solr Kerberos Authentication disabled
[junit4] 2> 1440283 INFO (qtp449352999-24549) [n:127.0.0.1:44863_k_ncz%2Fco c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.SolrCore [[control_collection_shard1_replica_n1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J0/temp/solr.index.hdfs.CheckHdfsIndexTest_5C7437DC6E97098B-001/control-001/cores/control_collection_shard1_replica_n1], dataDir=[hdfs://localhost.localdomain:44959/solr_hdfs_home/control_collection/core_node2/data/]
[junit4] 2> 1440284 INFO (qtp449352999-24549) [n:127.0.0.1:44863_k_ncz%2Fco c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.HdfsDirectoryFactory creating directory factory for path hdfs://localhost.localdomain:44959/solr_hdfs_home/control_collection/core_node2/data/snapshot_metadata
[junit4] 2> 1440292 INFO (qtp449352999-24549) [n:127.0.0.1:44863_k_ncz%2Fco c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.HdfsDirectoryFactory Number of slabs of block cache [1] with direct memory allocation set to [true]
[junit4] 2> 1440292 INFO (qtp449352999-24549) [n:127.0.0.1:44863_k_ncz%2Fco c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.HdfsDirectoryFactory Block cache target memory usage, slab size of [4194304] will allocate [1] slabs and use ~[4194304] bytes
[junit4] 2> 1440292 INFO (qtp449352999-24549) [n:127.0.0.1:44863_k_ncz%2Fco c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.HdfsDirectoryFactory Creating new single instance HDFS BlockCache
[junit4] 2> 1440297 INFO (qtp449352999-24549) [n:127.0.0.1:44863_k_ncz%2Fco c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.s.b.BlockDirectory Block cache on write is disabled
[junit4] 2> 1440298 INFO (qtp449352999-24549) [n:127.0.0.1:44863_k_ncz%2Fco c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.HdfsDirectoryFactory creating directory factory for path hdfs://localhost.localdomain:44959/solr_hdfs_home/control_collection/core_node2/data
[junit4] 2> 1440314 INFO (qtp449352999-24549) [n:127.0.0.1:44863_k_ncz%2Fco c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.HdfsDirectoryFactory creating directory factory for path hdfs://localhost.localdomain:44959/solr_hdfs_home/control_collection/core_node2/data/index
[junit4] 2> 1440320 INFO (qtp449352999-24549) [n:127.0.0.1:44863_k_ncz%2Fco c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.HdfsDirectoryFactory Number of slabs of block cache [1] with direct memory allocation set to [true]
[junit4] 2> 1440320 INFO (qtp449352999-24549) [n:127.0.0.1:44863_k_ncz%2Fco c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.HdfsDirectoryFactory Block cache target memory usage, slab size of [4194304] will allocate [1] slabs and use ~[4194304] bytes
[junit4] 2> 1440320 INFO (qtp449352999-24549) [n:127.0.0.1:44863_k_ncz%2Fco c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.HdfsDirectoryFactory Creating new single instance HDFS BlockCache
[junit4] 2> 1440324 INFO (qtp449352999-24549) [n:127.0.0.1:44863_k_ncz%2Fco c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.s.b.BlockDirectory Block cache on write is disabled
[junit4] 2> 1440325 INFO (qtp449352999-24549) [n:127.0.0.1:44863_k_ncz%2Fco c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@6324148c
[junit4] 2> 1440335 WARN (qtp449352999-24549) [n:127.0.0.1:44863_k_ncz%2Fco c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,attributes = {initParams=a, name=/dump, class=DumpRequestHandler},args = {defaults={a=A, b=B}}}
[junit4] 2> 1440399 INFO (qtp449352999-24549) [n:127.0.0.1:44863_k_ncz%2Fco c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.HdfsUpdateLog
[junit4] 2> 1440399 INFO (qtp449352999-24549) [n:127.0.0.1:44863_k_ncz%2Fco c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1440399 INFO (qtp449352999-24549) [n:127.0.0.1:44863_k_ncz%2Fco c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.u.HdfsUpdateLog Initializing HdfsUpdateLog: tlogDfsReplication=2
[junit4] 2> 1440417 INFO (qtp449352999-24549) [n:127.0.0.1:44863_k_ncz%2Fco c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1440418 INFO (qtp449352999-24549) [n:127.0.0.1:44863_k_ncz%2Fco c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1440419 INFO (qtp449352999-24549) [n:127.0.0.1:44863_k_ncz%2Fco c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=46, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.8390087562876979]
[junit4] 2> 1440423 INFO (qtp449352999-24549) [n:127.0.0.1:44863_k_ncz%2Fco c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.s.SolrIndexSearcher Opening [Searcher@74d528d9[control_collection_shard1_replica_n1] main]
[junit4] 2> 1440425 INFO (qtp449352999-24549) [n:127.0.0.1:44863_k_ncz%2Fco c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 1440425 INFO (qtp449352999-24549) [n:127.0.0.1:44863_k_ncz%2Fco c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 1440425 INFO (qtp449352999-24549) [n:127.0.0.1:44863_k_ncz%2Fco c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 1440426 INFO (qtp449352999-24549) [n:127.0.0.1:44863_k_ncz%2Fco c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1665384860047376384
[junit4] 2> 1440434 INFO (searcherExecutor-10775-thread-1-processing-n:127.0.0.1:44863_k_ncz%2Fco x:control_collection_shard1_replica_n1 c:control_collection s:shard1) [n:127.0.0.1:44863_k_ncz%2Fco c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.SolrCore [control_collection_shard1_replica_n1] Registered new searcher Searcher@74d528d9[control_collection_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1440440 INFO (qtp449352999-24549) [n:127.0.0.1:44863_k_ncz%2Fco c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.ZkShardTerms Successful update of terms at /collections/control_collection/terms/shard1 to Terms{values={core_node2=0}, version=0}
[junit4] 2> 1440440 INFO (qtp449352999-24549) [n:127.0.0.1:44863_k_ncz%2Fco c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/control_collection/leaders/shard1
[junit4] 2> 1440442 INFO (qtp449352999-24549) [n:127.0.0.1:44863_k_ncz%2Fco c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 1440443 INFO (qtp449352999-24549) [n:127.0.0.1:44863_k_ncz%2Fco c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 1440443 INFO (qtp449352999-24549) [n:127.0.0.1:44863_k_ncz%2Fco c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:44863/k_ncz/co/control_collection_shard1_replica_n1/
[junit4] 2> 1440443 INFO (qtp449352999-24549) [n:127.0.0.1:44863_k_ncz%2Fco c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 1440443 INFO (qtp449352999-24549) [n:127.0.0.1:44863_k_ncz%2Fco c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.SyncStrategy http://127.0.0.1:44863/k_ncz/co/control_collection_shard1_replica_n1/ has no replicas
[junit4] 2> 1440443 INFO (qtp449352999-24549) [n:127.0.0.1:44863_k_ncz%2Fco c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/control_collection/leaders/shard1/leader after winning as /collections/control_collection/leader_elect/shard1/election/73673473110310916-core_node2-n_0000000000
[junit4] 2> 1440444 INFO (qtp449352999-24549) [n:127.0.0.1:44863_k_ncz%2Fco c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:44863/k_ncz/co/control_collection_shard1_replica_n1/ shard1
[junit4] 2> 1440546 INFO (zkCallback-10755-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/control_collection/state.json] for collection [control_collection] has occurred - updating... (live nodes size: [1])
[junit4] 2> 1440546 INFO (zkCallback-10755-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/control_collection/state.json] for collection [control_collection] has occurred - updating... (live nodes size: [1])
[junit4] 2> 1440547 INFO (qtp449352999-24549) [n:127.0.0.1:44863_k_ncz%2Fco c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 1440550 INFO (qtp449352999-24549) [n:127.0.0.1:44863_k_ncz%2Fco ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&collection.configName=conf1&newCollection=true&name=control_collection_shard1_replica_n1&action=CREATE&numShards=1&collection=control_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=1423
[junit4] 2> 1440552 INFO (qtp449352999-24550) [n:127.0.0.1:44863_k_ncz%2Fco ] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 45 seconds. Check all shard replicas
[junit4] 2> 1440651 INFO (zkCallback-10755-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/control_collection/state.json] for collection [control_collection] has occurred - updating... (live nodes size: [1])
[junit4] 2> 1440651 INFO (zkCallback-10755-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/control_collection/state.json] for collection [control_collection] has occurred - updating... (live nodes size: [1])
[junit4] 2> 1440651 INFO (zkCallback-10755-thread-3) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/control_collection/state.json] for collection [control_collection] has occurred - updating... (live nodes size: [1])
[junit4] 2> 1440652 INFO (qtp449352999-24550) [n:127.0.0.1:44863_k_ncz%2Fco ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={collection.configName=conf1&name=control_collection&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=127.0.0.1:44863_k_ncz%252Fco&wt=javabin&version=2} status=0 QTime=1647
[junit4] 2> 1440652 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.a.s.c.AbstractFullDistribZkTestBase Waiting to see 1 active replicas in collection: control_collection
[junit4] 2> 1440758 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1440759 INFO (zkConnectionManagerCallback-10784-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1440759 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1440760 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1440761 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45553/solr ready
[junit4] 2> 1440761 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection loss:false
[junit4] 2> 1440762 INFO (qtp449352999-24549) [n:127.0.0.1:44863_k_ncz%2Fco ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params collection.configName=conf1&name=collection1&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=&stateFormat=2&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 1440765 INFO (OverseerThreadFactory-10763-thread-2-processing-n:127.0.0.1:44863_k_ncz%2Fco) [n:127.0.0.1:44863_k_ncz%2Fco ] o.a.s.c.a.c.CreateCollectionCmd Create collection collection1
[junit4] 2> 1440765 INFO (OverseerCollectionConfigSetProcessor-73673473110310916-127.0.0.1:44863_k_ncz%2Fco-n_0000000000) [n:127.0.0.1:44863_k_ncz%2Fco ] 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> 1440972 WARN (OverseerThreadFactory-10763-thread-2-processing-n:127.0.0.1:44863_k_ncz%2Fco) [n:127.0.0.1:44863_k_ncz%2Fco ] o.a.s.c.a.c.CreateCollectionCmd It is unusual to create a collection (collection1) without cores.
[junit4] 2> 1440973 INFO (qtp449352999-24549) [n:127.0.0.1:44863_k_ncz%2Fco ] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 45 seconds. Check all shard replicas
[junit4] 2> 1440974 INFO (qtp449352999-24549) [n:127.0.0.1:44863_k_ncz%2Fco ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={collection.configName=conf1&name=collection1&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=&stateFormat=2&wt=javabin&version=2} status=0 QTime=211
[junit4] 2> 1440975 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.a.s.c.SolrCloudTestCase active slice count: 1 expected:1
[junit4] 2> 1440975 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.a.s.c.SolrCloudTestCase active replica count: 0 expected replica count: 0
[junit4] 2> 1440975 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.a.s.c.SolrCloudTestCase active slice count: 1 expected:1
[junit4] 2> 1440975 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.a.s.c.SolrCloudTestCase active replica count: 0 expected replica count: 0
[junit4] 2> 1440975 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.a.s.c.SolrCloudTestCase active slice count: 1 expected:1
[junit4] 2> 1440975 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.a.s.c.SolrCloudTestCase active replica count: 0 expected replica count: 0
[junit4] 2> 1440975 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.a.s.c.AbstractFullDistribZkTestBase Creating jetty instances pullReplicaCount=0 numOtherReplicas=1
[junit4] 2> 1441187 INFO (TEST-CheckHdfsIndexTest.testDeletedDocs-seed#[5C7437DC6E97098B]) [ ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J0/temp/solr.index.hdfs.CheckHdfsIndexTest_5C7437DC6E97098B-001/shard-1-001 of type NRT for shard1
[junit4] 2> 1441188 INFO (closeThreadPool-10785-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 1441188 INFO (closeThreadPool-10785-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 1441188 INFO (closeThreadPool-10785-thread-1) [ ] o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git: a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 11.0.4+10-LTS
[junit4] 2> 1441189 INFO (closeThreadPool-10785-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1441189 INFO (closeThreadPool-10785-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1441189 INFO (closeThreadPool-10785-thread-1) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 1441190 INFO (closeThreadPool-10785-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@5cf8b34c{/k_ncz/co,null,AVAILABLE}
[junit4] 2> 1441190 INFO (closeThreadPool-10785-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@5f8f36df{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:38795}
[junit4] 2> 1441190 INFO (closeThreadPool-10785-thread-1) [ ] o.e.j.s.Server Started @1441223ms
[junit4] 2> 1441190 INFO (closeThreadPool-10785-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/k_ncz/co, solrconfig=solrconfig.xml, solr.data.dir=hdfs://localhost.localdomain:44959/hdfs__localhost.localdomain_44959__home_jenkins_jenkins-slave_workspace_Lucene-Solr-NightlyTests-master_checkout_solr_build_solr-core_test_J0_temp_solr.index.hdfs.CheckHdfsIndexTest_5C7437DC6E97098B-001_tempDir-002_jetty1, hostPort=38795, coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J0/../../../../../../../../../../../home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J0/temp/solr.index.hdfs.CheckHdfsIndexTest_5C7437DC6E97098B-001/shard-1-001/cores, replicaType=NRT}
[junit4] 2> 1441191 ERROR (closeThreadPool-10785-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1441191 INFO (closeThreadPool-10785-thread-1) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1441191 INFO (closeThreadPool-10785-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 9.0.0
[junit4] 2> 1441191 INFO (closeThreadPool-10785-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1441191 INFO (closeThreadPool-10785-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr
[junit4] 2> 1441191 INFO (closeThreadPool-10785-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-04-30T08:19:28.724217Z
[junit4] 2> 1441192 INFO (closeThreadPool-10785-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1441192 INFO (zkConnectionManagerCallback-10787-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1441192 INFO (closeThreadPool-10785-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1441293 INFO (closeThreadPool-10785-thread-1) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper)
[junit4] 2> 1441293 INFO (closeThreadPool-10785-thread-1) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J0/../../../../../../../../../../../home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J0/temp/solr.index.hdfs.CheckHdfsIndexTest_5C7437DC6E97098B-001/shard-1-001/solr.xml
[junit4] 2> 1441298 INFO (closeThreadPool-10785-thread-1) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@4c0885a2, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 1442767 INFO (OverseerCollectionConfigSetProcessor-73673473110310916-127.0.0.1:44863_k_ncz%2Fco-n_0000000000) [n:127.0.0.1:44863_k_ncz%2Fco ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000002 doesn't exist. Requestor may have disconnected from ZooKeeper
[junit4] 2> 1442792 INFO (closeThreadPool-10785-thread-1) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 1442793 WARN (closeThreadPool-10785-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@60982e48[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1442793 WARN (closeThreadPool-10785-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@60982e48[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1442796 WARN (closeThreadPool-10785-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@6316b0f2[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1442796 WARN (closeThreadPool-10785-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@6316b0f2[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1442797 INFO (closeThreadPool-10785-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:45553/solr
[junit4] 2> 1442798 INFO (closeThreadPool-10785-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1442799 INFO (zkConnectionManagerCallback-10798-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1442799 INFO (closeThreadPool-10785-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1442901 INFO (closeThreadPool-10785-thread-1) [n:127.0.0.1:38795_k_ncz%2Fco ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1442902 INFO (zkConnectionManagerCallback-10800-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1442902 INFO (closeThreadPool-10785-thread-1) [n:127.0.0.1:38795_k_ncz%2Fco ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1442906 INFO (closeThreadPool-10785-thread-1) [n:127.0.0.1:38795_k_ncz%2Fco ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1442909 INFO (closeThreadPool-10785-thread-1) [n:127.0.0.1:38795_k_ncz%2Fco ] o.a.s.c.ZkController Publish node=127.0.0.1:38795_k_ncz%2Fco as DOWN
[junit4] 2> 1442910 INFO (closeThreadPool-10785-thread-1) [n:127.0.0.1:38795_k_ncz%2Fco ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 1442910 INFO (closeThreadPool-10785-thread-1) [n:127.0.0.1:38795_k_ncz%2Fco ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:38795_k_ncz%2Fco
[junit4] 2> 1442911 INFO (zkCallback-10755-thread-3) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1442911 INFO (zkCallback-10783-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1442911 INFO (zkCallback-10799-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1442913 INFO (closeThreadPool-10785-thread-1) [n:127.0.0.1:38795_k_ncz%2Fco ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 1442913 WARN (closeThreadPool-10785-thread-1) [n:127.0.0.1:38795_k_ncz%2Fco ] o.a.s.c.CoreContainer Not all security plugins configured! authentication=you make it. Consider configuring authentication/authorization before exposing Solr to users internal or authorization=external. See https://s.apache.org/solrsecurity for more info. Solr is only as secure as disableddisabled
[junit4] 2> 1442931 INFO (closeThreadPool-10785-thread-1) [n:127.0.0.1:38795_k_ncz%2Fco ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 1442951 INFO (closeThreadPool-10785-thread-1) [n:127.0.0.1:38795_k_ncz%2Fco ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4c0885a2
[junit4] 2> 1442960 INFO (closeThreadPool-10785-thread-1) [n:127.0.0.1:38795_k_ncz%2Fco ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4c0885a2
[junit4] 2> 1442960 INFO (closeThreadPool-10785-thread-1) [n:127.0.0.1:38795_k_ncz%2Fco ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4c0885a2
[junit4] 2> 1442961 INFO (closeThreadPool-10785-thread-1) [n:127.0.0.1:38795_k_ncz%2Fco ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J0/../../../../../../../../../../../home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J0/temp/solr.index.hdfs.CheckHdfsIndexTest_5C7437DC6E97098B-001/shard-1-001/cores
[junit4] 2> 1442970 INFO (closeThreadPool-10785-thread-1) [ ] o.a.s.c.AbstractFullDistribZkTestBase waitForLiveNode: 127.0.0.1:38795_k_ncz%2Fco
[junit4] 2> 1442973 INFO (qtp1538304369-24609) [n:127.0.0.1:38795_k_ncz%2Fco ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with params node=127.0.0.1:38795_k_ncz%252Fco&action=ADDREPLICA&collection=collection1&shard=shard1&type=NRT&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 1442977 INFO (qtp1538304369-24612) [n:127.0.0.1:38795_k_ncz%2Fco ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=0
[junit4] 2> 1442980 INFO (qtp449352999-24550) [n:127.0.0.1:44863_k_ncz%2Fco ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={wt=javabin&version=2&key=solr.core.control_collection.shard1.replica_n1:INDEX.sizeInBytes} status=0 QTime=2
[junit4] 2> 1442981 INFO (qtp449352999-24553) [n:127.0.0.1:44863_k_ncz%2Fco ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=1
[junit4] 2> 1442983 INFO (qtp1538304369-24613) [n:127.0.0.1:38795_k_ncz%2Fco ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=0
[junit4] 2> 1442984 INFO (qtp449352999-24551) [n:127.0.0.1:44863_k_ncz%2Fco ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={wt=javabin&version=2&key=solr.core.control_collection.shard1.replica_n1:INDEX.sizeInBytes} status=0 QTime=1
[junit4] 2> 1442986 INFO (qtp449352999-24552) [n:127.0.0.1:44863_k_ncz%2Fco ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=0
[junit4] 2> 1442987 INFO (OverseerThreadFactory-10763-thread-3-processing-n:127.0.0.1:44863_k_ncz%2Fco) [n:127.0.0.1:44863_k_ncz%2Fco c:collection1 s:shard1 ] o.a.s.c.a.c.AddReplicaCmd Node Identified 127.0.0.1:38795_k_ncz%2Fco for creating new replica of shard shard1 for collection collection1
[junit4] 2> 1442988 INFO (OverseerThreadFactory-10763-thread-3-processing-n:127.0.0.1:44863_k_ncz%2Fco) [n:127.0.0.1:44863_k_ncz%2Fco c:collection1 s:shard1 ] o.a.s.c.a.c.AddReplicaCmd Returning CreateReplica command.
[junit4] 2> 1442994 INFO (qtp1538304369-24612) [n:127.0.0.1:38795_k_ncz%2Fco x:collection1_shard1_replica_n1 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=conf1&name=collection1_shard1_replica_n1&action=CREATE&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1444005 INFO (qtp1538304369-24612) [n:127.0.0.1:38795_k_ncz%2Fco c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0
[junit4] 2> 1444026 INFO (qtp1538304369-24612) [n:127.0.0.1:38795_k_ncz%2Fco c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.s.IndexSchema Schema name=test
[junit4] 2> 1444132 INFO (qtp1538304369-24612) [n:127.0.0.1:38795_k_ncz%2Fco c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1444147 INFO (qtp1538304369-24612) [n:127.0.0.1:38795_k_ncz%2Fco c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1_shard1_replica_n1' using configuration from configset conf1, trusted=true
[junit4] 2> 1444148 INFO (qtp1538304369-24612) [n:127.0.0.1:38795_k_ncz%2Fco c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1.shard1.replica_n1' (registry 'solr.core.collection1.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4c0885a2
[junit4] 2> 1444148 INFO (qtp1538304369-24612) [n:127.0.0.1:38795_k_ncz%2Fco c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.c.HdfsDirectoryFactory solr.hdfs.home=hdfs://localhost.localdomain:44959/solr_hdfs_home
[junit4] 2> 1444148 INFO (qtp1538304369-24612) [n:127.0.0.1:38795_k_ncz%2Fco c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.c.HdfsDirectoryFactory Solr Kerberos Authentication disabled
[junit4] 2> 1444148 INFO (qtp1538304369-24612) [n:127.0.0.1:38795_k_ncz%2Fco c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.c.SolrCore [[collection1_shard1_replica_n1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J0/../../../../../../../../../../../home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J0/temp/solr.index.hdfs.CheckHdfsIndexTest_5C7437DC6E97098B-001/shard-1-001/cores/collection1_shard1_replica_n1], dataDir=[hdfs://localhost.localdomain:44959/solr_hdfs_home/collection1/core_node2/data/]
[junit4] 2> 1444149 INFO (qtp1538304369-24612) [n:127.0.0.1:38795_k_ncz%2Fco c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.c.HdfsDirectoryFactory creating directory factory for path hdfs://localhost.localdomain:44959/solr_hdfs_home/collection1/core_node2/data/snapshot_metadata
[junit4] 2> 1444157 INFO (qtp1538304369-24612) [n:127.0.0.1:38795_k_ncz%2Fco c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.c.HdfsDirectoryFactory Number of slabs of block cache [1] with direct memory allocation set to [true]
[junit4] 2> 1444157 INFO (qtp1538304369-24612) [n:127.0.0.1:38795_k_ncz%2Fco c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.c.HdfsDirectoryFactory Block cache target memory usage, slab size of [4194304] will allocate [1] slabs and use ~[4194304] bytes
[junit4] 2> 1444157 INFO (qtp1538304369-24612) [n:127.0.0.1:38795_k_ncz%2Fco c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.c.HdfsDirectoryFactory Creating new single instance HDFS BlockCache
[junit4] 2> 1444162 INFO (qtp1538304369-24612) [n:127.0.0.1:38795_k_ncz%2Fco c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.s.b.BlockDirectory Block cache on write is disabled
[junit4] 2> 1444162 INFO (qtp1538304369-24612) [n:127.0.0.1:38795_k_ncz%2Fco c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.c.HdfsDirectoryFactory creating directory factory for path hdfs://localhost.localdomain:44959/solr_hdfs_home/collection1/core_node2/data
[junit4] 2> 1444178 INFO (qtp1538304369-24612) [n:127.0.0.1:38795_k_ncz%2Fco c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.c.HdfsDirectoryFactory creating directory factory for path hdfs://localhost.localdomain:44959/solr_hdfs_home/collection1/core_node2/data/index
[junit4] 2> 1444185 INFO (qtp1538304369-24612) [n:127.0.0.1:38795_k_ncz%2Fco c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.c.HdfsDirectoryFactory Number of slabs of block cache [1] with direct memory allocation set to [true]
[junit4] 2> 1444185 INFO (qtp1538304369-24612) [n:127.0.0.1:38795_k_ncz%2Fco c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.c.HdfsDirectoryFactory Block cache target memory usage, slab size of [4194304] will allocate [1] slabs and use ~[4194304] bytes
[junit4] 2> 1444185 INFO (qtp1538304369-24612) [n:127.0.0.1:38795_k_ncz%2Fco c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.c.HdfsDirectoryFactory Creating new single instance HDFS BlockCache
[junit4] 2> 1444189 INFO (qtp1538304369-24612) [n:127.0.0.1:38795_k_ncz%2Fco c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.s.b.BlockDirectory Block cache on write is disabled
[junit4] 2> 1444189 INFO (qtp1538304369-24612) [n:127.0.0.1:38795_k_ncz%2Fco c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@19f234a4
[junit4] 2> 1444199 WARN (qtp1538304369-24612) [n:127.0.0.1:38795_k_ncz%2Fco c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,attributes = {initParams=a, name=/dump, class=DumpRequestHandler},args = {defaults={a=A, b=B}}}
[junit4] 2> 1444261 INFO (qtp1538304369-24612) [n:127.0.0.1:38795_k_ncz%2Fco c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.HdfsUpdateLog
[junit4] 2> 1444261 INFO (qtp1538304369-24612) [n:127.0.0.1:38795_k_ncz%2Fco c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1444261 INFO (qtp1538304369-24612) [n:127.0.0.1:38795_k_ncz%2Fco c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.u.HdfsUpdateLog Initializing HdfsUpdateLog: tlogDfsReplication=2
[junit4] 2> 1444271 INFO (qtp1538304369-24612) [n:127.0.0.1:38795_k_ncz%2Fco c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1444272 INFO (qtp1538304369-24612) [n:127.0.0.1:38795_k_ncz%2Fco c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1444273 INFO (qtp1538304369-24612) [n:127.0.0.1:38795_k_ncz%2Fco c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=46, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.8390087562876979]
[junit4] 2> 1444283 INFO (qtp1538304369-24612) [n:127.0.0.1:38795_k_ncz%2Fco c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.s.SolrIndexSearcher Opening [Searcher@189224dc[collection1_shard1_replica_n1] main]
[junit4] 2> 1444289 INFO (qtp1538304369-24612) [n:127.0.0.1:38795_k_ncz%2Fco c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 1444289 INFO (qtp1538304369-24612) [n:127.0.0.1:38795_k_ncz%2Fco c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 1444290 INFO (qtp1538304369-24612) [n:127.0.0.1:38795_k_ncz%2Fco c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 1444290 INFO (qtp1538304369-24612) [n:127.0.0.1:38795_k_ncz%2Fco c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1665384864099074048
[junit4] 2> 1444295 INFO (searcherExecutor-10811-thread-1-processing-n:127.0.0.1:38795_k_ncz%2Fco x:collection1_shard1_replica_n1 c:collection1 s:shard1) [n:127.0.0.1:38795_k_ncz%2Fco c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.c.SolrCore [collection1_shard1_replica_n1] Registered new searcher Searcher@189224dc[collection1_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1444298 INFO (qtp1538304369-24612) [n:127.0.0.1:38795_k_ncz%2Fco c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.c.ZkShardTerms Successful update of terms at /collections/collection1/terms/shard1 to Terms{values={core_node2=0}, version=0}
[junit4] 2> 1444298 INFO (qtp1538304369-24612) [n:127.0.0.1:38795_k_ncz%2Fco c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/collection1/leaders/shard1
[junit4] 2> 1444300 INFO (qtp1538304369-24612) [n:127.0.0.1:38795_k_ncz%2Fco c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 1444300 INFO (qtp1538304369-24612) [n:127.0.0.1:38795_k_ncz%2Fco c:collection1 s:shard1
[...truncated too long message...]
ner DirectoryScanner: shutdown has been called
[junit4] 2> 4663037 INFO (SUITE-StressHdfsTest-seed#[5C7437DC6E97098B]-worker) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.w.WebAppContext@13a59ee7{datanode,/,null,UNAVAILABLE}{jar:file:/home/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-3.2.0-tests.jar!/webapps/datanode}
[junit4] 2> 4663037 INFO (SUITE-StressHdfsTest-seed#[5C7437DC6E97098B]-worker) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@30c88337{HTTP/1.1, (http/1.1)}{localhost:0}
[junit4] 2> 4663037 INFO (SUITE-StressHdfsTest-seed#[5C7437DC6E97098B]-worker) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 4663037 INFO (SUITE-StressHdfsTest-seed#[5C7437DC6E97098B]-worker) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@47fe6119{static,/static,jar:file:/home/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-3.2.0-tests.jar!/webapps/static,UNAVAILABLE}
[junit4] 2> 4663040 WARN (BP-1143250947-127.0.0.1-1588237962158 heartbeating to localhost.localdomain/127.0.0.1:42971) [ ] o.a.h.h.s.d.IncrementalBlockReportManager IncrementalBlockReportManager interrupted
[junit4] 2> 4663040 WARN (BP-1143250947-127.0.0.1-1588237962158 heartbeating to localhost.localdomain/127.0.0.1:42971) [ ] o.a.h.h.s.d.DataNode Ending block pool service for: Block pool BP-1143250947-127.0.0.1-1588237962158 (Datanode Uuid 25cf9e80-5296-452a-afc6-4223f55f4334) service to localhost.localdomain/127.0.0.1:42971
[junit4] 2> 4663064 INFO (SUITE-StressHdfsTest-seed#[5C7437DC6E97098B]-worker) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.w.WebAppContext@e024aca{hdfs,/,null,UNAVAILABLE}{jar:file:/home/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-3.2.0-tests.jar!/webapps/hdfs}
[junit4] 2> 4663064 INFO (SUITE-StressHdfsTest-seed#[5C7437DC6E97098B]-worker) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@6f129a26{HTTP/1.1, (http/1.1)}{localhost.localdomain:0}
[junit4] 2> 4663064 INFO (SUITE-StressHdfsTest-seed#[5C7437DC6E97098B]-worker) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 4663064 INFO (SUITE-StressHdfsTest-seed#[5C7437DC6E97098B]-worker) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@47e036aa{static,/static,jar:file:/home/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-3.2.0-tests.jar!/webapps/static,UNAVAILABLE}
[junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.StressHdfsTest_5C7437DC6E97098B-001
[junit4] 2> Apr 30, 2020 9:13:10 AM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 33 leaked thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene84): {multiDefault=FST50, _root_=BlockTreeOrds(blocksize=128), id=Lucene84, text=PostingsFormat(name=LuceneVarGapDocFreqInterval), txt_t=PostingsFormat(name=LuceneVarGapDocFreqInterval)}, docValues:{range_facet_l_dv=DocValuesFormat(name=Lucene80), _version_=DocValuesFormat(name=Asserting), intDefault=DocValuesFormat(name=Asserting), id_i1=DocValuesFormat(name=Asserting), range_facet_i_dv=DocValuesFormat(name=Asserting), intDvoDefault=DocValuesFormat(name=Lucene80), range_facet_l=DocValuesFormat(name=Asserting), timestamp=DocValuesFormat(name=Asserting)}, maxPointsInLeafNode=32, maxMBSortInHeap=7.476878323790383, sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@38ba8e5a), locale=es-PE, timezone=Africa/Dar_es_Salaam
[junit4] 2> NOTE: Linux 4.15.0-54-generic amd64/Oracle Corporation 11.0.4 (64-bit)/cpus=4,threads=4,free=183675048,total=536870912
[junit4] 2> NOTE: All tests run in this JVM: [RestartWhileUpdatingTest, TestCloudManagedSchema, SortSpecParsingTest, TestFieldCollectionResource, TestStressThreadBackup, SpellingQueryConverterTest, TestLeaderElectionZkExpiry, AutoAddReplicasPlanActionTest, SSLMigrationTest, AdminHandlersProxyTest, TestCaffeineCache, ChaosMonkeySafeLeaderTest, TestSolrIndexConfig, TestTermsQParserPlugin, TestFuzzyAnalyzedSuggestions, SimpleCollectionCreateDeleteTest, NumberUtilsTest, TestSolrCloudWithHadoopAuthPlugin, CdcrRequestHandlerTest, RegexBoostProcessorTest, TestConfigReload, TestDistributedMap, TestQueryTypes, DeleteStatusTest, TestFieldCacheSort, OverriddenZkACLAndCredentialsProvidersTest, HDFSCollectionsAPITest, SparseHLLTest, ActionThrottleTest, TestWaitForStateWithJettyShutdowns, TestCloudPivotFacet, ScheduledTriggerIntegrationTest, SignatureUpdateProcessorFactoryTest, PluginInfoTest, CustomCollectionTest, TimeZoneUtilsTest, CachingDirectoryFactoryTest, DocValuesNotIndexedTest, TestTrie, TestManagedSchemaAPI, DocValuesMissingTest, TestReqParamsAPI, IndexSchemaTest, ZkSolrClientTest, MetricsHistoryIntegrationTest, CursorMarkTest, TestRandomDVFaceting, TestFacetMethods, CoreAdminHandlerTest, TestLogWatcher, VMParamsZkACLAndCredentialsProvidersTest, SimplePostToolTest, TestCollectionsAPIViaSolrCloudCluster, TlogReplayBufferedWhileIndexingTest, TestStressLucene, OverseerStatusTest, RequiredFieldsTest, PackageManagerCLITest, BitVectorTest, ResponseHeaderTest, TestRebalanceLeaders, DirectoryFactoryTest, DistributedFacetPivotLongTailTest, TestSlowCompositeReaderWrapper, TestSha256AuthenticationProvider, TestExactSharedStatsCache, TestReplicaProperties, TestLegacyNumericUtils, IgnoreCommitOptimizeUpdateProcessorFactoryTest, TestDocTermOrdsUninvertLimit, MetricsHistoryHandlerTest, BlobRepositoryCloudTest, TestCoreAdminApis, BasicAuthOnSingleNodeTest, XmlInterpolationTest, AuditLoggerIntegrationTest, OverseerRolesTest, CloneFieldUpdateProcessorFactoryTest, MoreLikeThisHandlerTest, V2StandaloneTest, TestDistributedStatsComponentCardinality, TestConfigSets, TestFieldCacheWithThreads, TestClusterStateMutator, QueryElevationComponentTest, PreAnalyzedFieldManagedSchemaCloudTest, TestReloadAndDeleteDocs, TestMaxTokenLenTokenizer, CdcrBootstrapTest, TestBadConfig, DistribJoinFromCollectionTest, TestConfigOverlay, TestCloudJSONFacetSKG, ClusterStateTest, HdfsSyncSliceTest, SolrCLIZkUtilsTest, AnalysisAfterCoreReloadTest, ReplaceNodeNoTargetTest, TestMinMaxOnMultiValuedField, TestAuthorizationFramework, PeerSyncWithLeaderAndIndexFingerprintCachingTest, AtomicUpdateRemovalJavabinTest, HighlighterMaxOffsetTest, TestSolrQueryParser, TestSimDistribStateManager, VersionInfoTest, TestSchemalessBufferedUpdates, SchemaVersionSpecificBehaviorTest, TestScoreJoinQPScore, CheckHdfsIndexTest, SolrIndexMetricsTest, LeaderTragicEventTest, CursorPagingTest, TestCrossCoreJoin, TestCloudRecovery2, CollectionReloadTest, ExecutePlanActionTest, SolrShardReporterTest, JSONWriterTest, TestPullReplica, RankQueryTest, TestCryptoKeys, HttpPartitionWithTlogReplicasTest, CoreMergeIndexesAdminHandlerTest, TestJsonFacets, TransactionLogTest, TestPivotHelperCode, TestSolrCoreProperties, ZkStateWriterTest, HdfsUnloadDistributedZkTest, TestUniqueKeyFieldResource, BooleanFieldTest, IndexSizeTriggerMixedBoundsTest, TestCloudDeleteByQuery, TestMultiWordSynonyms, NestedAtomicUpdateTest, TestSkipOverseerOperations, Tagger2Test, TestSegmentSorting, TestPartialUpdateDeduplication, UpdateRequestProcessorFactoryTest, TestFieldTypeResource, TestJsonRangeFacets, TestCopyFieldCollectionResource, TestPushWriter, TestConfigSetsAPI, TestBM25SimilarityFactory, HLLSerializationTest, DisMaxRequestHandlerTest, DistributedIntervalFacetingTest, EchoParamsTest, MinimalSchemaTest, OutputWriterTest, SampleTest, SolrInfoBeanTest, SolrTestCaseJ4Test, TestDistributedMissingSort, TestDocumentBuilder, TestGroupingSearch, TestHighlightDedupGrouping, TestJoin, TestSolrTestCaseJ4, TestTolerantSearch, TestCharFilters, TestReversedWildcardFilterFactory, TestWordDelimiterFilterFactory, TokenizerChainTest, TestLuceneIndexBackCompat, TestEmbeddedSolrServerAdminHandler, TestEmbeddedSolrServerConstructors, TestEmbeddedSolrServerSchemaAPI, AddReplicaTest, AliasIntegrationTest, AssignBackwardCompatibilityTest, BasicZkTest, ChaosMonkeyNothingIsSafeTest, ChaosMonkeySafeLeaderWithPullReplicasTest, ConfigSetsAPITest, DeleteShardTest, DistribCursorPagingTest, DistributedQueueTest, DistributedVersionInfoTest, ForceLeaderTest, ForceLeaderWithTlogReplicasTest, HttpPartitionTest, MetricsHistoryWithAuthIntegrationTest, MissingSegmentRecoveryTest, MoveReplicaHDFSFailoverTest, NodeMutatorTest, OutOfBoxZkACLAndCredentialsProvidersTest, OverseerSolrResponseTest, OverseerSolrResponseUnsafeSerializationTest, RecoveryZkTest, RemoteQueryErrorTest, ReplaceNodeTest, ReplicationFactorTest, RoutingToNodesWithPropertiesTest, SaslZkACLProviderTest, ShardRoutingCustomTest, ShardRoutingTest, SyncSliceTest, TestCloudSearcherWarming, TestExactSharedStatsCacheCloud, TestExactStatsCacheCloud, TestExclusionRuleCollectionAccess, TestLocalStatsCacheCloud, TestLockTree, TestMiniSolrCloudClusterSSL, TestRSAKeyPair, TestRequestForwarding, TestShortCircuitedRequests, TestSolrCloudWithKerberosAlt, TestStressCloudBlindAtomicUpdates, TestTolerantUpdateProcessorCloud, TriLevelCompositeIdRoutingTest, UnloadDistributedZkTest, ZkCLITest, ZkControllerTest, ZkFailoverTest, ZkNodePropsTest, ZkShardTermsTest, CollectionsAPIDistributedZkTest, ConcurrentCreateCollectionTest, ConcurrentDeleteAndCreateCollectionTest, HdfsCollectionsAPIDistributedZkTest, ShardSplitTest, HttpTriggerListenerTest, IndexSizeTriggerSizeEstimationTest, NodeAddedTriggerTest, NodeMarkersRegistrationTest, SearchRateTriggerTest, TriggerEventQueueTest, TriggerIntegrationTest, TestSimNodeAddedTrigger, TestSimNodeLostTrigger, TestSimPolicyCloud, TestSimScenario, TestSimTriggerIntegration, TestSimUtils, TestSnapshotCloudManager, HdfsChaosMonkeyNothingIsSafeTest, HdfsWriteToMultipleCollectionsTest, StressHdfsTest]
[junit4] Completed [604/910 (2!)] on J0 in 31.45s, 1 test, 1 error <<< FAILURES!
[...truncated 53627 lines...]
[JENKINS] Lucene-Solr-NightlyTests-master - Build # 2180 - Still
unstable
Posted by Apache Jenkins Server <je...@builds.apache.org>.
Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-master/2180/
2 tests failed.
FAILED: org.apache.solr.cloud.ShardRoutingTest.test
Error Message:
expected:<3> but was:<21>
Stack Trace:
java.lang.AssertionError: expected:<3> but was:<21>
at __randomizedtesting.SeedInfo.seed([21EA3A52F6A0A7C4:A9BE0588585CCA3C]:0)
at org.junit.Assert.fail(Assert.java:88)
at org.junit.Assert.failNotEquals(Assert.java:834)
at org.junit.Assert.assertEquals(Assert.java:645)
at org.junit.Assert.assertEquals(Assert.java:631)
at org.apache.solr.cloud.ShardRoutingTest.doTestNumRequests(ShardRoutingTest.java:256)
at org.apache.solr.cloud.ShardRoutingTest.test(ShardRoutingTest.java:110)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:566)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1754)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:942)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:978)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:992)
at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:1081)
at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:1053)
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:370)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:819)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:470)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:951)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:836)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:887)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:898)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:370)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.lambda$forkTimeoutingTask$0(ThreadLeakControl.java:826)
at java.base/java.lang.Thread.run(Thread.java:834)
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.api.collections.TestHdfsCloudBackupRestore
Error Message:
ObjectTracker found 7 object(s) that were not released!!! [InternalHttpClient, MMapDirectory, MMapDirectory, MMapDirectory, InternalHttpClient, MMapDirectory, SolrCore] org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.http.impl.client.InternalHttpClient at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:339) at org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:348) at org.apache.solr.handler.IndexFetcher.createHttpClient(IndexFetcher.java:230) at org.apache.solr.handler.IndexFetcher.<init>(IndexFetcher.java:272) at org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:418) at org.apache.solr.cloud.RecoveryStrategy.replicate(RecoveryStrategy.java:250) at org.apache.solr.cloud.RecoveryStrategy.doReplicateOnlyRecovery(RecoveryStrategy.java:392) at org.apache.solr.cloud.RecoveryStrategy.doRecovery(RecoveryStrategy.java:334) at org.apache.solr.cloud.RecoveryStrategy.run(RecoveryStrategy.java:315) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:180) at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:515) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) at java.base/java.lang.Thread.run(Thread.java:834) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MMapDirectory at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:354) at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:519) at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:351) at org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:422) at org.apache.solr.cloud.RecoveryStrategy.replicate(RecoveryStrategy.java:250) at org.apache.solr.cloud.RecoveryStrategy.doReplicateOnlyRecovery(RecoveryStrategy.java:392) at org.apache.solr.cloud.RecoveryStrategy.doRecovery(RecoveryStrategy.java:334) at org.apache.solr.cloud.RecoveryStrategy.run(RecoveryStrategy.java:315) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:180) at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:515) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) at java.base/java.lang.Thread.run(Thread.java:834) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MMapDirectory at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:354) at org.apache.solr.core.SolrCore.getNewIndexDir(SolrCore.java:391) at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:767) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:985) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:903) at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1281) at org.apache.solr.core.CoreContainer.create(CoreContainer.java:1190) at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:93) at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:362) at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:397) at org.apache.solr.handler.admin.CoreAdminHandler.lambda$handleRequestBody$0(CoreAdminHandler.java:189) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:180) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) at java.base/java.lang.Thread.run(Thread.java:834) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MMapDirectory at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:354) at org.apache.solr.core.SolrCore.initSnapshotMetaDataManager(SolrCore.java:539) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:977) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:903) at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1281) at org.apache.solr.core.CoreContainer.create(CoreContainer.java:1190) at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:93) at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:362) at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:397) at org.apache.solr.handler.admin.CoreAdminHandler.lambda$handleRequestBody$0(CoreAdminHandler.java:189) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:180) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) at java.base/java.lang.Thread.run(Thread.java:834) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.http.impl.client.InternalHttpClient at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:339) at org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:348) at org.apache.solr.handler.IndexFetcher.createHttpClient(IndexFetcher.java:230) at org.apache.solr.handler.IndexFetcher.<init>(IndexFetcher.java:272) at org.apache.solr.handler.ReplicationHandler.inform(ReplicationHandler.java:1239) at org.apache.solr.cloud.ReplicateFromLeader.startReplication(ReplicateFromLeader.java:109) at org.apache.solr.cloud.ZkController.startReplicationFromLeader(ZkController.java:1327) at org.apache.solr.cloud.RecoveryStrategy.doReplicateOnlyRecovery(RecoveryStrategy.java:412) at org.apache.solr.cloud.RecoveryStrategy.doRecovery(RecoveryStrategy.java:334) at org.apache.solr.cloud.RecoveryStrategy.run(RecoveryStrategy.java:315) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:180) at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:515) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) at java.base/java.lang.Thread.run(Thread.java:834) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MMapDirectory at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:354) at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:519) at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:351) at org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:422) at org.apache.solr.handler.ReplicationHandler.lambda$setupPolling$13(ReplicationHandler.java:1208) at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:515) at java.base/java.util.concurrent.FutureTask.runAndReset(FutureTask.java:305) at java.base/java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:305) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) at java.base/java.lang.Thread.run(Thread.java:834) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.solr.core.SolrCore at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:1072) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:903) at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1281) at org.apache.solr.core.CoreContainer.create(CoreContainer.java:1190) at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:93) at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:362) at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:397) at org.apache.solr.handler.admin.CoreAdminHandler.lambda$handleRequestBody$0(CoreAdminHandler.java:189) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:180) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) at java.base/java.lang.Thread.run(Thread.java:834) expected null, but was:<ObjectTracker found 7 object(s) that were not released!!! [InternalHttpClient, MMapDirectory, MMapDirectory, MMapDirectory, InternalHttpClient, MMapDirectory, SolrCore] org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.http.impl.client.InternalHttpClient at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:339) at org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:348) at org.apache.solr.handler.IndexFetcher.createHttpClient(IndexFetcher.java:230) at org.apache.solr.handler.IndexFetcher.<init>(IndexFetcher.java:272) at org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:418) at org.apache.solr.cloud.RecoveryStrategy.replicate(RecoveryStrategy.java:250) at org.apache.solr.cloud.RecoveryStrategy.doReplicateOnlyRecovery(RecoveryStrategy.java:392) at org.apache.solr.cloud.RecoveryStrategy.doRecovery(RecoveryStrategy.java:334) at org.apache.solr.cloud.RecoveryStrategy.run(RecoveryStrategy.java:315) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:180) at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:515) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) at java.base/java.lang.Thread.run(Thread.java:834) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MMapDirectory at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:354) at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:519) at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:351) at org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:422) at org.apache.solr.cloud.RecoveryStrategy.replicate(RecoveryStrategy.java:250) at org.apache.solr.cloud.RecoveryStrategy.doReplicateOnlyRecovery(RecoveryStrategy.java:392) at org.apache.solr.cloud.RecoveryStrategy.doRecovery(RecoveryStrategy.java:334) at org.apache.solr.cloud.RecoveryStrategy.run(RecoveryStrategy.java:315) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:180) at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:515) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) at java.base/java.lang.Thread.run(Thread.java:834) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MMapDirectory at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:354) at org.apache.solr.core.SolrCore.getNewIndexDir(SolrCore.java:391) at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:767) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:985) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:903) at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1281) at org.apache.solr.core.CoreContainer.create(CoreContainer.java:1190) at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:93) at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:362) at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:397) at org.apache.solr.handler.admin.CoreAdminHandler.lambda$handleRequestBody$0(CoreAdminHandler.java:189) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:180) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) at java.base/java.lang.Thread.run(Thread.java:834) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MMapDirectory at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:354) at org.apache.solr.core.SolrCore.initSnapshotMetaDataManager(SolrCore.java:539) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:977) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:903) at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1281) at org.apache.solr.core.CoreContainer.create(CoreContainer.java:1190) at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:93) at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:362) at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:397) at org.apache.solr.handler.admin.CoreAdminHandler.lambda$handleRequestBody$0(CoreAdminHandler.java:189) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:180) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) at java.base/java.lang.Thread.run(Thread.java:834) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.http.impl.client.InternalHttpClient at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:339) at org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:348) at org.apache.solr.handler.IndexFetcher.createHttpClient(IndexFetcher.java:230) at org.apache.solr.handler.IndexFetcher.<init>(IndexFetcher.java:272) at org.apache.solr.handler.ReplicationHandler.inform(ReplicationHandler.java:1239) at org.apache.solr.cloud.ReplicateFromLeader.startReplication(ReplicateFromLeader.java:109) at org.apache.solr.cloud.ZkController.startReplicationFromLeader(ZkController.java:1327) at org.apache.solr.cloud.RecoveryStrategy.doReplicateOnlyRecovery(RecoveryStrategy.java:412) at org.apache.solr.cloud.RecoveryStrategy.doRecovery(RecoveryStrategy.java:334) at org.apache.solr.cloud.RecoveryStrategy.run(RecoveryStrategy.java:315) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:180) at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:515) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) at java.base/java.lang.Thread.run(Thread.java:834) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MMapDirectory at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:354) at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:519) at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:351) at org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:422) at org.apache.solr.handler.ReplicationHandler.lambda$setupPolling$13(ReplicationHandler.java:1208) at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:515) at java.base/java.util.concurrent.FutureTask.runAndReset(FutureTask.java:305) at java.base/java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:305) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) at java.base/java.lang.Thread.run(Thread.java:834) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.solr.core.SolrCore at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:1072) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:903) at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1281) at org.apache.solr.core.CoreContainer.create(CoreContainer.java:1190) at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:93) at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:362) at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:397) at org.apache.solr.handler.admin.CoreAdminHandler.lambda$handleRequestBody$0(CoreAdminHandler.java:189) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:180) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) at java.base/java.lang.Thread.run(Thread.java:834) >
Stack Trace:
java.lang.AssertionError: ObjectTracker found 7 object(s) that were not released!!! [InternalHttpClient, MMapDirectory, MMapDirectory, MMapDirectory, InternalHttpClient, MMapDirectory, SolrCore]
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.http.impl.client.InternalHttpClient
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:339)
at org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:348)
at org.apache.solr.handler.IndexFetcher.createHttpClient(IndexFetcher.java:230)
at org.apache.solr.handler.IndexFetcher.<init>(IndexFetcher.java:272)
at org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:418)
at org.apache.solr.cloud.RecoveryStrategy.replicate(RecoveryStrategy.java:250)
at org.apache.solr.cloud.RecoveryStrategy.doReplicateOnlyRecovery(RecoveryStrategy.java:392)
at org.apache.solr.cloud.RecoveryStrategy.doRecovery(RecoveryStrategy.java:334)
at org.apache.solr.cloud.RecoveryStrategy.run(RecoveryStrategy.java:315)
at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:180)
at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:515)
at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
at java.base/java.lang.Thread.run(Thread.java:834)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MMapDirectory
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:354)
at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:519)
at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:351)
at org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:422)
at org.apache.solr.cloud.RecoveryStrategy.replicate(RecoveryStrategy.java:250)
at org.apache.solr.cloud.RecoveryStrategy.doReplicateOnlyRecovery(RecoveryStrategy.java:392)
at org.apache.solr.cloud.RecoveryStrategy.doRecovery(RecoveryStrategy.java:334)
at org.apache.solr.cloud.RecoveryStrategy.run(RecoveryStrategy.java:315)
at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:180)
at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:515)
at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
at java.base/java.lang.Thread.run(Thread.java:834)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MMapDirectory
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:354)
at org.apache.solr.core.SolrCore.getNewIndexDir(SolrCore.java:391)
at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:767)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:985)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:903)
at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1281)
at org.apache.solr.core.CoreContainer.create(CoreContainer.java:1190)
at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:93)
at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:362)
at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:397)
at org.apache.solr.handler.admin.CoreAdminHandler.lambda$handleRequestBody$0(CoreAdminHandler.java:189)
at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:180)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
at java.base/java.lang.Thread.run(Thread.java:834)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MMapDirectory
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:354)
at org.apache.solr.core.SolrCore.initSnapshotMetaDataManager(SolrCore.java:539)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:977)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:903)
at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1281)
at org.apache.solr.core.CoreContainer.create(CoreContainer.java:1190)
at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:93)
at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:362)
at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:397)
at org.apache.solr.handler.admin.CoreAdminHandler.lambda$handleRequestBody$0(CoreAdminHandler.java:189)
at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:180)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
at java.base/java.lang.Thread.run(Thread.java:834)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.http.impl.client.InternalHttpClient
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:339)
at org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:348)
at org.apache.solr.handler.IndexFetcher.createHttpClient(IndexFetcher.java:230)
at org.apache.solr.handler.IndexFetcher.<init>(IndexFetcher.java:272)
at org.apache.solr.handler.ReplicationHandler.inform(ReplicationHandler.java:1239)
at org.apache.solr.cloud.ReplicateFromLeader.startReplication(ReplicateFromLeader.java:109)
at org.apache.solr.cloud.ZkController.startReplicationFromLeader(ZkController.java:1327)
at org.apache.solr.cloud.RecoveryStrategy.doReplicateOnlyRecovery(RecoveryStrategy.java:412)
at org.apache.solr.cloud.RecoveryStrategy.doRecovery(RecoveryStrategy.java:334)
at org.apache.solr.cloud.RecoveryStrategy.run(RecoveryStrategy.java:315)
at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:180)
at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:515)
at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
at java.base/java.lang.Thread.run(Thread.java:834)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MMapDirectory
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:354)
at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:519)
at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:351)
at org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:422)
at org.apache.solr.handler.ReplicationHandler.lambda$setupPolling$13(ReplicationHandler.java:1208)
at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:515)
at java.base/java.util.concurrent.FutureTask.runAndReset(FutureTask.java:305)
at java.base/java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:305)
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
at java.base/java.lang.Thread.run(Thread.java:834)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.solr.core.SolrCore
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:1072)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:903)
at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1281)
at org.apache.solr.core.CoreContainer.create(CoreContainer.java:1190)
at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:93)
at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:362)
at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:397)
at org.apache.solr.handler.admin.CoreAdminHandler.lambda$handleRequestBody$0(CoreAdminHandler.java:189)
at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:180)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
at java.base/java.lang.Thread.run(Thread.java:834)
expected null, but was:<ObjectTracker found 7 object(s) that were not released!!! [InternalHttpClient, MMapDirectory, MMapDirectory, MMapDirectory, InternalHttpClient, MMapDirectory, SolrCore]
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.http.impl.client.InternalHttpClient
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:339)
at org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:348)
at org.apache.solr.handler.IndexFetcher.createHttpClient(IndexFetcher.java:230)
at org.apache.solr.handler.IndexFetcher.<init>(IndexFetcher.java:272)
at org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:418)
at org.apache.solr.cloud.RecoveryStrategy.replicate(RecoveryStrategy.java:250)
at org.apache.solr.cloud.RecoveryStrategy.doReplicateOnlyRecovery(RecoveryStrategy.java:392)
at org.apache.solr.cloud.RecoveryStrategy.doRecovery(RecoveryStrategy.java:334)
at org.apache.solr.cloud.RecoveryStrategy.run(RecoveryStrategy.java:315)
at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:180)
at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:515)
at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
at java.base/java.lang.Thread.run(Thread.java:834)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MMapDirectory
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:354)
at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:519)
at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:351)
at org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:422)
at org.apache.solr.cloud.RecoveryStrategy.replicate(RecoveryStrategy.java:250)
at org.apache.solr.cloud.RecoveryStrategy.doReplicateOnlyRecovery(RecoveryStrategy.java:392)
at org.apache.solr.cloud.RecoveryStrategy.doRecovery(RecoveryStrategy.java:334)
at org.apache.solr.cloud.RecoveryStrategy.run(RecoveryStrategy.java:315)
at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:180)
at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:515)
at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
at java.base/java.lang.Thread.run(Thread.java:834)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MMapDirectory
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:354)
at org.apache.solr.core.SolrCore.getNewIndexDir(SolrCore.java:391)
at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:767)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:985)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:903)
at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1281)
at org.apache.solr.core.CoreContainer.create(CoreContainer.java:1190)
at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:93)
at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:362)
at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:397)
at org.apache.solr.handler.admin.CoreAdminHandler.lambda$handleRequestBody$0(CoreAdminHandler.java:189)
at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:180)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
at java.base/java.lang.Thread.run(Thread.java:834)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MMapDirectory
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:354)
at org.apache.solr.core.SolrCore.initSnapshotMetaDataManager(SolrCore.java:539)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:977)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:903)
at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1281)
at org.apache.solr.core.CoreContainer.create(CoreContainer.java:1190)
at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:93)
at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:362)
at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:397)
at org.apache.solr.handler.admin.CoreAdminHandler.lambda$handleRequestBody$0(CoreAdminHandler.java:189)
at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:180)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
at java.base/java.lang.Thread.run(Thread.java:834)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.http.impl.client.InternalHttpClient
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:339)
at org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:348)
at org.apache.solr.handler.IndexFetcher.createHttpClient(IndexFetcher.java:230)
at org.apache.solr.handler.IndexFetcher.<init>(IndexFetcher.java:272)
at org.apache.solr.handler.ReplicationHandler.inform(ReplicationHandler.java:1239)
at org.apache.solr.cloud.ReplicateFromLeader.startReplication(ReplicateFromLeader.java:109)
at org.apache.solr.cloud.ZkController.startReplicationFromLeader(ZkController.java:1327)
at org.apache.solr.cloud.RecoveryStrategy.doReplicateOnlyRecovery(RecoveryStrategy.java:412)
at org.apache.solr.cloud.RecoveryStrategy.doRecovery(RecoveryStrategy.java:334)
at org.apache.solr.cloud.RecoveryStrategy.run(RecoveryStrategy.java:315)
at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:180)
at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:515)
at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
at java.base/java.lang.Thread.run(Thread.java:834)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MMapDirectory
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:354)
at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:519)
at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:351)
at org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:422)
at org.apache.solr.handler.ReplicationHandler.lambda$setupPolling$13(ReplicationHandler.java:1208)
at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:515)
at java.base/java.util.concurrent.FutureTask.runAndReset(FutureTask.java:305)
at java.base/java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:305)
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
at java.base/java.lang.Thread.run(Thread.java:834)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.solr.core.SolrCore
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:1072)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:903)
at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1281)
at org.apache.solr.core.CoreContainer.create(CoreContainer.java:1190)
at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:93)
at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:362)
at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:397)
at org.apache.solr.handler.admin.CoreAdminHandler.lambda$handleRequestBody$0(CoreAdminHandler.java:189)
at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:180)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
at java.base/java.lang.Thread.run(Thread.java:834)
>
at __randomizedtesting.SeedInfo.seed([21EA3A52F6A0A7C4]:0)
at org.junit.Assert.fail(Assert.java:88)
at org.junit.Assert.failNotNull(Assert.java:755)
at org.junit.Assert.assertNull(Assert.java:737)
at org.apache.solr.SolrTestCaseJ4.teardownTestCases(SolrTestCaseJ4.java:334)
at jdk.internal.reflect.GeneratedMethodAccessor78.invoke(Unknown Source)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:566)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1754)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:905)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:370)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.lambda$forkTimeoutingTask$0(ThreadLeakControl.java:826)
at java.base/java.lang.Thread.run(Thread.java:834)
Build Log:
[...truncated 14733 lines...]
[junit4] Suite: org.apache.solr.cloud.ShardRoutingTest
[junit4] 2> 4212155 INFO (SUITE-ShardRoutingTest-seed#[21EA3A52F6A0A7C4]-worker) [ ] o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to test-framework derived value of '/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/server/solr/configsets/_default/conf'
[junit4] 2> 4212155 INFO (SUITE-ShardRoutingTest-seed#[21EA3A52F6A0A7C4]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 4212156 INFO (SUITE-ShardRoutingTest-seed#[21EA3A52F6A0A7C4]-worker) [ ] o.a.s.SolrTestCaseJ4 Created dataDir: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.ShardRoutingTest_21EA3A52F6A0A7C4-001/data-dir-168-001
[junit4] 2> 4212156 WARN (SUITE-ShardRoutingTest-seed#[21EA3A52F6A0A7C4]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=10 numCloses=10
[junit4] 2> 4212156 INFO (SUITE-ShardRoutingTest-seed#[21EA3A52F6A0A7C4]-worker) [ ] o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 4212158 INFO (SUITE-ShardRoutingTest-seed#[21EA3A52F6A0A7C4]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason="", value=0.0/0.0, ssl=0.0/0.0, clientAuth=0.0/0.0)
[junit4] 2> 4212159 INFO (SUITE-ShardRoutingTest-seed#[21EA3A52F6A0A7C4]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /
[junit4] 2> 4212172 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 4212172 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer client port: 0.0.0.0/0.0.0.0:0
[junit4] 2> 4212173 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 4212273 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.a.s.c.ZkTestServer start zk server on port: 33613
[junit4] 2> 4212273 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:33613
[junit4] 2> 4212273 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:33613
[junit4] 2> 4212273 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 33613
[junit4] 2> 4212275 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 4212283 INFO (zkConnectionManagerCallback-21004-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 4212283 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 4212286 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 4212287 INFO (zkConnectionManagerCallback-21006-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 4212287 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 4212289 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml to /configs/conf1/solrconfig.xml
[junit4] 2> 4212303 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/schema15.xml to /configs/conf1/schema.xml
[junit4] 2> 4212305 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 4212307 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/stopwords.txt to /configs/conf1/stopwords.txt
[junit4] 2> 4212308 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/protwords.txt to /configs/conf1/protwords.txt
[junit4] 2> 4212310 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/currency.xml to /configs/conf1/currency.xml
[junit4] 2> 4212311 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml to /configs/conf1/enumsConfig.xml
[junit4] 2> 4212313 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json to /configs/conf1/open-exchange-rates.json
[junit4] 2> 4212314 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 4212316 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt to /configs/conf1/old_synonyms.txt
[junit4] 2> 4212317 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/synonyms.txt to /configs/conf1/synonyms.txt
[junit4] 2> 4212319 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 4212348 INFO (zkConnectionManagerCallback-21010-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 4212360 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 4212463 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.a.s.c.AbstractFullDistribZkTestBase Will use NRT replicas unless explicitly asked otherwise
[junit4] 2> 4212966 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 4212966 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 4212966 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git: a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 11.0.4+10-LTS
[junit4] 2> 4212967 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 4212967 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 4212967 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 4212967 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@7a5aa749{/,null,AVAILABLE}
[junit4] 2> 4212968 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@2206df55{ssl, (ssl, alpn, http/1.1, h2)}{127.0.0.1:37273}
[junit4] 2> 4212968 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.e.j.s.Server Started @4213007ms
[junit4] 2> 4212968 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, solr.data.dir=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.ShardRoutingTest_21EA3A52F6A0A7C4-001/tempDir-001/control/data, hostPort=37273, coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.ShardRoutingTest_21EA3A52F6A0A7C4-001/control-001/cores}
[junit4] 2> 4212969 ERROR (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 4212969 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 4212969 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 9.0.0
[junit4] 2> 4212969 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 4212969 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr
[junit4] 2> 4212969 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-05-02T12:37:53.471372Z
[junit4] 2> 4212970 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 4212971 INFO (zkConnectionManagerCallback-21012-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 4212971 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 4213073 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper)
[junit4] 2> 4213073 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.ShardRoutingTest_21EA3A52F6A0A7C4-001/control-001/solr.xml
[junit4] 2> 4213078 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@17c93308, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 4214155 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 4214157 WARN (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@529a30c5[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 4214157 WARN (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@529a30c5[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 4214161 WARN (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@6dde7a3a[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 4214161 WARN (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@6dde7a3a[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 4214163 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:33613/solr
[junit4] 2> 4214164 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 4214165 INFO (zkConnectionManagerCallback-21023-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 4214165 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 4214268 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [n:127.0.0.1:37273_ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 4214269 INFO (zkConnectionManagerCallback-21025-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 4214269 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [n:127.0.0.1:37273_ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 4214404 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [n:127.0.0.1:37273_ ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:37273_
[junit4] 2> 4214405 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [n:127.0.0.1:37273_ ] o.a.s.c.Overseer Overseer (id=72725970028920837-127.0.0.1:37273_-n_0000000000) starting
[junit4] 2> 4214410 INFO (OverseerStateUpdate-72725970028920837-127.0.0.1:37273_-n_0000000000) [n:127.0.0.1:37273_ ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:37273_
[junit4] 2> 4214411 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [n:127.0.0.1:37273_ ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:37273_
[junit4] 2> 4214412 INFO (zkCallback-21024-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 4214414 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [n:127.0.0.1:37273_ ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 4214415 WARN (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [n:127.0.0.1:37273_ ] o.a.s.c.CoreContainer Not all security plugins configured! authentication=disabled authorization=disabled. Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external. See https://s.apache.org/solrsecurity for more info
[junit4] 2> 4214450 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [n:127.0.0.1:37273_ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 4214532 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [n:127.0.0.1:37273_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@17c93308
[junit4] 2> 4214600 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [n:127.0.0.1:37273_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@17c93308
[junit4] 2> 4214600 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [n:127.0.0.1:37273_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@17c93308
[junit4] 2> 4214602 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [n:127.0.0.1:37273_ ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.ShardRoutingTest_21EA3A52F6A0A7C4-001/control-001/cores
[junit4] 2> 4214618 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 4214619 INFO (zkConnectionManagerCallback-21042-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 4214620 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 4214621 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 4214622 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:33613/solr ready
[junit4] 2> 4214694 INFO (qtp1058631310-96655) [n:127.0.0.1:37273_ ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params collection.configName=conf1&name=control_collection&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=127.0.0.1:37273_&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 4214698 INFO (OverseerThreadFactory-21032-thread-1-processing-n:127.0.0.1:37273_) [n:127.0.0.1:37273_ ] o.a.s.c.a.c.CreateCollectionCmd Create collection control_collection
[junit4] 2> 4214833 INFO (qtp1058631310-96654) [n:127.0.0.1:37273_ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=1
[junit4] 2> 4214835 INFO (qtp1058631310-96656) [n:127.0.0.1:37273_ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=0
[junit4] 2> 4214851 INFO (qtp1058631310-96654) [n:127.0.0.1:37273_ x:control_collection_shard1_replica_n1 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=conf1&newCollection=true&name=control_collection_shard1_replica_n1&action=CREATE&numShards=1&collection=control_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 4214851 INFO (qtp1058631310-96654) [n:127.0.0.1:37273_ x:control_collection_shard1_replica_n1 ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 4215885 INFO (qtp1058631310-96654) [n:127.0.0.1:37273_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0
[junit4] 2> 4215906 INFO (qtp1058631310-96654) [n:127.0.0.1:37273_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.s.IndexSchema Schema name=test
[junit4] 2> 4216101 INFO (qtp1058631310-96654) [n:127.0.0.1:37273_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 4216134 INFO (qtp1058631310-96654) [n:127.0.0.1:37273_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.CoreContainer Creating SolrCore 'control_collection_shard1_replica_n1' using configuration from configset conf1, trusted=true
[junit4] 2> 4216135 INFO (qtp1058631310-96654) [n:127.0.0.1:37273_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.control_collection.shard1.replica_n1' (registry 'solr.core.control_collection.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@17c93308
[junit4] 2> 4216138 INFO (qtp1058631310-96654) [n:127.0.0.1:37273_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.SolrCore [[control_collection_shard1_replica_n1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.ShardRoutingTest_21EA3A52F6A0A7C4-001/control-001/cores/control_collection_shard1_replica_n1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.ShardRoutingTest_21EA3A52F6A0A7C4-001/control-001/cores/control_collection_shard1_replica_n1/data/]
[junit4] 2> 4216168 INFO (qtp1058631310-96654) [n:127.0.0.1:37273_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=32, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 4216181 WARN (qtp1058631310-96654) [n:127.0.0.1:37273_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,attributes = {initParams=a, name=/dump, class=DumpRequestHandler},args = {defaults={a=A, b=B}}}
[junit4] 2> 4216337 INFO (qtp1058631310-96654) [n:127.0.0.1:37273_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 4216337 INFO (qtp1058631310-96654) [n:127.0.0.1:37273_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 4216339 INFO (qtp1058631310-96654) [n:127.0.0.1:37273_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 4216339 INFO (qtp1058631310-96654) [n:127.0.0.1:37273_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 4216341 INFO (qtp1058631310-96654) [n:127.0.0.1:37273_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=10, maxMergeAtOnceExplicit=38, maxMergedSegmentMB=62.4326171875, floorSegmentMB=0.4404296875, forceMergeDeletesPctAllowed=0.9519533738061325, segmentsPerTier=49.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.25301174542145755, deletesPctAllowed=49.53624294206415
[junit4] 2> 4216356 INFO (qtp1058631310-96654) [n:127.0.0.1:37273_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.s.SolrIndexSearcher Opening [Searcher@29e2919a[control_collection_shard1_replica_n1] main]
[junit4] 2> 4216366 INFO (qtp1058631310-96654) [n:127.0.0.1:37273_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 4216367 INFO (qtp1058631310-96654) [n:127.0.0.1:37273_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 4216367 INFO (qtp1058631310-96654) [n:127.0.0.1:37273_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 4216368 INFO (qtp1058631310-96654) [n:127.0.0.1:37273_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1665582316252037120
[junit4] 2> 4216371 INFO (searcherExecutor-21044-thread-1-processing-n:127.0.0.1:37273_ x:control_collection_shard1_replica_n1 c:control_collection s:shard1) [n:127.0.0.1:37273_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.SolrCore [control_collection_shard1_replica_n1] Registered new searcher Searcher@29e2919a[control_collection_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 4216374 INFO (qtp1058631310-96654) [n:127.0.0.1:37273_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.ZkShardTerms Successful update of terms at /collections/control_collection/terms/shard1 to Terms{values={core_node2=0}, version=0}
[junit4] 2> 4216374 INFO (qtp1058631310-96654) [n:127.0.0.1:37273_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/control_collection/leaders/shard1
[junit4] 2> 4216378 INFO (qtp1058631310-96654) [n:127.0.0.1:37273_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 4216378 INFO (qtp1058631310-96654) [n:127.0.0.1:37273_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 4216378 INFO (qtp1058631310-96654) [n:127.0.0.1:37273_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync replicas to https://127.0.0.1:37273/control_collection_shard1_replica_n1/
[junit4] 2> 4216378 INFO (qtp1058631310-96654) [n:127.0.0.1:37273_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 4216378 INFO (qtp1058631310-96654) [n:127.0.0.1:37273_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.SyncStrategy https://127.0.0.1:37273/control_collection_shard1_replica_n1/ has no replicas
[junit4] 2> 4216378 INFO (qtp1058631310-96654) [n:127.0.0.1:37273_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/control_collection/leaders/shard1/leader after winning as /collections/control_collection/leader_elect/shard1/election/72725970028920837-core_node2-n_0000000000
[junit4] 2> 4216380 INFO (qtp1058631310-96654) [n:127.0.0.1:37273_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext I am the new leader: https://127.0.0.1:37273/control_collection_shard1_replica_n1/ shard1
[junit4] 2> 4216482 INFO (zkCallback-21024-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/control_collection/state.json] for collection [control_collection] has occurred - updating... (live nodes size: [1])
[junit4] 2> 4216482 INFO (zkCallback-21024-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/control_collection/state.json] for collection [control_collection] has occurred - updating... (live nodes size: [1])
[junit4] 2> 4216483 INFO (qtp1058631310-96654) [n:127.0.0.1:37273_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 4216485 INFO (qtp1058631310-96654) [n:127.0.0.1:37273_ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&collection.configName=conf1&newCollection=true&name=control_collection_shard1_replica_n1&action=CREATE&numShards=1&collection=control_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=1635
[junit4] 2> 4216487 INFO (qtp1058631310-96655) [n:127.0.0.1:37273_ ] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 45 seconds. Check all shard replicas
[junit4] 2> 4216585 INFO (zkCallback-21024-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/control_collection/state.json] for collection [control_collection] has occurred - updating... (live nodes size: [1])
[junit4] 2> 4216585 INFO (zkCallback-21024-thread-3) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/control_collection/state.json] for collection [control_collection] has occurred - updating... (live nodes size: [1])
[junit4] 2> 4216586 INFO (zkCallback-21024-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/control_collection/state.json] for collection [control_collection] has occurred - updating... (live nodes size: [1])
[junit4] 2> 4216586 INFO (qtp1058631310-96655) [n:127.0.0.1:37273_ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={collection.configName=conf1&name=control_collection&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=127.0.0.1:37273_&wt=javabin&version=2} status=0 QTime=1892
[junit4] 2> 4216586 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.a.s.c.AbstractFullDistribZkTestBase Waiting to see 1 active replicas in collection: control_collection
[junit4] 2> 4216692 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 4216696 INFO (zkConnectionManagerCallback-21053-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 4216696 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 4216697 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 4216698 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:33613/solr ready
[junit4] 2> 4216698 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection loss:false
[junit4] 2> 4216700 INFO (OverseerCollectionConfigSetProcessor-72725970028920837-127.0.0.1:37273_-n_0000000000) [n:127.0.0.1:37273_ ] 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> 4216777 INFO (qtp1058631310-96654) [n:127.0.0.1:37273_ ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params collection.configName=conf1&name=collection1&nrtReplicas=1&action=CREATE&numShards=4&createNodeSet=&stateFormat=1&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 4216780 INFO (OverseerThreadFactory-21032-thread-2-processing-n:127.0.0.1:37273_) [n:127.0.0.1:37273_ ] o.a.s.c.a.c.CreateCollectionCmd Create collection collection1
[junit4] 2> 4216984 WARN (OverseerThreadFactory-21032-thread-2-processing-n:127.0.0.1:37273_) [n:127.0.0.1:37273_ ] o.a.s.c.a.c.CreateCollectionCmd It is unusual to create a collection (collection1) without cores.
[junit4] 2> 4216986 INFO (qtp1058631310-96654) [n:127.0.0.1:37273_ ] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 45 seconds. Check all shard replicas
[junit4] 2> 4216987 INFO (qtp1058631310-96654) [n:127.0.0.1:37273_ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={collection.configName=conf1&name=collection1&nrtReplicas=1&action=CREATE&numShards=4&createNodeSet=&stateFormat=1&wt=javabin&version=2} status=0 QTime=209
[junit4] 2> 4216988 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.a.s.c.SolrCloudTestCase active slice count: 4 expected: 4
[junit4] 2> 4216988 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.a.s.c.SolrCloudTestCase active replica count: 0 expected replica count: 0
[junit4] 2> 4216988 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.a.s.c.SolrCloudTestCase active slice count: 4 expected: 4
[junit4] 2> 4216988 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.a.s.c.SolrCloudTestCase active replica count: 0 expected replica count: 0
[junit4] 2> 4216988 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.a.s.c.SolrCloudTestCase active slice count: 4 expected: 4
[junit4] 2> 4216988 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.a.s.c.SolrCloudTestCase active replica count: 0 expected replica count: 0
[junit4] 2> 4216988 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.a.s.c.AbstractFullDistribZkTestBase Creating jetty instances pullReplicaCount=0 numOtherReplicas=8
[junit4] 2> 4217815 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.ShardRoutingTest_21EA3A52F6A0A7C4-001/shard-1-001 of type NRT for shard2
[junit4] 2> 4217819 INFO (closeThreadPool-21054-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 4217819 INFO (closeThreadPool-21054-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 4217819 INFO (closeThreadPool-21054-thread-1) [ ] o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git: a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 11.0.4+10-LTS
[junit4] 2> 4217820 INFO (closeThreadPool-21054-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 4217820 INFO (closeThreadPool-21054-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 4217820 INFO (closeThreadPool-21054-thread-1) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 4217820 INFO (closeThreadPool-21054-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@44faed79{/,null,AVAILABLE}
[junit4] 2> 4217821 INFO (closeThreadPool-21054-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@5254a2ce{ssl, (ssl, alpn, http/1.1, h2)}{127.0.0.1:45418}
[junit4] 2> 4217821 INFO (closeThreadPool-21054-thread-1) [ ] o.e.j.s.Server Started @4217859ms
[junit4] 2> 4217821 INFO (closeThreadPool-21054-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, solrconfig=solrconfig.xml, solr.data.dir=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.ShardRoutingTest_21EA3A52F6A0A7C4-001/tempDir-001/jetty1, hostPort=45418, coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.ShardRoutingTest_21EA3A52F6A0A7C4-001/shard-1-001/cores}
[junit4] 2> 4217821 ERROR (closeThreadPool-21054-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 4217821 INFO (closeThreadPool-21054-thread-1) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 4217821 INFO (closeThreadPool-21054-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 9.0.0
[junit4] 2> 4217822 INFO (closeThreadPool-21054-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 4217822 INFO (closeThreadPool-21054-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr
[junit4] 2> 4217822 INFO (closeThreadPool-21054-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-05-02T12:37:58.324039Z
[junit4] 2> 4217823 INFO (closeThreadPool-21054-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 4217824 INFO (zkConnectionManagerCallback-21056-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 4217824 INFO (closeThreadPool-21054-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 4218021 INFO (closeThreadPool-21054-thread-1) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper)
[junit4] 2> 4218021 INFO (closeThreadPool-21054-thread-1) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.ShardRoutingTest_21EA3A52F6A0A7C4-001/shard-1-001/solr.xml
[junit4] 2> 4218043 INFO (closeThreadPool-21054-thread-1) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@17c93308, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 4218783 INFO (OverseerCollectionConfigSetProcessor-72725970028920837-127.0.0.1:37273_-n_0000000000) [n:127.0.0.1:37273_ ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000002 doesn't exist. Requestor may have disconnected from ZooKeeper
[junit4] 2> 4219827 INFO (TEST-ShardRoutingTest.test-seed#[21EA3A52F6A0A7C4]) [ ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 2 in directory /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.ShardRoutingTest_21EA3A52F6A0A7C4-001/shard-2-001 of type NRT for shard3
[junit4] 2> 4219846 INFO (closeThreadPool-21054-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 4219846 INFO (closeThreadPool-21054-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 4219846 INFO (closeThreadPool-21054-thread-2) [ ] o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git: a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 11.0.4+10-LTS
[junit4] 2> 4220023 INFO (closeThreadPool-21054-thread-2) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 4220023 INFO (closeThreadPool-21054-thread-2) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 4220023 INFO (closeThreadPool-21054-thread-2) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 4220023 INFO (closeThreadPool-21054-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@579ea46{/,null,AVAILABLE}
[junit4] 2> 4220044 INFO (closeThreadPool-21054-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@3d5a7cc{ssl, (ssl, alpn, http/1.1, h2)}{127.0.0.1:43093}
[junit4] 2> 4220044 INFO (closeThreadPool-21054-thread-2) [ ] o.e.j.s.Server Started @4220082ms
[junit4] 2> 4220044 INFO (closeThreadPool-21054-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, solrconfig=solrconfig.xml, solr.data.dir=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Nightly
[...truncated too long message...]
m.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:180)
[junit4] > at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:515)
[junit4] > at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
[junit4] > at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
[junit4] > at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
[junit4] > at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
[junit4] > at java.base/java.lang.Thread.run(Thread.java:834)
[junit4] > org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MMapDirectory
[junit4] > at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
[junit4] > at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:354)
[junit4] > at org.apache.solr.core.SolrCore.getNewIndexDir(SolrCore.java:391)
[junit4] > at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:767)
[junit4] > at org.apache.solr.core.SolrCore.<init>(SolrCore.java:985)
[junit4] > at org.apache.solr.core.SolrCore.<init>(SolrCore.java:903)
[junit4] > at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1281)
[junit4] > at org.apache.solr.core.CoreContainer.create(CoreContainer.java:1190)
[junit4] > at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:93)
[junit4] > at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:362)
[junit4] > at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:397)
[junit4] > at org.apache.solr.handler.admin.CoreAdminHandler.lambda$handleRequestBody$0(CoreAdminHandler.java:189)
[junit4] > at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:180)
[junit4] > at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
[junit4] > at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
[junit4] > at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
[junit4] > at java.base/java.lang.Thread.run(Thread.java:834)
[junit4] > org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MMapDirectory
[junit4] > at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
[junit4] > at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:354)
[junit4] > at org.apache.solr.core.SolrCore.initSnapshotMetaDataManager(SolrCore.java:539)
[junit4] > at org.apache.solr.core.SolrCore.<init>(SolrCore.java:977)
[junit4] > at org.apache.solr.core.SolrCore.<init>(SolrCore.java:903)
[junit4] > at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1281)
[junit4] > at org.apache.solr.core.CoreContainer.create(CoreContainer.java:1190)
[junit4] > at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:93)
[junit4] > at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:362)
[junit4] > at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:397)
[junit4] > at org.apache.solr.handler.admin.CoreAdminHandler.lambda$handleRequestBody$0(CoreAdminHandler.java:189)
[junit4] > at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:180)
[junit4] > at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
[junit4] > at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
[junit4] > at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
[junit4] > at java.base/java.lang.Thread.run(Thread.java:834)
[junit4] > org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.http.impl.client.InternalHttpClient
[junit4] > at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
[junit4] > at org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:339)
[junit4] > at org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:348)
[junit4] > at org.apache.solr.handler.IndexFetcher.createHttpClient(IndexFetcher.java:230)
[junit4] > at org.apache.solr.handler.IndexFetcher.<init>(IndexFetcher.java:272)
[junit4] > at org.apache.solr.handler.ReplicationHandler.inform(ReplicationHandler.java:1239)
[junit4] > at org.apache.solr.cloud.ReplicateFromLeader.startReplication(ReplicateFromLeader.java:109)
[junit4] > at org.apache.solr.cloud.ZkController.startReplicationFromLeader(ZkController.java:1327)
[junit4] > at org.apache.solr.cloud.RecoveryStrategy.doReplicateOnlyRecovery(RecoveryStrategy.java:412)
[junit4] > at org.apache.solr.cloud.RecoveryStrategy.doRecovery(RecoveryStrategy.java:334)
[junit4] > at org.apache.solr.cloud.RecoveryStrategy.run(RecoveryStrategy.java:315)
[junit4] > at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:180)
[junit4] > at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:515)
[junit4] > at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
[junit4] > at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
[junit4] > at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
[junit4] > at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
[junit4] > at java.base/java.lang.Thread.run(Thread.java:834)
[junit4] > org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MMapDirectory
[junit4] > at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
[junit4] > at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:354)
[junit4] > at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:519)
[junit4] > at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:351)
[junit4] > at org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:422)
[junit4] > at org.apache.solr.handler.ReplicationHandler.lambda$setupPolling$13(ReplicationHandler.java:1208)
[junit4] > at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:515)
[junit4] > at java.base/java.util.concurrent.FutureTask.runAndReset(FutureTask.java:305)
[junit4] > at java.base/java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:305)
[junit4] > at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
[junit4] > at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
[junit4] > at java.base/java.lang.Thread.run(Thread.java:834)
[junit4] > org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.solr.core.SolrCore
[junit4] > at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
[junit4] > at org.apache.solr.core.SolrCore.<init>(SolrCore.java:1072)
[junit4] > at org.apache.solr.core.SolrCore.<init>(SolrCore.java:903)
[junit4] > at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1281)
[junit4] > at org.apache.solr.core.CoreContainer.create(CoreContainer.java:1190)
[junit4] > at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:93)
[junit4] > at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:362)
[junit4] > at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:397)
[junit4] > at org.apache.solr.handler.admin.CoreAdminHandler.lambda$handleRequestBody$0(CoreAdminHandler.java:189)
[junit4] > at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:180)
[junit4] > at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
[junit4] > at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
[junit4] > at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
[junit4] > at java.base/java.lang.Thread.run(Thread.java:834)
[junit4] > >
[junit4] > at __randomizedtesting.SeedInfo.seed([21EA3A52F6A0A7C4]:0)
[junit4] > at org.apache.solr.SolrTestCaseJ4.teardownTestCases(SolrTestCaseJ4.java:334)
[junit4] > at jdk.internal.reflect.GeneratedMethodAccessor78.invoke(Unknown Source)
[junit4] > at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4] > at java.base/java.lang.reflect.Method.invoke(Method.java:566)
[junit4] > at java.base/java.lang.Thread.run(Thread.java:834)
[junit4] Completed [553/911 (2!)] on J1 in 102.74s, 2 tests, 1 failure <<< FAILURES!
[...truncated 53883 lines...]
[JENKINS] Lucene-Solr-NightlyTests-master - Build # 2179 - Failure
Posted by Apache Jenkins Server <je...@builds.apache.org>.
Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-master/2179/
No tests ran.
Build Log:
[...truncated 5909 lines...]
ERROR: command execution failed.
ERROR: Step ‘Archive the artifacts’ failed: no workspace for Lucene-Solr-NightlyTests-master #2179
ERROR: Step ‘Publish JUnit test result report’ failed: no workspace for Lucene-Solr-NightlyTests-master #2179
ERROR: lucene2 is offline; cannot locate JDK 11 (latest)
ERROR: lucene2 is offline; cannot locate JDK 11 (latest)
ERROR: lucene2 is offline; cannot locate JDK 11 (latest)
ERROR: lucene2 is offline; cannot locate JDK 11 (latest)
ERROR: lucene2 is offline; cannot locate JDK 11 (latest)
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
ERROR: lucene2 is offline; cannot locate JDK 11 (latest)
ERROR: lucene2 is offline; cannot locate JDK 11 (latest)
ERROR: lucene2 is offline; cannot locate JDK 11 (latest)
ERROR: lucene2 is offline; cannot locate JDK 11 (latest)