You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2017/03/16 20:33:23 UTC
[JENKINS-EA] Lucene-Solr-master-Linux (32bit/jdk-9-ea+160) - Build
# 19186 - Still Unstable!
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/19186/
Java: 32bit/jdk-9-ea+160 -client -XX:+UseG1GC
10 tests failed.
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.SolrCloudExampleTest
Error Message:
ObjectTracker found 6 object(s) that were not released!!! [SolrIndexSearcher, MockDirectoryWrapper, MDCAwareThreadPoolExecutor, MockDirectoryWrapper, TransactionLog, MockDirectoryWrapper] org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.solr.search.SolrIndexSearcher at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.search.SolrIndexSearcher.<init>(SolrIndexSearcher.java:361) at org.apache.solr.core.SolrCore.openNewSearcher(SolrCore.java:2015) at org.apache.solr.core.SolrCore.getSearcher(SolrCore.java:2176) at org.apache.solr.core.SolrCore.initSearcher(SolrCore.java:1073) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:957) at org.apache.solr.core.SolrCore.reload(SolrCore.java:642) at org.apache.solr.core.CoreContainer.reload(CoreContainer.java:1139) at org.apache.solr.core.SolrCore.lambda$getConfListener$16(SolrCore.java:2964) at org.apache.solr.handler.SolrConfigHandler$Command.lambda$handleGET$0(SolrConfigHandler.java:225) at java.base/java.lang.Thread.run(Thread.java:844) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MockDirectoryWrapper at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:347) at org.apache.solr.core.SolrCore.getNewIndexDir(SolrCore.java:353) at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:715) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:931) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:849) at org.apache.solr.core.CoreContainer.create(CoreContainer.java:950) at org.apache.solr.core.CoreContainer.create(CoreContainer.java:886) at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:88) at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:370) at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:388) at org.apache.solr.handler.admin.CoreAdminHandler.handleRequestBody(CoreAdminHandler.java:174) at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:173) at org.apache.solr.servlet.HttpSolrCall.handleAdmin(HttpSolrCall.java:747) at org.apache.solr.servlet.HttpSolrCall.handleAdminRequest(HttpSolrCall.java:728) at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:509) at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:347) at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:298) at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1699) at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:139) at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1699) at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:582) at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:224) at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180) at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512) at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185) at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141) at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:395) at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134) at org.eclipse.jetty.server.Server.handle(Server.java:534) at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:320) at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251) at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:273) at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95) at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93) at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303) at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148) at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671) at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589) at java.base/java.lang.Thread.run(Thread.java:844) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:872) at org.apache.solr.core.SolrCore.reload(SolrCore.java:642) at org.apache.solr.core.CoreContainer.reload(CoreContainer.java:1139) at org.apache.solr.core.SolrCore.lambda$getConfListener$16(SolrCore.java:2964) at org.apache.solr.handler.SolrConfigHandler$Command.lambda$handleGET$0(SolrConfigHandler.java:225) at java.base/java.lang.Thread.run(Thread.java:844) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MockDirectoryWrapper at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:347) at org.apache.solr.core.SolrCore.initSnapshotMetaDataManager(SolrCore.java:484) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:925) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:849) at org.apache.solr.core.CoreContainer.create(CoreContainer.java:950) at org.apache.solr.core.CoreContainer.create(CoreContainer.java:886) at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:88) at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:370) at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:388) at org.apache.solr.handler.admin.CoreAdminHandler.handleRequestBody(CoreAdminHandler.java:174) at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:173) at org.apache.solr.servlet.HttpSolrCall.handleAdmin(HttpSolrCall.java:747) at org.apache.solr.servlet.HttpSolrCall.handleAdminRequest(HttpSolrCall.java:728) at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:509) at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:347) at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:298) at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1699) at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:139) at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1699) at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:582) at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:224) at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180) at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512) at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185) at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141) at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:395) at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134) at org.eclipse.jetty.server.Server.handle(Server.java:534) at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:320) at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251) at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:273) at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95) at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93) at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303) at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148) at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671) at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589) at java.base/java.lang.Thread.run(Thread.java:844) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.solr.update.TransactionLog at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.update.TransactionLog.<init>(TransactionLog.java:190) at org.apache.solr.update.UpdateLog.newTransactionLog(UpdateLog.java:438) at org.apache.solr.update.UpdateLog.ensureLog(UpdateLog.java:1253) at org.apache.solr.update.UpdateLog.add(UpdateLog.java:524) at org.apache.solr.update.UpdateLog.add(UpdateLog.java:509) at org.apache.solr.update.DirectUpdateHandler2.doNormalUpdate(DirectUpdateHandler2.java:335) at org.apache.solr.update.DirectUpdateHandler2.addDoc0(DirectUpdateHandler2.java:254) at org.apache.solr.update.DirectUpdateHandler2.addDoc(DirectUpdateHandler2.java:204) at org.apache.solr.update.processor.RunUpdateProcessor.processAdd(RunUpdateProcessorFactory.java:67) at org.apache.solr.update.processor.UpdateRequestProcessor.processAdd(UpdateRequestProcessor.java:55) at org.apache.solr.update.processor.DistributedUpdateProcessor.doLocalAdd(DistributedUpdateProcessor.java:992) at org.apache.solr.update.processor.DistributedUpdateProcessor.versionAdd(DistributedUpdateProcessor.java:1208) at org.apache.solr.update.processor.DistributedUpdateProcessor.processAdd(DistributedUpdateProcessor.java:754) at org.apache.solr.update.processor.LogUpdateProcessorFactory$LogUpdateProcessor.processAdd(LogUpdateProcessorFactory.java:103) at org.apache.solr.update.processor.UpdateRequestProcessor.processAdd(UpdateRequestProcessor.java:55) at org.apache.solr.update.processor.AddSchemaFieldsUpdateProcessorFactory$AddSchemaFieldsUpdateProcessor.processAdd(AddSchemaFieldsUpdateProcessorFactory.java:336) at org.apache.solr.update.processor.UpdateRequestProcessor.processAdd(UpdateRequestProcessor.java:55) at org.apache.solr.update.processor.FieldMutatingUpdateProcessor.processAdd(FieldMutatingUpdateProcessor.java:118) at org.apache.solr.update.processor.UpdateRequestProcessor.processAdd(UpdateRequestProcessor.java:55) at org.apache.solr.update.processor.FieldMutatingUpdateProcessor.processAdd(FieldMutatingUpdateProcessor.java:118) at org.apache.solr.update.processor.UpdateRequestProcessor.processAdd(UpdateRequestProcessor.java:55) at org.apache.solr.update.processor.FieldMutatingUpdateProcessor.processAdd(FieldMutatingUpdateProcessor.java:118) at org.apache.solr.update.processor.UpdateRequestProcessor.processAdd(UpdateRequestProcessor.java:55) at org.apache.solr.update.processor.FieldMutatingUpdateProcessor.processAdd(FieldMutatingUpdateProcessor.java:118) at org.apache.solr.update.processor.UpdateRequestProcessor.processAdd(UpdateRequestProcessor.java:55) at org.apache.solr.update.processor.FieldNameMutatingUpdateProcessorFactory$1.processAdd(FieldNameMutatingUpdateProcessorFactory.java:74) at org.apache.solr.update.processor.UpdateRequestProcessor.processAdd(UpdateRequestProcessor.java:55) at org.apache.solr.update.processor.FieldMutatingUpdateProcessor.processAdd(FieldMutatingUpdateProcessor.java:118) at org.apache.solr.update.processor.UpdateRequestProcessor.processAdd(UpdateRequestProcessor.java:55) at org.apache.solr.update.processor.AbstractDefaultValueUpdateProcessorFactory$DefaultValueUpdateProcessor.processAdd(AbstractDefaultValueUpdateProcessorFactory.java:91) at org.apache.solr.handler.loader.XMLLoader.processUpdate(XMLLoader.java:252) at org.apache.solr.handler.loader.XMLLoader.load(XMLLoader.java:179) at org.apache.solr.handler.UpdateRequestHandler$1.load(UpdateRequestHandler.java:97) at org.apache.solr.handler.ContentStreamHandlerBase.handleRequestBody(ContentStreamHandlerBase.java:68) at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:173) at org.apache.solr.core.SolrCore.execute(SolrCore.java:2464) at org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:722) at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:528) at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:347) at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:298) at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1699) at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:139) at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1699) at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:582) at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:224) at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180) at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512) at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185) at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141) at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:395) at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134) at org.eclipse.jetty.server.Server.handle(Server.java:534) at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:320) at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251) at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:273) at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95) at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93) at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303) at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148) at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671) at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589) at java.base/java.lang.Thread.run(Thread.java:844) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MockDirectoryWrapper at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:347) at org.apache.solr.update.SolrIndexWriter.create(SolrIndexWriter.java:92) at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:747) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:931) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:849) at org.apache.solr.core.CoreContainer.create(CoreContainer.java:950) at org.apache.solr.core.CoreContainer.create(CoreContainer.java:886) at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:88) at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:370) at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:388) at org.apache.solr.handler.admin.CoreAdminHandler.handleRequestBody(CoreAdminHandler.java:174) at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:173) at org.apache.solr.servlet.HttpSolrCall.handleAdmin(HttpSolrCall.java:747) at org.apache.solr.servlet.HttpSolrCall.handleAdminRequest(HttpSolrCall.java:728) at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:509) at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:347) at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:298) at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1699) at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:139) at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1699) at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:582) at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:224) at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180) at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512) at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185) at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141) at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:395) at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134) at org.eclipse.jetty.server.Server.handle(Server.java:534) at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:320) at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251) at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:273) at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95) at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93) at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303) at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148) at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671) at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589) at java.base/java.lang.Thread.run(Thread.java:844)
Stack Trace:
java.lang.AssertionError: ObjectTracker found 6 object(s) that were not released!!! [SolrIndexSearcher, MockDirectoryWrapper, MDCAwareThreadPoolExecutor, MockDirectoryWrapper, TransactionLog, MockDirectoryWrapper]
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.solr.search.SolrIndexSearcher
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.search.SolrIndexSearcher.<init>(SolrIndexSearcher.java:361)
at org.apache.solr.core.SolrCore.openNewSearcher(SolrCore.java:2015)
at org.apache.solr.core.SolrCore.getSearcher(SolrCore.java:2176)
at org.apache.solr.core.SolrCore.initSearcher(SolrCore.java:1073)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:957)
at org.apache.solr.core.SolrCore.reload(SolrCore.java:642)
at org.apache.solr.core.CoreContainer.reload(CoreContainer.java:1139)
at org.apache.solr.core.SolrCore.lambda$getConfListener$16(SolrCore.java:2964)
at org.apache.solr.handler.SolrConfigHandler$Command.lambda$handleGET$0(SolrConfigHandler.java:225)
at java.base/java.lang.Thread.run(Thread.java:844)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MockDirectoryWrapper
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:347)
at org.apache.solr.core.SolrCore.getNewIndexDir(SolrCore.java:353)
at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:715)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:931)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:849)
at org.apache.solr.core.CoreContainer.create(CoreContainer.java:950)
at org.apache.solr.core.CoreContainer.create(CoreContainer.java:886)
at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:88)
at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:370)
at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:388)
at org.apache.solr.handler.admin.CoreAdminHandler.handleRequestBody(CoreAdminHandler.java:174)
at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:173)
at org.apache.solr.servlet.HttpSolrCall.handleAdmin(HttpSolrCall.java:747)
at org.apache.solr.servlet.HttpSolrCall.handleAdminRequest(HttpSolrCall.java:728)
at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:509)
at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:347)
at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:298)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1699)
at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:139)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1699)
at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:582)
at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:224)
at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180)
at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512)
at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112)
at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:395)
at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134)
at org.eclipse.jetty.server.Server.handle(Server.java:534)
at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:320)
at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251)
at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:273)
at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93)
at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303)
at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148)
at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136)
at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671)
at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589)
at java.base/java.lang.Thread.run(Thread.java:844)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:872)
at org.apache.solr.core.SolrCore.reload(SolrCore.java:642)
at org.apache.solr.core.CoreContainer.reload(CoreContainer.java:1139)
at org.apache.solr.core.SolrCore.lambda$getConfListener$16(SolrCore.java:2964)
at org.apache.solr.handler.SolrConfigHandler$Command.lambda$handleGET$0(SolrConfigHandler.java:225)
at java.base/java.lang.Thread.run(Thread.java:844)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MockDirectoryWrapper
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:347)
at org.apache.solr.core.SolrCore.initSnapshotMetaDataManager(SolrCore.java:484)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:925)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:849)
at org.apache.solr.core.CoreContainer.create(CoreContainer.java:950)
at org.apache.solr.core.CoreContainer.create(CoreContainer.java:886)
at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:88)
at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:370)
at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:388)
at org.apache.solr.handler.admin.CoreAdminHandler.handleRequestBody(CoreAdminHandler.java:174)
at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:173)
at org.apache.solr.servlet.HttpSolrCall.handleAdmin(HttpSolrCall.java:747)
at org.apache.solr.servlet.HttpSolrCall.handleAdminRequest(HttpSolrCall.java:728)
at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:509)
at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:347)
at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:298)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1699)
at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:139)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1699)
at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:582)
at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:224)
at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180)
at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512)
at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112)
at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:395)
at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134)
at org.eclipse.jetty.server.Server.handle(Server.java:534)
at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:320)
at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251)
at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:273)
at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93)
at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303)
at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148)
at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136)
at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671)
at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589)
at java.base/java.lang.Thread.run(Thread.java:844)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.solr.update.TransactionLog
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.update.TransactionLog.<init>(TransactionLog.java:190)
at org.apache.solr.update.UpdateLog.newTransactionLog(UpdateLog.java:438)
at org.apache.solr.update.UpdateLog.ensureLog(UpdateLog.java:1253)
at org.apache.solr.update.UpdateLog.add(UpdateLog.java:524)
at org.apache.solr.update.UpdateLog.add(UpdateLog.java:509)
at org.apache.solr.update.DirectUpdateHandler2.doNormalUpdate(DirectUpdateHandler2.java:335)
at org.apache.solr.update.DirectUpdateHandler2.addDoc0(DirectUpdateHandler2.java:254)
at org.apache.solr.update.DirectUpdateHandler2.addDoc(DirectUpdateHandler2.java:204)
at org.apache.solr.update.processor.RunUpdateProcessor.processAdd(RunUpdateProcessorFactory.java:67)
at org.apache.solr.update.processor.UpdateRequestProcessor.processAdd(UpdateRequestProcessor.java:55)
at org.apache.solr.update.processor.DistributedUpdateProcessor.doLocalAdd(DistributedUpdateProcessor.java:992)
at org.apache.solr.update.processor.DistributedUpdateProcessor.versionAdd(DistributedUpdateProcessor.java:1208)
at org.apache.solr.update.processor.DistributedUpdateProcessor.processAdd(DistributedUpdateProcessor.java:754)
at org.apache.solr.update.processor.LogUpdateProcessorFactory$LogUpdateProcessor.processAdd(LogUpdateProcessorFactory.java:103)
at org.apache.solr.update.processor.UpdateRequestProcessor.processAdd(UpdateRequestProcessor.java:55)
at org.apache.solr.update.processor.AddSchemaFieldsUpdateProcessorFactory$AddSchemaFieldsUpdateProcessor.processAdd(AddSchemaFieldsUpdateProcessorFactory.java:336)
at org.apache.solr.update.processor.UpdateRequestProcessor.processAdd(UpdateRequestProcessor.java:55)
at org.apache.solr.update.processor.FieldMutatingUpdateProcessor.processAdd(FieldMutatingUpdateProcessor.java:118)
at org.apache.solr.update.processor.UpdateRequestProcessor.processAdd(UpdateRequestProcessor.java:55)
at org.apache.solr.update.processor.FieldMutatingUpdateProcessor.processAdd(FieldMutatingUpdateProcessor.java:118)
at org.apache.solr.update.processor.UpdateRequestProcessor.processAdd(UpdateRequestProcessor.java:55)
at org.apache.solr.update.processor.FieldMutatingUpdateProcessor.processAdd(FieldMutatingUpdateProcessor.java:118)
at org.apache.solr.update.processor.UpdateRequestProcessor.processAdd(UpdateRequestProcessor.java:55)
at org.apache.solr.update.processor.FieldMutatingUpdateProcessor.processAdd(FieldMutatingUpdateProcessor.java:118)
at org.apache.solr.update.processor.UpdateRequestProcessor.processAdd(UpdateRequestProcessor.java:55)
at org.apache.solr.update.processor.FieldNameMutatingUpdateProcessorFactory$1.processAdd(FieldNameMutatingUpdateProcessorFactory.java:74)
at org.apache.solr.update.processor.UpdateRequestProcessor.processAdd(UpdateRequestProcessor.java:55)
at org.apache.solr.update.processor.FieldMutatingUpdateProcessor.processAdd(FieldMutatingUpdateProcessor.java:118)
at org.apache.solr.update.processor.UpdateRequestProcessor.processAdd(UpdateRequestProcessor.java:55)
at org.apache.solr.update.processor.AbstractDefaultValueUpdateProcessorFactory$DefaultValueUpdateProcessor.processAdd(AbstractDefaultValueUpdateProcessorFactory.java:91)
at org.apache.solr.handler.loader.XMLLoader.processUpdate(XMLLoader.java:252)
at org.apache.solr.handler.loader.XMLLoader.load(XMLLoader.java:179)
at org.apache.solr.handler.UpdateRequestHandler$1.load(UpdateRequestHandler.java:97)
at org.apache.solr.handler.ContentStreamHandlerBase.handleRequestBody(ContentStreamHandlerBase.java:68)
at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:173)
at org.apache.solr.core.SolrCore.execute(SolrCore.java:2464)
at org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:722)
at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:528)
at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:347)
at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:298)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1699)
at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:139)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1699)
at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:582)
at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:224)
at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180)
at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512)
at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112)
at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:395)
at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134)
at org.eclipse.jetty.server.Server.handle(Server.java:534)
at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:320)
at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251)
at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:273)
at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93)
at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303)
at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148)
at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136)
at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671)
at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589)
at java.base/java.lang.Thread.run(Thread.java:844)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MockDirectoryWrapper
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:347)
at org.apache.solr.update.SolrIndexWriter.create(SolrIndexWriter.java:92)
at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:747)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:931)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:849)
at org.apache.solr.core.CoreContainer.create(CoreContainer.java:950)
at org.apache.solr.core.CoreContainer.create(CoreContainer.java:886)
at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:88)
at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:370)
at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:388)
at org.apache.solr.handler.admin.CoreAdminHandler.handleRequestBody(CoreAdminHandler.java:174)
at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:173)
at org.apache.solr.servlet.HttpSolrCall.handleAdmin(HttpSolrCall.java:747)
at org.apache.solr.servlet.HttpSolrCall.handleAdminRequest(HttpSolrCall.java:728)
at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:509)
at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:347)
at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:298)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1699)
at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:139)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1699)
at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:582)
at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:224)
at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180)
at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512)
at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112)
at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:395)
at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134)
at org.eclipse.jetty.server.Server.handle(Server.java:534)
at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:320)
at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251)
at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:273)
at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93)
at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303)
at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148)
at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136)
at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671)
at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589)
at java.base/java.lang.Thread.run(Thread.java:844)
at __randomizedtesting.SeedInfo.seed([C776CFFE6FD191FC]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.junit.Assert.assertNull(Assert.java:551)
at org.apache.solr.SolrTestCaseJ4.teardownTestCases(SolrTestCaseJ4.java:301)
at jdk.internal.reflect.GeneratedMethodAccessor39.invoke(Unknown Source)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:547)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:870)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:844)
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.SolrCloudExampleTest
Error Message:
1 thread leaked from SUITE scope at org.apache.solr.cloud.SolrCloudExampleTest: 1) Thread[id=3399, name=searcherExecutor-1539-thread-1, state=WAITING, group=TGRP-SolrCloudExampleTest] at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) at java.base@9-ea/java.util.concurrent.locks.LockSupport.park(LockSupport.java:192) at java.base@9-ea/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2062) at java.base@9-ea/java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:435) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1086) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1146) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) at java.base@9-ea/java.lang.Thread.run(Thread.java:844)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE scope at org.apache.solr.cloud.SolrCloudExampleTest:
1) Thread[id=3399, name=searcherExecutor-1539-thread-1, state=WAITING, group=TGRP-SolrCloudExampleTest]
at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method)
at java.base@9-ea/java.util.concurrent.locks.LockSupport.park(LockSupport.java:192)
at java.base@9-ea/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2062)
at java.base@9-ea/java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:435)
at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1086)
at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1146)
at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635)
at java.base@9-ea/java.lang.Thread.run(Thread.java:844)
at __randomizedtesting.SeedInfo.seed([C776CFFE6FD191FC]:0)
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.SolrCloudExampleTest
Error Message:
There are still zombie threads that couldn't be terminated: 1) Thread[id=3399, name=searcherExecutor-1539-thread-1, state=WAITING, group=TGRP-SolrCloudExampleTest] at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) at java.base@9-ea/java.util.concurrent.locks.LockSupport.park(LockSupport.java:192) at java.base@9-ea/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2062) at java.base@9-ea/java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:435) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1086) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1146) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) at java.base@9-ea/java.lang.Thread.run(Thread.java:844)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie threads that couldn't be terminated:
1) Thread[id=3399, name=searcherExecutor-1539-thread-1, state=WAITING, group=TGRP-SolrCloudExampleTest]
at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method)
at java.base@9-ea/java.util.concurrent.locks.LockSupport.park(LockSupport.java:192)
at java.base@9-ea/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2062)
at java.base@9-ea/java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:435)
at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1086)
at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1146)
at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635)
at java.base@9-ea/java.lang.Thread.run(Thread.java:844)
at __randomizedtesting.SeedInfo.seed([C776CFFE6FD191FC]:0)
FAILED: org.apache.solr.client.solrj.SolrExampleBinaryTest.testUpdateField
Error Message:
Error from server at http://127.0.0.1:42472/solr/collection1: Exception writing document id unique to the index; possible analysis error: DocValuesField "price_pf" appears more than once in this document (only one value is allowed per field)
Stack Trace:
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:42472/solr/collection1: Exception writing document id unique to the index; possible analysis error: DocValuesField "price_pf" appears more than once in this document (only one value is allowed per field)
at __randomizedtesting.SeedInfo.seed([67D470B159DC58AB:32A7DAE599F4486D]:0)
at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:627)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:279)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:268)
at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:160)
at org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:173)
at org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:138)
at org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:152)
at org.apache.solr.client.solrj.SolrExampleTests.testUpdateField(SolrExampleTests.java:1654)
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:547)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:844)
FAILED: org.apache.solr.client.solrj.SolrExampleXMLTest.testUpdateField
Error Message:
Error from server at http://127.0.0.1:34357/solr/collection1: Exception writing document id unique to the index; possible analysis error: DocValuesField "price_pf" appears more than once in this document (only one value is allowed per field)
Stack Trace:
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:34357/solr/collection1: Exception writing document id unique to the index; possible analysis error: DocValuesField "price_pf" appears more than once in this document (only one value is allowed per field)
at __randomizedtesting.SeedInfo.seed([67D470B159DC58AB:32A7DAE599F4486D]:0)
at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:627)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:279)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:268)
at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:160)
at org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:173)
at org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:138)
at org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:152)
at org.apache.solr.client.solrj.SolrExampleTests.testUpdateField(SolrExampleTests.java:1654)
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:547)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:844)
FAILED: org.apache.solr.client.solrj.embedded.SolrExampleEmbeddedTest.testUpdateField
Error Message:
Exception writing document id unique to the index; possible analysis error: DocValuesField "price_pf" appears more than once in this document (only one value is allowed per field)
Stack Trace:
org.apache.solr.common.SolrException: Exception writing document id unique to the index; possible analysis error: DocValuesField "price_pf" appears more than once in this document (only one value is allowed per field)
at __randomizedtesting.SeedInfo.seed([67D470B159DC58AB:32A7DAE599F4486D]:0)
at org.apache.solr.update.DirectUpdateHandler2.addDoc(DirectUpdateHandler2.java:209)
at org.apache.solr.update.processor.RunUpdateProcessor.processAdd(RunUpdateProcessorFactory.java:67)
at org.apache.solr.update.processor.UpdateRequestProcessor.processAdd(UpdateRequestProcessor.java:55)
at org.apache.solr.update.processor.DistributedUpdateProcessor.doLocalAdd(DistributedUpdateProcessor.java:992)
at org.apache.solr.update.processor.DistributedUpdateProcessor.versionAdd(DistributedUpdateProcessor.java:1208)
at org.apache.solr.update.processor.DistributedUpdateProcessor.processAdd(DistributedUpdateProcessor.java:754)
at org.apache.solr.update.processor.LogUpdateProcessorFactory$LogUpdateProcessor.processAdd(LogUpdateProcessorFactory.java:103)
at org.apache.solr.handler.loader.XMLLoader.processUpdate(XMLLoader.java:252)
at org.apache.solr.handler.loader.XMLLoader.load(XMLLoader.java:179)
at org.apache.solr.handler.UpdateRequestHandler$1.load(UpdateRequestHandler.java:97)
at org.apache.solr.handler.ContentStreamHandlerBase.handleRequestBody(ContentStreamHandlerBase.java:68)
at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:173)
at org.apache.solr.core.SolrCore.execute(SolrCore.java:2464)
at org.apache.solr.client.solrj.embedded.EmbeddedSolrServer.request(EmbeddedSolrServer.java:179)
at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:160)
at org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:173)
at org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:138)
at org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:152)
at org.apache.solr.client.solrj.SolrExampleTests.testUpdateField(SolrExampleTests.java:1654)
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:547)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:844)
Caused by: java.lang.IllegalArgumentException: DocValuesField "price_pf" appears more than once in this document (only one value is allowed per field)
at org.apache.lucene.index.NumericDocValuesWriter.addValue(NumericDocValuesWriter.java:55)
at org.apache.lucene.index.DefaultIndexingChain.indexDocValue(DefaultIndexingChain.java:537)
at org.apache.lucene.index.DefaultIndexingChain.processField(DefaultIndexingChain.java:467)
at org.apache.lucene.index.DefaultIndexingChain.processDocument(DefaultIndexingChain.java:393)
at org.apache.lucene.index.DocumentsWriterPerThread.updateDocument(DocumentsWriterPerThread.java:232)
at org.apache.lucene.index.DocumentsWriter.updateDocument(DocumentsWriter.java:478)
at org.apache.lucene.index.IndexWriter.updateDocument(IndexWriter.java:1569)
at org.apache.solr.update.DirectUpdateHandler2.updateDocument(DirectUpdateHandler2.java:948)
at org.apache.solr.update.DirectUpdateHandler2.updateDocOrDocValues(DirectUpdateHandler2.java:937)
at org.apache.solr.update.DirectUpdateHandler2.doNormalUpdate(DirectUpdateHandler2.java:317)
at org.apache.solr.update.DirectUpdateHandler2.addDoc0(DirectUpdateHandler2.java:254)
at org.apache.solr.update.DirectUpdateHandler2.addDoc(DirectUpdateHandler2.java:204)
... 56 more
FAILED: org.apache.solr.client.solrj.embedded.SolrExampleJettyTest.testUpdateField
Error Message:
Error from server at http://127.0.0.1:45907/solr/collection1: Exception writing document id unique to the index; possible analysis error: DocValuesField "price_pf" appears more than once in this document (only one value is allowed per field)
Stack Trace:
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:45907/solr/collection1: Exception writing document id unique to the index; possible analysis error: DocValuesField "price_pf" appears more than once in this document (only one value is allowed per field)
at __randomizedtesting.SeedInfo.seed([67D470B159DC58AB:32A7DAE599F4486D]:0)
at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:627)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:279)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:268)
at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:160)
at org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:173)
at org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:138)
at org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:152)
at org.apache.solr.client.solrj.SolrExampleTests.testUpdateField(SolrExampleTests.java:1654)
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:547)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:844)
FAILED: org.apache.solr.client.solrj.embedded.SolrExampleStreamingBinaryTest.testUpdateField
Error Message:
price was not updated? expected:<100.0> but was:<1.0>
Stack Trace:
java.lang.AssertionError: price was not updated? expected:<100.0> but was:<1.0>
at __randomizedtesting.SeedInfo.seed([67D470B159DC58AB:32A7DAE599F4486D]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.failNotEquals(Assert.java:647)
at org.junit.Assert.assertEquals(Assert.java:128)
at org.apache.solr.client.solrj.SolrExampleTests.testUpdateField(SolrExampleTests.java:1658)
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:547)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:844)
FAILED: org.apache.solr.client.solrj.embedded.SolrExampleStreamingTest.testUpdateField
Error Message:
price was not updated? expected:<100.0> but was:<1.0>
Stack Trace:
java.lang.AssertionError: price was not updated? expected:<100.0> but was:<1.0>
at __randomizedtesting.SeedInfo.seed([67D470B159DC58AB:32A7DAE599F4486D]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.failNotEquals(Assert.java:647)
at org.junit.Assert.assertEquals(Assert.java:128)
at org.apache.solr.client.solrj.SolrExampleTests.testUpdateField(SolrExampleTests.java:1658)
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:547)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:844)
FAILED: org.apache.solr.update.TestInPlaceUpdatesDistrib.test
Error Message:
Earlier: [13153, 13153, 13153], now: [13153, -1, 13153]
Stack Trace:
java.lang.AssertionError: Earlier: [13153, 13153, 13153], now: [13153, -1, 13153]
at __randomizedtesting.SeedInfo.seed([C776CFFE6FD191FC:4F22F024C12DFC04]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.apache.solr.update.TestInPlaceUpdatesDistrib.ensureRtgWorksWithPartialUpdatesTest(TestInPlaceUpdatesDistrib.java:533)
at org.apache.solr.update.TestInPlaceUpdatesDistrib.test(TestInPlaceUpdatesDistrib.java:161)
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:547)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:985)
at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:960)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:844)
Build Log:
[...truncated 11206 lines...]
[junit4] Suite: org.apache.solr.update.TestInPlaceUpdatesDistrib
[junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.update.TestInPlaceUpdatesDistrib_C776CFFE6FD191FC-001/init-core-data-001
[junit4] 2> 305156 WARN (SUITE-TestInPlaceUpdatesDistrib-seed#[C776CFFE6FD191FC]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=76 numCloses=76
[junit4] 2> 305157 INFO (SUITE-TestInPlaceUpdatesDistrib-seed#[C776CFFE6FD191FC]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields
[junit4] 2> 305158 INFO (SUITE-TestInPlaceUpdatesDistrib-seed#[C776CFFE6FD191FC]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason="", ssl=0.0/0.0, value=0.0/0.0, clientAuth=0.0/0.0)
[junit4] 2> 305158 INFO (SUITE-TestInPlaceUpdatesDistrib-seed#[C776CFFE6FD191FC]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /
[junit4] 2> 305159 INFO (SUITE-TestInPlaceUpdatesDistrib-seed#[C776CFFE6FD191FC]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 305161 INFO (SUITE-TestInPlaceUpdatesDistrib-seed#[C776CFFE6FD191FC]-worker) [ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 305243 INFO (SUITE-TestInPlaceUpdatesDistrib-seed#[C776CFFE6FD191FC]-worker) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 305251 INFO (SUITE-TestInPlaceUpdatesDistrib-seed#[C776CFFE6FD191FC]-worker) [ ] o.a.s.s.IndexSchema [null] Schema name=inplace-updates
[junit4] 2> 305253 INFO (SUITE-TestInPlaceUpdatesDistrib-seed#[C776CFFE6FD191FC]-worker) [ ] o.a.s.s.IndexSchema Loaded schema inplace-updates/1.6 with uniqueid field id
[junit4] 2> 305403 WARN (SUITE-TestInPlaceUpdatesDistrib-seed#[C776CFFE6FD191FC]-worker) [ ] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first MBeanServer.
[junit4] 2> 305408 INFO (SUITE-TestInPlaceUpdatesDistrib-seed#[C776CFFE6FD191FC]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1a3b313
[junit4] 2> 305408 WARN (SUITE-TestInPlaceUpdatesDistrib-seed#[C776CFFE6FD191FC]-worker) [ ] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first MBeanServer.
[junit4] 2> 305415 INFO (SUITE-TestInPlaceUpdatesDistrib-seed#[C776CFFE6FD191FC]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1a3b313
[junit4] 2> 305415 WARN (SUITE-TestInPlaceUpdatesDistrib-seed#[C776CFFE6FD191FC]-worker) [ ] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first MBeanServer.
[junit4] 2> 305415 INFO (SUITE-TestInPlaceUpdatesDistrib-seed#[C776CFFE6FD191FC]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1a3b313
[junit4] 2> 305419 INFO (coreLoadExecutor-1526-thread-1) [ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 305528 INFO (coreLoadExecutor-1526-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 305536 INFO (coreLoadExecutor-1526-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=inplace-updates
[junit4] 2> 305538 INFO (coreLoadExecutor-1526-thread-1) [ ] o.a.s.s.IndexSchema Loaded schema inplace-updates/1.6 with uniqueid field id
[junit4] 2> 305541 INFO (coreLoadExecutor-1526-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1
[junit4] 2> 305541 WARN (coreLoadExecutor-1526-thread-1) [ ] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first MBeanServer.
[junit4] 2> 305542 INFO (coreLoadExecutor-1526-thread-1) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1a3b313
[junit4] 2> 305542 INFO (coreLoadExecutor-1526-thread-1) [ ] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 305542 INFO (coreLoadExecutor-1526-thread-1) [ ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.update.TestInPlaceUpdatesDistrib_C776CFFE6FD191FC-001/init-core-data-001/]
[junit4] 2> 305542 INFO (coreLoadExecutor-1526-thread-1) [ ] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@1a3b313
[junit4] 2> 305549 WARN (coreLoadExecutor-1526-thread-1) [ ] 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> 305740 INFO (coreLoadExecutor-1526-thread-1) [ ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 305740 INFO (coreLoadExecutor-1526-thread-1) [ ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 305741 INFO (coreLoadExecutor-1526-thread-1) [ ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 305741 INFO (coreLoadExecutor-1526-thread-1) [ ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 305742 INFO (coreLoadExecutor-1526-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@18e174d[collection1] main]
[junit4] 2> 305742 WARN (coreLoadExecutor-1526-thread-1) [ ] o.a.s.r.ManagedResourceStorage Cannot write to config directory /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
[junit4] 2> 305743 INFO (coreLoadExecutor-1526-thread-1) [ ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 305743 INFO (searcherExecutor-1527-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@18e174d[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 305744 INFO (coreLoadExecutor-1526-thread-1) [ ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1562058406190120960
[junit4] 2> 305746 INFO (SUITE-TestInPlaceUpdatesDistrib-seed#[C776CFFE6FD191FC]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 305748 INFO (TEST-TestInPlaceUpdatesDistrib.test-seed#[C776CFFE6FD191FC]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 305748 INFO (Thread-670) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 305748 INFO (Thread-670) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 305848 INFO (TEST-TestInPlaceUpdatesDistrib.test-seed#[C776CFFE6FD191FC]) [ ] o.a.s.c.ZkTestServer start zk server on port:46039
[junit4] 2> 305856 INFO (TEST-TestInPlaceUpdatesDistrib.test-seed#[C776CFFE6FD191FC]) [ ] o.a.s.c.AbstractZkTestCase put /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml to /configs/conf1/solrconfig.xml
[junit4] 2> 305860 INFO (TEST-TestInPlaceUpdatesDistrib.test-seed#[C776CFFE6FD191FC]) [ ] o.a.s.c.AbstractZkTestCase put /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf/schema-inplace-updates.xml to /configs/conf1/schema.xml
[junit4] 2> 305862 INFO (TEST-TestInPlaceUpdatesDistrib.test-seed#[C776CFFE6FD191FC]) [ ] o.a.s.c.AbstractZkTestCase put /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 305865 INFO (TEST-TestInPlaceUpdatesDistrib.test-seed#[C776CFFE6FD191FC]) [ ] o.a.s.c.AbstractZkTestCase put /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf/stopwords.txt to /configs/conf1/stopwords.txt
[junit4] 2> 305867 INFO (TEST-TestInPlaceUpdatesDistrib.test-seed#[C776CFFE6FD191FC]) [ ] o.a.s.c.AbstractZkTestCase put /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf/protwords.txt to /configs/conf1/protwords.txt
[junit4] 2> 305870 INFO (TEST-TestInPlaceUpdatesDistrib.test-seed#[C776CFFE6FD191FC]) [ ] o.a.s.c.AbstractZkTestCase put /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf/currency.xml to /configs/conf1/currency.xml
[junit4] 2> 305872 INFO (TEST-TestInPlaceUpdatesDistrib.test-seed#[C776CFFE6FD191FC]) [ ] o.a.s.c.AbstractZkTestCase put /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/
[...truncated too long message...]
[junit4] 2> 78019 INFO (qtp538870-873) [ ] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=*:*&fl=id,json_s:[json],xml_s:[xml]&wt=xml&version=2.2} hits=1 status=0 QTime=0
[junit4] 2> 78019 INFO (TEST-SolrExampleJettyTest.testRawFields-seed#[67D470B159DC58AB]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testRawFields
[junit4] 2> 78021 INFO (SUITE-SolrExampleJettyTest-seed#[67D470B159DC58AB]-worker) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@76fb92{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 78021 INFO (SUITE-SolrExampleJettyTest-seed#[67D470B159DC58AB]-worker) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=8572728
[junit4] 2> 78021 INFO (SUITE-SolrExampleJettyTest-seed#[67D470B159DC58AB]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 78022 INFO (coreCloseExecutor-459-thread-1) [ ] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@1d978fe
[junit4] 2> 78024 INFO (coreCloseExecutor-459-thread-1) [ ] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-459-thread-1]: now flush at close
[junit4] 2> 78024 INFO (coreCloseExecutor-459-thread-1) [ ] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-459-thread-1]: start flush: applyAllDeletes=true
[junit4] 2> 78024 INFO (coreCloseExecutor-459-thread-1) [ ] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-459-thread-1]: index before flush _1k(7.0.0):C1
[junit4] 2> 78024 INFO (coreCloseExecutor-459-thread-1) [ ] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-459-thread-1]: startFullFlush
[junit4] 2> 78024 INFO (coreCloseExecutor-459-thread-1) [ ] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-459-thread-1]: coreCloseExecutor-459-thread-1 finishFullFlush success=true
[junit4] 2> 78024 INFO (coreCloseExecutor-459-thread-1) [ ] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-459-thread-1]: apply all deletes during flush
[junit4] 2> 78024 INFO (coreCloseExecutor-459-thread-1) [ ] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-459-thread-1]: now apply all deletes for all segments maxDoc=1
[junit4] 2> 78024 INFO (coreCloseExecutor-459-thread-1) [ ] o.a.s.u.LoggingInfoStream [BD][coreCloseExecutor-459-thread-1]: applyDeletes: open segment readers took 0 msec
[junit4] 2> 78024 INFO (coreCloseExecutor-459-thread-1) [ ] o.a.s.u.LoggingInfoStream [BD][coreCloseExecutor-459-thread-1]: applyDeletes: no segments; skipping
[junit4] 2> 78024 INFO (coreCloseExecutor-459-thread-1) [ ] o.a.s.u.LoggingInfoStream [BD][coreCloseExecutor-459-thread-1]: prune sis=segments_28: _1k(7.0.0):C1 minGen=363 packetCount=0
[junit4] 2> 78024 INFO (coreCloseExecutor-459-thread-1) [ ] o.a.s.u.LoggingInfoStream [MS][coreCloseExecutor-459-thread-1]: updateMergeThreads ioThrottle=true targetMBPerSec=10240.0 MB/sec
[junit4] 2> 78024 INFO (coreCloseExecutor-459-thread-1) [ ] o.a.s.u.LoggingInfoStream [MS][coreCloseExecutor-459-thread-1]: now merge
[junit4] 2> 78024 INFO (coreCloseExecutor-459-thread-1) [ ] o.a.s.u.LoggingInfoStream [MS][coreCloseExecutor-459-thread-1]: index: _1k(7.0.0):C1
[junit4] 2> 78024 INFO (coreCloseExecutor-459-thread-1) [ ] o.a.s.u.LoggingInfoStream [MS][coreCloseExecutor-459-thread-1]: no more merges pending; now return
[junit4] 2> 78024 INFO (coreCloseExecutor-459-thread-1) [ ] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-459-thread-1]: waitForMerges
[junit4] 2> 78024 INFO (coreCloseExecutor-459-thread-1) [ ] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-459-thread-1]: waitForMerges done
[junit4] 2> 78024 INFO (coreCloseExecutor-459-thread-1) [ ] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-459-thread-1]: commit: start
[junit4] 2> 78024 INFO (coreCloseExecutor-459-thread-1) [ ] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-459-thread-1]: commit: enter lock
[junit4] 2> 78025 INFO (coreCloseExecutor-459-thread-1) [ ] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-459-thread-1]: commit: now prepare
[junit4] 2> 78025 INFO (coreCloseExecutor-459-thread-1) [ ] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-459-thread-1]: prepareCommit: flush
[junit4] 2> 78025 INFO (coreCloseExecutor-459-thread-1) [ ] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-459-thread-1]: index before flush _1k(7.0.0):C1
[junit4] 2> 78025 INFO (coreCloseExecutor-459-thread-1) [ ] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-459-thread-1]: startFullFlush
[junit4] 2> 78025 INFO (coreCloseExecutor-459-thread-1) [ ] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-459-thread-1]: apply all deletes during flush
[junit4] 2> 78025 INFO (coreCloseExecutor-459-thread-1) [ ] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-459-thread-1]: now apply all deletes for all segments maxDoc=1
[junit4] 2> 78025 INFO (coreCloseExecutor-459-thread-1) [ ] o.a.s.u.LoggingInfoStream [BD][coreCloseExecutor-459-thread-1]: applyDeletes: open segment readers took 0 msec
[junit4] 2> 78025 INFO (coreCloseExecutor-459-thread-1) [ ] o.a.s.u.LoggingInfoStream [BD][coreCloseExecutor-459-thread-1]: applyDeletes: no segments; skipping
[junit4] 2> 78025 INFO (coreCloseExecutor-459-thread-1) [ ] o.a.s.u.LoggingInfoStream [BD][coreCloseExecutor-459-thread-1]: prune sis=segments_28: _1k(7.0.0):C1 minGen=363 packetCount=0
[junit4] 2> 78025 INFO (coreCloseExecutor-459-thread-1) [ ] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-459-thread-1]: coreCloseExecutor-459-thread-1 finishFullFlush success=true
[junit4] 2> 78025 INFO (coreCloseExecutor-459-thread-1) [ ] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-459-thread-1]: startCommit(): start
[junit4] 2> 78025 INFO (coreCloseExecutor-459-thread-1) [ ] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-459-thread-1]: skip startCommit(): no changes pending
[junit4] 2> 78025 INFO (coreCloseExecutor-459-thread-1) [ ] o.a.s.u.LoggingInfoStream [IFD][coreCloseExecutor-459-thread-1]: delete []
[junit4] 2> 78025 INFO (coreCloseExecutor-459-thread-1) [ ] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-459-thread-1]: commit: pendingCommit == null; skip
[junit4] 2> 78025 INFO (coreCloseExecutor-459-thread-1) [ ] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-459-thread-1]: commit: took 0.3 msec
[junit4] 2> 78025 INFO (coreCloseExecutor-459-thread-1) [ ] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-459-thread-1]: commit: done
[junit4] 2> 78025 INFO (coreCloseExecutor-459-thread-1) [ ] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-459-thread-1]: rollback
[junit4] 2> 78025 INFO (coreCloseExecutor-459-thread-1) [ ] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-459-thread-1]: all running merges have aborted
[junit4] 2> 78025 INFO (coreCloseExecutor-459-thread-1) [ ] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-459-thread-1]: rollback: done finish merges
[junit4] 2> 78025 INFO (coreCloseExecutor-459-thread-1) [ ] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-459-thread-1]: abort
[junit4] 2> 78025 INFO (coreCloseExecutor-459-thread-1) [ ] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-459-thread-1]: done abort success=true
[junit4] 2> 78025 INFO (coreCloseExecutor-459-thread-1) [ ] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-459-thread-1]: rollback: infos=_1k(7.0.0):C1
[junit4] 2> 78025 INFO (coreCloseExecutor-459-thread-1) [ ] o.a.s.u.LoggingInfoStream [IFD][coreCloseExecutor-459-thread-1]: now checkpoint "_1k(7.0.0):C1" [1 segments ; isCommit = false]
[junit4] 2> 78025 INFO (coreCloseExecutor-459-thread-1) [ ] o.a.s.u.LoggingInfoStream [IFD][coreCloseExecutor-459-thread-1]: delete []
[junit4] 2> 78025 INFO (coreCloseExecutor-459-thread-1) [ ] o.a.s.u.LoggingInfoStream [IFD][coreCloseExecutor-459-thread-1]: 0 msec to checkpoint
[junit4] 2> 78025 INFO (coreCloseExecutor-459-thread-1) [ ] o.a.s.u.LoggingInfoStream [IFD][coreCloseExecutor-459-thread-1]: delete []
[junit4] 2> 78025 INFO (coreCloseExecutor-459-thread-1) [ ] o.a.s.u.LoggingInfoStream [IFD][coreCloseExecutor-459-thread-1]: delete []
[junit4] 2> 78059 INFO (coreCloseExecutor-459-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=31029502
[junit4] 2> 78060 INFO (SUITE-SolrExampleJettyTest-seed#[67D470B159DC58AB]-worker) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@1f0b4d3{/solr,null,UNAVAILABLE}
[junit4] 2> 78060 INFO (SUITE-SolrExampleJettyTest-seed#[67D470B159DC58AB]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.embedded.SolrExampleJettyTest_67D470B159DC58AB-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {}, docValues:{}, maxPointsInLeafNode=323, maxMBSortInHeap=6.975673696039772, sim=RandomSimilarity(queryNorm=false): {}, locale=or-IN, timezone=GMT
[junit4] 2> NOTE: Linux 4.4.0-66-generic i386/Oracle Corporation 9-ea (32-bit)/cpus=12,threads=1,free=53408360,total=258998272
[junit4] 2> NOTE: All tests run in this JVM: [SolrPingTest, SolrSchemalessExampleTest, CloudSolrClientMultiConstructorTest, TestValidatingJsonMap, CompoundEvaluatorTest, JettyWebappTest, ConcurrentUpdateSolrClientTest, TestDelegationTokenRequest, TestZkConfigManager, AbsoluteValueEvaluatorTest, GraphTest, HttpSolrClientSSLAuthConPoolTest, BasicHttpSolrClientTest, ShardParamsTest, TestCoreAdmin, SolrExampleXMLTest, JDBCStreamTest, SolrExampleJettyTest]
[junit4] Completed [81/107 (6!)] on J2 in 6.29s, 37 tests, 1 error <<< FAILURES!
[...truncated 51052 lines...]
[JENKINS-EA] Lucene-Solr-master-Linux (64bit/jdk-9-ea+160) - Build
# 19187 - Still Unstable!
Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/19187/
Java: 64bit/jdk-9-ea+160 -XX:-UseCompressedOops -XX:+UseParallelGC
2 tests failed.
FAILED: junit.framework.TestSuite.org.apache.solr.search.LargeFieldTest
Error Message:
Stack Trace:
java.lang.AssertionError
at __randomizedtesting.SeedInfo.seed([4E896977EBBAC264]:0)
at org.junit.Assert.fail(Assert.java:92)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.junit.Assert.assertNull(Assert.java:551)
at org.junit.Assert.assertNull(Assert.java:562)
at org.apache.solr.search.LargeFieldTest.initManagedSchemaCore(LargeFieldTest.java:61)
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:547)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:847)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:844)
FAILED: org.apache.solr.TestDistributedSearch.test
Error Message:
Expected to find shardAddress in the up shard info: {error=org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request,trace=org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:416) at org.apache.solr.handler.component.HttpShardHandlerFactory.makeLoadBalancedRequest(HttpShardHandlerFactory.java:259) at org.apache.solr.handler.component.HttpShardHandler.lambda$submit$0(HttpShardHandler.java:166) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264) at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:514) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:176) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:229) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1161) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) at java.base/java.lang.Thread.run(Thread.java:844) ,time=1}
Stack Trace:
java.lang.AssertionError: Expected to find shardAddress in the up shard info: {error=org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request,trace=org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request
at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:416)
at org.apache.solr.handler.component.HttpShardHandlerFactory.makeLoadBalancedRequest(HttpShardHandlerFactory.java:259)
at org.apache.solr.handler.component.HttpShardHandler.lambda$submit$0(HttpShardHandler.java:166)
at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:514)
at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:176)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:229)
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1161)
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635)
at java.base/java.lang.Thread.run(Thread.java:844)
,time=1}
at __randomizedtesting.SeedInfo.seed([4E896977EBBAC264:C6DD56AD4546AF9C]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.apache.solr.TestDistributedSearch.comparePartialResponses(TestDistributedSearch.java:1186)
at org.apache.solr.TestDistributedSearch.queryPartialResults(TestDistributedSearch.java:1127)
at org.apache.solr.TestDistributedSearch.test(TestDistributedSearch.java:987)
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:547)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsRepeatStatement.callStatement(BaseDistributedSearchTestCase.java:1011)
at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:960)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:844)
Build Log:
[...truncated 11251 lines...]
[junit4] Suite: org.apache.solr.search.LargeFieldTest
[junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.search.LargeFieldTest_4E896977EBBAC264-001/init-core-data-001
[junit4] 2> 344113 WARN (SUITE-LargeFieldTest-seed#[4E896977EBBAC264]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=49 numCloses=49
[junit4] 2> 344113 INFO (SUITE-LargeFieldTest-seed#[4E896977EBBAC264]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields
[junit4] 2> 344116 INFO (SUITE-LargeFieldTest-seed#[4E896977EBBAC264]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason="", value=0.0/0.0, ssl=0.0/0.0, clientAuth=0.0/0.0)
[junit4] 2> 344118 INFO (SUITE-LargeFieldTest-seed#[4E896977EBBAC264]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 344119 INFO (SUITE-LargeFieldTest-seed#[4E896977EBBAC264]-worker) [ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 344210 INFO (SUITE-LargeFieldTest-seed#[4E896977EBBAC264]-worker) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 344223 INFO (SUITE-LargeFieldTest-seed#[4E896977EBBAC264]-worker) [ ] o.a.s.s.IndexSchema [null] Schema name=one_field_no_dynamic_field_unique_key
[junit4] 2> 344225 INFO (SUITE-LargeFieldTest-seed#[4E896977EBBAC264]-worker) [ ] o.a.s.s.IndexSchema Loaded schema one_field_no_dynamic_field_unique_key/1.1 with uniqueid field str
[junit4] 2> 344360 WARN (SUITE-LargeFieldTest-seed#[4E896977EBBAC264]-worker) [ ] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first MBeanServer.
[junit4] 2> 344364 INFO (SUITE-LargeFieldTest-seed#[4E896977EBBAC264]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7bb82723
[junit4] 2> 344364 WARN (SUITE-LargeFieldTest-seed#[4E896977EBBAC264]-worker) [ ] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first MBeanServer.
[junit4] 2> 344368 INFO (SUITE-LargeFieldTest-seed#[4E896977EBBAC264]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7bb82723
[junit4] 2> 344368 WARN (SUITE-LargeFieldTest-seed#[4E896977EBBAC264]-worker) [ ] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first MBeanServer.
[junit4] 2> 344368 INFO (SUITE-LargeFieldTest-seed#[4E896977EBBAC264]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7bb82723
[junit4] 2> 344370 INFO (coreLoadExecutor-1907-thread-1) [ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 344460 INFO (coreLoadExecutor-1907-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 344469 INFO (coreLoadExecutor-1907-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=one_field_no_dynamic_field_unique_key
[junit4] 2> 344471 INFO (coreLoadExecutor-1907-thread-1) [ ] o.a.s.s.IndexSchema Loaded schema one_field_no_dynamic_field_unique_key/1.1 with uniqueid field str
[junit4] 2> 344475 INFO (coreLoadExecutor-1907-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1
[junit4] 2> 344475 WARN (coreLoadExecutor-1907-thread-1) [ ] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first MBeanServer.
[junit4] 2> 344475 INFO (coreLoadExecutor-1907-thread-1) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7bb82723
[junit4] 2> 344475 INFO (coreLoadExecutor-1907-thread-1) [ ] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 344475 INFO (coreLoadExecutor-1907-thread-1) [ ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.search.LargeFieldTest_4E896977EBBAC264-001/init-core-data-001/]
[junit4] 2> 344479 INFO (coreLoadExecutor-1907-thread-1) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=15, maxMergeAtOnceExplicit=23, maxMergedSegmentMB=55.75390625, floorSegmentMB=1.2861328125, forceMergeDeletesPctAllowed=26.796308836543638, segmentsPerTier=37.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.42642693659746866
[junit4] 2> 364729 WARN (coreLoadExecutor-1907-thread-1) [ ] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,attributes = {initParams=a, name=/dump, registerPath=/solr,/v2, class=DumpRequestHandler},args = {defaults={a=A,b=B}}}
[junit4] 2> 364882 INFO (coreLoadExecutor-1907-thread-1) [ ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 364882 INFO (coreLoadExecutor-1907-thread-1) [ ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 364883 INFO (coreLoadExecutor-1907-thread-1) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=23, maxMergeAtOnceExplicit=23, maxMergedSegmentMB=52.474609375, floorSegmentMB=1.6337890625, forceMergeDeletesPctAllowed=11.6249157629736, segmentsPerTier=12.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 364883 INFO (coreLoadExecutor-1907-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@47520b24[collection1] main]
[junit4] 2> 364884 WARN (coreLoadExecutor-1907-thread-1) [ ] o.a.s.r.ManagedResourceStorage Cannot write to config directory /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
[junit4] 2> 364884 INFO (coreLoadExecutor-1907-thread-1) [ ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 364884 INFO (searcherExecutor-1908-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@47520b24[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 364885 INFO (SUITE-LargeFieldTest-seed#[4E896977EBBAC264]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 364891 INFO (SUITE-LargeFieldTest-seed#[4E896977EBBAC264]-worker) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={wt=xml} status=500 QTime=5
[junit4] 2> 364891 INFO (SUITE-LargeFieldTest-seed#[4E896977EBBAC264]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> 364891 INFO (SUITE-LargeFieldTest-seed#[4E896977EBBAC264]-worker) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1002099095
[junit4] 2> 364891 INFO (SUITE-LargeFieldTest-seed#[4E896977EBBAC264]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 364893 INFO (coreCloseExecutor-1912-thread-1) [ ] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@449eb66e
[junit4] 2> 364894 INFO (coreCloseExecutor-1912-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=1151252078
[junit4] 2> 364896 INFO (SUITE-LargeFieldTest-seed#[4E896977EBBAC264]-worker) [ ] o.a.s.SolrTestCaseJ4 ------------------------------------------------------- Done waiting for tracked resources to be released
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70), sim=RandomSimilarity(queryNorm=true): {}, locale=yo-NG, timezone=PLT
[junit4] 2> NOTE: Linux 4.4.0-66-generic amd64/Oracle Corporation 9-ea (64-bit)/cpus=12,threads=1,free=171784232,total=480772096
[junit4] 2> NOTE: All tests run in this JVM: [SolrMetricManagerTest, TestFoldingMultitermQuery, TestDistribIDF, TestShortCircuitedRequests, TestSchemaSimilarityResource, NumericFieldsTest, CopyFieldTest, TestMaxScoreQueryParser, ResponseHeaderTest, TestSolrQueryParserDefaultOperatorResource, ZkNodePropsTest, TestRawTransformer, QueryEqualityTest, XsltUpdateRequestHandlerTest, SolrCloudExampleTest, HdfsRestartWhileUpdatingTest, TestFieldTypeResource, TestJoin, TestOrdValues, CollectionReloadTest, PreAnalyzedUpdateProcessorTest, TestOmitPositions, TestComplexPhraseLeadingWildcard, BlockJoinFacetDistribTest, SolrGangliaReporterTest, TestOnReconnectListenerSupport, TestJmxMonitoredMap, TestLeaderInitiatedRecoveryThread, TestImplicitCoreProperties, TestRealTimeGet, ReturnFieldsTest, PeerSyncWithIndexFingerprintCachingTest, TestLazyCores, DistributedSpellCheckComponentTest, TestClassicSimilarityFactory, QueryElevationComponentTest, UniqFieldsUpdateProcessorFactoryTest, TestCollationFieldDocValues, TestHighlightDedupGrouping, TestRTimerTree, CustomCollectionTest, StandardRequestHandlerTest, CacheHeaderTest, DocumentAnalysisRequestHandlerTest, TestLRUCache, SaslZkACLProviderTest, SolrRequestParserTest, BasicZkTest, TestRandomFaceting, AnalysisErrorHandlingTest, TestLMJelinekMercerSimilarityFactory, TestNamedUpdateProcessors, LargeFieldTest]
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=LargeFieldTest -Dtests.seed=4E896977EBBAC264 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=yo-NG -Dtests.timezone=PLT -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
[junit4] ERROR 0.00s J0 | LargeFieldTest (suite) <<<
[junit4] > Throwable #1: java.lang.AssertionError
[junit4] > at __randomizedtesting.SeedInfo.seed([4E896977EBBAC264]:0)
[junit4] > at org.apache.solr.search.LargeFieldTest.initManagedSchemaCore(LargeFieldTest.java:61)
[junit4] > at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit4] > at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
[junit4] > at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4] > at java.base/java.lang.reflect.Method.invoke(Method.java:547)
[junit4] > at java.base/java.lang.Thread.run(Thread.java:844)
[junit4] Completed [139/700 (1!)] on J0 in 20.81s, 0 tests, 1 failure <<< FAILURES!
[...truncated 696 lines...]
[junit4] Suite: org.apache.solr.TestDistributedSearch
[junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_4E896977EBBAC264-001/init-core-data-001
[junit4] 2> 1586966 WARN (SUITE-TestDistributedSearch-seed#[4E896977EBBAC264]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=158 numCloses=158
[junit4] 2> 1586966 INFO (SUITE-TestDistributedSearch-seed#[4E896977EBBAC264]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields
[junit4] 2> 1586967 INFO (SUITE-TestDistributedSearch-seed#[4E896977EBBAC264]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl="https://issues.apache.org/jira/browse/SOLR-9061")
[junit4] 2> 1586967 INFO (SUITE-TestDistributedSearch-seed#[4E896977EBBAC264]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /_bm/s
[junit4] 2> 1587749 INFO (TEST-TestDistributedSearch.test-seed#[4E896977EBBAC264]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_4E896977EBBAC264-001/tempDir-001/control/cores/collection1
[junit4] 2> 1587750 INFO (TEST-TestDistributedSearch.test-seed#[4E896977EBBAC264]) [ ] o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 1587751 INFO (TEST-TestDistributedSearch.test-seed#[4E896977EBBAC264]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@5dde300e{/_bm/s,null,AVAILABLE}
[junit4] 2> 1587753 INFO (TEST-TestDistributedSearch.test-seed#[4E896977EBBAC264]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@1d3d918{HTTP/1.1,[http/1.1]}{127.0.0.1:46089}
[junit4] 2> 1587753 INFO (TEST-TestDistributedSearch.test-seed#[4E896977EBBAC264]) [ ] o.e.j.s.Server Started @1589467ms
[junit4] 2> 1587753 INFO (TEST-TestDistributedSearch.test-seed#[4E896977EBBAC264]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/_bm/s, hostPort=46089, coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_4E896977EBBAC264-001/tempDir-001/control/cores}
[junit4] 2> 1587753 ERROR (TEST-TestDistributedSearch.test-seed#[4E896977EBBAC264]) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1587753 INFO (TEST-TestDistributedSearch.test-seed#[4E896977EBBAC264]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 7.0.0
[junit4] 2> 1587753 INFO (TEST-TestDistributedSearch.test-seed#[4E896977EBBAC264]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 1587753 INFO (TEST-TestDistributedSearch.test-seed#[4E896977EBBAC264]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1587753 INFO (TEST-TestDistributedSearch.test-seed#[4E896977EBBAC264]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-03-16T23:27:06.084912Z
[junit4] 2> 1587754 INFO (TEST-TestDistributedSearch.test-seed#[4E896977EBBAC264]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_4E896977EBBAC264-001/tempDir-001/control/solr.xml
[junit4] 2> 1587843 INFO (TEST-TestDistributedSearch.test-seed#[4E896977EBBAC264]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_4E896977EBBAC264-001/tempDir-001/control/cores
[junit4] 2> 1587843 INFO (TEST-TestDistributedSearch.test-seed#[4E896977EBBAC264]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 1587844 INFO (coreLoadExecutor-5758-thread-1) [ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1587922 WARN (coreLoadExecutor-5758-thread-1) [ ] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 1587925 INFO (coreLoadExecutor-5758-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 1587955 INFO (coreLoadExecutor-5758-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1588095 WARN (coreLoadExecutor-5758-thread-1) [ ] o.a.s.s.IndexSchema [collection1] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead.
[junit4] 2> 1588098 INFO (coreLoadExecutor-5758-thread-1) [ ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1588126 INFO (coreLoadExecutor-5758-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1
[junit4] 2> 1588126 INFO (coreLoadExecutor-5758-thread-1) [ ] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1588126 INFO (coreLoadExecutor-5758-thread-1) [ ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_4E896977EBBAC264-001/tempDir-001/control/cores/collection1/data/]
[junit4] 2> 1588126 INFO (coreLoadExecutor-5758-thread-1) [ ] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@31890313
[junit4] 2> 1588127 INFO (coreLoadExecutor-5758-thread-1) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=15, maxMergeAtOnceExplicit=27, maxMergedSegmentMB=90.2939453125, floorSegmentMB=0.8486328125, forceMergeDeletesPctAllowed=5.694849770298337, segmentsPerTier=41.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5588845704718087
[junit4] 2> 1588380 INFO (coreLoadExecutor-5758-thread-1) [ ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1588380 INFO (coreLoadExecutor-5758-thread-1) [ ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1588382 INFO (coreLoadExecutor-5758-thread-1) [ ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1588382 INFO (coreLoadExecutor-5758-thread-1) [ ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1588383 INFO (coreLoadExecutor-5758-thread-1) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=41, maxMergeAtOnceExplicit=34, maxMergedSegmentMB=42.2099609375, floorSegmentMB=1.013671875, forceMergeDeletesPctAllowed=7.228377848005464, segmentsPerTier=42.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.13620109689915447
[junit4] 2> 1588383 INFO (coreLoadExecutor-5758-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@ff33c90[collection1] main]
[junit4] 2> 1588384 INFO (coreLoadExecutor-5758-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 1588447 INFO (coreLoadExecutor-5758-thread-1) [ ] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 1588728 INFO (coreLoadExecutor-5758-thread-1) [ ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1588728 INFO (searcherExecutor-5759-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 1588728 INFO (coreLoadExecutor-5758-thread-1) [ ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1562070825890217984
[junit4] 2> 1588731 INFO (searcherExecutor-5759-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 1588731 INFO (searcherExecutor-5759-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 1588731 INFO (searcherExecutor-5759-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
[junit4] 2> 1588733 INFO (searcherExecutor-5759-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 1588736 INFO (searcherExecutor-5759-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 1588738 INFO (searcherExecutor-5759-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 1588739 INFO (searcherExecutor-5759-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 1588741 INFO (searcherExecutor-5759-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 1588742 INFO (searcherExecutor-5759-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@ff33c90[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1590504 INFO (TEST-TestDistributedSearch.test-seed#[4E896977EBBAC264]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_4E896977EBBAC264-001/tempDir-001/shard0/cores/collection1
[junit4] 2> 1590507 INFO (TEST-TestDistributedSearch.test-seed#[4E896977EBBAC264]) [ ] o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 1590508 INFO (TEST-TestDistributedSearch.test-seed#[4E896977EBBAC264]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@76f32f03{/_bm/s,null,AVAILABLE}
[junit4] 2> 1590509 INFO (TEST-TestDistributedSearch.test-seed#[4E896977EBBAC264]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@1a5f90f7{HTTP/1.1,[http/1.1]}{127.0.0.1:44273}
[junit4] 2> 1590509 INFO (TEST-TestDistributedSearch.test-seed#[4E896977EBBAC264]) [ ] o.e.j.s.Server Started @1592222ms
[junit4] 2> 1590509 INFO (TEST-TestDistributedSearch.test-seed#[4E896977EBBAC264]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/_bm/s, hostPort=44273, coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_4E896977EBBAC264-001/tempDir-001/shard0/cores}
[junit4] 2> 1590509 ERROR (TEST-TestDistributedSearch.test-seed#[4E896977EBBAC264]) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1590510 INFO (TEST-TestDistributedSearch.test-seed#[4E896977EBBAC264]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 7.0.0
[junit4] 2> 1590510 INFO (TEST-TestDistributedSearch.test-seed#[4E896977EBBAC264]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 1590510 INFO (TEST-TestDistributedSearch.test-seed#[4E896977EBBAC264]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1590510 INFO (TEST-TestDistributedSearch.test-seed#[4E896977EBBAC264]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-03-16T23:27:08.841157Z
[junit4] 2> 1590510 INFO (TEST-TestDistributedSearch.test-seed#[4E896977EBBAC264]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_4E896977EBBAC264-001/tempDir-001/shard0/solr.xml
[junit4] 2> 1590659 INFO (TEST-TestDistributedSearch.test-seed#[4E896977EBBAC264]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_4E896977EBBAC264-001/tempDir-001/shard0/cores
[junit4] 2> 1590659 INFO (TEST-TestDistributedSearch.test-seed#[4E896977EBBAC264]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 1590660 INFO (coreLoadExecutor-5769-thread-1) [ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1590740 WARN (coreLoadExecutor-5769-thread-1) [ ] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 1590741 INFO (coreLoadExecutor-5769-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 1590759 INFO (coreLoadExecutor-5769-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1590853 WARN (coreLoadExecutor-5769-thread-1) [ ] o.a.s.s.IndexSchema [collection1] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead.
[junit4] 2> 1590856 INFO (coreLoadExecutor-5769-thread-1) [ ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1590881 INFO (coreLoadExecutor-5769-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1
[junit4] 2> 1590881 INFO (coreLoadExecutor-5769-thread-1) [ ] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1590881 INFO (coreLoadExecutor-5769-thread-1) [ ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_4E896977EBBAC264-001/tempDir-001/shard0/cores/collection1/data/]
[junit4] 2> 1590881 INFO (coreLoadExecutor-5769-thread-1) [ ] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@31890313
[junit4] 2> 1590882 INFO (coreLoadExecutor-5769-thread-1) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=15, maxMergeAtOnceExplicit=27, maxMergedSegmentMB=90.2939453125, floorSegmentMB=0.8486328125, forceMergeDeletesPctAllowed=5.694849770298337, segmentsPerTier=41.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5588845704718087
[junit4] 2> 1591144 INFO (coreLoadExecutor-5769-thread-1) [ ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1591144 INFO (coreLoadExecutor-5769-thread-1) [ ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1591147 INFO (coreLoadExecutor-5769-thread-1) [ ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1591147 INFO (coreLoadExecutor-5769-thread-1) [ ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1591148 INFO (coreLoadExecutor-5769-thread-1) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=41, maxMergeAtOnceExplicit=34, maxMergedSegmentMB=42.2099609375, floorSegmentMB=1.013671875, forceMergeDeletesPctAllowed=7.228377848005464, segmentsPerTier=42.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.13620109689915447
[junit4] 2> 1591149 INFO (coreLoadExecutor-5769-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@137e09c3[collection1] main]
[junit4] 2> 1591149 INFO (coreLoadExecutor-5769-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 1591202 INFO (coreLoadExecutor-5769-thread-1) [ ] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 1591599 INFO (coreLoadExecutor-5769-thread-1) [ ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1591599 INFO (searcherExecutor-5770-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 1591601 INFO (coreLoadExecutor-5769-thread-1) [ ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1562070828902776832
[junit4] 2> 1591602 INFO (searcherExecutor-5770-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 1591602 INFO (searcherExecutor-5770-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 1591602 INFO (searcherExecutor-5770-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
[junit4] 2> 1591605 INFO (searcherExecutor-5770-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 1591607 INFO (searcherExecutor-5770-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 1591609 INFO (searcherExecutor-5770-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 1591611 INFO (searcherExecutor-5770-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 1591614 INFO (searcherExecutor-5770-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 1591615 INFO (searcherExecutor-5770-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@137e09c3[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1592064 INFO (TEST-TestDistributedSearch.test-seed#[4E896977EBBAC264]) [ ] o.a.s.SolrTestCaseJ4 ###Starting test
[junit4] 2> 1592069 INFO (qtp1057698359-13674) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{deleteByQuery=*:* (-1562070829390364672)} 0 2
[junit4] 2> 1592073 INFO (qtp1059442885-13691) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{deleteByQuery=*:* (-1562070829395607552)} 0 2
[junit4] 2> 1592076 INFO (qtp1057698359-13675) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[1 (1562070829398753280)]} 0 1
[junit4] 2> 1592079 INFO (qtp1059442885-13692) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[1 (1562070829401899008)]} 0 2
[junit4] 2> 1592081 INFO (qtp1057698359-13676) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[2 (1562070829405044736)]} 0 0
[junit4] 2> 1592082 INFO (qtp1059442885-13693) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[2 (1562070829407141888)]} 0 0
[junit4] 2> 1592083 INFO (qtp1057698359-13669) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[3 (1562070829408190464)]} 0 0
[junit4] 2> 1592084 INFO (qtp1059442885-13686) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[3 (1562070829409239040)]} 0 0
[junit4] 2> 1592085 INFO (qtp1057698359-13674) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[4 (1562070829409239040)]} 0 0
[junit4] 2> 1592085 INFO (qtp1059442885-13686) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[4 (1562070829410287616)]} 0 0
[junit4] 2> 1592086 INFO (qtp1057698359-13675) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[5 (1562070829410287616)]} 0 0
[junit4] 2> 1592086 INFO (qtp1059442885-13686) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[5 (1562070829411336192)]} 0 0
[junit4] 2> 1592087 INFO (qtp1057698359-13676) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[6 (1562070829412384768)]} 0 0
[junit4] 2> 1592087 INFO (qtp1059442885-13686) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[6 (1562070829412384768)]} 0 0
[junit4] 2> 1592088 INFO (qtp1057698359-13669) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[7 (1562070829413433344)]} 0 0
[junit4] 2> 1592089 INFO (qtp1059442885-13686) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[7 (1562070829413433344)]} 0 0
[junit4] 2> 1592089 INFO (qtp1057698359-13669) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[8 (1562070829414481920)]} 0 0
[junit4] 2> 1592090 INFO (qtp1059442885-13686) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[8 (1562070829415530496)]} 0 0
[junit4] 2> 1592090 INFO (qtp1057698359-13669) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[9 (1562070829415530496)]} 0 0
[junit4] 2> 1592091 INFO (qtp1059442885-13686) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[9 (1562070829416579072)]} 0 0
[junit4] 2> 1592091 INFO (qtp1057698359-13669) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1592092 INFO (qtp1057698359-13669) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@5b385799 commitCommandVersion:0
[junit4] 2> 1592103 INFO (qtp1057698359-13669) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@2656c34b[collection1] main]
[junit4] 2> 1592105 INFO (qtp1057698359-13669) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1592106 INFO (searcherExecutor-5759-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@2656c34b[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C9)))}
[junit4] 2> 1592106 INFO (qtp1057698359-13669) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 14
[junit4] 2> 1592106 INFO (qtp1059442885-13686) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1592106 INFO (qtp1059442885-13686) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@632b15f8 commitCommandVersion:0
[junit4] 2> 1592114 INFO (qtp1059442885-13686) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@f41dea1[collection1] main]
[junit4] 2> 1592114 INFO (qtp1059442885-13686) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1592116 INFO (searcherExecutor-5770-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@f41dea1[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C9)))}
[junit4] 2> 1592117 INFO (qtp1059442885-13686) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 10
[junit4] 2> 1592121 INFO (qtp1057698359-13674) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[10 (1562070829444890624)]} 0 3
[junit4] 2> 1592125 INFO (qtp1059442885-13692) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[10 (1562070829449084928)]} 0 2
[junit4] 2> 1592126 INFO (qtp1057698359-13675) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[11 (1562070829452230656)]} 0 0
[junit4] 2> 1592128 INFO (qtp1059442885-13693) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[11 (1562070829454327808)]} 0 1
[junit4] 2> 1592129 INFO (qtp1057698359-13676) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[12 (1562070829456424960)]} 0 0
[junit4] 2> 1592130 INFO (qtp1059442885-13691) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[12 (1562070829456424960)]} 0 0
[junit4] 2> 1592130 INFO (qtp1057698359-13676) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[13 (1562070829457473536)]} 0 0
[junit4] 2> 1592131 INFO (qtp1059442885-13686) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[13 (1562070829458522112)]} 0 0
[junit4] 2> 1592132 INFO (qtp1057698359-13674) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[1001 (1562070829459570688)]} 0 0
[junit4] 2> 1592133 INFO (qtp1059442885-13692) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[1001 (1562070829460619264)]} 0 0
[junit4] 2> 1592134 INFO (qtp1057698359-13675) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[14 (1562070829461667840)]} 0 0
[junit4] 2> 1592135 INFO (qtp1059442885-13692) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[14 (1562070829461667840)]} 0 0
[junit4] 2> 1592135 INFO (qtp1057698359-13675) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[15 (1562070829462716416)]} 0 0
[junit4] 2> 1592136 INFO (qtp1059442885-13691) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[15 (1562070829462716416)]} 0 0
[junit4] 2> 1592136 INFO (qtp1057698359-13676) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[16 (1562070829463764992)]} 0 0
[junit4] 2> 1592137 INFO (qtp1059442885-13691) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[16 (1562070829463764992)]} 0 0
[junit4] 2> 1592137 INFO (qtp1057698359-13674) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[17 (1562070829464813568)]} 0 0
[junit4] 2> 1592138 INFO (qtp1059442885-13693) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[17 (1562070829465862144)]} 0 0
[junit4] 2> 1592139 INFO (qtp1057698359-13674) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[100 (1562070829465862144)]} 0 0
[junit4] 2> 1592139 INFO (qtp1059442885-13693) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[100 (1562070829466910720)]} 0 0
[junit4] 2> 1592140 INFO (qtp1057698359-13675) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[101 (1562070829467959296)]} 0 0
[junit4] 2> 1592141 INFO (qtp1059442885-13686) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[101 (1562070829467959296)]} 0 0
[junit4] 2> 1592141 INFO (qtp1057698359-13676) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[102 (1562070829469007872)]} 0 0
[junit4] 2> 1592142 INFO (qtp1059442885-13691) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[102 (1562070829469007872)]} 0 0
[junit4] 2> 1592142 INFO (qtp1057698359-13669) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[103 (1562070829470056448)]} 0 0
[junit4] 2> 1592142 INFO (qtp1059442885-13692) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[103 (1562070829470056448)]} 0 0
[junit4] 2> 1592143 INFO (qtp1057698359-13669) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[104 (1562070829471105024)]} 0 0
[junit4] 2> 1592143 INFO (qtp1059442885-13692) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[104 (1562070829471105024)]} 0 0
[junit4] 2> 1592144 INFO (qtp1057698359-13675) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[105 (1562070829472153600)]} 0 0
[junit4] 2> 1592145 INFO (qtp1059442885-13686) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[105 (1562070829472153600)]} 0 0
[junit4] 2> 1592160 INFO (qtp1057698359-13676) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[106 (1562070829473202176)]} 0 0
[junit4] 2> 1592161 INFO (qtp1059442885-13691) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[106 (1562070829489979392)]} 0 0
[junit4] 2> 1592162 INFO (qtp1057698359-13674) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[107 (1562070829491027968)]} 0 0
[junit4] 2> 1592163 INFO (qtp1059442885-13693) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[107 (1562070829491027968)]} 0 0
[junit4] 2> 1592163 INFO (qtp1057698359-13674) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[108 (1562070829492076544)]} 0 0
[junit4] 2> 1592164 INFO (qtp1059442885-13692) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[108 (1562070829493125120)]} 0 0
[junit4] 2> 1592165 INFO (qtp1057698359-13675) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[109 (1562070829494173696)]} 0 0
[junit4] 2> 1592165 INFO (qtp1059442885-13686) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[109 (1562070829494173696)]} 0 0
[junit4] 2> 1592166 INFO (qtp1057698359-13675) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[110 (1562070829495222272)]} 0 0
[junit4] 2> 1592167 INFO (qtp1059442885-13691) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[110 (1562070829495222272)]} 0 0
[junit4] 2> 1592167 INFO (qtp1057698359-13675) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[111 (1562070829496270848)]} 0 0
[junit4] 2> 1592167 INFO (qtp1059442885-13693) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[111 (1562070829496270848)]} 0 0
[junit4] 2> 1592168 INFO (qtp1057698359-13675) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[112 (1562070829497319424)]} 0 0
[junit4] 2> 1592169 INFO (qtp1059442885-13693) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[112 (1562070829497319424)]} 0 0
[junit4] 2> 1592169 INFO (qtp1057698359-13676) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[113 (1562070829498368000)]} 0 0
[junit4] 2> 1592169 INFO (qtp1059442885-13693) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[113 (1562070829498368000)]} 0 0
[junit4] 2> 1592170 INFO (qtp1057698359-13676) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[114 (1562070829499416576)]} 0 0
[junit4] 2> 1592170 INFO (qtp1059442885-13691) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[114 (1562070829499416576)]} 0 0
[junit4] 2> 1592171 INFO (qtp1057698359-13676) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[115 (1562070829500465152)]} 0 0
[junit4] 2> 1592171 INFO (qtp1059442885-13692) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[115 (1562070829500465152)]} 0 0
[junit4] 2> 1592172 INFO (qtp1057698359-13675) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[116 (1562070829501513728)]} 0 0
[junit4] 2> 1592172 INFO (qtp1059442885-13692) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[116 (1562070829501513728)]} 0 0
[junit4] 2> 1592173 INFO (qtp1057698359-13669) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[117 (1562070829502562304)]} 0 0
[junit4] 2> 1592173 INFO (qtp1059442885-13692) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[117 (1562070829502562304)]} 0 0
[junit4] 2> 1592174 INFO (qtp1057698359-13669) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[118 (1562070829503610880)]} 0 0
[junit4] 2> 1592175 INFO (qtp1059442885-13691) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[118 (1562070829503610880)]} 0 0
[junit4] 2> 1592175 INFO (qtp1057698359-13676) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[119 (1562070829504659456)]} 0 0
[junit4] 2> 1592176 INFO (qtp1059442885-13686) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[119 (1562070829505708032)]} 0 0
[junit4] 2> 1592177 INFO (qtp1057698359-13675) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[120 (1562070829505708032)]} 0 0
[junit4] 2> 1592177 INFO (qtp1059442885-13693) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[120 (1562070829506756608)]} 0 0
[junit4] 2> 1592178 INFO (qtp1057698359-13675) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[121 (1562070829506756608)]} 0 0
[junit4] 2> 1592178 INFO (qtp1059442885-13693) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[121 (1562070829507805184)]} 0 0
[junit4] 2> 1592179 INFO (qtp1057698359-13675) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[122 (1562070829507805184)]} 0 0
[junit4] 2> 1592179 INFO (qtp1059442885-13693) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[122 (1562070829508853760)]} 0 0
[junit4] 2> 1592180 INFO (qtp1057698359-13675) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[123 (1562070829508853760)]} 0 0
[junit4] 2> 1592180 INFO (qtp1059442885-13693) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[123 (1562070829509902336)]} 0 0
[junit4] 2> 1592181 INFO (qtp1057698359-13676) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[124 (1562070829510950912)]} 0 0
[junit4] 2> 1592181 INFO (qtp1059442885-13693) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[124 (1562070829510950912)]} 0 0
[junit4] 2> 1592182 INFO (qtp1057698359-13674) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[125 (1562070829511999488)]} 0 0
[junit4] 2> 1592182 INFO (qtp1059442885-13693) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[125 (1562070829511999488)]} 0 0
[junit4] 2> 1592183 INFO (qtp1057698359-13674) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[126 (1562070829513048064)]} 0 0
[junit4] 2> 1592183 INFO (qtp1059442885-13693) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[126 (1562070829513048064)]} 0 0
[junit4] 2> 1592184 INFO (qtp1057698359-13675) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[127 (1562070829514096640)]} 0 0
[junit4] 2> 1592185 INFO (qtp1059442885-13692) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[127 (1562070829514096640)]} 0 0
[junit4] 2> 1592185 INFO (qtp1057698359-13675) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[128 (1562070829515145216)]} 0 0
[junit4] 2> 1592186 INFO (qtp1059442885-13691) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[128 (1562070829515145216)]} 0 0
[junit4] 2> 1592186 INFO (qtp1057698359-13669) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[129 (1562070829516193792)]} 0 0
[junit4] 2> 1592187 INFO (qtp1059442885-13691) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[129 (1562070829516193792)]} 0 0
[junit4] 2> 1592187 INFO (qtp1057698359-13669) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[130 (1562070829517242368)]} 0 0
[junit4] 2> 1592188 INFO (qtp1059442885-13691) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[130 (1562070829518290944)]} 0 0
[junit4] 2> 1592189 INFO (qtp1057698359-13676) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[131 (1562070829518290944)]} 0 0
[junit4] 2> 1592189 INFO (qtp1059442885-13692) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[131 (1562070829519339520)]} 0 0
[junit4] 2> 1592190 INFO (qtp1057698359-13676) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[132 (1562070829519339520)]} 0 0
[junit4] 2> 1592190 INFO (qtp1059442885-13686) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[132 (1562070829520388096)]} 0 0
[junit4] 2> 1592191 INFO (qtp1057698359-13674) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[133 (1562070829521436672)]} 0 0
[junit4] 2> 1592191 INFO (qtp1059442885-13686) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[133 (1562070829521436672)]} 0 0
[junit4] 2> 1592194 INFO (qtp1057698359-13674) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[134 (1562070829523533824)]} 0 0
[junit4] 2> 1592194 INFO (qtp1059442885-13691) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[134 (1562070829524582400)]} 0 0
[junit4] 2> 1592194 INFO (qtp1057698359-13674) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[135 (1562070829524582400)]} 0 0
[junit4] 2> 1592202 INFO (qtp1059442885-13692) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[135 (1562070829531922432)]} 0 0
[junit4] 2> 1592202 INFO (qtp1057698359-13674) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[136 (1562070829532971008)]} 0 0
[junit4] 2> 1592203 INFO (qtp1059442885-13692) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[136 (1562070829534019584)]} 0 0
[junit4] 2> 1592203 INFO (qtp1057698359-13675) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[137 (1562070829534019584)]} 0 0
[junit4] 2> 1592204 INFO (qtp1059442885-13686) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[137 (1562070829535068160)]} 0 0
[junit4] 2> 1592204 INFO (qtp1057698359-13676) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[138 (1562070829535068160)]} 0 0
[junit4] 2> 1592204 INFO (qtp1059442885-13691) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[138 (1562070829535068161)]} 0 0
[junit4] 2> 1592205 INFO (qtp1057698359-13669) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[139 (1562070829536116736)]} 0 0
[junit4] 2> 1592205 INFO (qtp1059442885-13693) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[139 (1562070829536116736)]} 0 0
[junit4] 2> 1592206 INFO (qtp1057698359-13674) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[140 (1562070829537165312)]} 0 0
[junit4] 2> 1592206 INFO (qtp1059442885-13693) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[140 (1562070829537165312)]} 0 0
[junit4] 2> 1592207 INFO (qtp1057698359-13675) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[141 (1562070829538213888)]} 0 0
[junit4] 2> 1592207 INFO (qtp1059442885-13686) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[141 (1562070829538213888)]} 0 0
[junit4] 2> 1592208 INFO (qtp1057698359-13675) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[142 (1562070829538213889)]} 0 0
[junit4] 2> 1592208 INFO (qtp1059442885-13691) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[142 (1562070829539262464)]} 0 0
[junit4] 2> 1592209 INFO (qtp1057698359-13669) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[143 (1562070829539262464)]} 0 0
[junit4] 2> 1592209 INFO (qtp1059442885-13692) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[143 (1562070829540311040)]} 0 0
[junit4] 2> 1592209 INFO (qtp1057698359-13674) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[144 (1562070829540311040)]} 0 0
[junit4] 2> 1592210 INFO (qtp1059442885-13692) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[144 (1562070829541359616)]} 0 0
[junit4] 2> 1592210 INFO (qtp1057698359-13676) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[145 (1562070829541359616)]} 0 0
[junit4] 2> 1592211 INFO (qtp1059442885-13686) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[145 (1562070829542408192)]} 0 0
[junit4] 2> 1592211 INFO (qtp1057698359-13676) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[146 (1562070829542408192)]} 0 0
[junit4] 2> 1592212 INFO (qtp1059442885-13691) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[146 (1562070829543456768)]} 0 0
[junit4] 2> 1592213 INFO (qtp1057698359-13669) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[147 (1562070829544505344)]} 0 0
[junit4] 2> 1592213 INFO (qtp1059442885-13693) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[147 (1562070829544505344)]} 0 0
[junit4] 2> 1592214 INFO (qtp1057698359-13674) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[148 (1562070829544505345)]} 0 0
[junit4] 2> 1592214 INFO (qtp1059442885-13692) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[148 (1562070829545553920)]} 0 0
[junit4] 2> 1592214 INFO (qtp1057698359-13675) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[149 (1562070829545553920)]} 0 0
[junit4] 2> 1592215 INFO (qtp1059442885-13686) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={wt=javabin&version=2}{add=[149 (1562070829546602496)]} 0 0
[junit4] 2> 1592215 INFO (qtp1057698359-13676) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1592215 INFO (qtp1057698359-13676) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@5b385799 commitCommandVersion:0
[junit4] 2> 1592228 INFO (qtp1057698359-13676) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@26a9a990[collection1] main]
[junit4] 2> 1592230 INFO (searcherExecutor-5759-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@26a9a990[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C9) Uninverting(_1(7.0.0):C59)))}
[junit4] 2> 1592230 INFO (qtp1057698359-13676) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1592230 INFO (qtp1057698359-13676) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 15
[junit4] 2> 1592231 INFO (qtp1059442885-13691) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1592231 INFO (qtp1059442885-13691) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@632b15f8 commitCommandVersion:0
[junit4] 2> 1592242 INFO (qtp1059442885-13691) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@354620d9[collection1] main]
[junit4] 2> 1592242 INFO (qtp1059442885-13691) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1592243 INFO (searcherExecutor-5770-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@354620d9[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C9) Uninverting(_1(7.0.0):C59)))}
[junit4] 2> 1592243 INFO (qtp1059442885-13691) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/_bm/s path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 12
[junit4] 2> 1592244 INFO (qtp1057698359-13669) [ ] o.a.s.h.RequestHandlerBase Ignoring exception matching parameter cannot be negative
[junit4] 2> 1592244 INFO (qtp1057698359-13669) [ ] o.a.s.c.S.Request [collection1] webapp=/_bm/s path=/select params={q=*&distrib=false&start=-1&wt=javabin&version=2} status=400 QTime=0
[junit4] 2> 1592245 INFO (qtp1057698359-13674) [ ] o.a.s.h.RequestHandlerBase Ignoring exception matching parameter cannot be negative
[junit4] 2> 1592245 INFO (qtp1057698359-13674) [ ] o.a.s.c.S.Request [collection1] webapp=/_bm/s path=/select params={q=*&distrib=false&start=0&rows=-1&wt=javabin&version=2} status=400 QTime=0
[junit4] 2> 1592245 INFO (qtp1057698359-13675) [ ] o.a.s.c.S.Request [collection1] webapp=/_bm/s path=/select params={q=*:*&distrib=false&sort=n_ti1+desc&wt=javabin&version=2} hits=68 status=0 QTime=0
[junit4] 2> 1592251 INFO (qtp1059442885-13686) [ ] o.a.s.c.S.Request [collection1] webapp=/_bm/s path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_ti1+desc&shard.url=[ff01::213]:33332/_bm/s|http://127.0.0.1:44273/_bm/s/collection1|[ff01::083]:33332/_bm/s&rows=10&version=2&q=*:*&NOW=1489706830578&isShard=true&wt=javabin} hits=68 status=0 QTime=0
[junit4] 2> 1592252 INFO (qtp1059442885-13691) [ ] o.a.s.c.S.Request [collection1] webapp=/_bm/s path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1489706830578&ids=132,147,149,6,17,117,119,108,140,142&isShard=true&shard.url=[ff01::213]:33332/_bm/s|http://127.0.0.1:44273/_bm/s/collection1|[ff01::083]:33332/_bm/s&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1592254 INFO (qtp1059442885-13693) [ ] o.a.s.c.S.Request [collection1] webapp=/_bm/s path=/select params={q=*:*&shards=[ff01::213]:33332/_bm/s|http://127.0.0.1:44273/_bm/s/collection1|[ff01::083]:33332/_bm/s&sort=n_ti1+desc&wt=javabin&version=2} hits=68 status=0 QTime=6
[junit4] 2> 1592255 INFO (qtp1057698359-13676) [ ] o.a.s.c.S.Request [collection1] webapp=/_bm/s path=/select params={q=*:*&distrib=false&sort=n_ti1+asc&wt=javabin&version=2} hits=68 status=0 QTime=0
[junit4] 2> 1592261 INFO (qtp1059442885-13687) [ ] o.a.s.c.S.Request [collection1] webapp=/_bm/s path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_ti1+asc&shard.url=[ff01::114]:33332/_bm/s|[ff01::213]:33332/_bm/s|http://127.0.0.1:44273/_bm/s/collection1|[ff01::083]:33332/_bm/s&rows=10&version=2&q=*:*&NOW=1489706830588&isShard=true&wt=javabin} hits=68 status=0 QTime=0
[junit4] 2> 1592263 INFO (qtp1059442885-13687) [ ] o.a.s.c.S.Request [collection1] webapp=/_bm/s path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1489706830588&ids=121,1,134,101,102,135,124,114,127,7&isShard=true&shard.url=[ff01::114]:33332/_bm/s|[ff01::213]:33332/_bm/s|http://127.0.0.1:44273/_bm/s/collection1|[ff01::083]:33332/_bm/s&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1592265 INFO (qtp1059442885-13692) [ ] o.a.s.c.S.Request [collection1] webapp=/_bm/s path=/select params={q=*:*&shards=[ff01::114]:33332/_bm/s|[ff01::213]:33332/_bm/s|http://127.0.0.1:44273/_bm/s/collection1|[ff01::083]:33332/_bm/s&sort=n_ti1+asc&wt=javabin&version=2} hits=68 status=0 QTime=7
[junit4] 2> 1592266 INFO (qtp1057698359-13669) [ ] o.a.s.c.S.Request [collection1] webapp=/_bm/s path=/select params={q=*:*&distrib=false&sort=n_f1+desc&wt=javabin&version=2} hits=68 status=0 QTime=0
[junit4] 2> 1592268 INFO (qtp1059442885-13693) [ ] o.a.s.c.S.Request [collection1] webapp=/_bm/s path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_f1+desc&shard.url=[ff01::213]:33332/_bm/s|http://127.0.0.1:44273/_bm/s/collection1&rows=10&version=2&q=*:*&NOW=1489706830598&isShard=true&wt=javabin} hits=68 status=0 QTime=0
[junit4] 2> 1592270 INFO (qtp1059442885-13693) [ ] o.a.s.c.S.Request [collection1] webapp=/_bm/s path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1489706830598&ids=11,13,101,146,4,126,116,106,118,142&isShard=true&shard.url=[ff01::213]:33332/_bm/s|http://127.0.0.1:44273/_bm/s/collection1&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1592271 INFO (qtp1059442885-13686) [ ] o.a.s.c.S.Request [collection1] webapp=/_bm/s path=/select params={q=*:*&shards=[ff01::213]:33332/_bm/s|http://127.0.0.1:44273/_bm/s/collection1&sort=n_f1+desc&wt=javabin&version=2} hits=68 status=0 QTime=3
[junit4] 2> 1592273 INFO (qtp1057698359-13669) [ ] o.a.s.c.S.Request [collection1] webapp=/_bm/s path=/select params={q=*:*&distrib=false&sort=n_f1+asc&wt=javabin&version=2} hits=68 status=0 QTime=0
[junit4] 2> 1592276 INFO (qtp1059442885-13693) [ ] o.a.s.c.S.Request [collection1] webapp=/_bm/s path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_f1+asc&shard.url=[ff01::083]:33332/_bm/s|[ff01::114]:33332/_bm/s|[ff01::213]:33332/_bm/s|http://127.0.0.1:44273/_bm/s/collection1&rows=10&version=2&q=*:*&NOW=1489706830605&isShard=true&wt=javabin} hits=68 status=0 QTime=0
[junit4] 2> 1592277 INFO (qtp1059442885-13693) [ ] o.a.s.c.S.Request [collection1] webapp=/_bm/s path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1489706830605&ids=132,14,103,15,136,16,137,148,138,1001&isShard=true&shard.url=[ff01::083]:33332/_bm/s|[ff01::114]:33332/_bm/s|[ff01::213]:33332/_bm/s|http://127.0.0.1:44273/_bm/s/collection1&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1592278 INFO (qtp1059442885-13691) [ ] o.a.s.c.S.Request [collection1] webapp=/_bm/s path=/select params={q=*:*&shards=[ff01::083]:33332/_bm/s|[ff01::114]:33332/_bm/s|[ff01::213]:33332/_bm/s|http://127.0.0.1:44273/_bm/s/collection1&sort=n_f1+asc&wt=javabin&version=2} hits=68 status=0 QTime=4
[junit4] 2> 1592280 INFO (qtp1057698359-13675) [ ] o.a.s.c.S.Request [collection1] webapp=/_bm/s path=/select params={q=*:*&distrib=false&sort=n_tf1+desc&wt=javabin&version=2} hits=68 status=0 QTime=0
[junit4] 2> 1592282 INFO (qtp1059442885-13686) [ ] o.a.s.c.S.Request [collection1] webapp=/_bm/s path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_tf1+desc&shard.url=http://127.0.0.1:44273/_bm/s/collection1|[ff01::083]:33332/_bm/s|[ff01::213]:33332/_bm/s|[ff01::114]:33332/_bm/s&rows=10&version=2&q=*:*&NOW=1489706830612&isShard=true&wt=javabin} hits=68 status=0 QTime=0
[junit4] 2> 1592282 INFO (qtp1059442885-13693) [ ] o.a.s.c.S.Request [collection1] webapp=/_bm/s path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1489706830612&ids=11,123,14,4,6,139,128,109,140,10&isShard=true&shard.url=http://127.0.0.1:44273/_bm/s/collection1|[ff01::083]:33332/_bm/s|[ff01::213]:33332/_bm/s|[ff01::114]:33332/_bm/s&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1592283 INFO (qtp1059442885-13687) [ ] o.a.s.c.S.Request [collection1] webapp=/_bm/s path=/select params={q=*:*&shards=http://127.0.0.1:44273/_bm/s/collection1|[ff01::083]:33332/_bm/s|[ff01::213]:33332/_bm/s|[ff01::114]:33332/_bm/s&sort=n_tf1+desc&wt=javabin&version=2} hits=68 status=0 QTime=2
[junit4] 2> 1592285 INFO (qtp1057698359-13675) [ ] o.a.s.c.S.Request [collection1] webapp=/_bm/s path=/select params={q=*:*&distrib=false&sort=n_tf1+asc&wt=javabin&version=2} hits=68 status=0 QTime=0
[junit4] 2> 1592286 INFO (qtp1059442885-13691) [ ] o.a.s.c.S.Request [collection1] webapp=/_bm/s path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_tf1+asc&shard.url=http://127.0.0.1:44273/_bm/s/collection1|[ff01::083]:33332/_bm/s&rows=10&version=2&q=*:*&NOW=1489706830617&isShard=true&wt=javabin} hits=68 status=0 QTime=0
[junit4] 2> 1592287 INFO (qtp1059442885-13693) [ ] o.a.s.c.S.Request [collection1] webapp=/_bm/s path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1489706830617&ids=122,144,1,124,103,114,138,116,9,119&isShard=true&shard.url=http://127.0.0.1:44273/_bm/s/collection1|[ff01::083]:33332/_bm/s&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1592288 INFO (qtp1059442885-13692) [ ] o.a.s.c.S.Request [collection1] webapp=/_bm/s path=/select params={q=*:*&shards=http://127.0.0.1:44273/_bm/s/collection1|[ff01::083]:33332/_bm/s&sort=n_tf1+asc&wt=javabin&version=2} hits=68 status=0 QTime=2
[junit4] 2> 1592289 INFO (qtp1057698359-13675) [ ] o.a.s.c.S.Request [collection1] webapp=/_bm/s path=/select params={q=*:*&distrib=false&sort=n_d1+desc&wt=javabin&version=2} hits=68 status=0 QTime=0
[junit4] 2> 1592291 INFO (qtp1059442885-13687) [ ] o.a.s.c.S.Request [collection1] webapp=/_bm/s path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_d1+desc&shard.url=[ff01::213]:33332/_bm/s|http://127.0.0.1:44273/_bm/s/collection1&rows=10&version=2&q=*:*&NOW=1489706830621&isShard=true&wt=javabin} hits=68 status=0 QTime=0
[junit4] 2> 1592297 INFO (qtp1059442885-13693) [ ] o.a.s.c.S.Request [collection1] webapp=/_bm/s path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1489706830621&ids=110,133,15,136,4,115,104,149,128,109&isShard=true&shard.url=[ff01::213]:33332/_bm/s|http://127.0.0.1:44273/_bm/s/collection1&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1592298 INFO (qtp1059442885-13686) [ ] o.a.s.c.S.Request [collection1] webapp=/_bm/s path=/select params={q=*:*&shards=[ff01::213]:33332/_bm/s|http://127.0.0.1:44273/_bm/s/collection1&sort=n_d1+desc&wt=javabin&version=2} hits=68 status=0 QTime=7
[junit4] 2> 1592299 INFO (qtp1057698359-13675) [ ] o.a.s.c.S.Request [collection1] webapp=/_bm/s path=/select params={q=*:*&distrib=false&sort=n_d1+asc&wt=javabin&version=2} hits=68 status=0 QTime=0
[junit4] 2> 1592301 INFO (qtp1059442885-13692) [ ] o.a.s.c.S.Request [collection1] webapp=/_bm/s path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_d1+asc&shard.url=[ff01::213]:33332/_bm/s|[ff01::083]:33332/_bm/s|http://127.0.0.1:44273/_bm/s/collection1|[ff01::114]:33332/_bm/s&rows=10&version=2&q=*:*&NOW=1489706830631&isShard=true&wt=javabin} hits=68 status=0 QTime=0
[junit4] 2> 1592302 INFO (qtp1059442885-13693) [ ] o.a.s.c.S.Request [collection1] webapp=/_bm/s path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1489706830631&ids=144,1,2,13,113,147,5,118,141,120&isShard=true&shard.url=[ff01::213]:33332/_bm/s|[ff01::083]:33332/_bm/s|http://127.0.0.1:44273/_bm/s/collection1|[ff01::114]:33332/_bm/s&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1592303 INFO (qtp1059442885-13691) [ ] o.a.s.c.S.Request [collection1] webapp=/_bm/s path=/select params={q=*:*&shards=[ff01::213]:33332/_bm/s|[ff01::083]:33332/_bm/s|http://127.0.0.1:44273/_bm/s/collection1|[ff01::114]:33332/_bm/s&sort=n_d1+asc&wt=javabin&version=2} hits=68 status=0 QTime=2
[junit4] 2> 1592304 INFO (qtp1057698359-13676) [ ] o.a.s.c.S.Request [collection1] webapp=/_bm/s path=/select params={q=*:*&distrib=false&sort=n_td1+desc&wt=javabin&version=2} hits=68 status=0 QTime=0
[junit4] 2> 1592306 INFO (qtp1059442885-13686) [ ] o.a.s.c.S.Request [collection1] webapp=/_bm/s path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_td1+desc&shard.url=http://127.0.0.1:44273/_bm/s/collection1|[ff01::213]:33332/_bm/s|[ff01::114]:33332/_bm/s&rows=10&version=2&q=*:*&NOW=1489706830636&isShard=true&wt=javabin} hits=68 status=0 QTime=0
[junit4] 2> 1592307 INFO (qtp1059442885-13693) [ ] o.a.s.c.S.Request [collection1] webapp=/_bm/s path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1489706830636&ids=11,101,112,2,13,113,104,127,107,142&isShard=true&shard.url=http://127.0.0.1:44273/_bm/s/collection1|[ff01::213]:33332/_bm/s|[ff01::114]:33332/_bm/s&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1592309 INFO (qtp1059442885-13687) [ ] o.a.s.c.S.Request [collection1] webapp=/_bm/s path=/select params={q=*:*&shards=http://127.0.0.1:44273/_bm/s/collection1|[ff01::213]:33332/_bm/s|[ff01::114]:33332/_bm/s&sort=n_td1+desc&wt=javabin&version=2} hits=68 status=0 QTime=3
[junit4] 2> 1592310 INFO (qtp1057698359-13676) [ ] o.a.s.c.S.Request [collection1] webapp=/_bm/s path=/select params={q=*:*&distrib=false&sort=n_td1+asc&wt=javabin&version=2} hits=68 status=0 QTime=0
[junit4] 2> 1592312 INFO (qtp1059442885-13691) [ ] o.a.s.c.S.Request [collection1] webapp=/_bm/s path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_td1+asc&shard.url=http://127.0.0.1:44273/_bm/s/collection1|[ff01::114]:33332/_bm/s|[ff01::213]:33332/_bm/s&rows=10&version=2&q=*:*&NOW=1489706830643&isShard=true&wt=javabin} hits=68 status=0 QTime=0
[junit4] 2> 1592314 INFO (qtp1059442885-13691) [ ] o.a.s.c.S.Request [collection1] webapp=/_bm/s path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1489706830643&ids=143,121,145,147,4,137,7,129,9,141&isShard=true&shard.url=http://127.0.0.1:44273/_bm/s/collection1|[ff01::114]:33332/_bm/s|[ff01::213]:33332/_bm/s&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1592315 INFO (qtp1059442885-13692) [ ] o.a.s.c.S.Request [collection1] webapp=/_bm/s path=/select params={q=*:*&shards=http://127.0.0.1:44273/_bm/s/collection1|[ff01::114]:33332/_bm/s|[ff01::213]:33332/_bm/s&sort=n_td1+asc&wt=javabin&version=2} hits=68 status=0 QTime=2
[junit4] 2> 1592316 INFO (qtp1057698359-13676) [ ] o.a.s.c.S.Request [collection1] webapp=/_bm/s path=/select params={q=*:*&distrib=false&sort=n_l1+desc&wt=javabin&version=2} hits=68 status=0 QTime=0
[junit4] 2> 1592317 INFO (qtp1059442885-13687) [ ] o.a.s.c.S.Request [collection1] webapp=/_bm/s path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_l1+desc&shard.url=[ff01::114]:33332/_bm/s|[ff01::213]:33332/_bm/s|http://127.0.0.1:44273/_bm/s/collection1|[ff01::083]:33332/_bm/s&rows=10&version=2&q=*:*&NOW=1489706830648&isShard=true&wt=javabin} hits=68 status=0 QTime=0
[junit4] 2> 1592319 INFO (qtp1059442885-13687) [ ] o.a.s.c.S.Request [collection1] webapp=/_bm/s path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1489706830648&ids=121,144,135,147,103,114,104,137,1001,109&isShard=true&shard.url=[ff01::114]:33332/_bm/s|[ff01::213]:33332/_bm/s|http://127.0.0.1:44273/_bm/s/collection1|[ff01::083]:33332/_bm/s&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1592320 INFO (qtp1059442885-13686) [ ] o.a.s.c.S.Request [collection1] webapp=/_bm/s path=/select params={q=*:*&shards=[ff01::114]:33332/_bm/s|[ff01::213]:33332/_bm/s|http://127.0.0.1:44273/_bm/s/collection1|[ff01::083]:33332/_bm/s&sort=n_l1+desc&wt=javabin&version=2} hits=68 status=0 QTime=3
[junit4] 2> 1592321 INFO (qtp1057698359-13675) [ ] o.a.s.c.S.Request [collection1] webapp=/_bm/s path=/select params={q=*:*&distrib=false&sort=n_l1+asc&wt=javabin&version=2} hits=68 status=0 QTime=0
[junit4] 2> 1592323 INFO (qtp1059442885-13692) [ ] o.a.s.c.S.Request [collection1] webapp=/_bm/s path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_l1+asc&shard.url=[ff01::114]:33332/_bm/s|http://127.0.0.1:44273/_bm/s/collection1|[ff01::083]:33332/_bm/s|[ff01::213]:33332/_bm/s&rows=10&version=2&q=*:*&NOW=1489706830653&isShard=true&wt=javabin} hits=68 status=0 QTime=0
[junit4] 2> 1592324 INFO (qtp1059442885-13687) [ ] o.a.s.c.S.Request [collection1] webapp=/_bm/s path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1489706830653&ids=110,133,100,134,113,115,127,118,130,141&isShard=true&shard.url=[ff01::114]:33332/_bm/s|http://127.0.0.1:44273/_bm/s/collection1|[ff01::083]:33332/_bm/s|[ff01::213]:33332/_bm/s&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1592325 INFO (qtp1059442885-13693) [ ] o.a.s.c.S.Request [collection1] webapp=/_bm/s path=/select params={q=*:*&shards=[ff01::114]:33332/_bm/s|http://127.0.0.1:44273/_bm/s/collection1|[ff01::083]:33332/_bm/s|[ff01::213]:33332/_bm/s&sort=n_l1+asc&wt=javabin&version=2} hits=68 status=0 QTime=2
[junit4] 2> 1592326 INFO (qtp1057698359-13674) [ ] o.a.s.c.S.Request [collection1] webapp=/_bm/s path=/select params={q=*:*&distrib=false&sort=n_tl1+desc&wt=javabin&version=2} hits=68 status=0 QTime=0
[junit4] 2> 1592328 INFO (qtp1059442885-13687) [ ] o.a.s.c.S.Request [collection1] webapp=/_bm/s path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_tl1+desc&shard.url=http://127.0.0.1:44273/_bm/s/collection1&rows=10&version=2&q=*:*&NOW=1489706830658&isShard=true&wt=javabin} hits=68 status=0 QTime=0
[junit4] 2> 1592329 INFO (qtp1059442885-13686) [ ] o.a.s.c.S.Request [collection1] webapp=/_bm/s path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1489706830658&ids=123,145,3,14,146,147,126,117,139,107&isShard=true&shard.url=http://127.0.0.1:44273/_bm/s/collection1&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1592330 INFO (qtp1059442885-13691) [ ] o.a.s.c.S.Request [collection1] webapp=/_bm/s path=/select params={q=*:*&shards=http://127.0.0.1:44273/_bm/s/collection1&sort=n_tl1+desc&wt=javabi
[...truncated too long message...]
rch.test-seed#[4E896977EBBAC264]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1438398826
[junit4] 2> 1618544 INFO (TEST-TestDistributedSearch.test-seed#[4E896977EBBAC264]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 1618545 INFO (coreCloseExecutor-5814-thread-1) [ ] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@7b8cfcb6
[junit4] 2> 1618554 INFO (coreCloseExecutor-5814-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=2072837302
[junit4] 2> 1618555 INFO (TEST-TestDistributedSearch.test-seed#[4E896977EBBAC264]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@1e84e057{/_bm/s,null,UNAVAILABLE}
[junit4] 2> 1618556 INFO (TEST-TestDistributedSearch.test-seed#[4E896977EBBAC264]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@2806533c{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 1618556 INFO (TEST-TestDistributedSearch.test-seed#[4E896977EBBAC264]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1994620180
[junit4] 2> 1618556 INFO (TEST-TestDistributedSearch.test-seed#[4E896977EBBAC264]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 1618556 INFO (coreCloseExecutor-5816-thread-1) [ ] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@3b789ab1
[junit4] 2> 1618565 INFO (coreCloseExecutor-5816-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=997759665
[junit4] 2> 1618566 INFO (TEST-TestDistributedSearch.test-seed#[4E896977EBBAC264]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@137633bc{/_bm/s,null,UNAVAILABLE}
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestDistributedSearch -Dtests.method=test -Dtests.seed=4E896977EBBAC264 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=ca -Dtests.timezone=Australia/NSW -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
[junit4] FAILURE 31.6s J1 | TestDistributedSearch.test <<<
[junit4] > Throwable #1: java.lang.AssertionError: Expected to find shardAddress in the up shard info: {error=org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request,trace=org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request
[junit4] > at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:416)
[junit4] > at org.apache.solr.handler.component.HttpShardHandlerFactory.makeLoadBalancedRequest(HttpShardHandlerFactory.java:259)
[junit4] > at org.apache.solr.handler.component.HttpShardHandler.lambda$submit$0(HttpShardHandler.java:166)
[junit4] > at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
[junit4] > at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:514)
[junit4] > at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
[junit4] > at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:176)
[junit4] > at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:229)
[junit4] > at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1161)
[junit4] > at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635)
[junit4] > at java.base/java.lang.Thread.run(Thread.java:844)
[junit4] > ,time=1}
[junit4] > at __randomizedtesting.SeedInfo.seed([4E896977EBBAC264:C6DD56AD4546AF9C]:0)
[junit4] > at org.apache.solr.TestDistributedSearch.comparePartialResponses(TestDistributedSearch.java:1186)
[junit4] > at org.apache.solr.TestDistributedSearch.queryPartialResults(TestDistributedSearch.java:1127)
[junit4] > at org.apache.solr.TestDistributedSearch.test(TestDistributedSearch.java:987)
[junit4] > at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit4] > at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
[junit4] > at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4] > at java.base/java.lang.reflect.Method.invoke(Method.java:547)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsRepeatStatement.callStatement(BaseDistributedSearchTestCase.java:1011)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:960)
[junit4] > at java.base/java.lang.Thread.run(Thread.java:844)
[junit4] 2> 1618569 INFO (SUITE-TestDistributedSearch-seed#[4E896977EBBAC264]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_4E896977EBBAC264-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {severity=PostingsFormat(name=Memory), other_tl1=PostingsFormat(name=LuceneFixedGap), foo_sev_enum=Lucene50(blocksize=128), SubjectTerms_mfacet=PostingsFormat(name=LuceneFixedGap), a_n_tdt=Lucene50(blocksize=128), multiDefault=FST50, n_td1=FST50, b_n_tdt=PostingsFormat(name=LuceneFixedGap), n_ti1=Lucene50(blocksize=128), rnd_b=Lucene50(blocksize=128), n_tl1=FST50, a_s=PostingsFormat(name=Memory), oddField_s=PostingsFormat(name=Memory), n_tf1=PostingsFormat(name=LuceneFixedGap), lowerfilt1and2=FST50, a_t=PostingsFormat(name=LuceneFixedGap), foo_b=PostingsFormat(name=Memory), n_tdt1=PostingsFormat(name=LuceneFixedGap), lowerfilt=FST50, id=Lucene50(blocksize=128), text=PostingsFormat(name=Memory)}, docValues:{range_facet_l_dv=DocValuesFormat(name=Lucene70), foo_sev_enum=DocValuesFormat(name=Lucene70), n_l1=DocValuesFormat(name=Memory), intDefault=DocValuesFormat(name=Memory), n_dt1=DocValuesFormat(name=Direct), n_d1=DocValuesFormat(name=Memory), range_facet_l=DocValuesFormat(name=Memory), n_f1=DocValuesFormat(name=Direct), _version_=DocValuesFormat(name=Memory), foo_d=DocValuesFormat(name=Lucene70), range_facet_i_dv=DocValuesFormat(name=Memory), foo_f=DocValuesFormat(name=Asserting), intDvoDefault=DocValuesFormat(name=Asserting), a_i_ni_p=DocValuesFormat(name=Direct), timestamp=DocValuesFormat(name=Memory)}, maxPointsInLeafNode=648, maxMBSortInHeap=6.163415348104737, sim=RandomSimilarity(queryNorm=true): {}, locale=ca, timezone=Australia/NSW
[junit4] 2> NOTE: Linux 4.4.0-66-generic amd64/Oracle Corporation 9-ea (64-bit)/cpus=12,threads=1,free=248826720,total=509607936
[junit4] 2> NOTE: All tests run in this JVM: [TestQueryUtils, TlogReplayBufferedWhileIndexingTest, TestFieldResource, ConnectionManagerTest, DeleteReplicaTest, TestInfoStreamLogging, TestDownShardTolerantSearch, TestPushWriter, DocValuesTest, ZkControllerTest, TestFilteredDocIdSet, TestCustomStream, TestConfigSetProperties, TestSha256AuthenticationProvider, TestSolrCloudWithSecureImpersonation, BasicFunctionalityTest, TimeZoneUtilsTest, TestDynamicFieldCollectionResource, ForceLeaderTest, TestSimpleTrackingShardHandler, HdfsSyncSliceTest, LeaderInitiatedRecoveryOnShardRestartTest, CloudMLTQParserTest, TestSubQueryTransformerCrossCore, TestMissingGroups, TestFuzzyAnalyzedSuggestions, TestTrie, SortByFunctionTest, CdcrUpdateLogTest, JsonValidatorTest, ShardRoutingCustomTest, HdfsRecoverLeaseTest, WrapperMergePolicyFactoryTest, MultiThreadedOCPTest, TestSearchPerf, TestBM25SimilarityFactory, DistributedQueryComponentOptimizationTest, DOMUtilTest, TestCryptoKeys, PeerSyncReplicationTest, MoreLikeThisHandlerTest, TestComplexPhraseQParserPlugin, RollingRestartTest, TestCollectionAPIs, SimplePostToolTest, TestExactSharedStatsCache, TestInitQParser, SpatialHeatmapFacetsTest, CdcrRequestHandlerTest, TestTrackingShardHandlerFactory, TestSizeLimitedDistributedMap, TestConfigSetsAPI, TestCloudInspectUtil, TestStandardQParsers, TestSolrCloudWithHadoopAuthPlugin, TestSystemCollAutoCreate, TestSchemaNameResource, TestDFISimilarityFactory, ExitableDirectoryReaderTest, TestBackupRepositoryFactory, TolerantUpdateProcessorTest, DirectSolrSpellCheckerTest, TestDistributedGrouping, TestBinaryResponseWriter, TestSolrCoreSnapshots, TestManagedResourceStorage, SuggesterFSTTest, TestFastLRUCache, TestDistributedStatsComponentCardinality, SpellCheckCollatorTest, TestWordDelimiterFilterFactory, ConjunctionSolrSpellCheckerTest, ZkCLITest, ChaosMonkeySafeLeaderTest, TestAuthorizationFramework, HdfsBasicDistributedZk2Test, IndexSchemaRuntimeFieldTest, TestFiltering, ClassificationUpdateProcessorTest, SolrIndexMetricsTest, TestSolr4Spatial2, SimpleCollectionCreateDeleteTest, IndexSchemaTest, ZkSolrClientTest, SpatialRPTFieldTypeTest, DistanceFunctionTest, CleanupOldIndexTest, ShardRoutingTest, SolrXmlInZkTest, ChaosMonkeyNothingIsSafeTest, CollectionStateFormat2Test, TestStressRecovery, TestSolrCLIRunExample, FileUtilsTest, DistributedDebugComponentTest, DistribCursorPagingTest, BlockCacheTest, TestUpdate, BigEndianAscendingWordDeserializerTest, TestAddFieldRealTimeGet, BlockJoinFacetRandomTest, TestSolrQueryParserResource, TestClassNameShortening, SolrCmdDistributorTest, ShardSplitTest, TestReqParamsAPI, TestCharFilters, CdcrBootstrapTest, TestGeoJSONResponseWriter, SchemaVersionSpecificBehaviorTest, OverriddenZkACLAndCredentialsProvidersTest, AtomicUpdatesTest, CollectionsAPISolrJTest, OpenCloseCoreStressTest, LeaderElectionIntegrationTest, TestReplicationHandler, TestDistributedSearch]
[junit4] Completed [348/700 (2!)] on J1 in 31.62s, 1 test, 1 failure <<< FAILURES!
[...truncated 52838 lines...]