You are viewing a plain text version of this content. The canonical link for it is here.
Posted to builds@lucene.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2019/12/16 04:33:09 UTC
[JENKINS] Lucene-Solr-NightlyTests-master - Build # 2046 - Unstable
Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-master/2046/
3 tests failed.
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest
Error Message:
Suite timeout exceeded (>= 7200000 msec).
Stack Trace:
java.lang.Exception: Suite timeout exceeded (>= 7200000 msec).
at __randomizedtesting.SeedInfo.seed([89A94EC11D0B136F]:0)
FAILED: junit.framework.TestSuite.org.apache.solr.handler.TestReplicationHandler
Error Message:
ObjectTracker found 6 object(s) that were not released!!! [MockDirectoryWrapper, MockDirectoryWrapper, RawDirectoryWrapper, SolrCore, InternalHttpClient, MockDirectoryWrapper] org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MockDirectoryWrapper at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348) at org.apache.solr.core.SolrCore.getNewIndexDir(SolrCore.java:387) at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:764) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:988) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:900) at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1279) at org.apache.solr.core.CoreContainer.lambda$load$13(CoreContainer.java:786) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:202) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) at java.base/java.lang.Thread.run(Thread.java:834) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MockDirectoryWrapper at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348) at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:509) at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:351) at org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:422) at org.apache.solr.handler.ReplicationHandler.lambda$setupPolling$13(ReplicationHandler.java:1208) at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:515) at java.base/java.util.concurrent.FutureTask.runAndReset(FutureTask.java:305) at java.base/java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:305) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) at java.base/java.lang.Thread.run(Thread.java:834) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.RawDirectoryWrapper at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348) at org.apache.solr.core.SolrCore.initSnapshotMetaDataManager(SolrCore.java:535) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:980) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:900) at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1279) at org.apache.solr.core.CoreContainer.lambda$load$13(CoreContainer.java:786) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:202) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) at java.base/java.lang.Thread.run(Thread.java:834) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.solr.core.SolrCore at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:1075) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:900) at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1279) at org.apache.solr.core.CoreContainer.lambda$load$13(CoreContainer.java:786) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:202) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) at java.base/java.lang.Thread.run(Thread.java:834) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.http.impl.client.InternalHttpClient at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:322) at org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:331) at org.apache.solr.handler.IndexFetcher.createHttpClient(IndexFetcher.java:230) at org.apache.solr.handler.IndexFetcher.<init>(IndexFetcher.java:272) at org.apache.solr.handler.ReplicationHandler.inform(ReplicationHandler.java:1239) at org.apache.solr.core.SolrResourceLoader.inform(SolrResourceLoader.java:721) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:1022) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:900) at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1279) at org.apache.solr.core.CoreContainer.lambda$load$13(CoreContainer.java:786) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:202) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) at java.base/java.lang.Thread.run(Thread.java:834) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MockDirectoryWrapper at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348) at org.apache.solr.update.SolrIndexWriter.create(SolrIndexWriter.java:98) at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:796) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:988) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:900) at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1279) at org.apache.solr.core.CoreContainer.lambda$load$13(CoreContainer.java:786) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:202) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) at java.base/java.lang.Thread.run(Thread.java:834) expected null, but was:<ObjectTracker found 6 object(s) that were not released!!! [MockDirectoryWrapper, MockDirectoryWrapper, RawDirectoryWrapper, SolrCore, InternalHttpClient, MockDirectoryWrapper] org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MockDirectoryWrapper at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348) at org.apache.solr.core.SolrCore.getNewIndexDir(SolrCore.java:387) at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:764) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:988) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:900) at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1279) at org.apache.solr.core.CoreContainer.lambda$load$13(CoreContainer.java:786) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:202) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) at java.base/java.lang.Thread.run(Thread.java:834) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MockDirectoryWrapper at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348) at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:509) at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:351) at org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:422) at org.apache.solr.handler.ReplicationHandler.lambda$setupPolling$13(ReplicationHandler.java:1208) at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:515) at java.base/java.util.concurrent.FutureTask.runAndReset(FutureTask.java:305) at java.base/java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:305) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) at java.base/java.lang.Thread.run(Thread.java:834) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.RawDirectoryWrapper at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348) at org.apache.solr.core.SolrCore.initSnapshotMetaDataManager(SolrCore.java:535) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:980) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:900) at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1279) at org.apache.solr.core.CoreContainer.lambda$load$13(CoreContainer.java:786) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:202) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) at java.base/java.lang.Thread.run(Thread.java:834) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.solr.core.SolrCore at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:1075) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:900) at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1279) at org.apache.solr.core.CoreContainer.lambda$load$13(CoreContainer.java:786) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:202) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) at java.base/java.lang.Thread.run(Thread.java:834) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.http.impl.client.InternalHttpClient at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:322) at org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:331) at org.apache.solr.handler.IndexFetcher.createHttpClient(IndexFetcher.java:230) at org.apache.solr.handler.IndexFetcher.<init>(IndexFetcher.java:272) at org.apache.solr.handler.ReplicationHandler.inform(ReplicationHandler.java:1239) at org.apache.solr.core.SolrResourceLoader.inform(SolrResourceLoader.java:721) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:1022) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:900) at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1279) at org.apache.solr.core.CoreContainer.lambda$load$13(CoreContainer.java:786) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:202) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) at java.base/java.lang.Thread.run(Thread.java:834) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MockDirectoryWrapper at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348) at org.apache.solr.update.SolrIndexWriter.create(SolrIndexWriter.java:98) at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:796) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:988) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:900) at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1279) at org.apache.solr.core.CoreContainer.lambda$load$13(CoreContainer.java:786) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:202) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) at java.base/java.lang.Thread.run(Thread.java:834) >
Stack Trace:
java.lang.AssertionError: ObjectTracker found 6 object(s) that were not released!!! [MockDirectoryWrapper, MockDirectoryWrapper, RawDirectoryWrapper, SolrCore, InternalHttpClient, MockDirectoryWrapper]
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MockDirectoryWrapper
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348)
at org.apache.solr.core.SolrCore.getNewIndexDir(SolrCore.java:387)
at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:764)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:988)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:900)
at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1279)
at org.apache.solr.core.CoreContainer.lambda$load$13(CoreContainer.java:786)
at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:202)
at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
at java.base/java.lang.Thread.run(Thread.java:834)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MockDirectoryWrapper
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348)
at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:509)
at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:351)
at org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:422)
at org.apache.solr.handler.ReplicationHandler.lambda$setupPolling$13(ReplicationHandler.java:1208)
at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:515)
at java.base/java.util.concurrent.FutureTask.runAndReset(FutureTask.java:305)
at java.base/java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:305)
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
at java.base/java.lang.Thread.run(Thread.java:834)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.RawDirectoryWrapper
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348)
at org.apache.solr.core.SolrCore.initSnapshotMetaDataManager(SolrCore.java:535)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:980)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:900)
at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1279)
at org.apache.solr.core.CoreContainer.lambda$load$13(CoreContainer.java:786)
at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:202)
at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
at java.base/java.lang.Thread.run(Thread.java:834)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.solr.core.SolrCore
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:1075)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:900)
at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1279)
at org.apache.solr.core.CoreContainer.lambda$load$13(CoreContainer.java:786)
at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:202)
at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
at java.base/java.lang.Thread.run(Thread.java:834)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.http.impl.client.InternalHttpClient
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:322)
at org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:331)
at org.apache.solr.handler.IndexFetcher.createHttpClient(IndexFetcher.java:230)
at org.apache.solr.handler.IndexFetcher.<init>(IndexFetcher.java:272)
at org.apache.solr.handler.ReplicationHandler.inform(ReplicationHandler.java:1239)
at org.apache.solr.core.SolrResourceLoader.inform(SolrResourceLoader.java:721)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:1022)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:900)
at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1279)
at org.apache.solr.core.CoreContainer.lambda$load$13(CoreContainer.java:786)
at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:202)
at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
at java.base/java.lang.Thread.run(Thread.java:834)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MockDirectoryWrapper
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348)
at org.apache.solr.update.SolrIndexWriter.create(SolrIndexWriter.java:98)
at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:796)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:988)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:900)
at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1279)
at org.apache.solr.core.CoreContainer.lambda$load$13(CoreContainer.java:786)
at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:202)
at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
at java.base/java.lang.Thread.run(Thread.java:834)
expected null, but was:<ObjectTracker found 6 object(s) that were not released!!! [MockDirectoryWrapper, MockDirectoryWrapper, RawDirectoryWrapper, SolrCore, InternalHttpClient, MockDirectoryWrapper]
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MockDirectoryWrapper
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348)
at org.apache.solr.core.SolrCore.getNewIndexDir(SolrCore.java:387)
at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:764)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:988)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:900)
at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1279)
at org.apache.solr.core.CoreContainer.lambda$load$13(CoreContainer.java:786)
at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:202)
at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
at java.base/java.lang.Thread.run(Thread.java:834)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MockDirectoryWrapper
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348)
at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:509)
at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:351)
at org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:422)
at org.apache.solr.handler.ReplicationHandler.lambda$setupPolling$13(ReplicationHandler.java:1208)
at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:515)
at java.base/java.util.concurrent.FutureTask.runAndReset(FutureTask.java:305)
at java.base/java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:305)
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
at java.base/java.lang.Thread.run(Thread.java:834)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.RawDirectoryWrapper
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348)
at org.apache.solr.core.SolrCore.initSnapshotMetaDataManager(SolrCore.java:535)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:980)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:900)
at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1279)
at org.apache.solr.core.CoreContainer.lambda$load$13(CoreContainer.java:786)
at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:202)
at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
at java.base/java.lang.Thread.run(Thread.java:834)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.solr.core.SolrCore
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:1075)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:900)
at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1279)
at org.apache.solr.core.CoreContainer.lambda$load$13(CoreContainer.java:786)
at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:202)
at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
at java.base/java.lang.Thread.run(Thread.java:834)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.http.impl.client.InternalHttpClient
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:322)
at org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:331)
at org.apache.solr.handler.IndexFetcher.createHttpClient(IndexFetcher.java:230)
at org.apache.solr.handler.IndexFetcher.<init>(IndexFetcher.java:272)
at org.apache.solr.handler.ReplicationHandler.inform(ReplicationHandler.java:1239)
at org.apache.solr.core.SolrResourceLoader.inform(SolrResourceLoader.java:721)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:1022)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:900)
at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1279)
at org.apache.solr.core.CoreContainer.lambda$load$13(CoreContainer.java:786)
at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:202)
at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
at java.base/java.lang.Thread.run(Thread.java:834)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MockDirectoryWrapper
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348)
at org.apache.solr.update.SolrIndexWriter.create(SolrIndexWriter.java:98)
at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:796)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:988)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:900)
at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1279)
at org.apache.solr.core.CoreContainer.lambda$load$13(CoreContainer.java:786)
at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:202)
at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
at java.base/java.lang.Thread.run(Thread.java:834)
>
at __randomizedtesting.SeedInfo.seed([89A94EC11D0B136F]:0)
at org.junit.Assert.fail(Assert.java:88)
at org.junit.Assert.failNotNull(Assert.java:755)
at org.junit.Assert.assertNull(Assert.java:737)
at org.apache.solr.SolrTestCaseJ4.teardownTestCases(SolrTestCaseJ4.java:342)
at jdk.internal.reflect.GeneratedMethodAccessor82.invoke(Unknown Source)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:566)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1754)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:905)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:834)
FAILED: org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest.test
Error Message:
Test abandoned because suite timeout was reached.
Stack Trace:
java.lang.Exception: Test abandoned because suite timeout was reached.
at __randomizedtesting.SeedInfo.seed([89A94EC11D0B136F]:0)
Build Log:
[...truncated 13888 lines...]
[junit4] Suite: org.apache.solr.handler.TestReplicationHandler
[junit4] 2> 699909 INFO (SUITE-TestReplicationHandler-seed#[89A94EC11D0B136F]-worker) [ ] o.a.s.SolrTestCaseJ4 Created dataDir: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_89A94EC11D0B136F-001/data-dir-89-001
[junit4] 2> 699910 WARN (SUITE-TestReplicationHandler-seed#[89A94EC11D0B136F]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=9 numCloses=9
[junit4] 2> 699910 INFO (SUITE-TestReplicationHandler-seed#[89A94EC11D0B136F]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 699910 INFO (SUITE-TestReplicationHandler-seed#[89A94EC11D0B136F]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl="None")
[junit4] 2> 699910 INFO (SUITE-TestReplicationHandler-seed#[89A94EC11D0B136F]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 699913 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.a.s.SolrTestCaseJ4 ###Starting doTestIndexAndConfigAliasReplication
[junit4] 2> 699918 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_89A94EC11D0B136F-001/solr-instance-001/collection1
[junit4] 2> 699922 WARN (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 699922 WARN (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23
[junit4] 2> 699922 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 699922 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 699922 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.e.j.s.Server jetty-9.4.24.v20191120; built: 2019-11-20T21:37:49.771Z; git: 363d5f2df3a8a28de40604320230664b9c793c16; jvm 11.0.4+10-LTS
[junit4] 2> 699937 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 699937 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 699937 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 699939 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@36b8bad6{/solr,null,AVAILABLE}
[junit4] 2> 699939 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@ab2d9ca{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:٣٦٦٤٩}
[junit4] 2> 699939 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.e.j.s.Server Started @٦٩٩٩٧٦ms
[junit4] 2> 699939 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, solr.data.dir=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_89A94EC11D0B136F-001/solr-instance-001/collection1/data, hostPort=36649}
[junit4] 2> 699940 ERROR (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 699940 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 699940 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 9.0.0
[junit4] 2> 699940 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 699940 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 699940 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-12-16T02:15:07.114588Z
[junit4] 2> 699940 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_89A94EC11D0B136F-001/solr-instance-001/solr.xml
[junit4] 2> 699942 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 699942 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 699944 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@113ff3e4, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 699990 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 699991 WARN (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@6f172a03[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 699991 WARN (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@6f172a03[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 699996 WARN (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@78e8be15[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 699996 WARN (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@78e8be15[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 699998 WARN (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.a.s.c.CoreContainer Not all security plugins configured! authentication=disabled authorization=disabled. Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external. See https://s.apache.org/solrsecurity for more info
[junit4] 2> 700009 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 700009 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 700023 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@113ff3e4
[junit4] 2> 700029 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@113ff3e4
[junit4] 2> 700029 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@113ff3e4
[junit4] 2> 700030 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_89A94EC11D0B136F-001/solr-instance-001/.
[junit4] 2> 700030 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 700034 INFO (coreLoadExecutor-4045-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0
[junit4] 2> 700042 INFO (coreLoadExecutor-4045-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 700043 INFO (coreLoadExecutor-4045-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
[junit4] 2> 700043 INFO (coreLoadExecutor-4045-thread-1) [ x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_89A94EC11D0B136F-001/solr-instance-001/./collection1, trusted=true
[junit4] 2> 700043 INFO (coreLoadExecutor-4045-thread-1) [ x:collection1 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@113ff3e4
[junit4] 2> 700044 INFO (coreLoadExecutor-4045-thread-1) [ x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_89A94EC11D0B136F-001/solr-instance-001/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_89A94EC11D0B136F-001/solr-instance-001/./collection1/data/]
[junit4] 2> 700045 INFO (coreLoadExecutor-4045-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@3b35ab5d
[junit4] 2> 700085 INFO (coreLoadExecutor-4045-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 700085 INFO (coreLoadExecutor-4045-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 700086 INFO (coreLoadExecutor-4045-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=3, maxMergeAtOnceExplicit=9, maxMergedSegmentMB=16.2890625, floorSegmentMB=2.0224609375, forceMergeDeletesPctAllowed=27.99682540444757, segmentsPerTier=26.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0, deletesPctAllowed=41.97882505940096
[junit4] 2> 700086 INFO (coreLoadExecutor-4045-thread-1) [ x:collection1 ] o.a.s.s.SolrIndexSearcher Opening [Searcher@296b3d7b[collection1] main]
[junit4] 2> 700087 INFO (coreLoadExecutor-4045-thread-1) [ x:collection1 ] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_89A94EC11D0B136F-001/solr-instance-001/collection1/conf
[junit4] 2> 700087 INFO (coreLoadExecutor-4045-thread-1) [ x:collection1 ] o.a.s.h.ReplicationHandler Replication enabled for following config files: schema.xml,xslt/dummy.xsl
[junit4] 2> 700087 INFO (coreLoadExecutor-4045-thread-1) [ x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 700089 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_89A94EC11D0B136F-001/solr-instance-002/collection1
[junit4] 2> 700090 WARN (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 700090 WARN (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23
[junit4] 2> 700090 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 700090 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 700090 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.e.j.s.Server jetty-9.4.24.v20191120; built: 2019-11-20T21:37:49.771Z; git: 363d5f2df3a8a28de40604320230664b9c793c16; jvm 11.0.4+10-LTS
[junit4] 2> 700091 INFO (searcherExecutor-4046-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@296b3d7b[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 700093 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 700093 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 700093 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 700094 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@2305fcf5{/solr,null,AVAILABLE}
[junit4] 2> 700094 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@60fc8740{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:٣٦٢٠٩}
[junit4] 2> 700094 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.e.j.s.Server Started @٧٠٠١٣٠ms
[junit4] 2> 700094 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, solr.data.dir=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_89A94EC11D0B136F-001/solr-instance-002/collection1/data, hostPort=36209}
[junit4] 2> 700094 ERROR (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 700094 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 700094 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 9.0.0
[junit4] 2> 700094 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 700094 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 700094 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-12-16T02:15:07.268710Z
[junit4] 2> 700094 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_89A94EC11D0B136F-001/solr-instance-002/solr.xml
[junit4] 2> 700097 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 700097 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 700098 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@113ff3e4, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 700123 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 700124 WARN (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@43fea1ea[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 700124 WARN (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@43fea1ea[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 700126 WARN (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@f96e237[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 700126 WARN (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@f96e237[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 700127 WARN (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.a.s.c.CoreContainer Not all security plugins configured! authentication=disabled authorization=disabled. Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external. See https://s.apache.org/solrsecurity for more info
[junit4] 2> 700139 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 700139 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 700153 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@113ff3e4
[junit4] 2> 700161 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@113ff3e4
[junit4] 2> 700161 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@113ff3e4
[junit4] 2> 700163 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_89A94EC11D0B136F-001/solr-instance-002/.
[junit4] 2> 700163 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[89A94EC11D0B136F]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 700167 INFO (coreLoadExecutor-4058-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0
[junit4] 2> 700174 INFO (coreLoadExecutor-4058-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 700175 INFO (coreLoadExecutor-4058-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
[junit4] 2> 700175 INFO (coreLoadExecutor-4058-thread-1) [ x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_89A94EC11D0B136F-001/solr-instance-002/./collection1, trusted=true
[junit4] 2> 700175 INFO (coreLoadExecutor-4058-thread-1) [ x:collection1 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@113ff3e4
[junit4] 2> 700175 INFO (coreLoadExecutor-4058-thread-1) [ x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_89A94EC11D0B136F-001/solr-instance-002/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_89A94EC11D0B136F-001/solr-instance-002/./collection1/data/]
[junit4] 2> 700176 INFO (coreLoadExecutor-4058-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@469ce24c
[junit4] 2> 700212 INFO (coreLoadExecutor-4058-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 700212 INFO (coreLoadExecutor-4058-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 700213 INFO (coreLoadExecutor-4058-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=3, maxMergeAtOnceExplicit=9, maxMergedSegmentMB=16.2890625, floorSegmentMB=2.0224609375, forceMergeDeletesPctAllowed=27.99682540444757, segmentsPerTier=26.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0, deletesPctAllowed=41.97882505940096
[junit4] 2> 700213 INFO (coreLoadExecutor-4058-thread-1) [ x:collection1 ] o.a.s.s.SolrIndexSearcher Opening [Searcher@3a63d28f[collection1] main]
[junit4] 2> 700214 INFO (coreLoadExecutor-4058-thread-1) [ x:collection1 ] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_89A94EC11D0B136F-001/solr-instance-002/collection1/conf
[junit4] 2> 700215 INFO (coreLoadExecutor-4058-thread-1) [ x:collection1 ] o.a.s.h.ReplicationHandler Poll scheduled at an interval of 1000ms
[junit4] 2> 700215 INFO (coreLoadExecutor-4058-thread-1) [ x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 700216 INFO (searcherExecutor-4059-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@3a63d28f[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 700217 INFO (qtp297594151-12429) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=*:*&sort=id+desc&wt=javabin&version=2} hits=0 status=0 QTime=0
[junit4] 2> 700221 INFO (qtp297594151-12430) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[0]} 0 3
[junit4] 2> 700222 INFO (qtp297594151-12431) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[1]} 0 0
[junit4] 2> 700223 INFO (qtp297594151-12432) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[2]} 0 0
[junit4] 2> 700223 INFO (qtp297594151-12429) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 QTime=0
[junit4] 2> 700224 INFO (indexFetcher-4063-thread-1) [ ] o.a.s.h.IndexFetcher Master's generation: 1
[junit4] 2> 700224 INFO (indexFetcher-4063-thread-1) [ ] o.a.s.h.IndexFetcher Master's version: 0
[junit4] 2> 700224 INFO (indexFetcher-4063-thread-1) [ ] o.a.s.h.IndexFetcher Slave's generation: 1
[junit4] 2> 700224 INFO (indexFetcher-4063-thread-1) [ ] o.a.s.h.IndexFetcher Slave's version: 0
[junit4] 2> 700224 INFO (indexFetcher-4063-thread-1) [ ] o.a.s.h.IndexFetcher New index in Master. Deleting mine...
[junit4] 2> 700225 INFO (indexFetcher-4063-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@729c64cd[collection1] main]
[junit4] 2> 700225 INFO (qtp297594151-12430) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[3]} 0 1
[junit4] 2> 700226 INFO (qtp297594151-12431) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[4]} 0 0
[junit4] 2> 700226 INFO (searcherExecutor-4059-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@729c64cd[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 700226 INFO (qtp297594151-12432) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[5]} 0 0
[junit4] 2> 700227 INFO (qtp297594151-12428) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[6]} 0 0
[junit4] 2> 700227 INFO (qtp297594151-12429) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[7]} 0 0
[junit4] 2> 700228 INFO (qtp297594151-12430) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[8]} 0 0
[junit4] 2> 700228 INFO (qtp297594151-12431) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[9]} 0 0
[junit4] 2> 700228 INFO (qtp297594151-12432) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[10]} 0 0
[junit4] 2> 700229 INFO (qtp297594151-12428) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[11]} 0 0
[junit4] 2> 700229 INFO (qtp297594151-12429) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[12]} 0 0
[junit4] 2> 700229 INFO (qtp297594151-12430) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[13]} 0 0
[junit4] 2> 700230 INFO (qtp297594151-12431) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[14]} 0 0
[junit4] 2> 700230 INFO (qtp297594151-12432) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[15]} 0 0
[junit4] 2> 700230 INFO (qtp297594151-12428) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[16]} 0 0
[junit4] 2> 700231 INFO (qtp297594151-12429) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[17]} 0 0
[junit4] 2> 700231 INFO (qtp297594151-12430) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[18]} 0 0
[junit4] 2> 700231 INFO (qtp297594151-12431) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[19]} 0 0
[junit4] 2> 700232 INFO (qtp297594151-12432) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[20]} 0 0
[junit4] 2> 700232 INFO (qtp297594151-12428) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[21]} 0 0
[junit4] 2> 700232 INFO (qtp297594151-12429) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[22]} 0 0
[junit4] 2> 700233 INFO (qtp297594151-12430) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[23]} 0 0
[junit4] 2> 700233 INFO (qtp297594151-12431) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[24]} 0 0
[junit4] 2> 700233 INFO (qtp297594151-12432) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[25]} 0 0
[junit4] 2> 700234 INFO (qtp297594151-12428) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[26]} 0 0
[junit4] 2> 700234 INFO (qtp297594151-12429) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[27]} 0 0
[junit4] 2> 700234 INFO (qtp297594151-12430) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[28]} 0 0
[junit4] 2> 700234 INFO (qtp297594151-12431) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[29]} 0 0
[junit4] 2> 700235 INFO (qtp297594151-12432) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[30]} 0 0
[junit4] 2> 700235 INFO (qtp297594151-12428) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[31]} 0 0
[junit4] 2> 700235 INFO (qtp297594151-12429) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[32]} 0 0
[junit4] 2> 700236 INFO (qtp297594151-12430) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[33]} 0 0
[junit4] 2> 700236 INFO (qtp297594151-12431) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[34]} 0 0
[junit4] 2> 700236 INFO (qtp297594151-12432) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[35]} 0 0
[junit4] 2> 700237 INFO (qtp297594151-12428) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[36]} 0 0
[junit4] 2> 700237 INFO (qtp297594151-12429) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[37]} 0 0
[junit4] 2> 700237 INFO (qtp297594151-12430) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[38]} 0 0
[junit4] 2> 700237 INFO (qtp297594151-12431) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[39]} 0 0
[junit4] 2> 700238 INFO (qtp297594151-12432) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[40]} 0 0
[junit4] 2> 700238 INFO (qtp297594151-12428) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[41]} 0 0
[junit4] 2> 700238 INFO (qtp297594151-12429) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[42]} 0 0
[junit4] 2> 700239 INFO (qtp297594151-12430) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[43]} 0 0
[junit4] 2> 700239 INFO (qtp297594151-12431) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[44]} 0 0
[junit4] 2> 700239 INFO (qtp297594151-12432) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[45]} 0 0
[junit4] 2> 700240 INFO (qtp297594151-12428) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[46]} 0 0
[junit4] 2> 700240 INFO (qtp297594151-12429) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[47]} 0 0
[junit4] 2> 700240 INFO (qtp297594151-12430) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[48]} 0 0
[junit4] 2> 700241 INFO (qtp297594151-12431) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[49]} 0 0
[junit4] 2> 700241 INFO (qtp297594151-12432) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[50]} 0 0
[junit4] 2> 700241 INFO (qtp297594151-12428) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[51]} 0 0
[junit4] 2> 700241 INFO (qtp297594151-12429) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[52]} 0 0
[junit4] 2> 700242 INFO (qtp297594151-12430) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[53]} 0 0
[junit4] 2> 700242 INFO (qtp297594151-12431) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[54]} 0 0
[junit4] 2> 700242 INFO (qtp297594151-12432) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[55]} 0 0
[junit4] 2> 700243 INFO (qtp297594151-12428) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[56]} 0 0
[junit4] 2> 700243 INFO (qtp297594151-12429) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[57]} 0 0
[junit4] 2> 700243 INFO (qtp297594151-12430) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[58]} 0 0
[junit4] 2> 700244 INFO (qtp297594151-12431) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[59]} 0 0
[junit4] 2> 700244 INFO (qtp297594151-12432) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[60]} 0 0
[junit4] 2> 700244 INFO (qtp297594151-12428) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[61]} 0 0
[junit4] 2> 700245 INFO (qtp297594151-12429) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[62]} 0 0
[junit4] 2> 700245 INFO (qtp297594151-12430) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[63]} 0 0
[junit4] 2> 700245 INFO (qtp297594151-12431) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[64]} 0 0
[junit4] 2> 700245 INFO (qtp297594151-12432) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[65]} 0 0
[junit4] 2> 700246 INFO (qtp297594151-12428) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[66]} 0 0
[junit4] 2> 700246 INFO (qtp297594151-12429) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[67]} 0 0
[junit4] 2> 700246 INFO (qtp297594151-12430) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[68]} 0 0
[junit4] 2> 700247 INFO (qtp297594151-12431) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[69]} 0 0
[junit4] 2> 700247 INFO (qtp297594151-12432) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[70]} 0 0
[junit4] 2> 700247 INFO (qtp297594151-12428) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[71]} 0 0
[junit4] 2> 700248 INFO (qtp297594151-12429) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[72]} 0 0
[junit4] 2> 700248 INFO (qtp297594151-12430) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[73]} 0 0
[junit4] 2> 700248 INFO (qtp297594151-12431) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[74]} 0 0
[junit4] 2> 700248 INFO (qtp297594151-12432) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[75]} 0 0
[junit4] 2> 700249 INFO (qtp297594151-12428) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[76]} 0 0
[junit4] 2> 700249 INFO (qtp297594151-12429) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[77]} 0 0
[junit4] 2> 700249 INFO (qtp297594151-12430) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[78]} 0 0
[junit4] 2> 700250 INFO (qtp297594151-12431) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[79]} 0 0
[junit4] 2> 700250 INFO (qtp297594151-12432) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[80]} 0 0
[junit4] 2> 700250 INFO (qtp297594151-12428) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[81]} 0 0
[junit4] 2> 700251 INFO (qtp297594151-12429) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[82]} 0 0
[junit4] 2> 700251 INFO (qtp297594151-12430) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[83]} 0 0
[junit4] 2> 700251 INFO (qtp297594151-12431) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[84]} 0 0
[junit4] 2> 700251 INFO (qtp297594151-12432) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[85]} 0 0
[junit4] 2> 700253 INFO (qtp297594151-12428) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[86]} 0 0
[junit4] 2> 700253 INFO (qtp297594151-12429) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[87]} 0 0
[junit4] 2> 700253 INFO (qtp297594151-12430) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[88]} 0 0
[junit4] 2> 700254 INFO (qtp297594151-12431) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[89]} 0 0
[junit4] 2> 700255 INFO (qtp297594151-12432) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[90]} 0 0
[junit4] 2> 700255 INFO (qtp297594151-12428) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[91]} 0 0
[junit4] 2> 700256 INFO (qtp297594151-12429) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[92]} 0 0
[junit4] 2> 700257 INFO (qtp297594151-12430) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[93]} 0 0
[junit4] 2> 700257 INFO (qtp297594151-12431) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[94]} 0 0
[junit4] 2> 700259 INFO (qtp297594151-12432) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[95]} 0 0
[junit4] 2> 700259 INFO (qtp297594151-12428) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[96]} 0 0
[junit4] 2> 700259 INFO (qtp297594151-12429) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[97]} 0 0
[junit4] 2> 700260 INFO (qtp297594151-12430) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[98]} 0 0
[junit4] 2> 700260 INFO (qtp297594151-12431) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[99]} 0 0
[junit4] 2> 700260 INFO (qtp297594151-12432) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[100]} 0 0
[junit4] 2> 700261 INFO (qtp297594151-12428) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[101]} 0 0
[junit4] 2> 700261 INFO (qtp297594151-12429) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[102]} 0 0
[junit4] 2> 700261 INFO (qtp297594151-12430) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[103]} 0 0
[junit4] 2> 700262 INFO (qtp297594151-12431) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[104]} 0 0
[junit4] 2> 700262 INFO (qtp297594151-12432) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[105]} 0 0
[junit4] 2> 700262 INFO (qtp297594151-12428) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[106]} 0 0
[junit4] 2> 700263 INFO (qtp297594151-12429) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[107]} 0 0
[junit4] 2> 700263 INFO (qtp297594151-12430) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[108]} 0 0
[junit4] 2> 700263 INFO (qtp297594151-12431) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[109]} 0 0
[junit4] 2> 700263 INFO (qtp297594151-12432) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[110]} 0 0
[junit4] 2> 700264 INFO (qtp297594151-12428) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[111]} 0 0
[junit4] 2> 700264 INFO (qtp297594151-12429) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[112]} 0 0
[junit4] 2> 700264 INFO (qtp297594151-12430) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[113]} 0 0
[junit4] 2> 700265 INFO (qtp297594151-12431) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[114]} 0 0
[junit4] 2> 700265 INFO (qtp297594151-12432) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[115]} 0 0
[junit4] 2> 700265 INFO (qtp297594151-12428) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[116]} 0 0
[junit4] 2> 700266 INFO (qtp297594151-12429) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[117]} 0 0
[junit4] 2> 700266 INFO (qtp297594151-12430) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[118]} 0 0
[junit4] 2> 700266 INFO (qtp297594151-12431) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[119]} 0 0
[junit4] 2> 700267 INFO (qtp297594151-12432) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[120]} 0 0
[junit4] 2> 700267 INFO (qtp297594151-12428) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[121]} 0 0
[junit4] 2> 700267 INFO (qtp297594151-12429) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[122]} 0 0
[junit4] 2> 700268 INFO (qtp297594151-12430) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[123]} 0 0
[junit4] 2> 700268 INFO (qtp297594151-12431) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[124]} 0 0
[junit4] 2> 700268 INFO (qtp297594151-12432) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[125]} 0 0
[junit4] 2> 700268 INFO (qtp297594151-12428) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[126]} 0 0
[junit4] 2> 700269 INFO (qtp297594151-12429) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[127]} 0 0
[junit4] 2> 700269 INFO (qtp297594151-12430) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[128]} 0 0
[junit4] 2> 700269 INFO (qtp297594151-12431) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[129]} 0 0
[junit4] 2> 700270 INFO (qtp297594151-12432) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[130]} 0 0
[junit4] 2> 700270 INFO (qtp297594151-12428) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[131]} 0 0
[junit4] 2> 700270 INFO (qtp297594151-12429) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[132]} 0 0
[junit4] 2> 700271 INFO (qtp297594151-12430) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[133]} 0 0
[junit4] 2> 700271 INFO (qtp297594151-12431) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[134]} 0 0
[junit4] 2> 700271 INFO (qtp297594151-12432) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[135]} 0 0
[junit4] 2> 700272 INFO (qtp297594151-12428) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[136]} 0 0
[junit4] 2> 700272 INFO (qtp297594151-12429) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[137]} 0 0
[junit4] 2> 700272 INFO (qtp297594151-12430) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[138]} 0 0
[junit4] 2> 700272 INFO (qtp297594151-12431) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[139]} 0 0
[junit4] 2> 700273 INFO (qtp297594151-12432) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[140]} 0 0
[junit4] 2> 700273 INFO (qtp297594151-12428) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[141]} 0 0
[junit4] 2> 700273 INFO (qtp297594151-12429) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[142]} 0 0
[junit4] 2> 700274 INFO (qtp297594151-12430) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[143]} 0 0
[junit4] 2> 700274 INFO (qtp297594151-12431) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[144]} 0 0
[junit4] 2> 700274 INFO (qtp297594151-12432) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection
[...truncated too long message...]
10256-9536, state=TIMED_WAITING, group=TGRP-ChaosMonkeyNothingIsSafeTest]
[junit4] 2> at java.base@11.0.4/jdk.internal.misc.Unsafe.park(Native Method)
[junit4] 2> at java.base@11.0.4/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:234)
[junit4] 2> at java.base@11.0.4/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2123)
[junit4] 2> at app//org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:382)
[junit4] 2> at app//org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.idleJobPoll(QueuedThreadPool.java:875)
[junit4] 2> at app//org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:925)
[junit4] 2> at java.base@11.0.4/java.lang.Thread.run(Thread.java:834)
[junit4] 2> 445) Thread[id=9955, name=watches-2596-thread-2, state=TIMED_WAITING, group=TGRP-ChaosMonkeyNothingIsSafeTest]
[junit4] 2> at java.base@11.0.4/jdk.internal.misc.Unsafe.park(Native Method)
[junit4] 2> at java.base@11.0.4/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:234)
[junit4] 2> at java.base@11.0.4/java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:462)
[junit4] 2> at java.base@11.0.4/java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:361)
[junit4] 2> at java.base@11.0.4/java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:937)
[junit4] 2> at java.base@11.0.4/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1053)
[junit4] 2> at java.base@11.0.4/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1114)
[junit4] 2> at java.base@11.0.4/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
[junit4] 2> at java.base@11.0.4/java.lang.Thread.run(Thread.java:834)
[junit4] 2> 446) Thread[id=9753, name=Thread-2544, state=WAITING, group=TGRP-ChaosMonkeyNothingIsSafeTest]
[junit4] 2> at java.base@11.0.4/java.lang.Object.wait(Native Method)
[junit4] 2> at java.base@11.0.4/java.lang.Object.wait(Object.java:328)
[junit4] 2> at app//org.apache.solr.core.CloserThread.run(CoreContainer.java:2066)
[junit4] 2> 447) Thread[id=10087, name=h2sc-2572-thread-7, state=WAITING, group=TGRP-ChaosMonkeyNothingIsSafeTest]
[junit4] 2> at java.base@11.0.4/jdk.internal.misc.Unsafe.park(Native Method)
[junit4] 2> at java.base@11.0.4/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
[junit4] 2> at java.base@11.0.4/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2081)
[junit4] 2> at app//org.eclipse.jetty.util.BlockingArrayQueue.take(BlockingArrayQueue.java:342)
[junit4] 2> at java.base@11.0.4/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1054)
[junit4] 2> at java.base@11.0.4/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1114)
[junit4] 2> at java.base@11.0.4/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
[junit4] 2> at java.base@11.0.4/java.lang.Thread.run(Thread.java:834)
[junit4] 2> 448) Thread[id=10251, name=h2sc-2581-thread-20, state=WAITING, group=TGRP-ChaosMonkeyNothingIsSafeTest]
[junit4] 2> at java.base@11.0.4/jdk.internal.misc.Unsafe.park(Native Method)
[junit4] 2> at java.base@11.0.4/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
[junit4] 2> at java.base@11.0.4/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2081)
[junit4] 2> at app//org.eclipse.jetty.util.BlockingArrayQueue.take(BlockingArrayQueue.java:342)
[junit4] 2> at java.base@11.0.4/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1054)
[junit4] 2> at java.base@11.0.4/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1114)
[junit4] 2> at java.base@11.0.4/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
[junit4] 2> at java.base@11.0.4/java.lang.Thread.run(Thread.java:834)
[junit4] 2> 449) Thread[id=9692, name=h2sc-2583-thread-1, state=RUNNABLE, group=TGRP-ChaosMonkeyNothingIsSafeTest]
[junit4] 2> at java.base@11.0.4/sun.nio.ch.EPoll.wait(Native Method)
[junit4] 2> at java.base@11.0.4/sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:120)
[junit4] 2> at java.base@11.0.4/sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:124)
[junit4] 2> at java.base@11.0.4/sun.nio.ch.SelectorImpl.select(SelectorImpl.java:141)
[junit4] 2> at app//org.eclipse.jetty.io.ManagedSelector$SelectorProducer.select(ManagedSelector.java:472)
[junit4] 2> at app//org.eclipse.jetty.io.ManagedSelector$SelectorProducer.produce(ManagedSelector.java:409)
[junit4] 2> at app//org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produceTask(EatWhatYouKill.java:360)
[junit4] 2> at app//org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:184)
[junit4] 2> at app//org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.tryProduce(EatWhatYouKill.java:171)
[junit4] 2> at app//org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produce(EatWhatYouKill.java:135)
[junit4] 2> at app//org.eclipse.jetty.io.ManagedSelector$$Lambda$201/0x0000000100469840.run(Unknown Source)
[junit4] 2> at app//org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
[junit4] 2> at app//org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$$Lambda$202/0x0000000100469040.run(Unknown Source)
[junit4] 2> at java.base@11.0.4/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
[junit4] 2> at java.base@11.0.4/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
[junit4] 2> at java.base@11.0.4/java.lang.Thread.run(Thread.java:834)
[junit4] 2> NOTE: test params are: codec=Lucene84, sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@61ff377d), locale=dyo-SN, timezone=Australia/West
[junit4] 2> 7748158 INFO (closeThreadPool-2710-thread-7) [ ] o.a.s.c.ZkController Publish this node as DOWN...
[junit4] 2> 7748158 INFO (closeThreadPool-2710-thread-7) [ ] o.a.s.c.ZkController Publish node=127.0.0.1:44327_dwn%2Fum as DOWN
[junit4] 2> 7748158 INFO (closeThreadPool-2710-thread-11) [ ] o.a.s.c.ZkController Publish this node as DOWN...
[junit4] 2> 7748158 INFO (closeThreadPool-2710-thread-11) [ ] o.a.s.c.ZkController Publish node=127.0.0.1:35373_dwn%2Fum as DOWN
[junit4] 2> 7748158 INFO (closeThreadPool-2710-thread-6) [ ] o.a.s.c.ZkController Publish this node as DOWN...
[junit4] 2> 7748158 INFO (closeThreadPool-2710-thread-6) [ ] o.a.s.c.ZkController Publish node=127.0.0.1:40719_dwn%2Fum as DOWN
[junit4] 2> 7748164 WARN (NIOWorkerThread-2) [ ] o.a.z.s.NIOServerCnxn Exception causing close of session 0x0: ZooKeeperServer not running
[junit4] 2> NOTE: Linux 4.15.0-54-generic amd64/Oracle Corporation 11.0.4 (64-bit)/cpus=4,threads=486,free=206644752,total=486539264
[junit4] 2> NOTE: All tests run in this JVM: [ConfigureRecoveryStrategyTest, JWTAuthPluginTest, TestRecoveryHdfs, TestSimExecutePlanAction, TestSolrJ, TestLeaderElectionZkExpiry, TestLazyCores, HdfsDirectoryTest, QueryParsingTest, SchemaVersionSpecificBehaviorTest, LeaderFailoverAfterPartitionTest, TestJettySolrRunner, ShardsWhitelistTest, TestJsonRequest, TestCloudPivotFacet, TestCryptoKeys, TestFieldCacheSort, OverseerStatusTest, ChaosMonkeySafeLeaderWithPullReplicasTest, TestExactSharedStatsCacheCloud, IgnoreCommitOptimizeUpdateProcessorFactoryTest, ExitableDirectoryReaderTest, TestExtendedDismaxParser, TestExactSharedStatsCache, TestSolrXml, TestSimComputePlanAction, TestRestoreCore, PreAnalyzedFieldManagedSchemaCloudTest, SpellingQueryConverterTest, BinaryUpdateRequestHandlerTest, TestCloudRecovery2, SynonymTokenizerTest, SolrInfoBeanTest, DirectUpdateHandlerTest, TriggerIntegrationTest, TestScoreJoinQPNoScore, TestSystemIdResolver, TestExceedMaxTermLength, DeleteShardTest, TestSystemCollAutoCreate, CloudExitableDirectoryReaderTest, OverseerCollectionConfigSetProcessorTest, TestConfigsApi, TestSimPolicyCloud, DirectSolrSpellCheckerTest, TestHighlightDedupGrouping, SuggesterWFSTTest, TestCustomSort, TestShortCircuitedRequests, TestSimLargeCluster, TestSortByMinMaxFunction, ChaosMonkeyNothingIsSafeTest]
[junit4] 2> NOTE: download the large Jenkins line-docs file by running 'ant get-jenkins-line-docs' in the lucene directory.
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=ChaosMonkeyNothingIsSafeTest -Dtests.seed=89A94EC11D0B136F -Dtests.multiplier=2 -Dtests.nightly=true -Dtests.slow=true -Dtests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/test-data/enwiki.random.lines.txt -Dtests.locale=dyo-SN -Dtests.timezone=Australia/West -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] ERROR 0.00s J1 | ChaosMonkeyNothingIsSafeTest (suite) <<<
[junit4] > Throwable #1: java.lang.Exception: Suite timeout exceeded (>= 7200000 msec).
[junit4] > at __randomizedtesting.SeedInfo.seed([89A94EC11D0B136F]:0)
[junit4] Completed [796/893 (2!)] on J1 in 7216.96s, 1 test, 2 errors <<< FAILURES!
[...truncated 53223 lines...]
[JENKINS] Lucene-Solr-NightlyTests-master - Build # 2047 - Failure
Posted by Apache Jenkins Server <je...@builds.apache.org>.
Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-master/2047/
1 tests failed.
FAILED: org.apache.lucene.index.TestBinaryDocValuesUpdates.testTonsOfUpdates
Error Message:
ReaderPool is already closed
Stack Trace:
org.apache.lucene.store.AlreadyClosedException: ReaderPool is already closed
at org.apache.lucene.index.ReaderPool.get(ReaderPool.java:369)
at org.apache.lucene.index.IndexWriter.writeSomeDocValuesUpdates(IndexWriter.java:625)
at org.apache.lucene.index.FrozenBufferedUpdates.forceApply(FrozenBufferedUpdates.java:253)
at org.apache.lucene.index.FrozenBufferedUpdates.tryApply(FrozenBufferedUpdates.java:158)
at org.apache.lucene.index.IndexWriter.lambda$publishFrozenUpdates$3(IndexWriter.java:2575)
at org.apache.lucene.index.IndexWriter.processEvents(IndexWriter.java:5099)
at org.apache.lucene.index.IndexWriter.updateDocValues(IndexWriter.java:1770)
at org.apache.lucene.index.TestBinaryDocValuesUpdates.testTonsOfUpdates(TestBinaryDocValuesUpdates.java:1324)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:566)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1754)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:942)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:978)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:992)
at org.apache.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:951)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:836)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:887)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:898)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:834)
Build Log:
[...truncated 1379 lines...]
[junit4] Suite: org.apache.lucene.index.TestBinaryDocValuesUpdates
[junit4] 1> TEST: isNRT=false reader1=StandardDirectoryReader(segments_1:4 _0(9.0.0):C2:[diagnostics={os=Linux, java.vendor=Oracle Corporation, os.version=4.15.0-54-generic, java.runtime.version=11.0.4+10-LTS, os.arch=amd64, source=flush, lucene.version=9.0.0, java.vm.version=11.0.4+10-LTS, java.version=11.0.4, timestamp=1576537549555}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])
[junit4] 1> TEST: now reopen
[junit4] 2> NOTE: download the large Jenkins line-docs file by running 'ant get-jenkins-line-docs' in the lucene directory.
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestBinaryDocValuesUpdates -Dtests.method=testTonsOfUpdates -Dtests.seed=31E61EFFD4EC2665 -Dtests.multiplier=2 -Dtests.nightly=true -Dtests.slow=true -Dtests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/test-data/enwiki.random.lines.txt -Dtests.locale=ti -Dtests.timezone=America/Coral_Harbour -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] ERROR 48.1s J0 | TestBinaryDocValuesUpdates.testTonsOfUpdates <<<
[junit4] > Throwable #1: org.apache.lucene.store.AlreadyClosedException: ReaderPool is already closed
[junit4] > at org.apache.lucene.index.ReaderPool.get(ReaderPool.java:369)
[junit4] > at org.apache.lucene.index.IndexWriter.writeSomeDocValuesUpdates(IndexWriter.java:625)
[junit4] > at org.apache.lucene.index.FrozenBufferedUpdates.forceApply(FrozenBufferedUpdates.java:253)
[junit4] > at org.apache.lucene.index.FrozenBufferedUpdates.tryApply(FrozenBufferedUpdates.java:158)
[junit4] > at org.apache.lucene.index.IndexWriter.lambda$publishFrozenUpdates$3(IndexWriter.java:2575)
[junit4] > at org.apache.lucene.index.IndexWriter.processEvents(IndexWriter.java:5099)
[junit4] > at org.apache.lucene.index.IndexWriter.updateDocValues(IndexWriter.java:1770)
[junit4] > at org.apache.lucene.index.TestBinaryDocValuesUpdates.testTonsOfUpdates(TestBinaryDocValuesUpdates.java:1324)
[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:566)
[junit4] > at java.base/java.lang.Thread.run(Thread.java:834)Throwable #2: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=7607, name=Lucene Merge Thread #4, state=RUNNABLE, group=TGRP-TestBinaryDocValuesUpdates]
[junit4] > Caused by: org.apache.lucene.index.MergePolicy$MergeException: java.lang.OutOfMemoryError: Java heap space
[junit4] > at __randomizedtesting.SeedInfo.seed([31E61EFFD4EC2665]:0)
[junit4] > at org.apache.lucene.index.ConcurrentMergeScheduler.handleMergeException(ConcurrentMergeScheduler.java:704)
[junit4] > at org.apache.lucene.index.ConcurrentMergeScheduler$MergeThread.run(ConcurrentMergeScheduler.java:684)
[junit4] > Caused by: java.lang.OutOfMemoryError: Java heap space
[junit4] > at java.base/java.nio.HeapByteBuffer.<init>(HeapByteBuffer.java:61)
[junit4] > at java.base/java.nio.ByteBuffer.allocate(ByteBuffer.java:348)
[junit4] > at org.apache.lucene.store.ByteBuffersDataOutput$$Lambda$96/0x0000000100172c40.apply(Unknown Source)
[junit4] > at org.apache.lucene.store.ByteBuffersDataOutput.appendBlock(ByteBuffersDataOutput.java:450)
[junit4] > at org.apache.lucene.store.ByteBuffersDataOutput.writeBytes(ByteBuffersDataOutput.java:188)
[junit4] > at org.apache.lucene.store.ByteBuffersDataOutput.rewriteToBlockSize(ByteBuffersDataOutput.java:465)
[junit4] > at org.apache.lucene.store.ByteBuffersDataOutput.appendBlock(ByteBuffersDataOutput.java:443)
[junit4] > at org.apache.lucene.store.ByteBuffersDataOutput.writeBytes(ByteBuffersDataOutput.java:164)
[junit4] > at org.apache.lucene.store.ByteBuffersIndexOutput.writeBytes(ByteBuffersIndexOutput.java:115)
[junit4] > at org.apache.lucene.store.MockIndexOutputWrapper.writeBytes(MockIndexOutputWrapper.java:141)
[junit4] > at org.apache.lucene.store.RateLimitedIndexOutput.writeBytes(RateLimitedIndexOutput.java:73)
[junit4] > at org.apache.lucene.store.DataOutput.copyBytes(DataOutput.java:278)
[junit4] > at org.apache.lucene.codecs.lucene50.Lucene50CompoundFormat.write(Lucene50CompoundFormat.java:96)
[junit4] > at org.apache.lucene.index.IndexWriter.createCompoundFile(IndexWriter.java:4997)
[junit4] > at org.apache.lucene.index.IndexWriter.mergeMiddle(IndexWriter.java:4510)
[junit4] > at org.apache.lucene.index.IndexWriter.merge(IndexWriter.java:4040)
[junit4] > at org.apache.lucene.index.ConcurrentMergeScheduler.doMerge(ConcurrentMergeScheduler.java:625)
[junit4] > at org.apache.lucene.index.ConcurrentMergeScheduler$MergeThread.run(ConcurrentMergeScheduler.java:662)
[junit4] 2> ታሕ 16, 2019 6:06:50 ድሕር ሰዓት com.carrotsearch.randomizedtesting.RandomizedRunner$QueueUncaughtExceptionsHandler uncaughtException
[junit4] 2> WARNING: Uncaught exception in thread: Thread[Lucene Merge Thread #4,5,TGRP-TestBinaryDocValuesUpdates]
[junit4] 2> org.apache.lucene.index.MergePolicy$MergeException: java.lang.OutOfMemoryError: Java heap space
[junit4] 2> at __randomizedtesting.SeedInfo.seed([31E61EFFD4EC2665]:0)
[junit4] 2> at org.apache.lucene.index.ConcurrentMergeScheduler.handleMergeException(ConcurrentMergeScheduler.java:704)
[junit4] 2> at org.apache.lucene.index.ConcurrentMergeScheduler$MergeThread.run(ConcurrentMergeScheduler.java:684)
[junit4] 2> Caused by: java.lang.OutOfMemoryError: Java heap space
[junit4] 2> at java.base/java.nio.HeapByteBuffer.<init>(HeapByteBuffer.java:61)
[junit4] 2> at java.base/java.nio.ByteBuffer.allocate(ByteBuffer.java:348)
[junit4] 2> at org.apache.lucene.store.ByteBuffersDataOutput$$Lambda$96/0x0000000100172c40.apply(Unknown Source)
[junit4] 2> at org.apache.lucene.store.ByteBuffersDataOutput.appendBlock(ByteBuffersDataOutput.java:450)
[junit4] 2> at org.apache.lucene.store.ByteBuffersDataOutput.writeBytes(ByteBuffersDataOutput.java:188)
[junit4] 2> at org.apache.lucene.store.ByteBuffersDataOutput.rewriteToBlockSize(ByteBuffersDataOutput.java:465)
[junit4] 2> at org.apache.lucene.store.ByteBuffersDataOutput.appendBlock(ByteBuffersDataOutput.java:443)
[junit4] 2> at org.apache.lucene.store.ByteBuffersDataOutput.writeBytes(ByteBuffersDataOutput.java:164)
[junit4] 2> at org.apache.lucene.store.ByteBuffersIndexOutput.writeBytes(ByteBuffersIndexOutput.java:115)
[junit4] 2> at org.apache.lucene.store.MockIndexOutputWrapper.writeBytes(MockIndexOutputWrapper.java:141)
[junit4] 2> at org.apache.lucene.store.RateLimitedIndexOutput.writeBytes(RateLimitedIndexOutput.java:73)
[junit4] 2> at org.apache.lucene.store.DataOutput.copyBytes(DataOutput.java:278)
[junit4] 2> at org.apache.lucene.codecs.lucene50.Lucene50CompoundFormat.write(Lucene50CompoundFormat.java:96)
[junit4] 2> at org.apache.lucene.index.IndexWriter.createCompoundFile(IndexWriter.java:4997)
[junit4] 2> at org.apache.lucene.index.IndexWriter.mergeMiddle(IndexWriter.java:4510)
[junit4] 2> at org.apache.lucene.index.IndexWriter.merge(IndexWriter.java:4040)
[junit4] 2> at org.apache.lucene.index.ConcurrentMergeScheduler.doMerge(ConcurrentMergeScheduler.java:625)
[junit4] 2> at org.apache.lucene.index.ConcurrentMergeScheduler$MergeThread.run(ConcurrentMergeScheduler.java:662)
[junit4] 2>
[junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/lucene/build/core/test/J0/temp/lucene.index.TestBinaryDocValuesUpdates_31E61EFFD4EC2665-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene84): {bdv=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)), k1=Lucene84, f=Lucene84, k2=PostingsFormat(name=MockRandom), foo=Lucene84, dvUpdateKey=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)), upd=FSTOrd50, updKey=Lucene84, id=PostingsFormat(name=MockRandom), key=PostingsFormat(name=MockRandom)}, docValues:{ndv=DocValuesFormat(name=Asserting), f10=DocValuesFormat(name=Lucene80), f12=DocValuesFormat(name=Lucene80), f11=DocValuesFormat(name=Asserting), f14=DocValuesFormat(name=Lucene80), updKey=DocValuesFormat(name=Asserting), f13=DocValuesFormat(name=Asserting), f0=DocValuesFormat(name=Asserting), f16=DocValuesFormat(name=Lucene80), f1=DocValuesFormat(name=Lucene80), f15=DocValuesFormat(name=Asserting), f2=DocValuesFormat(name=Asserting), f18=DocValuesFormat(name=Lucene80), f17=DocValuesFormat(name=Asserting), f3=DocValuesFormat(name=Lucene80), f4=DocValuesFormat(name=Asserting), f19=DocValuesFormat(name=Asserting), f5=DocValuesFormat(name=Lucene80), bdv2=DocValuesFormat(name=Asserting), f6=DocValuesFormat(name=Asserting), number=DocValuesFormat(name=Lucene80), f7=DocValuesFormat(name=Lucene80), f8=DocValuesFormat(name=Asserting), bdv1=DocValuesFormat(name=Lucene80), f9=DocValuesFormat(name=Lucene80), id=DocValuesFormat(name=Lucene80), val=DocValuesFormat(name=Lucene80), f21=DocValuesFormat(name=Lucene80), f20=DocValuesFormat(name=Asserting), f23=DocValuesFormat(name=Lucene80), f22=DocValuesFormat(name=Asserting), f25=DocValuesFormat(name=Lucene80), upd=DocValuesFormat(name=Lucene80), f24=DocValuesFormat(name=Asserting), f27=DocValuesFormat(name=Lucene80), sort=DocValuesFormat(name=Asserting), f26=DocValuesFormat(name=Asserting), cf0=DocValuesFormat(name=Lucene80), f29=DocValuesFormat(name=Lucene80), f28=DocValuesFormat(name=Asserting), cf2=DocValuesFormat(name=Lucene80), cf1=DocValuesFormat(name=Asserting), cf4=DocValuesFormat(name=Lucene80), cf3=DocValuesFormat(name=Asserting), cf6=DocValuesFormat(name=Lucene80), cf5=DocValuesFormat(name=Asserting), cf8=DocValuesFormat(name=Lucene80), cf7=DocValuesFormat(name=Asserting), cf9=DocValuesFormat(name=Asserting), cf29=DocValuesFormat(name=Asserting), ssdv=DocValuesFormat(name=Asserting), sdv=DocValuesFormat(name=Lucene80), cf27=DocValuesFormat(name=Asserting), cf28=DocValuesFormat(name=Lucene80), cf25=DocValuesFormat(name=Asserting), cf26=DocValuesFormat(name=Lucene80), cf23=DocValuesFormat(name=Asserting), cf24=DocValuesFormat(name=Lucene80), cf21=DocValuesFormat(name=Asserting), cf22=DocValuesFormat(name=Lucene80), cf20=DocValuesFormat(name=Lucene80), key=DocValuesFormat(name=Lucene80), cf=DocValuesFormat(name=Lucene80), cf18=DocValuesFormat(name=Asserting), cf19=DocValuesFormat(name=Lucene80), f=DocValuesFormat(name=Asserting), cf16=DocValuesFormat(name=Asserting), cf17=DocValuesFormat(name=Lucene80), cf14=DocValuesFormat(name=Asserting), cf15=DocValuesFormat(name=Lucene80), control=DocValuesFormat(name=Lucene80), cf12=DocValuesFormat(name=Asserting), cf13=DocValuesFormat(name=Lucene80), cf10=DocValuesFormat(name=Asserting), cf11=DocValuesFormat(name=Lucene80), bdv=DocValuesFormat(name=Asserting)}, maxPointsInLeafNode=1734, maxMBSortInHeap=6.354529084315797, sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@8bb5969), locale=ti, timezone=America/Coral_Harbour
[junit4] 2> NOTE: Linux 4.15.0-54-generic amd64/Oracle Corporation 11.0.4 (64-bit)/cpus=4,threads=1,free=181411408,total=536870912
[junit4] 2> NOTE: All tests run in this JVM: [Test2BPositions, TestAxiomaticF1EXP, TestNRTCachingDirectory, TestPackedInts, TestArrayUtil, TestOrdinalMap, TestTermVectorsReader, TestLazyProxSkipping, TestLucene50CompoundFormat, TestConjunctions, TestOmitPositions, TestMergeRateLimiter, TestFilterIterator, TestFieldCacheRewriteMethod, TestVersion, TestIndexWriterReader, TestReqOptSumScorer, TestSoftDeletesRetentionMergePolicy, TestLucene84PostingsFormat, TestFSTs, TestControlledRealTimeReopenThread, TestReusableStringReader, TestIndexWriterExceptions2, TestAxiomaticF2LOG, TestIndexSearcher, TestBooleanQuery, TestFixedLengthBytesRefArray, TestDelegatingAnalyzerWrapper, TestIndexWriterDelete, TestSpanMultiTermQueryWrapper, TestFileSwitchDirectory, TestSortRandom, TestThreadedForceMerge, TestSpans, TestComplexExplanations, TestSpanBoostQuery, TestDateTools, FuzzyTermOnShortTermsTest, TestCharArraySet, TestSimpleFSDirectory, Test4GBStoredFields, TestCheckIndex, TestBooleanSimilarity, TestBufferedIndexInput, TestDeterminizeLexicon, TestRadixSelector, TestNRTThreads, TestDistributionSPL, TestAssertions, TestSegmentTermDocs, TestField, TestByteBlockPool, TestSynonymQuery, TestMmapDirectory, TestRegexpRandom, TestMultiDocValues, TestRecyclingIntBlockAllocator, TestDoubleValuesSource, TestInfoStream, TestDocsWithFieldSet, TestWordlistLoader, TestLongRangeFieldQueries, TestBKDRadixSort, TestMultiCollector, TestSegmentInfos, TestCompiledAutomaton, TestPerFieldPostingsFormat, TestStressDeletes, TestSleepingLockWrapper, TestSimpleExplanationsOfNonMatches, TestFlushByRamOrCountsPolicy, TestTerm, TestExceedMaxTermLength, TestIndexWriterWithThreads, TestSPIClassIterator, TestLongRange, TestSearcherManager, TestScorerPerf, TestSparseFixedBitSet, TestPostingsOffsets, TestDeletionPolicy, FiniteStringsIteratorTest, TestSpanExplanations, TestBasicModelIF, TestFrozenBufferedUpdates, TestDirectoryReaderReopen, TestPForUtil, TestPerFieldDocValuesFormat, TestBinaryDocument, TestDocument, TestDoubleRange, TestFeatureDoubleValues, TestFeatureField, TestFeatureSort, TestIntRange, TestLatLonDocValuesField, TestLatLonPoint, TestLatLonPointDistanceFeatureQuery, TestPolygon, Test2BDocs, Test2BSortedDocValuesFixedSorted, TestAddIndexes, TestAllFilesCheckIndexHeader, TestAtomicUpdate, TestBinaryDocValuesUpdates]
[junit4] Completed [273/526 (1!)] on J0 in 65.41s, 29 tests, 1 error <<< FAILURES!
[...truncated 826 lines...]
[junit4] JVM J0: stdout was not empty, see: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/lucene/build/core/test/temp/junit4-J0-20191216_221008_2342480715008625400036.sysout
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] java.lang.OutOfMemoryError: Java heap space
[junit4] Dumping heap to /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/heapdumps/java_pid26306.hprof ...
[junit4] Heap dump file created [489522124 bytes in 0.840 secs]
[junit4] <<< JVM J0: EOF ----
[...truncated 23616 lines...]
BUILD FAILED
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/build.xml:652: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/build.xml:586: Some of the tests produced a heap dump, but did not fail. Maybe a suppressed OutOfMemoryError? Dumps created:
* java_pid26306.hprof
Total time: 314 minutes 37 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any