You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2019/02/03 22:12:29 UTC
[JENKINS] Lucene-Solr-master-MacOSX (64bit/jdk-9) - Build # 5044 -
Unstable!
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-MacOSX/5044/
Java: 64bit/jdk-9 -XX:+UseCompressedOops -XX:+UseParallelGC
1 tests failed.
FAILED: junit.framework.TestSuite.org.apache.solr.handler.TestReplicationHandler
Error Message:
ObjectTracker found 6 object(s) that were not released!!! [MockDirectoryWrapper, SolrCore, InternalHttpClient, MockDirectoryWrapper, MockDirectoryWrapper, 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:361) at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:740) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:969) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:876) at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1189) at org.apache.solr.core.CoreContainer.lambda$load$13(CoreContainer.java:695) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:197) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1167) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:641) at java.base/java.lang.Thread.run(Thread.java:844) 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:1056) at org.apache.solr.core.SolrCore.reload(SolrCore.java:668) at org.apache.solr.core.CoreContainer.reload(CoreContainer.java:1450) at org.apache.solr.handler.IndexFetcher.lambda$reloadCore$0(IndexFetcher.java:921) at java.base/java.lang.Thread.run(Thread.java:844) 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:321) at org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:330) at org.apache.solr.handler.IndexFetcher.createHttpClient(IndexFetcher.java:225) at org.apache.solr.handler.IndexFetcher.<init>(IndexFetcher.java:267) at org.apache.solr.handler.ReplicationHandler.inform(ReplicationHandler.java:1213) at org.apache.solr.core.SolrResourceLoader.inform(SolrResourceLoader.java:696) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:1002) at org.apache.solr.core.SolrCore.reload(SolrCore.java:668) at org.apache.solr.core.CoreContainer.reload(CoreContainer.java:1450) at org.apache.solr.handler.IndexFetcher.lambda$reloadCore$0(IndexFetcher.java:921) at java.base/java.lang.Thread.run(Thread.java:844) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MockDirectoryWrapper at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348) at org.apache.solr.core.SolrCore.initSnapshotMetaDataManager(SolrCore.java:510) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:961) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:876) at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1189) at org.apache.solr.core.CoreContainer.lambda$load$13(CoreContainer.java:695) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:197) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1167) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:641) at java.base/java.lang.Thread.run(Thread.java:844) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MockDirectoryWrapper at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348) at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:503) at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:346) at org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:422) at org.apache.solr.handler.ReplicationHandler.lambda$setupPolling$13(ReplicationHandler.java:1182) at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:514) at java.base/java.util.concurrent.FutureTask.runAndReset(FutureTask.java:305) at java.base/java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:300) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1167) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:641) at java.base/java.lang.Thread.run(Thread.java:844) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MockDirectoryWrapper at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348) at org.apache.solr.update.SolrIndexWriter.create(SolrIndexWriter.java:95) at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:772) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:969) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:876) at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1189) at org.apache.solr.core.CoreContainer.lambda$load$13(CoreContainer.java:695) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:197) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1167) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:641) at java.base/java.lang.Thread.run(Thread.java:844) expected null, but was:<ObjectTracker found 6 object(s) that were not released!!! [MockDirectoryWrapper, SolrCore, InternalHttpClient, MockDirectoryWrapper, MockDirectoryWrapper, 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:361) at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:740) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:969) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:876) at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1189) at org.apache.solr.core.CoreContainer.lambda$load$13(CoreContainer.java:695) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:197) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1167) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:641) at java.base/java.lang.Thread.run(Thread.java:844) 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:1056) at org.apache.solr.core.SolrCore.reload(SolrCore.java:668) at org.apache.solr.core.CoreContainer.reload(CoreContainer.java:1450) at org.apache.solr.handler.IndexFetcher.lambda$reloadCore$0(IndexFetcher.java:921) at java.base/java.lang.Thread.run(Thread.java:844) 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:321) at org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:330) at org.apache.solr.handler.IndexFetcher.createHttpClient(IndexFetcher.java:225) at org.apache.solr.handler.IndexFetcher.<init>(IndexFetcher.java:267) at org.apache.solr.handler.ReplicationHandler.inform(ReplicationHandler.java:1213) at org.apache.solr.core.SolrResourceLoader.inform(SolrResourceLoader.java:696) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:1002) at org.apache.solr.core.SolrCore.reload(SolrCore.java:668) at org.apache.solr.core.CoreContainer.reload(CoreContainer.java:1450) at org.apache.solr.handler.IndexFetcher.lambda$reloadCore$0(IndexFetcher.java:921) at java.base/java.lang.Thread.run(Thread.java:844) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MockDirectoryWrapper at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348) at org.apache.solr.core.SolrCore.initSnapshotMetaDataManager(SolrCore.java:510) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:961) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:876) at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1189) at org.apache.solr.core.CoreContainer.lambda$load$13(CoreContainer.java:695) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:197) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1167) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:641) at java.base/java.lang.Thread.run(Thread.java:844) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MockDirectoryWrapper at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348) at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:503) at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:346) at org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:422) at org.apache.solr.handler.ReplicationHandler.lambda$setupPolling$13(ReplicationHandler.java:1182) at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:514) at java.base/java.util.concurrent.FutureTask.runAndReset(FutureTask.java:305) at java.base/java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:300) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1167) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:641) at java.base/java.lang.Thread.run(Thread.java:844) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MockDirectoryWrapper at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348) at org.apache.solr.update.SolrIndexWriter.create(SolrIndexWriter.java:95) at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:772) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:969) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:876) at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1189) at org.apache.solr.core.CoreContainer.lambda$load$13(CoreContainer.java:695) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:197) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1167) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:641) at java.base/java.lang.Thread.run(Thread.java:844) >
Stack Trace:
java.lang.AssertionError: ObjectTracker found 6 object(s) that were not released!!! [MockDirectoryWrapper, SolrCore, InternalHttpClient, MockDirectoryWrapper, MockDirectoryWrapper, 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:361)
at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:740)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:969)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:876)
at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1189)
at org.apache.solr.core.CoreContainer.lambda$load$13(CoreContainer.java:695)
at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:197)
at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209)
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1167)
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:641)
at java.base/java.lang.Thread.run(Thread.java:844)
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:1056)
at org.apache.solr.core.SolrCore.reload(SolrCore.java:668)
at org.apache.solr.core.CoreContainer.reload(CoreContainer.java:1450)
at org.apache.solr.handler.IndexFetcher.lambda$reloadCore$0(IndexFetcher.java:921)
at java.base/java.lang.Thread.run(Thread.java:844)
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:321)
at org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:330)
at org.apache.solr.handler.IndexFetcher.createHttpClient(IndexFetcher.java:225)
at org.apache.solr.handler.IndexFetcher.<init>(IndexFetcher.java:267)
at org.apache.solr.handler.ReplicationHandler.inform(ReplicationHandler.java:1213)
at org.apache.solr.core.SolrResourceLoader.inform(SolrResourceLoader.java:696)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:1002)
at org.apache.solr.core.SolrCore.reload(SolrCore.java:668)
at org.apache.solr.core.CoreContainer.reload(CoreContainer.java:1450)
at org.apache.solr.handler.IndexFetcher.lambda$reloadCore$0(IndexFetcher.java:921)
at java.base/java.lang.Thread.run(Thread.java:844)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MockDirectoryWrapper
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348)
at org.apache.solr.core.SolrCore.initSnapshotMetaDataManager(SolrCore.java:510)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:961)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:876)
at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1189)
at org.apache.solr.core.CoreContainer.lambda$load$13(CoreContainer.java:695)
at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:197)
at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209)
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1167)
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:641)
at java.base/java.lang.Thread.run(Thread.java:844)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MockDirectoryWrapper
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348)
at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:503)
at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:346)
at org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:422)
at org.apache.solr.handler.ReplicationHandler.lambda$setupPolling$13(ReplicationHandler.java:1182)
at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:514)
at java.base/java.util.concurrent.FutureTask.runAndReset(FutureTask.java:305)
at java.base/java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:300)
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1167)
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:641)
at java.base/java.lang.Thread.run(Thread.java:844)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MockDirectoryWrapper
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348)
at org.apache.solr.update.SolrIndexWriter.create(SolrIndexWriter.java:95)
at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:772)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:969)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:876)
at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1189)
at org.apache.solr.core.CoreContainer.lambda$load$13(CoreContainer.java:695)
at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:197)
at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209)
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1167)
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:641)
at java.base/java.lang.Thread.run(Thread.java:844)
expected null, but was:<ObjectTracker found 6 object(s) that were not released!!! [MockDirectoryWrapper, SolrCore, InternalHttpClient, MockDirectoryWrapper, MockDirectoryWrapper, 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:361)
at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:740)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:969)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:876)
at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1189)
at org.apache.solr.core.CoreContainer.lambda$load$13(CoreContainer.java:695)
at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:197)
at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209)
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1167)
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:641)
at java.base/java.lang.Thread.run(Thread.java:844)
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:1056)
at org.apache.solr.core.SolrCore.reload(SolrCore.java:668)
at org.apache.solr.core.CoreContainer.reload(CoreContainer.java:1450)
at org.apache.solr.handler.IndexFetcher.lambda$reloadCore$0(IndexFetcher.java:921)
at java.base/java.lang.Thread.run(Thread.java:844)
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:321)
at org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:330)
at org.apache.solr.handler.IndexFetcher.createHttpClient(IndexFetcher.java:225)
at org.apache.solr.handler.IndexFetcher.<init>(IndexFetcher.java:267)
at org.apache.solr.handler.ReplicationHandler.inform(ReplicationHandler.java:1213)
at org.apache.solr.core.SolrResourceLoader.inform(SolrResourceLoader.java:696)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:1002)
at org.apache.solr.core.SolrCore.reload(SolrCore.java:668)
at org.apache.solr.core.CoreContainer.reload(CoreContainer.java:1450)
at org.apache.solr.handler.IndexFetcher.lambda$reloadCore$0(IndexFetcher.java:921)
at java.base/java.lang.Thread.run(Thread.java:844)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MockDirectoryWrapper
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348)
at org.apache.solr.core.SolrCore.initSnapshotMetaDataManager(SolrCore.java:510)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:961)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:876)
at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1189)
at org.apache.solr.core.CoreContainer.lambda$load$13(CoreContainer.java:695)
at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:197)
at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209)
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1167)
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:641)
at java.base/java.lang.Thread.run(Thread.java:844)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MockDirectoryWrapper
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348)
at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:503)
at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:346)
at org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:422)
at org.apache.solr.handler.ReplicationHandler.lambda$setupPolling$13(ReplicationHandler.java:1182)
at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:514)
at java.base/java.util.concurrent.FutureTask.runAndReset(FutureTask.java:305)
at java.base/java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:300)
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1167)
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:641)
at java.base/java.lang.Thread.run(Thread.java:844)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MockDirectoryWrapper
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348)
at org.apache.solr.update.SolrIndexWriter.create(SolrIndexWriter.java:95)
at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:772)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:969)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:876)
at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1189)
at org.apache.solr.core.CoreContainer.lambda$load$13(CoreContainer.java:695)
at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:197)
at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209)
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1167)
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:641)
at java.base/java.lang.Thread.run(Thread.java:844)
>
at __randomizedtesting.SeedInfo.seed([85A36685297B3E06]: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:322)
at jdk.internal.reflect.GeneratedMethodAccessor69.invoke(Unknown Source)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:564)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:901)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:844)
Build Log:
[...truncated 14786 lines...]
[junit4] Suite: org.apache.solr.handler.TestReplicationHandler
[junit4] 2> Creating dataDir: /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_85A36685297B3E06-001/init-core-data-001
[junit4] 2> 2285181 INFO (SUITE-TestReplicationHandler-seed#[85A36685297B3E06]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 2285181 INFO (SUITE-TestReplicationHandler-seed#[85A36685297B3E06]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl="None") w/ MAC_OS_X supressed clientAuth
[junit4] 2> 2285181 INFO (SUITE-TestReplicationHandler-seed#[85A36685297B3E06]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 2285183 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testShouldReportErrorWhenRequiredCommandArgMissing
[junit4] 2> 2285183 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_85A36685297B3E06-001/solr-instance-001/collection1
[junit4] 2> 2285190 WARN (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 2285190 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
[junit4] 2> 2285190 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 2285190 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 9+181
[junit4] 2> 2285192 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2285192 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2285192 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 2285192 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@4f007d7d{/solr,null,AVAILABLE}
[junit4] 2> 2285192 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@4d415496{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:54302}
[junit4] 2> 2285192 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.e.j.s.Server Started @2285271ms
[junit4] 2> 2285192 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, solr.data.dir=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_85A36685297B3E06-001/solr-instance-001/collection1/data, hostPort=54302}
[junit4] 2> 2285193 ERROR (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 2285193 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 2285193 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 9.0.0
[junit4] 2> 2285193 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 2285193 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2285193 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-02-03T21:30:58.845322Z
[junit4] 2> 2285193 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_85A36685297B3E06-001/solr-instance-001/solr.xml
[junit4] 2> 2285195 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 2285195 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 2285195 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@d97017c, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 2285262 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 2285262 WARN (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@6c975e46[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2285265 WARN (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@22c086f8[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2285279 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 2285279 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 2285293 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@d97017c
[junit4] 2> 2285303 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@d97017c
[junit4] 2> 2285303 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@d97017c
[junit4] 2> 2285305 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_85A36685297B3E06-001/solr-instance-001/.
[junit4] 2> 2285305 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 2285310 INFO (coreLoadExecutor-16486-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0
[junit4] 2> 2285325 INFO (coreLoadExecutor-16486-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 2285326 INFO (coreLoadExecutor-16486-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
[junit4] 2> 2285326 INFO (coreLoadExecutor-16486-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_85A36685297B3E06-001/solr-instance-001/./collection1, trusted=true
[junit4] 2> 2285326 INFO (coreLoadExecutor-16486-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@d97017c
[junit4] 2> 2285326 INFO (coreLoadExecutor-16486-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_85A36685297B3E06-001/solr-instance-001/collection1], dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_85A36685297B3E06-001/solr-instance-001/./collection1/data/]
[junit4] 2> 2285327 INFO (coreLoadExecutor-16486-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=41, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
[junit4] 2> 2285365 INFO (coreLoadExecutor-16486-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2285365 INFO (coreLoadExecutor-16486-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2285366 INFO (coreLoadExecutor-16486-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=41, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.2152098340850359]
[junit4] 2> 2285366 INFO (coreLoadExecutor-16486-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1544f01d[collection1] main]
[junit4] 2> 2285366 INFO (coreLoadExecutor-16486-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_85A36685297B3E06-001/solr-instance-001/collection1/conf
[junit4] 2> 2285367 INFO (coreLoadExecutor-16486-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following config files: schema.xml,xslt/dummy.xsl
[junit4] 2> 2285367 INFO (coreLoadExecutor-16486-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 2285367 INFO (searcherExecutor-16487-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1544f01d[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2285368 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_85A36685297B3E06-001/solr-instance-002/collection1
[junit4] 2> 2285371 WARN (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 2285371 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
[junit4] 2> 2285371 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 2285371 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 9+181
[junit4] 2> 2285373 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2285373 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2285373 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 2285373 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@64955b8d{/solr,null,AVAILABLE}
[junit4] 2> 2285374 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@5a16521e{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:54305}
[junit4] 2> 2285374 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.e.j.s.Server Started @2285452ms
[junit4] 2> 2285374 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, solr.data.dir=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_85A36685297B3E06-001/solr-instance-002/collection1/data, hostPort=54305}
[junit4] 2> 2285374 ERROR (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 2285374 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 2285374 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 9.0.0
[junit4] 2> 2285374 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 2285374 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2285374 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-02-03T21:30:59.026524Z
[junit4] 2> 2285374 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_85A36685297B3E06-001/solr-instance-002/solr.xml
[junit4] 2> 2285376 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 2285376 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 2285376 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@d97017c, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 2285416 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 2285417 WARN (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@74471aa2[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2285419 WARN (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@58b1e097[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2285434 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 2285434 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 2285449 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@d97017c
[junit4] 2> 2285461 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@d97017c
[junit4] 2> 2285461 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@d97017c
[junit4] 2> 2285463 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_85A36685297B3E06-001/solr-instance-002/.
[junit4] 2> 2285463 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 2285468 INFO (coreLoadExecutor-16499-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0
[junit4] 2> 2285471 INFO (coreLoadExecutor-16499-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 2285472 INFO (coreLoadExecutor-16499-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
[junit4] 2> 2285472 INFO (coreLoadExecutor-16499-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_85A36685297B3E06-001/solr-instance-002/./collection1, trusted=true
[junit4] 2> 2285472 INFO (coreLoadExecutor-16499-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@d97017c
[junit4] 2> 2285473 INFO (coreLoadExecutor-16499-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_85A36685297B3E06-001/solr-instance-002/collection1], dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_85A36685297B3E06-001/solr-instance-002/./collection1/data/]
[junit4] 2> 2285474 INFO (coreLoadExecutor-16499-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=41, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
[junit4] 2> 2285512 INFO (coreLoadExecutor-16499-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2285512 INFO (coreLoadExecutor-16499-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2285513 INFO (coreLoadExecutor-16499-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=41, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.2152098340850359]
[junit4] 2> 2285513 INFO (coreLoadExecutor-16499-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@78b01f11[collection1] main]
[junit4] 2> 2285521 INFO (coreLoadExecutor-16499-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_85A36685297B3E06-001/solr-instance-002/collection1/conf
[junit4] 2> 2285522 INFO (coreLoadExecutor-16499-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Poll scheduled at an interval of 1000ms
[junit4] 2> 2285522 INFO (coreLoadExecutor-16499-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 2285522 INFO (searcherExecutor-16500-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@78b01f11[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2285526 ERROR (qtp416196972-53579) [ x:collection1] o.a.s.h.RequestHandlerBase org.apache.solr.common.SolrException: Missing required parameter: command
[junit4] 2> at org.apache.solr.common.params.RequiredSolrParams.get(RequiredSolrParams.java:48)
[junit4] 2> at org.apache.solr.handler.ReplicationHandler.handleRequestBody(ReplicationHandler.java:241)
[junit4] 2> at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:199)
[junit4] 2> at org.apache.solr.core.SolrCore.execute(SolrCore.java:2559)
[junit4] 2> at org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:711)
[junit4] 2> at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:516)
[junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:394)
[junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:340)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1610)
[junit4] 2> at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:164)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1610)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:540)
[junit4] 2> at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:255)
[junit4] 2> at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:1588)
[junit4] 2> at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:255)
[junit4] 2> at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1345)
[junit4] 2> at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:203)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:480)
[junit4] 2> at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:1557)
[junit4] 2> at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:201)
[junit4] 2> at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1247)
[junit4] 2> at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:144)
[junit4] 2> at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:753)
[junit4] 2> at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:132)
[junit4] 2> at org.eclipse.jetty.server.Server.handle(Server.java:502)
[junit4] 2> at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:364)
[junit4] 2> at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:260)
[junit4] 2> at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:305)
[junit4] 2> at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:103)
[junit4] 2> at org.eclipse.jetty.io.ChannelEndPoint$2.run(ChannelEndPoint.java:118)
[junit4] 2> at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:765)
[junit4] 2> at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:683)
[junit4] 2> at java.base/java.lang.Thread.run(Thread.java:844)
[junit4] 2>
[junit4] 2> 2285526 INFO (qtp416196972-53579) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={qt=/replication&wt=javabin&version=2} status=400 QTime=0
[junit4] 2> 2285527 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testShouldReportErrorWhenRequiredCommandArgMissing
[junit4] 2> 2285527 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=864927659
[junit4] 2> 2285527 INFO (coreCloseExecutor-16505-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@4e5132d0
[junit4] 2> 2285527 INFO (coreCloseExecutor-16505-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=4e5132d0
[junit4] 2> 2285528 INFO (coreCloseExecutor-16505-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@79294ef0: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@167ef0d0
[junit4] 2> 2285533 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 2285533 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@40745178: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@1f800abc
[junit4] 2> 2285537 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 2285537 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@7a7adcb: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@2f3edfcd
[junit4] 2> 2285539 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 2285539 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@2405fec8: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@6e2b78fc
[junit4] 1> Done close org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor@766ac186[Terminated, pool size = 0, active threads = 0, queued tasks = 0, completed tasks = 1]
[junit4] 1> Done close org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor@36971791[Terminated, pool size = 0, active threads = 0, queued tasks = 0, completed tasks = 1]
[junit4] 2> 2285541 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@4d415496{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:0}
[junit4] 2> 2285541 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@4f007d7d{/solr,null,UNAVAILABLE}
[junit4] 2> 2285541 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 2285543 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=936241084
[junit4] 2> 2285543 INFO (coreCloseExecutor-16507-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@6ed8ed30
[junit4] 2> 2285543 INFO (coreCloseExecutor-16507-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=6ed8ed30
[junit4] 2> 2285543 INFO (coreCloseExecutor-16507-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@379810b3: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@242cb9b8
[junit4] 2> 2285551 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 2285551 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@284880cd: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@54e767b8
[junit4] 2> 2285556 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 2285556 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@16a31b74: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@2f3edfcd
[junit4] 2> 2285559 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 2285559 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@71e5a2bc: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@6e2b78fc
[junit4] 1> Done close org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor@632c45fe[Terminated, pool size = 0, active threads = 0, queued tasks = 0, completed tasks = 1]
[junit4] 1> Done close org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor@67a7094c[Terminated, pool size = 0, active threads = 0, queued tasks = 0, completed tasks = 1]
[junit4] 2> 2285561 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@5a16521e{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:0}
[junit4] 2> 2285561 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@64955b8d{/solr,null,UNAVAILABLE}
[junit4] 2> 2285561 INFO (TEST-TestReplicationHandler.testShouldReportErrorWhenRequiredCommandArgMissing-seed#[85A36685297B3E06]) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 2285564 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.a.s.SolrTestCaseJ4 ###Starting doTestIndexFetchWithMasterUrl
[junit4] 2> 2285565 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_85A36685297B3E06-001/solr-instance-003/collection1
[junit4] 2> 2285567 WARN (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 2285567 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
[junit4] 2> 2285567 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 2285568 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 9+181
[junit4] 2> 2285569 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2285569 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2285569 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 2285569 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@2995e348{/solr,null,AVAILABLE}
[junit4] 2> 2285570 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@1bfbefac{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:54307}
[junit4] 2> 2285570 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.e.j.s.Server Started @2285648ms
[junit4] 2> 2285570 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, solr.data.dir=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_85A36685297B3E06-001/solr-instance-003/collection1/data, hostPort=54307}
[junit4] 2> 2285570 ERROR (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 2285570 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 2285570 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 9.0.0
[junit4] 2> 2285570 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 2285570 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2285570 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-02-03T21:30:59.222506Z
[junit4] 2> 2285570 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_85A36685297B3E06-001/solr-instance-003/solr.xml
[junit4] 2> 2285572 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 2285572 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 2285572 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@d97017c, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 2285685 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 2285686 WARN (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@45688dd1[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2285689 WARN (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@14088757[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2285713 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 2285713 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 2285734 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@d97017c
[junit4] 2> 2285749 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@d97017c
[junit4] 2> 2285749 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@d97017c
[junit4] 2> 2285751 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_85A36685297B3E06-001/solr-instance-003/.
[junit4] 2> 2285751 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 2285759 INFO (coreLoadExecutor-16517-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0
[junit4] 2> 2285765 INFO (coreLoadExecutor-16517-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 2285766 INFO (coreLoadExecutor-16517-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
[junit4] 2> 2285766 INFO (coreLoadExecutor-16517-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_85A36685297B3E06-001/solr-instance-003/./collection1, trusted=true
[junit4] 2> 2285766 INFO (coreLoadExecutor-16517-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@d97017c
[junit4] 2> 2285766 INFO (coreLoadExecutor-16517-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_85A36685297B3E06-001/solr-instance-003/collection1], dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_85A36685297B3E06-001/solr-instance-003/./collection1/data/]
[junit4] 2> 2285767 INFO (coreLoadExecutor-16517-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=41, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
[junit4] 2> 2285811 INFO (coreLoadExecutor-16517-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2285811 INFO (coreLoadExecutor-16517-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2285812 INFO (coreLoadExecutor-16517-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=41, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.2152098340850359]
[junit4] 2> 2285812 INFO (coreLoadExecutor-16517-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1e3edba[collection1] main]
[junit4] 2> 2285813 INFO (coreLoadExecutor-16517-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_85A36685297B3E06-001/solr-instance-003/collection1/conf
[junit4] 2> 2285813 INFO (coreLoadExecutor-16517-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following config files: schema.xml,xslt/dummy.xsl
[junit4] 2> 2285813 INFO (coreLoadExecutor-16517-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 2285814 INFO (searcherExecutor-16518-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1e3edba[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2285815 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_85A36685297B3E06-001/solr-instance-004/collection1
[junit4] 2> 2285817 WARN (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 2285818 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
[junit4] 2> 2285818 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 2285818 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 9+181
[junit4] 2> 2285819 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2285819 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2285819 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 2285819 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@2c931f98{/solr,null,AVAILABLE}
[junit4] 2> 2285820 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@8f10c88{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:54308}
[junit4] 2> 2285820 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.e.j.s.Server Started @2285898ms
[junit4] 2> 2285820 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, solr.data.dir=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_85A36685297B3E06-001/solr-instance-004/collection1/data, hostPort=54308}
[junit4] 2> 2285820 ERROR (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 2285820 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 2285820 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 9.0.0
[junit4] 2> 2285820 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 2285820 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2285820 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-02-03T21:30:59.472515Z
[junit4] 2> 2285820 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_85A36685297B3E06-001/solr-instance-004/solr.xml
[junit4] 2> 2285823 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 2285823 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 2285823 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@d97017c, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 2285926 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 2285927 WARN (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@60b94a28[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2285930 WARN (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@4b6b3d02[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2285949 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 2285949 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 2285971 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@d97017c
[junit4] 2> 2286004 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@d97017c
[junit4] 2> 2286004 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@d97017c
[junit4] 2> 2286007 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_85A36685297B3E06-001/solr-instance-004/.
[junit4] 2> 2286007 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 2286014 INFO (coreLoadExecutor-16530-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0
[junit4] 2> 2286018 INFO (coreLoadExecutor-16530-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 2286019 INFO (coreLoadExecutor-16530-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
[junit4] 2> 2286019 INFO (coreLoadExecutor-16530-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_85A36685297B3E06-001/solr-instance-004/./collection1, trusted=true
[junit4] 2> 2286020 INFO (coreLoadExecutor-16530-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@d97017c
[junit4] 2> 2286020 INFO (coreLoadExecutor-16530-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_85A36685297B3E06-001/solr-instance-004/collection1], dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_85A36685297B3E06-001/solr-instance-004/./collection1/data/]
[junit4] 2> 2286021 INFO (coreLoadExecutor-16530-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=41, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
[junit4] 2> 2286121 INFO (coreLoadExecutor-16530-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2286121 INFO (coreLoadExecutor-16530-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2286142 INFO (coreLoadExecutor-16530-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=41, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.2152098340850359]
[junit4] 2> 2286173 INFO (coreLoadExecutor-16530-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@b4f1420[collection1] main]
[junit4] 2> 2286174 INFO (coreLoadExecutor-16530-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_85A36685297B3E06-001/solr-instance-004/collection1/conf
[junit4] 2> 2286175 INFO (coreLoadExecutor-16530-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Poll scheduled at an interval of 1000ms
[junit4] 2> 2286175 INFO (coreLoadExecutor-16530-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 2286175 INFO (searcherExecutor-16531-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@b4f1420[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2286176 INFO (qtp529521787-53612) [ 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> 2286176 INFO (indexFetcher-16535-thread-1) [ ] o.a.s.h.IndexFetcher Master's generation: 1
[junit4] 2> 2286176 INFO (indexFetcher-16535-thread-1) [ ] o.a.s.h.IndexFetcher Master's version: 0
[junit4] 2> 2286176 INFO (indexFetcher-16535-thread-1) [ ] o.a.s.h.IndexFetcher Slave's generation: 1
[junit4] 2> 2286176 INFO (indexFetcher-16535-thread-1) [ ] o.a.s.h.IndexFetcher Slave's version: 0
[junit4] 2> 2286176 INFO (indexFetcher-16535-thread-1) [ ] o.a.s.h.IndexFetcher New index in Master. Deleting mine...
[junit4] 2> 2286177 INFO (indexFetcher-16535-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@3fa76e4e[collection1] main]
[junit4] 2> 2286177 INFO (searcherExecutor-16531-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@3fa76e4e[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2286178 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[85A36685297B3E06]) [ ] o.a.s.c.CoreContainer
[...truncated too long message...]
ent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1167)
[junit4] > at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:641)
[junit4] > at java.base/java.lang.Thread.run(Thread.java:844)
[junit4] > expected null, but was:<ObjectTracker found 6 object(s) that were not released!!! [MockDirectoryWrapper, SolrCore, InternalHttpClient, MockDirectoryWrapper, MockDirectoryWrapper, MockDirectoryWrapper]
[junit4] > org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MockDirectoryWrapper
[junit4] > at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
[junit4] > at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348)
[junit4] > at org.apache.solr.core.SolrCore.getNewIndexDir(SolrCore.java:361)
[junit4] > at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:740)
[junit4] > at org.apache.solr.core.SolrCore.<init>(SolrCore.java:969)
[junit4] > at org.apache.solr.core.SolrCore.<init>(SolrCore.java:876)
[junit4] > at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1189)
[junit4] > at org.apache.solr.core.CoreContainer.lambda$load$13(CoreContainer.java:695)
[junit4] > at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:197)
[junit4] > at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
[junit4] > at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209)
[junit4] > at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1167)
[junit4] > at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:641)
[junit4] > at java.base/java.lang.Thread.run(Thread.java:844)
[junit4] > org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.solr.core.SolrCore
[junit4] > at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
[junit4] > at org.apache.solr.core.SolrCore.<init>(SolrCore.java:1056)
[junit4] > at org.apache.solr.core.SolrCore.reload(SolrCore.java:668)
[junit4] > at org.apache.solr.core.CoreContainer.reload(CoreContainer.java:1450)
[junit4] > at org.apache.solr.handler.IndexFetcher.lambda$reloadCore$0(IndexFetcher.java:921)
[junit4] > at java.base/java.lang.Thread.run(Thread.java:844)
[junit4] > org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.http.impl.client.InternalHttpClient
[junit4] > at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
[junit4] > at org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:321)
[junit4] > at org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:330)
[junit4] > at org.apache.solr.handler.IndexFetcher.createHttpClient(IndexFetcher.java:225)
[junit4] > at org.apache.solr.handler.IndexFetcher.<init>(IndexFetcher.java:267)
[junit4] > at org.apache.solr.handler.ReplicationHandler.inform(ReplicationHandler.java:1213)
[junit4] > at org.apache.solr.core.SolrResourceLoader.inform(SolrResourceLoader.java:696)
[junit4] > at org.apache.solr.core.SolrCore.<init>(SolrCore.java:1002)
[junit4] > at org.apache.solr.core.SolrCore.reload(SolrCore.java:668)
[junit4] > at org.apache.solr.core.CoreContainer.reload(CoreContainer.java:1450)
[junit4] > at org.apache.solr.handler.IndexFetcher.lambda$reloadCore$0(IndexFetcher.java:921)
[junit4] > at java.base/java.lang.Thread.run(Thread.java:844)
[junit4] > org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MockDirectoryWrapper
[junit4] > at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
[junit4] > at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348)
[junit4] > at org.apache.solr.core.SolrCore.initSnapshotMetaDataManager(SolrCore.java:510)
[junit4] > at org.apache.solr.core.SolrCore.<init>(SolrCore.java:961)
[junit4] > at org.apache.solr.core.SolrCore.<init>(SolrCore.java:876)
[junit4] > at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1189)
[junit4] > at org.apache.solr.core.CoreContainer.lambda$load$13(CoreContainer.java:695)
[junit4] > at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:197)
[junit4] > at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
[junit4] > at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209)
[junit4] > at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1167)
[junit4] > at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:641)
[junit4] > at java.base/java.lang.Thread.run(Thread.java:844)
[junit4] > org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MockDirectoryWrapper
[junit4] > at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
[junit4] > at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348)
[junit4] > at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:503)
[junit4] > at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:346)
[junit4] > at org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:422)
[junit4] > at org.apache.solr.handler.ReplicationHandler.lambda$setupPolling$13(ReplicationHandler.java:1182)
[junit4] > at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:514)
[junit4] > at java.base/java.util.concurrent.FutureTask.runAndReset(FutureTask.java:305)
[junit4] > at java.base/java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:300)
[junit4] > at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1167)
[junit4] > at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:641)
[junit4] > at java.base/java.lang.Thread.run(Thread.java:844)
[junit4] > org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MockDirectoryWrapper
[junit4] > at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
[junit4] > at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348)
[junit4] > at org.apache.solr.update.SolrIndexWriter.create(SolrIndexWriter.java:95)
[junit4] > at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:772)
[junit4] > at org.apache.solr.core.SolrCore.<init>(SolrCore.java:969)
[junit4] > at org.apache.solr.core.SolrCore.<init>(SolrCore.java:876)
[junit4] > at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1189)
[junit4] > at org.apache.solr.core.CoreContainer.lambda$load$13(CoreContainer.java:695)
[junit4] > at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:197)
[junit4] > at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
[junit4] > at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209)
[junit4] > at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1167)
[junit4] > at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:641)
[junit4] > at java.base/java.lang.Thread.run(Thread.java:844)
[junit4] > >
[junit4] > at __randomizedtesting.SeedInfo.seed([85A36685297B3E06]:0)
[junit4] > at org.apache.solr.SolrTestCaseJ4.teardownTestCases(SolrTestCaseJ4.java:322)
[junit4] > at jdk.internal.reflect.GeneratedMethodAccessor69.invoke(Unknown Source)
[junit4] > at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4] > at java.base/java.lang.reflect.Method.invoke(Method.java:564)
[junit4] > at java.base/java.lang.Thread.run(Thread.java:844)
[junit4] Completed [624/842 (1!)] on J0 in 141.49s, 20 tests, 1 failure <<< FAILURES!
[...truncated 43115 lines...]
[repro] Jenkins log URL: https://jenkins.thetaphi.de/job/Lucene-Solr-master-MacOSX/5044/consoleText
[repro] Revision: 1a23ab005bd7944ae5087eea9ab6f04ec76b2134
[repro] Ant options: "-Dargs=-XX:+UseCompressedOops -XX:+UseParallelGC"
[repro] Repro line: ant test -Dtestcase=TestReplicationHandler -Dtests.seed=85A36685297B3E06 -Dtests.slow=true -Dtests.locale=zh -Dtests.timezone=Etc/GMT-7 -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[repro] ant clean
[...truncated 6 lines...]
[repro] Test suites by module:
[repro] solr/core
[repro] TestReplicationHandler
[repro] ant compile-test
[...truncated 3589 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5 -Dtests.class="*.TestReplicationHandler" -Dtests.showOutput=onerror "-Dargs=-XX:+UseCompressedOops -XX:+UseParallelGC" -Dtests.seed=85A36685297B3E06 -Dtests.slow=true -Dtests.locale=zh -Dtests.timezone=Etc/GMT-7 -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[...truncated 167 lines...]
[repro] Failures:
[repro] 0/5 failed: org.apache.solr.handler.TestReplicationHandler
[repro] Exiting with code 0
[...truncated 70 lines...]