You are viewing a plain text version of this content. The canonical link for it is here.
Posted to builds@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2019/10/03 06:42:17 UTC
[JENKINS] Lucene-Solr-8.x-MacOSX (64bit/jdk1.8.0) - Build # 359 -
Still unstable!
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-8.x-MacOSX/359/
Java: 64bit/jdk1.8.0 -XX:-UseCompressedOops -XX:+UseParallelGC
1 tests failed.
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.api.collections.TestLocalFSCloudBackupRestore
Error Message:
ObjectTracker found 7 object(s) that were not released!!! [InternalHttpClient, MockDirectoryWrapper, MockDirectoryWrapper, MockDirectoryWrapper, MockDirectoryWrapper, SolrCore, InternalHttpClient] 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:230) at org.apache.solr.handler.IndexFetcher.<init>(IndexFetcher.java:272) at org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:420) at org.apache.solr.cloud.RecoveryStrategy.replicate(RecoveryStrategy.java:250) at org.apache.solr.cloud.RecoveryStrategy.doSyncOrReplicateRecovery(RecoveryStrategy.java:662) at org.apache.solr.cloud.RecoveryStrategy.doRecovery(RecoveryStrategy.java:336) at org.apache.solr.cloud.RecoveryStrategy.run(RecoveryStrategy.java:317) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:181) at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) at java.util.concurrent.FutureTask.run(FutureTask.java:266) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.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:396) at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:773) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:1003) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:914) at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1251) at org.apache.solr.core.CoreContainer.create(CoreContainer.java:1162) at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:92) at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:360) at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:396) at org.apache.solr.handler.admin.CoreAdminHandler.lambda$handleRequestBody$0(CoreAdminHandler.java:188) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:181) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.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:544) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:995) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:914) at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1251) at org.apache.solr.core.CoreContainer.create(CoreContainer.java:1162) at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:92) at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:360) at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:396) at org.apache.solr.handler.admin.CoreAdminHandler.lambda$handleRequestBody$0(CoreAdminHandler.java:188) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:181) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MockDirectoryWrapper at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348) at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:509) at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:351) at org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:424) at org.apache.solr.handler.ReplicationHandler.lambda$setupPolling$13(ReplicationHandler.java:1193) at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:308) at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:180) at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:294) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748) 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:99) at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:805) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:1003) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:914) at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1251) at org.apache.solr.core.CoreContainer.create(CoreContainer.java:1162) at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:92) at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:360) at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:396) at org.apache.solr.handler.admin.CoreAdminHandler.lambda$handleRequestBody$0(CoreAdminHandler.java:188) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:181) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.solr.core.SolrCore at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:1093) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:914) at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1251) at org.apache.solr.core.CoreContainer.create(CoreContainer.java:1162) at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:92) at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:360) at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:396) at org.apache.solr.handler.admin.CoreAdminHandler.lambda$handleRequestBody$0(CoreAdminHandler.java:188) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:181) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.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:230) at org.apache.solr.handler.IndexFetcher.<init>(IndexFetcher.java:272) at org.apache.solr.handler.ReplicationHandler.inform(ReplicationHandler.java:1224) at org.apache.solr.cloud.ReplicateFromLeader.startReplication(ReplicateFromLeader.java:109) at org.apache.solr.cloud.ZkController.startReplicationFromLeader(ZkController.java:1330) at org.apache.solr.cloud.RecoveryStrategy.doSyncOrReplicateRecovery(RecoveryStrategy.java:693) at org.apache.solr.cloud.RecoveryStrategy.doRecovery(RecoveryStrategy.java:336) at org.apache.solr.cloud.RecoveryStrategy.run(RecoveryStrategy.java:317) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:181) at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) at java.util.concurrent.FutureTask.run(FutureTask.java:266) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748) expected null, but was:<ObjectTracker found 7 object(s) that were not released!!! [InternalHttpClient, MockDirectoryWrapper, MockDirectoryWrapper, MockDirectoryWrapper, MockDirectoryWrapper, SolrCore, InternalHttpClient] 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:230) at org.apache.solr.handler.IndexFetcher.<init>(IndexFetcher.java:272) at org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:420) at org.apache.solr.cloud.RecoveryStrategy.replicate(RecoveryStrategy.java:250) at org.apache.solr.cloud.RecoveryStrategy.doSyncOrReplicateRecovery(RecoveryStrategy.java:662) at org.apache.solr.cloud.RecoveryStrategy.doRecovery(RecoveryStrategy.java:336) at org.apache.solr.cloud.RecoveryStrategy.run(RecoveryStrategy.java:317) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:181) at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) at java.util.concurrent.FutureTask.run(FutureTask.java:266) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.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:396) at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:773) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:1003) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:914) at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1251) at org.apache.solr.core.CoreContainer.create(CoreContainer.java:1162) at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:92) at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:360) at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:396) at org.apache.solr.handler.admin.CoreAdminHandler.lambda$handleRequestBody$0(CoreAdminHandler.java:188) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:181) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.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:544) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:995) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:914) at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1251) at org.apache.solr.core.CoreContainer.create(CoreContainer.java:1162) at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:92) at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:360) at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:396) at org.apache.solr.handler.admin.CoreAdminHandler.lambda$handleRequestBody$0(CoreAdminHandler.java:188) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:181) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MockDirectoryWrapper at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348) at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:509) at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:351) at org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:424) at org.apache.solr.handler.ReplicationHandler.lambda$setupPolling$13(ReplicationHandler.java:1193) at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:308) at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:180) at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:294) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748) 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:99) at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:805) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:1003) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:914) at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1251) at org.apache.solr.core.CoreContainer.create(CoreContainer.java:1162) at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:92) at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:360) at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:396) at org.apache.solr.handler.admin.CoreAdminHandler.lambda$handleRequestBody$0(CoreAdminHandler.java:188) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:181) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.solr.core.SolrCore at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:1093) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:914) at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1251) at org.apache.solr.core.CoreContainer.create(CoreContainer.java:1162) at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:92) at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:360) at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:396) at org.apache.solr.handler.admin.CoreAdminHandler.lambda$handleRequestBody$0(CoreAdminHandler.java:188) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:181) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.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:230) at org.apache.solr.handler.IndexFetcher.<init>(IndexFetcher.java:272) at org.apache.solr.handler.ReplicationHandler.inform(ReplicationHandler.java:1224) at org.apache.solr.cloud.ReplicateFromLeader.startReplication(ReplicateFromLeader.java:109) at org.apache.solr.cloud.ZkController.startReplicationFromLeader(ZkController.java:1330) at org.apache.solr.cloud.RecoveryStrategy.doSyncOrReplicateRecovery(RecoveryStrategy.java:693) at org.apache.solr.cloud.RecoveryStrategy.doRecovery(RecoveryStrategy.java:336) at org.apache.solr.cloud.RecoveryStrategy.run(RecoveryStrategy.java:317) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:181) at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) at java.util.concurrent.FutureTask.run(FutureTask.java:266) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748) >
Stack Trace:
java.lang.AssertionError: ObjectTracker found 7 object(s) that were not released!!! [InternalHttpClient, MockDirectoryWrapper, MockDirectoryWrapper, MockDirectoryWrapper, MockDirectoryWrapper, SolrCore, InternalHttpClient]
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:230)
at org.apache.solr.handler.IndexFetcher.<init>(IndexFetcher.java:272)
at org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:420)
at org.apache.solr.cloud.RecoveryStrategy.replicate(RecoveryStrategy.java:250)
at org.apache.solr.cloud.RecoveryStrategy.doSyncOrReplicateRecovery(RecoveryStrategy.java:662)
at org.apache.solr.cloud.RecoveryStrategy.doRecovery(RecoveryStrategy.java:336)
at org.apache.solr.cloud.RecoveryStrategy.run(RecoveryStrategy.java:317)
at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:181)
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
at java.util.concurrent.FutureTask.run(FutureTask.java:266)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.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:396)
at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:773)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:1003)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:914)
at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1251)
at org.apache.solr.core.CoreContainer.create(CoreContainer.java:1162)
at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:92)
at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:360)
at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:396)
at org.apache.solr.handler.admin.CoreAdminHandler.lambda$handleRequestBody$0(CoreAdminHandler.java:188)
at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:181)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.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:544)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:995)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:914)
at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1251)
at org.apache.solr.core.CoreContainer.create(CoreContainer.java:1162)
at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:92)
at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:360)
at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:396)
at org.apache.solr.handler.admin.CoreAdminHandler.lambda$handleRequestBody$0(CoreAdminHandler.java:188)
at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:181)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MockDirectoryWrapper
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348)
at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:509)
at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:351)
at org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:424)
at org.apache.solr.handler.ReplicationHandler.lambda$setupPolling$13(ReplicationHandler.java:1193)
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:308)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:180)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:294)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
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:99)
at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:805)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:1003)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:914)
at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1251)
at org.apache.solr.core.CoreContainer.create(CoreContainer.java:1162)
at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:92)
at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:360)
at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:396)
at org.apache.solr.handler.admin.CoreAdminHandler.lambda$handleRequestBody$0(CoreAdminHandler.java:188)
at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:181)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.solr.core.SolrCore
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:1093)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:914)
at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1251)
at org.apache.solr.core.CoreContainer.create(CoreContainer.java:1162)
at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:92)
at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:360)
at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:396)
at org.apache.solr.handler.admin.CoreAdminHandler.lambda$handleRequestBody$0(CoreAdminHandler.java:188)
at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:181)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.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:230)
at org.apache.solr.handler.IndexFetcher.<init>(IndexFetcher.java:272)
at org.apache.solr.handler.ReplicationHandler.inform(ReplicationHandler.java:1224)
at org.apache.solr.cloud.ReplicateFromLeader.startReplication(ReplicateFromLeader.java:109)
at org.apache.solr.cloud.ZkController.startReplicationFromLeader(ZkController.java:1330)
at org.apache.solr.cloud.RecoveryStrategy.doSyncOrReplicateRecovery(RecoveryStrategy.java:693)
at org.apache.solr.cloud.RecoveryStrategy.doRecovery(RecoveryStrategy.java:336)
at org.apache.solr.cloud.RecoveryStrategy.run(RecoveryStrategy.java:317)
at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:181)
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
at java.util.concurrent.FutureTask.run(FutureTask.java:266)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
expected null, but was:<ObjectTracker found 7 object(s) that were not released!!! [InternalHttpClient, MockDirectoryWrapper, MockDirectoryWrapper, MockDirectoryWrapper, MockDirectoryWrapper, SolrCore, InternalHttpClient]
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:230)
at org.apache.solr.handler.IndexFetcher.<init>(IndexFetcher.java:272)
at org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:420)
at org.apache.solr.cloud.RecoveryStrategy.replicate(RecoveryStrategy.java:250)
at org.apache.solr.cloud.RecoveryStrategy.doSyncOrReplicateRecovery(RecoveryStrategy.java:662)
at org.apache.solr.cloud.RecoveryStrategy.doRecovery(RecoveryStrategy.java:336)
at org.apache.solr.cloud.RecoveryStrategy.run(RecoveryStrategy.java:317)
at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:181)
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
at java.util.concurrent.FutureTask.run(FutureTask.java:266)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.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:396)
at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:773)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:1003)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:914)
at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1251)
at org.apache.solr.core.CoreContainer.create(CoreContainer.java:1162)
at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:92)
at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:360)
at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:396)
at org.apache.solr.handler.admin.CoreAdminHandler.lambda$handleRequestBody$0(CoreAdminHandler.java:188)
at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:181)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.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:544)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:995)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:914)
at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1251)
at org.apache.solr.core.CoreContainer.create(CoreContainer.java:1162)
at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:92)
at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:360)
at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:396)
at org.apache.solr.handler.admin.CoreAdminHandler.lambda$handleRequestBody$0(CoreAdminHandler.java:188)
at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:181)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MockDirectoryWrapper
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348)
at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:509)
at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:351)
at org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:424)
at org.apache.solr.handler.ReplicationHandler.lambda$setupPolling$13(ReplicationHandler.java:1193)
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:308)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:180)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:294)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
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:99)
at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:805)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:1003)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:914)
at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1251)
at org.apache.solr.core.CoreContainer.create(CoreContainer.java:1162)
at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:92)
at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:360)
at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:396)
at org.apache.solr.handler.admin.CoreAdminHandler.lambda$handleRequestBody$0(CoreAdminHandler.java:188)
at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:181)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.solr.core.SolrCore
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:1093)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:914)
at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1251)
at org.apache.solr.core.CoreContainer.create(CoreContainer.java:1162)
at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:92)
at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:360)
at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:396)
at org.apache.solr.handler.admin.CoreAdminHandler.lambda$handleRequestBody$0(CoreAdminHandler.java:188)
at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:181)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.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:230)
at org.apache.solr.handler.IndexFetcher.<init>(IndexFetcher.java:272)
at org.apache.solr.handler.ReplicationHandler.inform(ReplicationHandler.java:1224)
at org.apache.solr.cloud.ReplicateFromLeader.startReplication(ReplicateFromLeader.java:109)
at org.apache.solr.cloud.ZkController.startReplicationFromLeader(ZkController.java:1330)
at org.apache.solr.cloud.RecoveryStrategy.doSyncOrReplicateRecovery(RecoveryStrategy.java:693)
at org.apache.solr.cloud.RecoveryStrategy.doRecovery(RecoveryStrategy.java:336)
at org.apache.solr.cloud.RecoveryStrategy.run(RecoveryStrategy.java:317)
at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:181)
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
at java.util.concurrent.FutureTask.run(FutureTask.java:266)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
>
at __randomizedtesting.SeedInfo.seed([D0907050D186968D]:0)
at org.junit.Assert.fail(Assert.java:88)
at org.junit.Assert.failNotNull(Assert.java:755)
at org.junit.Assert.assertNull(Assert.java:737)
at org.apache.solr.SolrTestCaseJ4.teardownTestCases(SolrTestCaseJ4.java:342)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java: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 com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
Build Log:
[...truncated 13243 lines...]
[junit4] Suite: org.apache.solr.cloud.api.collections.TestLocalFSCloudBackupRestore
[junit4] 2> 7467 INFO (SUITE-TestLocalFSCloudBackupRestore-seed#[D0907050D186968D]-worker) [ ] o.a.s.SolrTestCaseJ4 Created dataDir: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.api.collections.TestLocalFSCloudBackupRestore_D0907050D186968D-001/data-dir-1-001
[junit4] 2> 7964 INFO (SUITE-TestLocalFSCloudBackupRestore-seed#[D0907050D186968D]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 8176 INFO (SUITE-TestLocalFSCloudBackupRestore-seed#[D0907050D186968D]-worker) [ ] o.e.j.u.log Logging initialized @8247ms to org.eclipse.jetty.util.log.Slf4jLog
[junit4] 2> 8198 INFO (SUITE-TestLocalFSCloudBackupRestore-seed#[D0907050D186968D]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN) w/ MAC_OS_X supressed clientAuth
[junit4] 2> 8293 INFO (SUITE-TestLocalFSCloudBackupRestore-seed#[D0907050D186968D]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 8314 INFO (SUITE-TestLocalFSCloudBackupRestore-seed#[D0907050D186968D]-worker) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.api.collections.TestLocalFSCloudBackupRestore_D0907050D186968D-001/tempDir-001
[junit4] 2> 8345 INFO (SUITE-TestLocalFSCloudBackupRestore-seed#[D0907050D186968D]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 8350 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 8350 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 8661 INFO (SUITE-TestLocalFSCloudBackupRestore-seed#[D0907050D186968D]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port:50444
[junit4] 2> 8661 INFO (SUITE-TestLocalFSCloudBackupRestore-seed#[D0907050D186968D]-worker) [ ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:50444
[junit4] 2> 8675 INFO (SUITE-TestLocalFSCloudBackupRestore-seed#[D0907050D186968D]-worker) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:50444
[junit4] 2> 8676 INFO (SUITE-TestLocalFSCloudBackupRestore-seed#[D0907050D186968D]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 50444
[junit4] 2> 9129 INFO (SUITE-TestLocalFSCloudBackupRestore-seed#[D0907050D186968D]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 9284 INFO (zkConnectionManagerCallback-3-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 9284 INFO (SUITE-TestLocalFSCloudBackupRestore-seed#[D0907050D186968D]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 9377 INFO (SUITE-TestLocalFSCloudBackupRestore-seed#[D0907050D186968D]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 9381 INFO (zkConnectionManagerCallback-5-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 9381 INFO (SUITE-TestLocalFSCloudBackupRestore-seed#[D0907050D186968D]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 9382 INFO (SUITE-TestLocalFSCloudBackupRestore-seed#[D0907050D186968D]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 9385 INFO (zkConnectionManagerCallback-7-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 9385 INFO (SUITE-TestLocalFSCloudBackupRestore-seed#[D0907050D186968D]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 10137 WARN (jetty-launcher-8-thread-1) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 10146 WARN (jetty-launcher-8-thread-2) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 10670 INFO (jetty-launcher-8-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 10670 INFO (jetty-launcher-8-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 10671 INFO (jetty-launcher-8-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 10672 INFO (jetty-launcher-8-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 10704 INFO (jetty-launcher-8-thread-1) [ ] o.e.j.s.Server jetty-9.4.19.v20190610; built: 2019-06-10T16:30:51.723Z; git: afcf563148970e98786327af5e07c261fda175d3; jvm 1.8.0_201-b09
[junit4] 2> 10705 INFO (jetty-launcher-8-thread-2) [ ] o.e.j.s.Server jetty-9.4.19.v20190610; built: 2019-06-10T16:30:51.723Z; git: afcf563148970e98786327af5e07c261fda175d3; jvm 1.8.0_201-b09
[junit4] 2> 10742 INFO (jetty-launcher-8-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 10742 INFO (jetty-launcher-8-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 10749 INFO (jetty-launcher-8-thread-2) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 10749 INFO (jetty-launcher-8-thread-2) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 10754 INFO (jetty-launcher-8-thread-1) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 10754 INFO (jetty-launcher-8-thread-2) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 10856 INFO (jetty-launcher-8-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@4046c955{/solr,null,AVAILABLE}
[junit4] 2> 10856 INFO (jetty-launcher-8-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@7ffe71fb{/solr,null,AVAILABLE}
[junit4] 2> 10914 INFO (jetty-launcher-8-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@5aff9726{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:50454}
[junit4] 2> 10914 INFO (jetty-launcher-8-thread-1) [ ] o.e.j.s.Server Started @10991ms
[junit4] 2> 10914 INFO (jetty-launcher-8-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=50454}
[junit4] 2> 10918 INFO (jetty-launcher-8-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@a5e6ed3{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:50455}
[junit4] 2> 10918 INFO (jetty-launcher-8-thread-2) [ ] o.e.j.s.Server Started @10994ms
[junit4] 2> 10919 INFO (jetty-launcher-8-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=50455}
[junit4] 2> 11430 ERROR (jetty-launcher-8-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 11430 ERROR (jetty-launcher-8-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 11430 INFO (jetty-launcher-8-thread-2) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 11430 INFO (jetty-launcher-8-thread-1) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 11430 INFO (jetty-launcher-8-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.3.0
[junit4] 2> 11430 INFO (jetty-launcher-8-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.3.0
[junit4] 2> 11438 INFO (jetty-launcher-8-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 11438 INFO (jetty-launcher-8-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 11438 INFO (jetty-launcher-8-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 11438 INFO (jetty-launcher-8-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 11438 INFO (jetty-launcher-8-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-10-03T04:45:53.962Z
[junit4] 2> 11439 INFO (jetty-launcher-8-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-10-03T04:45:53.963Z
[junit4] 2> 11548 INFO (jetty-launcher-8-thread-2) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 11548 INFO (jetty-launcher-8-thread-1) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 11550 INFO (jetty-launcher-8-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 11550 INFO (jetty-launcher-8-thread-2) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 11556 INFO (zkConnectionManagerCallback-12-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 11556 INFO (jetty-launcher-8-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 11557 INFO (zkConnectionManagerCallback-11-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 11558 INFO (jetty-launcher-8-thread-2) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 11565 INFO (jetty-launcher-8-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 11565 INFO (jetty-launcher-8-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 13768 INFO (jetty-launcher-8-thread-1) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 13777 INFO (jetty-launcher-8-thread-2) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 14223 WARN (jetty-launcher-8-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@7c3187b4[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 14223 WARN (jetty-launcher-8-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@7c3187b4[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 14224 WARN (jetty-launcher-8-thread-2) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@75c9a016[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 14224 WARN (jetty-launcher-8-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@75c9a016[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 14856 WARN (jetty-launcher-8-thread-2) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@2dfaaf84[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 14856 WARN (jetty-launcher-8-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@2dfaaf84[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 14858 WARN (jetty-launcher-8-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@5c30a7de[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 14858 WARN (jetty-launcher-8-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@5c30a7de[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 14884 INFO (jetty-launcher-8-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:50444/solr
[junit4] 2> 14884 INFO (jetty-launcher-8-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:50444/solr
[junit4] 2> 14939 INFO (jetty-launcher-8-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 14939 INFO (jetty-launcher-8-thread-2) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 14949 INFO (zkConnectionManagerCallback-24-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 14949 INFO (jetty-launcher-8-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 14953 INFO (zkConnectionManagerCallback-26-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 14954 INFO (jetty-launcher-8-thread-2) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 15088 INFO (jetty-launcher-8-thread-1) [n:127.0.0.1:50454_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 15088 INFO (jetty-launcher-8-thread-2) [n:127.0.0.1:50455_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 15095 INFO (zkConnectionManagerCallback-28-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 15096 INFO (jetty-launcher-8-thread-1) [n:127.0.0.1:50454_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 15097 INFO (zkConnectionManagerCallback-30-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 15098 INFO (jetty-launcher-8-thread-2) [n:127.0.0.1:50455_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 15730 INFO (jetty-launcher-8-thread-1) [n:127.0.0.1:50454_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:50454_solr
[junit4] 2> 15738 INFO (jetty-launcher-8-thread-2) [n:127.0.0.1:50455_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:50455_solr
[junit4] 2> 15738 INFO (jetty-launcher-8-thread-1) [n:127.0.0.1:50454_solr ] o.a.s.c.Overseer Overseer (id=72145739573166088-127.0.0.1:50454_solr-n_0000000000) starting
[junit4] 2> 15808 INFO (zkCallback-29-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 15808 INFO (zkCallback-27-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 15997 INFO (jetty-launcher-8-thread-2) [n:127.0.0.1:50455_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 15999 INFO (zkConnectionManagerCallback-42-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 15999 INFO (jetty-launcher-8-thread-2) [n:127.0.0.1:50455_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 16003 INFO (zkConnectionManagerCallback-44-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 16004 INFO (jetty-launcher-8-thread-1) [n:127.0.0.1:50454_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 16005 INFO (jetty-launcher-8-thread-1) [n:127.0.0.1:50454_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 16005 INFO (jetty-launcher-8-thread-2) [n:127.0.0.1:50455_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 16010 INFO (jetty-launcher-8-thread-2) [n:127.0.0.1:50455_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:50444/solr ready
[junit4] 2> 16011 INFO (jetty-launcher-8-thread-1) [n:127.0.0.1:50454_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 16015 INFO (jetty-launcher-8-thread-1) [n:127.0.0.1:50454_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:50444/solr ready
[junit4] 2> 16097 INFO (jetty-launcher-8-thread-2) [n:127.0.0.1:50455_solr ] o.a.s.c.PackageManager clusterprops.json changed , version -1
[junit4] 2> 16468 INFO (jetty-launcher-8-thread-2) [n:127.0.0.1:50455_solr ] o.a.s.c.b.r.BackupRepositoryFactory Added backup repository with configuration params {type = repository,name = poisioned,class = org.apache.solr.cloud.api.collections.TestLocalFSCloudBackupRestore$PoinsionedRepository,attributes = {default=true, name=poisioned, class=org.apache.solr.cloud.api.collections.TestLocalFSCloudBackupRestore$PoinsionedRepository},}
[junit4] 2> 16469 INFO (jetty-launcher-8-thread-2) [n:127.0.0.1:50455_solr ] o.a.s.c.b.r.BackupRepositoryFactory Added backup repository with configuration params {type = repository,name = local,class = org.apache.solr.core.backup.repository.LocalFileSystemRepository,attributes = {name=local, class=org.apache.solr.core.backup.repository.LocalFileSystemRepository},}
[junit4] 2> 16471 INFO (jetty-launcher-8-thread-2) [n:127.0.0.1:50455_solr ] o.a.s.c.b.r.BackupRepositoryFactory Default configuration for backup repository is with configuration params {type = repository,name = poisioned,class = org.apache.solr.cloud.api.collections.TestLocalFSCloudBackupRestore$PoinsionedRepository,attributes = {default=true, name=poisioned, class=org.apache.solr.cloud.api.collections.TestLocalFSCloudBackupRestore$PoinsionedRepository},}
[junit4] 2> 16626 INFO (OverseerStateUpdate-72145739573166088-127.0.0.1:50454_solr-n_0000000000) [n:127.0.0.1:50454_solr ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:50454_solr
[junit4] 2> 16679 INFO (jetty-launcher-8-thread-1) [n:127.0.0.1:50454_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:50454_solr as DOWN
[junit4] 2> 16790 INFO (jetty-launcher-8-thread-1) [n:127.0.0.1:50454_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 16793 INFO (jetty-launcher-8-thread-1) [n:127.0.0.1:50454_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:50454_solr
[junit4] 2> 16796 INFO (zkCallback-29-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 16796 INFO (zkCallback-43-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 16798 INFO (zkCallback-27-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 16798 INFO (zkCallback-41-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 16801 INFO (jetty-launcher-8-thread-1) [n:127.0.0.1:50454_solr ] o.a.s.c.PackageManager clusterprops.json changed , version -1
[junit4] 2> 16816 INFO (jetty-launcher-8-thread-1) [n:127.0.0.1:50454_solr ] o.a.s.c.b.r.BackupRepositoryFactory Added backup repository with configuration params {type = repository,name = poisioned,class = org.apache.solr.cloud.api.collections.TestLocalFSCloudBackupRestore$PoinsionedRepository,attributes = {default=true, name=poisioned, class=org.apache.solr.cloud.api.collections.TestLocalFSCloudBackupRestore$PoinsionedRepository},}
[junit4] 2> 16816 INFO (jetty-launcher-8-thread-1) [n:127.0.0.1:50454_solr ] o.a.s.c.b.r.BackupRepositoryFactory Added backup repository with configuration params {type = repository,name = local,class = org.apache.solr.core.backup.repository.LocalFileSystemRepository,attributes = {name=local, class=org.apache.solr.core.backup.repository.LocalFileSystemRepository},}
[junit4] 2> 16816 INFO (jetty-launcher-8-thread-1) [n:127.0.0.1:50454_solr ] o.a.s.c.b.r.BackupRepositoryFactory Default configuration for backup repository is with configuration params {type = repository,name = poisioned,class = org.apache.solr.cloud.api.collections.TestLocalFSCloudBackupRestore$PoinsionedRepository,attributes = {default=true, name=poisioned, class=org.apache.solr.cloud.api.collections.TestLocalFSCloudBackupRestore$PoinsionedRepository},}
[junit4] 2> 17819 INFO (jetty-launcher-8-thread-2) [n:127.0.0.1:50455_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 17819 INFO (jetty-launcher-8-thread-1) [n:127.0.0.1:50454_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 18355 INFO (jetty-launcher-8-thread-1) [n:127.0.0.1:50454_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_50454.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7f66a34e
[junit4] 2> 18367 INFO (jetty-launcher-8-thread-1) [n:127.0.0.1:50454_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_50454.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7f66a34e
[junit4] 2> 18372 INFO (jetty-launcher-8-thread-1) [n:127.0.0.1:50454_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_50454.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7f66a34e
[junit4] 2> 18388 INFO (jetty-launcher-8-thread-2) [n:127.0.0.1:50455_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_50455.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7f66a34e
[junit4] 2> 18390 INFO (jetty-launcher-8-thread-2) [n:127.0.0.1:50455_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_50455.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7f66a34e
[junit4] 2> 18390 INFO (jetty-launcher-8-thread-2) [n:127.0.0.1:50455_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_50455.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7f66a34e
[junit4] 2> 18563 INFO (jetty-launcher-8-thread-2) [n:127.0.0.1:50455_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.api.collections.TestLocalFSCloudBackupRestore_D0907050D186968D-001/tempDir-001/node2/.
[junit4] 2> 18564 INFO (jetty-launcher-8-thread-1) [n:127.0.0.1:50454_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.api.collections.TestLocalFSCloudBackupRestore_D0907050D186968D-001/tempDir-001/node1/.
[junit4] 2> 18761 INFO (SUITE-TestLocalFSCloudBackupRestore-seed#[D0907050D186968D]-worker) [ ] o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=2
[junit4] 2> 18762 INFO (SUITE-TestLocalFSCloudBackupRestore-seed#[D0907050D186968D]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 18766 INFO (zkConnectionManagerCallback-51-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 18766 INFO (SUITE-TestLocalFSCloudBackupRestore-seed#[D0907050D186968D]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 18770 INFO (SUITE-TestLocalFSCloudBackupRestore-seed#[D0907050D186968D]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 18773 INFO (SUITE-TestLocalFSCloudBackupRestore-seed#[D0907050D186968D]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:50444/solr ready
[junit4] 2> 18851 INFO (TEST-TestLocalFSCloudBackupRestore.testRestoreFailure-seed#[D0907050D186968D]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testRestoreFailure
[junit4] 2> 20163 INFO (qtp961100563-49) [n:127.0.0.1:50455_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params pullReplicas=1&collection.configName=conf1&maxShardsPerNode=4&name=backuprestore_testfailure&nrtReplicas=2&action=CREATE&numShards=2&tlogReplicas=1&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 20208 INFO (OverseerThreadFactory-14-thread-1-processing-n:127.0.0.1:50454_solr) [n:127.0.0.1:50454_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection backuprestore_testfailure
[junit4] 2> 20344 WARN (OverseerThreadFactory-14-thread-1-processing-n:127.0.0.1:50454_solr) [n:127.0.0.1:50454_solr ] o.a.s.c.a.c.CreateCollectionCmd Specified number of replicas of 4 on collection backuprestore_testfailure is higher than the number of Solr instances currently live or live and part of your createNodeSet(2). It's unusual to run two replica of the same slice on the same Solr-instance.
[junit4] 2> 20402 INFO (OverseerStateUpdate-72145739573166088-127.0.0.1:50454_solr-n_0000000000) [n:127.0.0.1:50454_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"backuprestore_testfailure",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"backuprestore_testfailure_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:50454/solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 20410 INFO (OverseerStateUpdate-72145739573166088-127.0.0.1:50454_solr-n_0000000000) [n:127.0.0.1:50454_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"backuprestore_testfailure",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"backuprestore_testfailure_shard1_replica_n2",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:50455/solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 20416 INFO (OverseerStateUpdate-72145739573166088-127.0.0.1:50454_solr-n_0000000000) [n:127.0.0.1:50454_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"backuprestore_testfailure",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"backuprestore_testfailure_shard1_replica_t4",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:50454/solr",
[junit4] 2> "type":"TLOG",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 20422 INFO (OverseerStateUpdate-72145739573166088-127.0.0.1:50454_solr-n_0000000000) [n:127.0.0.1:50454_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"backuprestore_testfailure",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"backuprestore_testfailure_shard1_replica_p6",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:50455/solr",
[junit4] 2> "type":"PULL",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 20433 INFO (OverseerStateUpdate-72145739573166088-127.0.0.1:50454_solr-n_0000000000) [n:127.0.0.1:50454_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"backuprestore_testfailure",
[junit4] 2> "shard":"shard2",
[junit4] 2> "core":"backuprestore_testfailure_shard2_replica_n8",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:50454/solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 20441 INFO (OverseerStateUpdate-72145739573166088-127.0.0.1:50454_solr-n_0000000000) [n:127.0.0.1:50454_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"backuprestore_testfailure",
[junit4] 2> "shard":"shard2",
[junit4] 2> "core":"backuprestore_testfailure_shard2_replica_n10",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:50455/solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 20450 INFO (OverseerStateUpdate-72145739573166088-127.0.0.1:50454_solr-n_0000000000) [n:127.0.0.1:50454_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"backuprestore_testfailure",
[junit4] 2> "shard":"shard2",
[junit4] 2> "core":"backuprestore_testfailure_shard2_replica_t12",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:50454/solr",
[junit4] 2> "type":"TLOG",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 20456 INFO (OverseerStateUpdate-72145739573166088-127.0.0.1:50454_solr-n_0000000000) [n:127.0.0.1:50454_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"backuprestore_testfailure",
[junit4] 2> "shard":"shard2",
[junit4] 2> "core":"backuprestore_testfailure_shard2_replica_p14",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:50455/solr",
[junit4] 2> "type":"PULL",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 20705 INFO (qtp2065026646-45) [n:127.0.0.1:50454_solr x:backuprestore_testfailure_shard1_replica_t4 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node7&collection.configName=conf1&newCollection=true&name=backuprestore_testfailure_shard1_replica_t4&action=CREATE&numShards=2&collection=backuprestore_testfailure&shard=shard1&wt=javabin&version=2&replicaType=TLOG
[junit4] 2> 20705 INFO (qtp961100563-53) [n:127.0.0.1:50455_solr x:backuprestore_testfailure_shard2_replica_n10 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node13&collection.configName=conf1&newCollection=true&name=backuprestore_testfailure_shard2_replica_n10&action=CREATE&numShards=2&collection=backuprestore_testfailure&shard=shard2&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 20705 INFO (qtp2065026646-41) [n:127.0.0.1:50454_solr x:backuprestore_testfailure_shard1_replica_n1 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf1&newCollection=true&name=backuprestore_testfailure_shard1_replica_n1&action=CREATE&numShards=2&collection=backuprestore_testfailure&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 20706 INFO (qtp961100563-48) [n:127.0.0.1:50455_solr x:backuprestore_testfailure_shard1_replica_p6 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node9&collection.configName=conf1&newCollection=true&name=backuprestore_testfailure_shard1_replica_p6&action=CREATE&numShards=2&collection=backuprestore_testfailure&shard=shard1&wt=javabin&version=2&replicaType=PULL
[junit4] 2> 20706 INFO (qtp961100563-50) [n:127.0.0.1:50455_solr x:backuprestore_testfailure_shard2_replica_p14 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node16&collection.configName=conf1&newCollection=true&name=backuprestore_testfailure_shard2_replica_p14&action=CREATE&numShards=2&collection=backuprestore_testfailure&shard=shard2&wt=javabin&version=2&replicaType=PULL
[junit4] 2> 20706 INFO (qtp2065026646-44) [n:127.0.0.1:50454_solr x:backuprestore_testfailure_shard2_replica_n8 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node11&collection.configName=conf1&newCollection=true&name=backuprestore_testfailure_shard2_replica_n8&action=CREATE&numShards=2&collection=backuprestore_testfailure&shard=shard2&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 20710 INFO (qtp961100563-48) [n:127.0.0.1:50455_solr x:backuprestore_testfailure_shard1_replica_p6 ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 20711 INFO (qtp961100563-52) [n:127.0.0.1:50455_solr x:backuprestore_testfailure_shard1_replica_n2 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node5&collection.configName=conf1&newCollection=true&name=backuprestore_testfailure_shard1_replica_n2&action=CREATE&numShards=2&collection=backuprestore_testfailure&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 20711 INFO (qtp2065026646-42) [n:127.0.0.1:50454_solr x:backuprestore_testfailure_shard2_replica_t12 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node15&collection.configName=conf1&newCollection=true&name=backuprestore_testfailure_shard2_replica_t12&action=CREATE&numShards=2&collection=backuprestore_testfailure&shard=shard2&wt=javabin&version=2&replicaType=TLOG
[junit4] 2> 21805 INFO (qtp2065026646-44) [n:127.0.0.1:50454_solr c:backuprestore_testfailure s:shard2 r:core_node11 x:backuprestore_testfailure_shard2_replica_n8 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.3.0
[junit4] 2> 21806 INFO (qtp2065026646-42) [n:127.0.0.1:50454_solr c:backuprestore_testfailure s:shard2 r:core_node15 x:backuprestore_testfailure_shard2_replica_t12 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.3.0
[junit4] 2> 21806 INFO (qtp961100563-52) [n:127.0.0.1:50455_solr c:backuprestore_testfailure s:shard1 r:core_node5 x:backuprestore_testfailure_shard1_replica_n2 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.3.0
[junit4] 2> 21807 INFO (qtp961100563-48) [n:127.0.0.1:50455_solr c:backuprestore_testfailure s:shard1 r:core_node9 x:backuprestore_testfailure_shard1_replica_p6 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.3.0
[junit4] 2> 21807 INFO (qtp961100563-50) [n:127.0.0.1:50455_solr c:backuprestore_testfailure s:shard2 r:core_node16 x:backuprestore_testfailure_shard2_replica_p14 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.3.0
[junit4] 2> 21807 INFO (qtp2065026646-45) [n:127.0.0.1:50454_solr c:backuprestore_testfailure s:shard1 r:core_node7 x:backuprestore_testfailure_shard1_replica_t4 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.3.0
[junit4] 2> 21808 INFO (qtp961100563-53) [n:127.0.0.1:50455_solr c:backuprestore_testfailure s:shard2 r:core_node13 x:backuprestore_testfailure_shard2_replica_n10 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.3.0
[junit4] 2> 21810 INFO (qtp2065026646-41) [n:127.0.0.1:50454_solr c:backuprestore_testfailure s:shard1 r:core_node3 x:backuprestore_testfailure_shard1_replica_n1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.3.0
[junit4] 2> 22117 INFO (qtp2065026646-41) [n:127.0.0.1:50454_solr c:backuprestore_testfailure s:shard1 r:core_node3 x:backuprestore_testfailure_shard1_replica_n1 ] o.a.s.s.IndexSchema [backuprestore_testfailure_shard1_replica_n1] Schema name=minimal
[junit4] 2> 22117 INFO (qtp961100563-50) [n:127.0.0.1:50455_solr c:backuprestore_testfailure s:shard2 r:core_node16 x:backuprestore_testfailure_shard2_replica_p14 ] o.a.s.s.IndexSchema [backuprestore_testfailure_shard2_replica_p14] Schema name=minimal
[junit4] 2> 22118 INFO (qtp961100563-48) [n:127.0.0.1:50455_solr c:backuprestore_testfailure s:shard1 r:core_node9 x:backuprestore_testfailure_shard1_replica_p6 ] o.a.s.s.IndexSchema [backuprestore_testfailure_shard1_replica_p6] Schema name=minimal
[junit4] 2> 22123 INFO (qtp2065026646-42) [n:127.0.0.1:50454_solr c:backuprestore_testfailure s:shard2 r:core_node15 x:backuprestore_testfailure_shard2_replica_t12 ] o.a.s.s.IndexSchema [backuprestore_testfailure_shard2_replica_t12] Schema name=minimal
[junit4] 2> 22123 INFO (qtp2065026646-45) [n:127.0.0.1:50454_solr c:backuprestore_testfailure s:shard1 r:core_node7 x:backuprestore_testfailure_shard1_replica_t4 ] o.a.s.s.IndexSchema [backuprestore_testfailure_shard1_replica_t4] Schema name=minimal
[junit4] 2> 22143 INFO (qtp961100563-53) [n:127.0.0.1:50455_solr c:backuprestore_testfailure s:shard2 r:core_node13 x:backuprestore_testfailure_shard2_replica_n10 ] o.a.s.s.IndexSchema [backuprestore_testfailure_shard2_replica_n10] Schema name=minimal
[junit4] 2> 22145 INFO (qtp961100563-52) [n:127.0.0.1:50455_solr c:backuprestore_testfailure s:shard1 r:core_node5 x:backuprestore_testfailure_shard1_replica_n2 ] o.a.s.s.IndexSchema [backuprestore_testfailure_shard1_replica_n2] Schema name=minimal
[junit4] 2> 22157 INFO (qtp2065026646-44) [n:127.0.0.1:50454_solr c:backuprestore_testfailure s:shard2 r:core_node11 x:backuprestore_testfailure_shard2_replica_n8 ] o.a.s.s.IndexSchema [backuprestore_testfailure_shard2_replica_n8] Schema name=minimal
[junit4] 2> 22310 INFO (qtp2065026646-45) [n:127.0.0.1:50454_solr c:backuprestore_testfailure s:shard1 r:core_node7 x:backuprestore_testfailure_shard1_replica_t4 ] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 22310 INFO (qtp2065026646-41) [n:127.0.0.1:50454_solr c:backuprestore_testfailure s:shard1 r:core_node3 x:backuprestore_testfailure_shard1_replica_n1 ] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 22310 INFO (qtp961100563-50) [n:127.0.0.1:50455_solr c:backuprestore_testfailure s:shard2 r:core_node16 x:backuprestore_testfailure_shard2_replica_p14 ] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 22310 INFO (qtp961100563-52) [n:127.0.0.1:50455_solr c:backuprestore_testfailure s:shard1 r:core_node5 x:backuprestore_testfailure_shard1_replica_n2 ] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 22310 INFO (qtp2065026646-44) [n:127.0.0.1:50454_solr c:backuprestore_testfailure s:shard2 r:core_node11 x:backuprestore_testfailure_shard2_replica_n8 ] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 22311 INFO (qtp961100563-53) [n:127.0.0.1:50455_solr c:backuprestore_testfailure s:shard2 r:core_node13 x:backuprestore_testfailure_shard2_replica_n10 ] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 22311 INFO (qtp2065026646-42) [n:127.0.0.1:50454_solr c:backuprestore_testfailure s:shard2 r:core_node15 x:backuprestore_testfailure_shard2_replica_t12 ] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 22311 INFO (qtp961100563-48) [n:127.0.0.1:50455_solr c:backuprestore_testfailure s:shard1 r:core_node9 x:backuprestore_testfailure_shard1_replica_p6 ] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 22312 INFO (qtp2065026646-41) [n:127.0.0.1:50454_solr c:backuprestore_testfailure s:shard1 r:core_node3 x:backuprestore_testfailure_shard1_replica_n1 ] o.a.s.c.CoreContainer Creating SolrCore 'backuprestore_testfailure_shard1_replica_n1' using configuration from collection backuprestore_testfailure, trusted=true
[junit4] 2> 22312 INFO (qtp2065026646-45) [n:127.0.0.1:50454_solr c:backuprestore_testfailure s:shard1 r:core_node7 x:backuprestore_testfailure_shard1_replica_t4 ] o.a.s.c.CoreContainer Creating SolrCore 'backuprestore_testfailure_shard1_replica_t4' using configuration from collection backuprestore_testfailure, trusted=true
[junit4] 2> 22312 INFO (qtp961100563-48) [n:127.0.0.1:50455_solr c:backuprestore_testfailure s:shard1 r:core_node9 x:backuprestore_testfailure_shard1_replica_p6 ] o.a.s.c.CoreContainer Creating SolrCore 'backuprestore_testfailure_shard1_replica_p6' using configuration from collection backuprestore_testfailure, trusted=true
[junit4] 2> 22312 INFO (qtp2065026646-42) [n:127.0.0.1:50454_solr c:backuprestore_testfailure s:shard2 r:core_node15 x:backuprestore_testfailure_shard2_replica_t12 ] o.a.s.c.CoreContainer Creating SolrCore 'backuprestore_testfailure_shard2_replica_t12' using configuration from collection backuprestore_testfailure, trusted=true
[junit4] 2> 22312 INFO (qtp961100563-53) [n:127.0.0.1:50455_solr c:backuprestore_testfailure s:shard2 r:core_node13 x:backuprestore_testfailure_shard2_replica_n10 ] o.a.s.c.CoreContainer Creating SolrCore 'backuprestore_testfailure_shard2_replica_n10' using configuration from collection backuprestore_testfailure, trusted=true
[junit4] 2> 22313 INFO (qtp2065026646-44) [n:127.0.0.1:50454_solr c:backuprestore_testfailure s:shard2 r:core_node11 x:backuprestore_testfailure_shard2_replica_n8 ] o.a.s.c.CoreContainer Creating SolrCore 'backuprestore_testfailure_shard2_replica_n8' using configuration from collection backuprestore_testfailure, trusted=true
[junit4] 2> 22313 INFO (qtp961100563-52) [n:127.0.0.1:50455_solr c:backuprestore_testfailure s:shard1 r:core_node5 x:backuprestore_testfailure_shard1_replica_n2 ] o.a.s.c.CoreContainer Creating SolrCore 'backuprestore_testfailure_shard1_replica_n2' using configuration from collection backuprestore_testfailure, trusted=true
[junit4] 2> 22313 INFO (qtp961100563-50) [n:127.0.0.1:50455_solr c:backuprestore_testfailure s:shard2 r:core_node16 x:backuprestore_testfailure_shard2_replica_p14 ] o.a.s.c.CoreContainer Creating SolrCore 'backuprestore_testfailure_shard2_replica_p14' using configuration from collection backuprestore_testfailure, trusted=true
[junit4] 2> 22432 INFO (qtp2065026646-45) [n:127.0.0.1:50454_solr c:backuprestore_testfailure s:shard1 r:core_node7 x:backuprestore_testfailure_shard1_replica_t4 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_50454.solr.core.backuprestore_testfailure.shard1.replica_t4' (registry 'solr.core.backuprestore_testfailure.shard1.replica_t4') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7f66a34e
[junit4] 2> 22433 INFO (qtp2065026646-41) [n:127.0.0.1:50454_solr c:backuprestore_testfailure s:shard1 r:core_node3 x:backuprestore_testfailure_shard1_replica_n1 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_50454.solr.core.backuprestore_testfailure.shard1.replica_n1' (registry 'solr.core.backuprestore_testfailure.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7f66a34e
[junit4] 2> 22433 INFO (qtp961100563-48) [n:127.0.0.1:50455_solr c:backuprestore_testfailure s:shard1 r:core_node9 x:backuprestore_testfailure_shard1_replica_p6 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_50455.solr.core.backuprestore_testfailure.shard1.replica_p6' (registry 'solr.core.backuprestore_testfailure.shard1.replica_p6') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7f66a34e
[junit4] 2> 22433 INFO (qtp2065026646-42) [n:127.0.0.1:50454_solr c:backuprestore_testfailure s:shard2 r:core_node15 x:backuprestore_testfailure_shard2_replica_t12 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_50454.solr.core.backuprestore_testfailure.shard2.replica_t12' (registry 'solr.core.backuprestore_testfailure.shard2.replica_t12') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7f66a34e
[junit4] 2> 22433 INFO (qtp961100563-50) [n:127.0.0.1:50455_solr c:backuprestore_testfailure s:shard2 r:core_node16 x:backuprestore_testfailure_shard2_replica_p14 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_50455.solr.core.backuprestore_testfailure.shard2.replica_p14' (registry 'solr.core.backuprestore_testfailure.shard2.replica_p14') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7f66a34e
[junit4] 2> 22434 INFO (qtp961100563-52) [n:127.0.0.1:50455_solr c:backuprestore_testfailure s:shard1 r:core_node5 x:backuprestore_testfailure_shard1_replica_n2 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_50455.solr.core.backuprestore_testfailure.shard1.replica_n2' (registry 'solr.core.backuprestore_testfailure.shard1.replica_n2') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7f66a34e
[junit4] 2> 22434 INFO (qtp961100563-53) [n:127.0.0.1:50455_solr c:backuprestore_testfailure s:shard2 r:core_node13 x:backuprestore_testfailure_shard2_replica_n10 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_50455.solr.core.backuprestore_testfailure.shard2.replica_n10' (registry 'solr.core.backuprestore_testfailure.shard2.replica_n10') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7f66a34e
[junit4] 2> 22434 INFO (qtp2065026646-44) [n:127.0.0.1:50454_solr c:backuprestore_testfailure s:shard2 r:core_node11 x:backuprestore_testfailure_shard2_replica_n8 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_50454.solr.core.backuprestore_testfailure.shard2.replica_n8' (registry 'solr.core.backuprestore_testfailure.shard2.replica_n8') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7f66a34e
[junit4] 2> 22478 INFO (qtp2065026646-45) [n:127.0.0.1:50454_solr c:backuprestore_testfailure s:shard1 r:core_node7 x:backuprestore_testfailure_shard1_replica_t4 ] o.a.s.c.SolrCore [[backuprestore_testfailure_shard1_replica_t4] ] Opening new SolrCore at [/Users/jenkins/
[...truncated too long message...]
ime: 1 minute 32 seconds
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5 -Dtests.class="*.TestLocalFSCloudBackupRestore" -Dtests.showOutput=onerror "-Dargs=-XX:-UseCompressedOops -XX:+UseParallelGC" -Dtests.seed=D0907050D186968D -Dtests.slow=true -Dtests.locale=fi -Dtests.timezone=Indian/Kerguelen -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
Buildfile: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/core/build.xml
-clover.disable:
ivy-configure:
[ivy:configure] :: Apache Ivy 2.4.0 - 20141213170938 :: http://ant.apache.org/ivy/ ::
[ivy:configure] :: loading settings :: file = /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/lucene/top-level-ivy-settings.xml
install-junit4-taskdef:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
resolve-groovy:
[ivy:cachepath] :: resolving dependencies :: org.codehaus.groovy#groovy-all-caller;working
[ivy:cachepath] confs: [default]
[ivy:cachepath] found org.codehaus.groovy#groovy-all;2.4.16 in public
[ivy:cachepath] :: resolution report :: resolve 16ms :: artifacts dl 1ms
---------------------------------------------------------------------
| | modules || artifacts |
| conf | number| search|dwnlded|evicted|| number|dwnlded|
---------------------------------------------------------------------
| default | 1 | 0 | 0 | 0 || 1 | 0 |
---------------------------------------------------------------------
-init-totals:
-test:
[mkdir] Created dir: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test
[junit4:pickseed] Seed property 'tests.seed' already defined: D0907050D186968D
[mkdir] Created dir: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/temp
[junit4] <JUnit4> says ciao! Master seed: D0907050D186968D
[junit4] Executing 5 suites with 2 JVMs.
[junit4]
[junit4] Started J1 PID(59267@serv1-vm2.sd-datasolutions.de).
[junit4] Started J0 PID(59268@serv1-vm2.sd-datasolutions.de).
[junit4] Suite: org.apache.solr.cloud.api.collections.TestLocalFSCloudBackupRestore
[junit4] OK 17.8s J1 | TestLocalFSCloudBackupRestore.testRestoreFailure
[junit4] OK 21.7s J1 | TestLocalFSCloudBackupRestore.test
[junit4] Completed [1/5] on J1 in 58.68s, 2 tests
[junit4]
[junit4] Suite: org.apache.solr.cloud.api.collections.TestLocalFSCloudBackupRestore
[junit4] OK 18.5s J0 | TestLocalFSCloudBackupRestore.testRestoreFailure
[junit4] OK 30.3s J0 | TestLocalFSCloudBackupRestore.test
[junit4] Completed [2/5] on J0 in 67.86s, 2 tests
[junit4]
[junit4] Suite: org.apache.solr.cloud.api.collections.TestLocalFSCloudBackupRestore
[junit4] OK 6.28s J1 | TestLocalFSCloudBackupRestore.testRestoreFailure
[junit4] OK 21.0s J1 | TestLocalFSCloudBackupRestore.test
[junit4] Completed [3/5] on J1 in 32.31s, 2 tests
[junit4]
[junit4] Suite: org.apache.solr.cloud.api.collections.TestLocalFSCloudBackupRestore
[junit4] OK 6.27s J0 | TestLocalFSCloudBackupRestore.testRestoreFailure
[junit4] OK 20.5s J0 | TestLocalFSCloudBackupRestore.test
[junit4] Completed [4/5] on J0 in 31.80s, 2 tests
[junit4]
[junit4] Suite: org.apache.solr.cloud.api.collections.TestLocalFSCloudBackupRestore
[junit4] OK 6.13s J1 | TestLocalFSCloudBackupRestore.testRestoreFailure
[junit4] OK 20.4s J1 | TestLocalFSCloudBackupRestore.test
[junit4] Completed [5/5] on J1 in 30.04s, 2 tests
[junit4]
[junit4] JVM J0: 0.96 .. 102.29 = 101.34s
[junit4] JVM J1: 0.69 .. 124.22 = 123.52s
[junit4] Execution time total: 2 minutes 4 seconds
[junit4] Tests summary: 5 suites, 10 tests
[junit4] Could not remove temporary path: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0 (java.nio.file.DirectoryNotEmptyException: Remaining files: [/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp])
[junit4] Could not remove temporary path: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1 (java.nio.file.DirectoryNotEmptyException: Remaining files: [/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp])
[echo] 5 slowest tests:
[junit4:tophints] 275.93s | org.apache.solr.cloud.autoscaling.IndexSizeTriggerTest
[junit4:tophints] 259.50s | org.apache.solr.cloud.api.collections.ShardSplitTest
[junit4:tophints] 172.32s | org.apache.solr.cloud.CollectionsAPISolrJTest
[junit4:tophints] 147.32s | org.apache.solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest
[junit4:tophints] 126.12s | org.apache.solr.cloud.ReindexCollectionTest
-check-totals:
test-nocompile:
BUILD SUCCESSFUL
Total time: 2 minutes 7 seconds
[repro] Failures:
[repro] 0/5 failed: org.apache.solr.cloud.api.collections.TestLocalFSCloudBackupRestore
[repro] Exiting with code 0
+ mv lucene/build lucene/build.repro
+ mv solr/build solr/build.repro
+ mv lucene/build.orig lucene/build
+ mv solr/build.orig solr/build
Archiving artifacts
Setting ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
java.lang.InterruptedException: no matches found within 10000
at hudson.FilePath$ValidateAntFileMask.hasMatch(FilePath.java:2822)
at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:2701)
at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:2682)
at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3069)
Also: hudson.remoting.Channel$CallSiteStackTrace: Remote call to MacOSX VBOX
at hudson.remoting.Channel.attachCallSiteStackTrace(Channel.java:1741)
at hudson.remoting.UserRequest$ExceptionResponse.retrieve(UserRequest.java:356)
at hudson.remoting.Channel.call(Channel.java:955)
at hudson.FilePath.act(FilePath.java:1069)
at hudson.FilePath.act(FilePath.java:1058)
at hudson.FilePath.validateAntFileMask(FilePath.java:2680)
at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:248)
at hudson.tasks.BuildStepCompatibilityLayer.perform(BuildStepCompatibilityLayer.java:79)
at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
at hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:741)
at hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:690)
at hudson.model.Build$BuildExecution.post2(Build.java:186)
at hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:635)
at hudson.model.Run.execute(Run.java:1860)
at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
at hudson.model.ResourceController.execute(ResourceController.java:97)
at hudson.model.Executor.run(Executor.java:429)
Caused: hudson.FilePath$TunneledInterruptedException
at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3071)
at hudson.remoting.UserRequest.perform(UserRequest.java:211)
at hudson.remoting.UserRequest.perform(UserRequest.java:54)
at hudson.remoting.Request$2.run(Request.java:369)
at hudson.remoting.InterceptingExecutorService$1.call(InterceptingExecutorService.java:72)
at java.util.concurrent.FutureTask.run(FutureTask.java:266)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
Caused: java.lang.InterruptedException: java.lang.InterruptedException: no matches found within 10000
at hudson.FilePath.act(FilePath.java:1071)
at hudson.FilePath.act(FilePath.java:1058)
at hudson.FilePath.validateAntFileMask(FilePath.java:2680)
at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:248)
at hudson.tasks.BuildStepCompatibilityLayer.perform(BuildStepCompatibilityLayer.java:79)
at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
at hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:741)
at hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:690)
at hudson.model.Build$BuildExecution.post2(Build.java:186)
at hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:635)
at hudson.model.Run.execute(Run.java:1860)
at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
at hudson.model.ResourceController.execute(ResourceController.java:97)
at hudson.model.Executor.run(Executor.java:429)
No artifacts found that match the file pattern "**/*.events,heapdumps/**,**/*_pid*.log". Configuration error?
[WARNINGS] Parsing warnings in console log with parser Java Compiler (javac)
Setting ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
No credentials specified
Setting ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
<Git Blamer> Using GitBlamer to create author and commit information for all warnings.
<Git Blamer> GIT_COMMIT=60b9ec0866e6223afb269fa377203f731cca2973, workspace=/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX
[WARNINGS] Computing warning deltas based on reference build #357
Recording test results
Setting ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Build step 'Publish JUnit test result report' changed build result to UNSTABLE
Email was triggered for: Unstable (Test Failures)
Sending email for trigger: Unstable (Test Failures)
Setting ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
[JENKINS] Lucene-Solr-8.x-MacOSX (64bit/jdk1.8.0) - Build # 360 -
Still Unstable!
Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-8.x-MacOSX/360/
Java: 64bit/jdk1.8.0 -XX:-UseCompressedOops -XX:+UseParallelGC
1 tests failed.
FAILED: org.apache.solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest.testCatTime
Error Message:
expected:<16> but was:<15>
Stack Trace:
java.lang.AssertionError: expected:<16> but was:<15>
at __randomizedtesting.SeedInfo.seed([44015EE4A14937C5:430A11E79EBA662D]:0)
at org.junit.Assert.fail(Assert.java:88)
at org.junit.Assert.failNotEquals(Assert.java:834)
at org.junit.Assert.assertEquals(Assert.java:645)
at org.junit.Assert.assertEquals(Assert.java:631)
at org.apache.solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest.assertCatTimeInvariants(DimensionalRoutedAliasUpdateProcessorTest.java:677)
at org.apache.solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest.testCatTime(DimensionalRoutedAliasUpdateProcessorTest.java:543)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
Build Log:
[...truncated 13282 lines...]
[junit4] Suite: org.apache.solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest
[junit4] 2> 74427 INFO (SUITE-DimensionalRoutedAliasUpdateProcessorTest-seed#[44015EE4A14937C5]-worker) [ ] o.a.s.SolrTestCaseJ4 Created dataDir: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_44015EE4A14937C5-001/data-dir-8-001
[junit4] 2> 74427 WARN (SUITE-DimensionalRoutedAliasUpdateProcessorTest-seed#[44015EE4A14937C5]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=3 numCloses=3
[junit4] 2> 74427 INFO (SUITE-DimensionalRoutedAliasUpdateProcessorTest-seed#[44015EE4A14937C5]-worker) [ ] o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 74431 INFO (SUITE-DimensionalRoutedAliasUpdateProcessorTest-seed#[44015EE4A14937C5]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN) w/ MAC_OS_X supressed clientAuth
[junit4] 2> 74431 INFO (SUITE-DimensionalRoutedAliasUpdateProcessorTest-seed#[44015EE4A14937C5]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 74434 INFO (TEST-DimensionalRoutedAliasUpdateProcessorTest.testCatTime-seed#[44015EE4A14937C5]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testCatTime
[junit4] 2> 74434 INFO (TEST-DimensionalRoutedAliasUpdateProcessorTest.testCatTime-seed#[44015EE4A14937C5]) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_44015EE4A14937C5-001/tempDir-001
[junit4] 2> 74434 INFO (TEST-DimensionalRoutedAliasUpdateProcessorTest.testCatTime-seed#[44015EE4A14937C5]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 74435 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 74435 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 74545 INFO (TEST-DimensionalRoutedAliasUpdateProcessorTest.testCatTime-seed#[44015EE4A14937C5]) [ ] o.a.s.c.ZkTestServer start zk server on port:59260
[junit4] 2> 74545 INFO (TEST-DimensionalRoutedAliasUpdateProcessorTest.testCatTime-seed#[44015EE4A14937C5]) [ ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:59260
[junit4] 2> 74545 INFO (TEST-DimensionalRoutedAliasUpdateProcessorTest.testCatTime-seed#[44015EE4A14937C5]) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:59260
[junit4] 2> 74545 INFO (TEST-DimensionalRoutedAliasUpdateProcessorTest.testCatTime-seed#[44015EE4A14937C5]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 59260
[junit4] 2> 74548 INFO (TEST-DimensionalRoutedAliasUpdateProcessorTest.testCatTime-seed#[44015EE4A14937C5]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 74562 INFO (zkConnectionManagerCallback-537-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 74562 INFO (TEST-DimensionalRoutedAliasUpdateProcessorTest.testCatTime-seed#[44015EE4A14937C5]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 74566 INFO (TEST-DimensionalRoutedAliasUpdateProcessorTest.testCatTime-seed#[44015EE4A14937C5]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 74568 INFO (zkConnectionManagerCallback-539-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 74568 INFO (TEST-DimensionalRoutedAliasUpdateProcessorTest.testCatTime-seed#[44015EE4A14937C5]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 74569 INFO (TEST-DimensionalRoutedAliasUpdateProcessorTest.testCatTime-seed#[44015EE4A14937C5]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 74572 INFO (zkConnectionManagerCallback-541-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 74572 INFO (TEST-DimensionalRoutedAliasUpdateProcessorTest.testCatTime-seed#[44015EE4A14937C5]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 74686 WARN (jetty-launcher-542-thread-3) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 74686 WARN (jetty-launcher-542-thread-2) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 74686 INFO (jetty-launcher-542-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 74686 INFO (jetty-launcher-542-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 74686 INFO (jetty-launcher-542-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 74686 INFO (jetty-launcher-542-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 74686 INFO (jetty-launcher-542-thread-2) [ ] o.e.j.s.Server jetty-9.4.19.v20190610; built: 2019-06-10T16:30:51.723Z; git: afcf563148970e98786327af5e07c261fda175d3; jvm 1.8.0_201-b09
[junit4] 2> 74686 INFO (jetty-launcher-542-thread-3) [ ] o.e.j.s.Server jetty-9.4.19.v20190610; built: 2019-06-10T16:30:51.723Z; git: afcf563148970e98786327af5e07c261fda175d3; jvm 1.8.0_201-b09
[junit4] 2> 74686 WARN (jetty-launcher-542-thread-1) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 74687 INFO (jetty-launcher-542-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 74687 INFO (jetty-launcher-542-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 74687 INFO (jetty-launcher-542-thread-1) [ ] o.e.j.s.Server jetty-9.4.19.v20190610; built: 2019-06-10T16:30:51.723Z; git: afcf563148970e98786327af5e07c261fda175d3; jvm 1.8.0_201-b09
[junit4] 2> 74688 INFO (jetty-launcher-542-thread-2) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 74688 INFO (jetty-launcher-542-thread-2) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 74688 INFO (jetty-launcher-542-thread-2) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 74689 INFO (jetty-launcher-542-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@5ad4553c{/solr,null,AVAILABLE}
[junit4] 2> 74690 WARN (jetty-launcher-542-thread-4) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 74690 INFO (jetty-launcher-542-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 74690 INFO (jetty-launcher-542-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 74690 INFO (jetty-launcher-542-thread-4) [ ] o.e.j.s.Server jetty-9.4.19.v20190610; built: 2019-06-10T16:30:51.723Z; git: afcf563148970e98786327af5e07c261fda175d3; jvm 1.8.0_201-b09
[junit4] 2> 74691 INFO (jetty-launcher-542-thread-3) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 74691 INFO (jetty-launcher-542-thread-3) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 74691 INFO (jetty-launcher-542-thread-3) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 74693 INFO (jetty-launcher-542-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@306c36b9{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:59265}
[junit4] 2> 74693 INFO (jetty-launcher-542-thread-2) [ ] o.e.j.s.Server Started @74776ms
[junit4] 2> 74693 INFO (jetty-launcher-542-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=59265}
[junit4] 2> 74700 INFO (jetty-launcher-542-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 74700 INFO (jetty-launcher-542-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 74700 INFO (jetty-launcher-542-thread-1) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 74701 INFO (jetty-launcher-542-thread-4) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 74701 INFO (jetty-launcher-542-thread-4) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 74701 INFO (jetty-launcher-542-thread-4) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 74701 INFO (jetty-launcher-542-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@6b3db986{/solr,null,AVAILABLE}
[junit4] 2> 74702 ERROR (jetty-launcher-542-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 74702 INFO (jetty-launcher-542-thread-2) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 74702 INFO (jetty-launcher-542-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.3.0
[junit4] 2> 74702 INFO (jetty-launcher-542-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 74702 INFO (jetty-launcher-542-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 74702 INFO (jetty-launcher-542-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-10-03T17:05:53.277Z
[junit4] 2> 74702 INFO (jetty-launcher-542-thread-4) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@20f4a682{/solr,null,AVAILABLE}
[junit4] 2> 74703 INFO (jetty-launcher-542-thread-3) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@5701c54f{/solr,null,AVAILABLE}
[junit4] 2> 74704 INFO (jetty-launcher-542-thread-2) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 74704 INFO (jetty-launcher-542-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@426ad2af{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:59266}
[junit4] 2> 74704 INFO (jetty-launcher-542-thread-1) [ ] o.e.j.s.Server Started @74787ms
[junit4] 2> 74704 INFO (jetty-launcher-542-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=59266}
[junit4] 2> 74704 ERROR (jetty-launcher-542-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 74704 INFO (jetty-launcher-542-thread-1) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 74705 INFO (jetty-launcher-542-thread-3) [ ] o.e.j.s.AbstractConnector Started ServerConnector@5fda6cac{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:59268}
[junit4] 2> 74705 INFO (jetty-launcher-542-thread-3) [ ] o.e.j.s.Server Started @74788ms
[junit4] 2> 74705 INFO (jetty-launcher-542-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=59268}
[junit4] 2> 74705 ERROR (jetty-launcher-542-thread-3) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 74705 INFO (jetty-launcher-542-thread-3) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 74705 INFO (jetty-launcher-542-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.3.0
[junit4] 2> 74705 INFO (jetty-launcher-542-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 74705 INFO (jetty-launcher-542-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 74705 INFO (jetty-launcher-542-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-10-03T17:05:53.280Z
[junit4] 2> 74705 INFO (jetty-launcher-542-thread-4) [ ] o.e.j.s.AbstractConnector Started ServerConnector@56dd5022{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:59267}
[junit4] 2> 74706 INFO (jetty-launcher-542-thread-4) [ ] o.e.j.s.Server Started @74789ms
[junit4] 2> 74706 INFO (jetty-launcher-542-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=59267}
[junit4] 2> 74706 ERROR (jetty-launcher-542-thread-4) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 74706 INFO (jetty-launcher-542-thread-4) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 74706 INFO (jetty-launcher-542-thread-3) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.3.0
[junit4] 2> 74706 INFO (jetty-launcher-542-thread-3) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 74706 INFO (jetty-launcher-542-thread-3) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 74706 INFO (jetty-launcher-542-thread-3) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-10-03T17:05:53.281Z
[junit4] 2> 74707 INFO (jetty-launcher-542-thread-4) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.3.0
[junit4] 2> 74707 INFO (jetty-launcher-542-thread-4) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 74707 INFO (jetty-launcher-542-thread-4) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 74707 INFO (jetty-launcher-542-thread-4) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-10-03T17:05:53.282Z
[junit4] 2> 74708 INFO (jetty-launcher-542-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 74709 INFO (jetty-launcher-542-thread-4) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 74709 INFO (jetty-launcher-542-thread-3) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 74710 INFO (zkConnectionManagerCallback-544-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 74710 INFO (jetty-launcher-542-thread-2) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 74711 INFO (jetty-launcher-542-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 74720 INFO (zkConnectionManagerCallback-550-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 74720 INFO (jetty-launcher-542-thread-3) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 74721 INFO (zkConnectionManagerCallback-548-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 74721 INFO (jetty-launcher-542-thread-4) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 74722 INFO (zkConnectionManagerCallback-546-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 74722 INFO (jetty-launcher-542-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 74722 INFO (jetty-launcher-542-thread-3) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 74723 INFO (jetty-launcher-542-thread-4) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 74723 INFO (jetty-launcher-542-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 74914 INFO (jetty-launcher-542-thread-2) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 74915 WARN (jetty-launcher-542-thread-2) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@31214add[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 74915 WARN (jetty-launcher-542-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@31214add[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 74920 WARN (jetty-launcher-542-thread-2) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@252e7e4e[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 74920 WARN (jetty-launcher-542-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@252e7e4e[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 74920 INFO (jetty-launcher-542-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:59260/solr
[junit4] 2> 74921 INFO (jetty-launcher-542-thread-2) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 74924 INFO (zkConnectionManagerCallback-557-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 74924 INFO (jetty-launcher-542-thread-2) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 75116 INFO (jetty-launcher-542-thread-4) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 75117 WARN (jetty-launcher-542-thread-4) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@4452b302[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 75117 WARN (jetty-launcher-542-thread-4) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@4452b302[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 75119 WARN (jetty-launcher-542-thread-4) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@5dbab596[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 75119 WARN (jetty-launcher-542-thread-4) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@5dbab596[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 75119 INFO (jetty-launcher-542-thread-4) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:59260/solr
[junit4] 2> 75119 INFO (jetty-launcher-542-thread-4) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 75126 INFO (zkConnectionManagerCallback-565-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 75126 INFO (jetty-launcher-542-thread-4) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 75196 INFO (jetty-launcher-542-thread-1) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 75197 WARN (jetty-launcher-542-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@2e4a1629[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 75197 WARN (jetty-launcher-542-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@2e4a1629[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 75200 WARN (jetty-launcher-542-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@32582cc7[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 75200 WARN (jetty-launcher-542-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@32582cc7[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 75200 INFO (jetty-launcher-542-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:59260/solr
[junit4] 2> 75201 INFO (jetty-launcher-542-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 75204 INFO (zkConnectionManagerCallback-572-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 75204 INFO (jetty-launcher-542-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 75251 INFO (jetty-launcher-542-thread-2) [n:127.0.0.1:59265_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 75256 INFO (zkConnectionManagerCallback-574-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 75256 INFO (jetty-launcher-542-thread-2) [n:127.0.0.1:59265_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 75292 INFO (jetty-launcher-542-thread-3) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 75293 WARN (jetty-launcher-542-thread-3) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@19db70f8[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 75293 WARN (jetty-launcher-542-thread-3) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@19db70f8[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 75296 WARN (jetty-launcher-542-thread-3) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@72077b97[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 75296 WARN (jetty-launcher-542-thread-3) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@72077b97[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 75296 INFO (jetty-launcher-542-thread-3) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:59260/solr
[junit4] 2> 75297 INFO (jetty-launcher-542-thread-3) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 75299 INFO (zkConnectionManagerCallback-580-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 75299 INFO (jetty-launcher-542-thread-3) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 75354 INFO (jetty-launcher-542-thread-1) [n:127.0.0.1:59266_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 75357 INFO (zkConnectionManagerCallback-582-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 75357 INFO (jetty-launcher-542-thread-1) [n:127.0.0.1:59266_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 75468 INFO (jetty-launcher-542-thread-4) [n:127.0.0.1:59267_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 75470 INFO (zkConnectionManagerCallback-584-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 75470 INFO (jetty-launcher-542-thread-4) [n:127.0.0.1:59267_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 75626 INFO (jetty-launcher-542-thread-4) [n:127.0.0.1:59267_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:59267_solr
[junit4] 2> 75629 INFO (jetty-launcher-542-thread-4) [n:127.0.0.1:59267_solr ] o.a.s.c.Overseer Overseer (id=72148649486319629-127.0.0.1:59267_solr-n_0000000000) starting
[junit4] 2> 75642 INFO (jetty-launcher-542-thread-4) [n:127.0.0.1:59267_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 75645 INFO (zkConnectionManagerCallback-595-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 75645 INFO (jetty-launcher-542-thread-4) [n:127.0.0.1:59267_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 75650 INFO (jetty-launcher-542-thread-4) [n:127.0.0.1:59267_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:59260/solr ready
[junit4] 2> 75652 INFO (OverseerStateUpdate-72148649486319629-127.0.0.1:59267_solr-n_0000000000) [n:127.0.0.1:59267_solr ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:59267_solr
[junit4] 2> 75652 INFO (jetty-launcher-542-thread-4) [n:127.0.0.1:59267_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:59267_solr
[junit4] 2> 75656 INFO (OverseerStateUpdate-72148649486319629-127.0.0.1:59267_solr-n_0000000000) [n:127.0.0.1:59267_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 75659 INFO (zkCallback-594-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 75660 INFO (zkCallback-581-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 75661 INFO (jetty-launcher-542-thread-4) [n:127.0.0.1:59267_solr ] o.a.s.c.PackageManager clusterprops.json changed , version -1
[junit4] 2> 75671 INFO (jetty-launcher-542-thread-1) [n:127.0.0.1:59266_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:59266_solr as DOWN
[junit4] 2> 75674 INFO (jetty-launcher-542-thread-1) [n:127.0.0.1:59266_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 75674 INFO (jetty-launcher-542-thread-1) [n:127.0.0.1:59266_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:59266_solr
[junit4] 2> 75677 INFO (zkCallback-581-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 75677 INFO (zkCallback-583-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 75677 INFO (zkCallback-594-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 75680 INFO (jetty-launcher-542-thread-1) [n:127.0.0.1:59266_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 75682 INFO (zkConnectionManagerCallback-600-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 75682 INFO (jetty-launcher-542-thread-1) [n:127.0.0.1:59266_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 75685 INFO (jetty-launcher-542-thread-1) [n:127.0.0.1:59266_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 75687 INFO (jetty-launcher-542-thread-1) [n:127.0.0.1:59266_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:59260/solr ready
[junit4] 2> 75687 INFO (jetty-launcher-542-thread-1) [n:127.0.0.1:59266_solr ] o.a.s.c.PackageManager clusterprops.json changed , version -1
[junit4] 2> 75712 INFO (jetty-launcher-542-thread-3) [n:127.0.0.1:59268_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 75717 INFO (zkConnectionManagerCallback-602-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 75731 INFO (jetty-launcher-542-thread-1) [n:127.0.0.1:59266_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 75732 INFO (jetty-launcher-542-thread-4) [n:127.0.0.1:59267_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 75764 INFO (jetty-launcher-542-thread-2) [n:127.0.0.1:59265_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 75791 INFO (jetty-launcher-542-thread-2) [n:127.0.0.1:59265_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:59265_solr as DOWN
[junit4] 2> 75794 INFO (jetty-launcher-542-thread-3) [n:127.0.0.1:59268_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 75795 INFO (jetty-launcher-542-thread-2) [n:127.0.0.1:59265_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 75795 INFO (jetty-launcher-542-thread-2) [n:127.0.0.1:59265_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:59265_solr
[junit4] 2> 75798 INFO (zkCallback-581-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 75798 INFO (zkCallback-599-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 75798 INFO (zkCallback-594-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 75798 INFO (zkCallback-583-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 75799 INFO (zkCallback-573-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 75801 INFO (jetty-launcher-542-thread-2) [n:127.0.0.1:59265_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 75803 INFO (zkConnectionManagerCallback-609-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 75803 INFO (jetty-launcher-542-thread-2) [n:127.0.0.1:59265_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 75805 INFO (jetty-launcher-542-thread-2) [n:127.0.0.1:59265_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
[junit4] 2> 75807 INFO (jetty-launcher-542-thread-2) [n:127.0.0.1:59265_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:59260/solr ready
[junit4] 2> 75808 INFO (jetty-launcher-542-thread-2) [n:127.0.0.1:59265_solr ] o.a.s.c.PackageManager clusterprops.json changed , version -1
[junit4] 2> 75810 INFO (jetty-launcher-542-thread-3) [n:127.0.0.1:59268_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
[junit4] 2> 75819 INFO (jetty-launcher-542-thread-3) [n:127.0.0.1:59268_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:59268_solr as DOWN
[junit4] 2> 75822 INFO (jetty-launcher-542-thread-3) [n:127.0.0.1:59268_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 75822 INFO (jetty-launcher-542-thread-3) [n:127.0.0.1:59268_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:59268_solr
[junit4] 2> 75825 INFO (zkCallback-608-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 75825 INFO (zkCallback-581-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 75825 INFO (zkCallback-594-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 75826 INFO (zkCallback-573-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 75826 INFO (zkCallback-599-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 75826 INFO (zkCallback-601-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 75826 INFO (zkCallback-583-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 75832 INFO (jetty-launcher-542-thread-3) [n:127.0.0.1:59268_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 75833 INFO (zkConnectionManagerCallback-616-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 75833 INFO (jetty-launcher-542-thread-3) [n:127.0.0.1:59268_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 75836 INFO (jetty-launcher-542-thread-3) [n:127.0.0.1:59268_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 75839 INFO (jetty-launcher-542-thread-3) [n:127.0.0.1:59268_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:59260/solr ready
[junit4] 2> 75839 INFO (jetty-launcher-542-thread-3) [n:127.0.0.1:59268_solr ] o.a.s.c.PackageManager clusterprops.json changed , version -1
[junit4] 2> 75882 INFO (jetty-launcher-542-thread-3) [n:127.0.0.1:59268_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 75906 INFO (jetty-launcher-542-thread-2) [n:127.0.0.1:59265_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 76021 INFO (jetty-launcher-542-thread-4) [n:127.0.0.1:59267_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_59267.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@290aad24
[junit4] 2> 76035 INFO (jetty-launcher-542-thread-1) [n:127.0.0.1:59266_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_59266.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@290aad24
[junit4] 2> 76040 INFO (jetty-launcher-542-thread-3) [n:127.0.0.1:59268_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_59268.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@290aad24
[junit4] 2> 76052 INFO (jetty-launcher-542-thread-2) [n:127.0.0.1:59265_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_59265.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@290aad24
[junit4] 2> 76084 INFO (jetty-launcher-542-thread-4) [n:127.0.0.1:59267_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_59267.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@290aad24
[junit4] 2> 76084 INFO (jetty-launcher-542-thread-4) [n:127.0.0.1:59267_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_59267.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@290aad24
[junit4] 2> 76089 INFO (jetty-launcher-542-thread-4) [n:127.0.0.1:59267_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_44015EE4A14937C5-001/tempDir-001/node4/.
[junit4] 2> 76091 INFO (jetty-launcher-542-thread-1) [n:127.0.0.1:59266_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_59266.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@290aad24
[junit4] 2> 76091 INFO (jetty-launcher-542-thread-1) [n:127.0.0.1:59266_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_59266.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@290aad24
[junit4] 2> 76091 INFO (jetty-launcher-542-thread-3) [n:127.0.0.1:59268_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_59268.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@290aad24
[junit4] 2> 76091 INFO (jetty-launcher-542-thread-3) [n:127.0.0.1:59268_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_59268.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@290aad24
[junit4] 2> 76092 INFO (jetty-launcher-542-thread-1) [n:127.0.0.1:59266_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_44015EE4A14937C5-001/tempDir-001/node1/.
[junit4] 2> 76092 INFO (jetty-launcher-542-thread-3) [n:127.0.0.1:59268_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_44015EE4A14937C5-001/tempDir-001/node3/.
[junit4] 2> 76097 INFO (jetty-launcher-542-thread-2) [n:127.0.0.1:59265_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_59265.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@290aad24
[junit4] 2> 76098 INFO (jetty-launcher-542-thread-2) [n:127.0.0.1:59265_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_59265.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@290aad24
[junit4] 2> 76098 INFO (jetty-launcher-542-thread-2) [n:127.0.0.1:59265_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_44015EE4A14937C5-001/tempDir-001/node2/.
[junit4] 2> 76423 INFO (TEST-DimensionalRoutedAliasUpdateProcessorTest.testCatTime-seed#[44015EE4A14937C5]) [ ] o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=4
[junit4] 2> 76424 INFO (TEST-DimensionalRoutedAliasUpdateProcessorTest.testCatTime-seed#[44015EE4A14937C5]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 76426 INFO (zkConnectionManagerCallback-623-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 76426 INFO (TEST-DimensionalRoutedAliasUpdateProcessorTest.testCatTime-seed#[44015EE4A14937C5]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 76429 INFO (TEST-DimensionalRoutedAliasUpdateProcessorTest.testCatTime-seed#[44015EE4A14937C5]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 76431 INFO (TEST-DimensionalRoutedAliasUpdateProcessorTest.testCatTime-seed#[44015EE4A14937C5]) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:59260/solr ready
[junit4] 2> 76432 INFO (TEST-DimensionalRoutedAliasUpdateProcessorTest.testCatTime-seed#[44015EE4A14937C5]) [ ] o.a.s.u.p.DimensionalRoutedAliasUpdateProcessorTest SolrClient: org.apache.solr.client.solrj.impl.CloudSolrClient@1344e5bd
[junit4] 2> 76432 INFO (TEST-DimensionalRoutedAliasUpdateProcessorTest.testCatTime-seed#[44015EE4A14937C5]) [ ] o.a.s.u.p.DimensionalRoutedAliasUpdateProcessorTest ClusterStateProvider 127.0.0.1:59260/solr
[junit4] 2> 76443 INFO (TEST-DimensionalRoutedAliasUpdateProcessorTest.testCatTime-seed#[44015EE4A14937C5]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 76446 INFO (zkConnectionManagerCallback-628-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 76446 INFO (TEST-DimensionalRoutedAliasUpdateProcessorTest.testCatTime-seed#[44015EE4A14937C5]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 76448 INFO (TEST-DimensionalRoutedAliasUpdateProcessorTest.testCatTime-seed#[44015EE4A14937C5]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 76451 INFO (TEST-DimensionalRoutedAliasUpdateProcessorTest.testCatTime-seed#[44015EE4A14937C5]) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:59260/solr ready
[junit4] 2> 76454 INFO (qtp1478141265-1354) [n:127.0.0.1:59267_solr ] o.a.s.h.a.ConfigSetsHandler Invoked ConfigSet Action :create with params baseConfigSet=_default&name=testCatTime&action=CREATE&wt=javabin&version=2
[junit4] 2> 76459 INFO (OverseerThreadFactory-309-thread-1-processing-n:127.0.0.1:59267_solr) [n:127.0.0.1:59267_solr ] o.a.s.c.OverseerConfigSetMessageHandler OverseerConfigSetMessageHandler.processMessage : create , {
[junit4] 2> "name":"testCatTime",
[junit4] 2> "baseConfigSet":"_default",
[junit4] 2> "immutable":"false",
[junit4] 2> "operation":"configsets:create"}
[junit4] 2> 76465 INFO (OverseerThreadFactory-309-thread-1-processing-n:127.0.0.1:59267_solr) [n:127.0.0.1:59267_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/managed-schema to /configs/testCatTime/managed-schema
[junit4] 2> 76468 INFO (OverseerThreadFactory-309-thread-1-processing-n:127.0.0.1:59267_solr) [n:127.0.0.1:59267_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/protwords.txt to /configs/testCatTime/protwords.txt
[junit4] 2> 76472 INFO (OverseerThreadFactory-309-thread-1-processing-n:127.0.0.1:59267_solr) [n:127.0.0.1:59267_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/solrconfig.xml to /configs/testCatTime/solrconfig.xml
[junit4] 2> 76474 INFO (OverseerThreadFactory-309-thread-1-processing-n:127.0.0.1:59267_solr) [n:127.0.0.1:59267_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/synonyms.txt to /configs/testCatTime/synonyms.txt
[junit4] 2> 76477 INFO (OverseerThreadFactory-309-thread-1-processing-n:127.0.0.1:59267_solr) [n:127.0.0.1:59267_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/stopwords.txt to /configs/testCatTime/stopwords.txt
[junit4] 2> 76481 INFO (OverseerThreadFactory-309-thread-1-processing-n:127.0.0.1:59267_solr) [n:127.0.0.1:59267_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/contractions_it.txt to /configs/testCatTime/lang/contractions_it.txt
[junit4] 2> 76484 INFO (OverseerThreadFactory-309-thread-1-processing-n:127.0.0.1:59267_solr) [n:127.0.0.1:59267_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/contractions_ca.txt to /configs/testCatTime/lang/contractions_ca.txt
[junit4] 2> 76487 INFO (OverseerThreadFactory-309-thread-1-processing-n:127.0.0.1:59267_solr) [n:127.0.0.1:59267_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stemdict_nl.txt to /configs/testCatTime/lang/stemdict_nl.txt
[junit4] 2> 76493 INFO (OverseerThreadFactory-309-thread-1-processing-n:127.0.0.1:59267_solr) [n:127.0.0.1:59267_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_hy.txt to /configs/testCatTime/lang/stopwords_hy.txt
[junit4] 2> 76497 INFO (OverseerThreadFactory-309-thread-1-processing-n:127.0.0.1:59267_solr) [n:127.0.0.1:59267_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_no.txt to /configs/testCatTime/lang/stopwords_no.txt
[junit4] 2> 76500 INFO (OverseerThreadFactory-309-thread-1-processing-n:127.0.0.1:59267_solr) [n:127.0.0.1:59267_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_id.txt to /configs/testCatTime/lang/stopwords_id.txt
[junit4] 2> 76504 INFO (OverseerThreadFactory-309-thread-1-processing-n:127.0.0.1:59267_solr) [n:127.0.0.1:59267_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_et.txt to /configs/testCatTime/lang/stopwords_et.txt
[junit4] 2> 76507 INFO (OverseerThreadFactory-309-thread-1-processing-n:127.0.0.1:59267_solr) [n:127.0.0.1:59267_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_da.txt to /configs/testCatTime/lang/stopwords_da.txt
[junit4] 2> 76511 INFO (OverseerThreadFactory-309-thread-1-processing-n:127.0.0.1:59267_solr) [n:127.0.0.1:59267_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ga.txt to /configs/testCatTime/lang/stopwords_ga.txt
[junit4] 2> 76514 INFO (OverseerThreadFactory-309-thread-1-processing-n:127.0.0.1:59267_solr) [n:127.0.0.1:59267_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_hi.txt to /configs/testCatTime/lang/stopwords_hi.txt
[junit4] 2> 76518 INFO (OverseerThreadFactory-309-thread-1-processing-n:127.0.0.1:59267_solr) [n:127.0.0.1:59267_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ja.txt to /configs/testCatTime/lang/stopwords_ja.txt
[junit4] 2> 76521 INFO (OverseerThreadFactory-309-thread-1-processing-n:127.0.0.1:59267_solr) [n:127.0.0.1:59267_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_pt.txt to /configs/testCatTime/lang/stopwords_pt.txt
[junit4] 2> 76525 INFO (OverseerThreadFactory-309-thread-1-processing-n:127.0.0.1:59267_solr) [n:127.0.0.1:59267_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_hu.txt to /configs/testCatTime/lang/stopwords_hu.txt
[junit4] 2> 76528 INFO (OverseerThreadFactory-309-thread-1-processing-n:127.0.0.1:59267_solr) [n:127.0.0.1:59267_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_el.txt to /configs/testCatTime/lang/stopwords_el.txt
[junit4] 2> 76531 INFO (OverseerThreadFactory-309-thread-1-processing-n:127.0.0.1:59267_solr) [n:127.0.0.1:59267_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ru.txt to /configs/testCatTime/lang/stopwords_ru.txt
[junit4] 2> 76535 INFO (OverseerThreadFactory-309-thread-1-processing-n:127.0.0.1:59267_solr) [n:127.0.0.1:59267_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_tr.txt to /configs/testCatTime/lang/stopwords_tr.txt
[junit4] 2> 76538 INFO (OverseerThreadFactory-309-thread-1-processing-n:127.0.0.1:59267_solr) [n:127.0.0.1:59267_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ar.txt to /configs/testCatTime/lang/stopwords_ar.txt
[junit4] 2> 76542 INFO (OverseerThreadFactory-309-thread-1-processing-n:127.0.0.1:59267_solr) [n:127.0.0.1:59267_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/userdict_ja.txt to /configs/testCatTime/lang/userdict_ja.txt
[junit4] 2> 76545 INFO (OverseerThreadFactory-309-thread-1-processing-n:127.0.0.1:59267_solr) [n:127.0.0.1:59267_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_eu.txt to /configs/testCatTime/lang/stopwords_eu.txt
[junit4] 2> 76547 INFO (OverseerThreadFactory-309-thread-1-processing-n:127.0.0.1:59267_solr) [n:127.0.0.1:59267_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_it.txt to /configs/testCatTime/lang/stopwords_it.txt
[junit4] 2> 76554 INFO (OverseerThreadFactory-309-thread-1-processing-n:127.0.0.1:59267_solr) [n:127.0.0.1:59267_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_cz.txt to /configs/testCatTime/lang/stopwords_cz.txt
[junit4] 2> 76558 INFO (OverseerThreadFactory-309-thread-1-processing-n:127.0.0.1:59267_solr) [n:127.0.0.1:59267_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stoptags_ja.txt to /configs/testCatTime/lang/stoptags_ja.txt
[junit4] 2> 76562 INFO (OverseerThreadFactory-309-thread-1-processing-n:127.0.0.1:59267_solr) [n:127.0.0.1:59267_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/contractions_fr.txt to /configs/testCatTime/lang/contractions_fr.txt
[junit4] 2> 76565 INFO (OverseerThreadFactory-309-thread-1-processing-n:127.0.0.1:59267_solr) [n:127.0.0.1:59267_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_de.txt to /configs/testCatTime/lang/stopwords_de.txt
[junit4] 2> 76568 INFO (OverseerThreadFactory-309-thread-1-processing-n:127.0.0.1:59267_solr) [n:127.0.0.1:59267_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_fa.txt to /configs/testCatTime/lang/stopwords_fa.txt
[junit4] 2> 76573 INFO (OverseerThreadFactory-309-thread-1-processing-n:127.0.0.1:59267_solr) [n:127.0.0.1:59267_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/contractions_ga.txt to /configs/testCatTime/lang/contractions_ga.txt
[junit4] 2> 76576 INFO (OverseerThreadFactory-309-thread-1-processing-n:127.0.0.1:59267_solr) [n:127.0.0.1:59267_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ca.txt to /configs/testCatTime/lang/stopwords_ca.txt
[junit4] 2> 76580 INFO (OverseerThreadFactory-309-thread-1-processing-n:127.0.0.1:59267_solr) [n:127.0.0.1:59267_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_nl.txt to /configs/testCatTime/lang/stopwords_nl.txt
[junit4] 2> 76583 INFO (OverseerThreadFactory-309-thread-1-processing-n:127.0.0.1:59267_solr) [n:127.0.0.1:59267_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_bg.txt to /configs/testCatTime/lang/stopwords_bg.txt
[junit4] 2> 76587 INFO (OverseerThreadFactory-309-thread-1-processing-n:127.0.0.1:59267_solr) [n:127.0.0.1:59267_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_en.txt to /configs/testCatTime/lang/stopwords_en.txt
[junit4] 2> 76590 INFO (OverseerThreadFactory-309-thread-1-processing-n:127.0.0.1:59267_solr) [n:127.0.0.1:59267_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_es.txt to /configs/testCatTime/lang/stopwords_es.txt
[junit4] 2> 76594 INFO (OverseerThreadFactory-309-thread-1-processing-n:127.0.0.1:59267_solr) [n:127.0.0.1:59267_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_lv.txt to /configs/testCatTime/lang/stopwords_lv.txt
[junit4] 2> 76600 INFO (OverseerThreadFactory-309-thread-1-processing-n:127.0.0.1:59267_solr) [n:127.0.0.1:59267_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ro.txt to /configs/testCatTime/lang/stopwords_ro.txt
[junit4] 2> 76603 INFO (OverseerThreadFactory-309-thread-1-processing-n:127.0.0.1:59267_solr) [n:127.0.0.1:59267_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_th.txt to /configs/testCatTime/lang/stopwords_th.txt
[junit4] 2> 76606 INFO (OverseerThreadFactory-309-thread-1-processing-n:127.0.0.1:59267_solr) [n:127.0.0.1:59267_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_fr.txt to /configs/testCatTime/lang/stopwords_fr.txt
[junit4] 2> 76610 INFO (OverseerThreadFactory-309-thread-1-processing-n:127.0.0.1:59267_solr) [n:127.0.0.1:59267_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_sv.txt to /configs/testCatTime/lang/stopwords_sv.txt
[junit4] 2> 76613 INFO (OverseerThreadFactory-309-thread-1-processing-n:127.0.0.1:59267_solr) [n:127.0.0.1:59267_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_fi.txt to /configs/testCatTime/lang/stopwords_fi.txt
[junit4] 2> 76617 INFO (OverseerThreadFactory-309-thread-1-processing-n:127.0.0.1:59267_solr) [n:127.0.0.1:59267_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/hyphenations_ga.txt to /configs/testCatTime/lang/hyphenations_ga.txt
[junit4] 2> 76619 INFO (OverseerThreadFactory-309-thread-1-processing-n:127.0.0.1:59267_solr) [n:127.0.0.1:59267_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_gl.txt to /configs/testCatTime/lang/stopwords_gl.txt
[junit4] 2> 76626 INFO (OverseerThreadFactory-309-thread-1-processing-n:127.0.0.1:59267_solr) [n:127.0.0.1:59267_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/params.json to /configs/testCatTime/params.json
[junit4] 2> 76632 INFO (qtp1478141265-1354) [n:127.0.0.1:59267_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/configs params={baseConfigSet=_default&name=testCatTime&action=CREATE&wt=javabin&version=2} status=0 QTime=178
[junit4] 2> 76633 INFO (qtp1478141265-1355) [n:127.0.0.1:59267_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params collection.configName=testCatTime&name=testCatTime&nrtReplicas=1&action=CREATE&numShards=1&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 76639 INFO (OverseerThreadFactory-309-thread-2-processing-n:127.0.0.1:59267_solr) [n:127.0.0.1:59267_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection testCatTime
[junit4] 2> 76639 INFO (OverseerCollectionConfigSetProcessor-72148649486319629-127.0.0.1:59267_solr-n_0000000000) [n:127.0.0.1:59267_solr ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000000 doesn't exist. Requestor may have disconnected from ZooKeeper
[junit4] 2> 76755 INFO (OverseerStateUpdate-72148649486319629-127.0.0.1:59267_solr-n_0000000000) [n:127.0.0.1:59267_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"testCatTime",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"testCatTime_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:59267/solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 76980 INFO (qtp1478141265-1357) [n:127.0.0.1:59267_solr x:testCatTime_shard1_replica_n1 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node2&collection.configName=testCatTime&newCollection=true&name=testCatTime_shard1_replica_n1&action=CREATE&numShards=1&collection=testCatTime&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 76981 INFO (qtp1478141265-1357) [n:127.0.0.1:59267_solr x:testCatTime_shard1_replica_n1 ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 78011 INFO (qtp1478141265-1357) [n:127.0.0.1:59267_solr c:testCatTime s:shard1 r:core_node2 x:testCatTime_shard1_replica_n1 ] o.a.s.c.RequestParams conf resource params.json loaded . version : 0
[junit4] 2> 78014 INFO (qtp1478141265-1357) [n:127.0.0.1:59267_solr c:testCatTime s:shard1 r:core_node2 x:testCatTime_shard1_replica_n1 ] o.a.s.c.RequestParams request params refreshed to version 0
[junit4] 2> 78018 WARN (qtp1478141265-1357) [n:127.0.0.1:59267_solr c:testCatTime s:shard1 r:core_node2 x:testCatTime_shard1_replica_n1 ] o.a.s.c.SolrConfig Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_44015EE4A14937C5-001/tempDir-001/node4/testCatTime_shard1_replica_n1/../../../../contrib/extraction/lib filtered by .*\.jar to classpath: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_44015EE4A14937C5-001/tempDir-001/node4/testCatTime_shard1_replica_n1/../../../../contrib/extraction/lib
[junit4] 2> 78018 WARN (qtp1478141265-1357) [n:127.0.0.1:59267_solr c:testCatTime s:shard1 r:core_node2 x:testCatTime_shard1_replica_n1 ] o.a.s.c.SolrConfig Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_44015EE4A14937C5-001/tempDir-001/node4/testCatTime_shard1_replica_n1/../../../../dist filtered by solr-cell-\d.*\.jar to classpath: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_44015EE4A14937C5-001/tempDir-001/node4/testCatTime_shard1_replica_n1/../../../../dist
[junit4] 2> 78019 WARN (qtp1478141265-1357) [n:127.0.0.1:59267_solr c:testCatTime s:shard1 r:core_node2 x:testCatTime_shard1_replica_n1 ] o.a.s.c.SolrConfig Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_44015EE4A14937C5-001/tempDir-001/node4/testCatTime_shard1_replica_n1/../../../../contrib/clustering/lib filtered by .*\.jar to classpath: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_44015EE4A14937C5-001/tempDir-001/node4/testCatTime_shard1_replica_n1/../../../../contrib/clustering/lib
[junit4] 2> 78019 WARN (qtp1478141265-1357) [n:127.0.0.1:59267_solr c:testCatTime s:shard1 r:core_node2 x:testCatTime_shard1_replica_n1 ] o.a.s.c.SolrConfig Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_44015EE4A14937C5-001/tempDir-001/node4/testCatTime_shard1_replica_n1/../../../../dist filtered by solr-clustering-\d.*\.jar to classpath: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_44015EE4A14937C5-001/tempDir-001/node4/testCatTime_shard1_replica_n1/../../../../dist
[junit4] 2> 78019 WARN (qtp1478141265-1357) [n:127.0.0.1:59267_solr c:testCatTime s:shard1 r:core_node2 x:testCatTime_shard1_replica_n1 ] o.a.s.c.SolrConfig Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_44015EE4A14937C5-001/tempDir-001/node4/testCatTime_shard1_replica_n1/../../../../contrib/langid/lib filtered by .*\.jar to classpath: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_44015EE4A14937C5-001/tempDir-001/node4/testCatTime_shard1_replica_n1/../../../../contrib/langid/lib
[junit4] 2> 78019 WARN (qtp1478141265-1357) [n:127.0.0.1:59267_solr c:testCatTime s:shard1 r:core_node2 x:testCatTime_shard1_replica_n1 ] o.a.s.c.SolrConfig Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_44015EE4A14937C5-001/tempDir-001/node4/testCatTime_shard1_replica_n1/../../../../dist filtered by solr-langid-\d.*\.jar to classpath: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_44015EE4A14937C5-001/tempDir-001/node4/testCatTime_shard1_replica_n1/../../../../dist
[junit4] 2> 78020 WARN (qtp1478141265-1357) [n:127.0.0.1:59267_solr c:testCatTime s:shard1 r:core_node2 x:testCatTime_shard1_replica_n1 ] o.a.s.c.SolrConfig Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_44015EE4A14937C5-001/tempDir-001/node4/testCatTime_shard1_replica_n1/../../../../contrib/velocity/lib filtered by .*\.jar to classpath: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_44015EE4A14937C5-001/tempDir-001/node4/testCatTime_shard1_replica_n1/../../../../contrib/velocity/lib
[junit4] 2> 78020 WARN (qtp1478141265-1357) [n:127.0.0.1:59267_solr c:testCatTime s:shard1 r:core_node2 x:testCatTime_shard1_replica_n1 ] o.a.s.c.SolrConfig Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_44015EE4A14937C5-001/tempDir-001/node4/testCatTime_shard1_replica_n1/../../../../dist filtered by solr-velocity-\d.*\.jar to classpath: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_44015EE4A14937C5-001/tempDir-001/node4/testCatTime_shard1_replica_n1/../../../../dist
[junit4] 2> 78020 WARN (qtp1478141265-1357) [n:127.0.0.1:59267_solr c:testCatTime s:shard1 r:core_node2 x:testCatTime_shard1_replica_n1 ] o.a.s.c.SolrConfig Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_44015EE4A14937C5-001/tempDir-001/node4/testCatTime_shard1_replica_n1/../../../../dist filtered by solr-ltr-\d.*\.jar to classpath: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_44015EE4A14937C5-001/tempDir-001/node4/testCatTime_shard1_replica_n1/../../../../dist
[junit4] 2> 78020 INFO (qtp1478141265-1357) [n:127.0.0.1:59267_solr c:testCatTime s:shard1 r:core_node2 x:testCatTime_shard1_replica_n1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.3.0
[junit4] 2> 78060 INFO (qtp1478141265-1357) [n:127.0.0.1:59267_solr c:testCatTime s:shard1 r:core_node2 x:testCatTime_shard1_replica_n1 ] o.a.s.s.IndexSchema [testCatTime_shard1_replica_n1] Schema name=default-config
[junit4] 2> 78344 INFO (qtp1478141265-1357) [n:127.0.0.1:59267_solr c:testCatTime s:shard1 r:core_node2 x:testCatTime_shard1_replica_n1 ] o.a.s.s.IndexSchema Loaded schema default-config/1.6 with uniqueid field id
[junit4] 2> 78415 INFO (qtp1478141265-1357) [n:127.0.0.1:59267_solr c:testCatTime s:shard1 r:core_node2 x:testCatTime_shard1_replica_n1 ] o.a.s.c.CoreContainer Creating SolrCore 'testCatTime_shard1_replica_n1' using configuration from collection testCatTime, trusted=true
[junit4] 2> 78416 INFO (qtp1478141265-1357) [n:127.0.0.1:59267_solr c:testCatTime s:shard1 r:core_node2 x:testCatTime_shard1_replica_n1 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_59267.solr.core.testCatTime.shard1.replica_n1' (registry 'solr.core.testCatTime.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@290aad24
[junit4] 2> 78416 INFO (qtp1478141265-1357) [n:127.0.0.1:59267_solr c:testCatTime s:shard1 r:core_node2 x:testCatTime_shard1_replica_n1 ] o.a.s.c.SolrCore [[testCatTime_shard1_replica_n1] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_44015EE4A14937C5-001/tempDir-001/node4/testCatTime_shard1_replica_n1], dataDir=[/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_44015EE4A14937C5-001/tempDir-001/node4/./testCatTime_shard1_replica_n1/data/]
[junit4] 2> 78528 INFO (qtp1478141265-1357) [n:127.0.0.1:59267_solr c:testCatTime s:shard1 r:core_node2 x:testCatTime_shard1_replica_n1 ] o.a.s.r.XSLTResponseWriter xsltCacheLifetimeSeconds=5
[junit4] 2> 79186 INFO (qtp1478141265-1357) [n:127.0.0.1:59267_solr c:testCatTime s:shard1 r:core_node2 x:testCatTime_shard1_replica_n1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 79186 INFO (qtp1478141265-1357) [n:127.0.0.1:59267_solr c:testCatTime s:shard1 r:core_node2 x:testCatTime_shard1_replica_n1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 79188 INFO (qtp1478141265-1357) [n:127.0.0.1:59267_solr c:testCatTime s:shard1 r:core_node2 x:testCatTime_shard1_replica_n1 ] o.a.s.u.CommitTracker Hard AutoCommit: if uncommitted for 15000ms;
[junit4] 2> 79188 INFO (qtp1478141265-1357) [n:127.0.0.1:59267_solr c:testCatTime s:shard1 r:core_node2 x:testCatTime_shard1_replica_n1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 79189 INFO (qtp1478141265-1357) [n:127.0.0.1:59267_solr c:testCatTime s:shard1 r:core_node2 x:testCatTime_shard1_replica_n1 ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1dfe438a[testCatTime_shard1_replica_n1] main]
[junit4] 2> 79192 INFO (qtp1478141265-1357) [n:127.0.0.1:59267_solr c:testCatTime s:shard1 r:core_node2 x:testCatTime_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/testCatTime
[junit4] 2> 79193 INFO (qtp1478141265-1357) [n:127.0.0.1:59267_solr c:testCatTime s:shard1 r:core_node2 x:testCatTime_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/testCatTime
[junit4] 2> 79202 INFO (qtp1478141265-1357) [n:127.0.0.1:59267_solr c:testCatTime s:shard1 r:core_node2 x:testCatTime_shard1_replica_n1 ] o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at /configs/testCatTime/managed-schema
[junit4] 2> 79205 INFO (qtp1478141265-1357) [n:127.0.0.1:59267_solr c:testCatTime s:shard1 r:core_node2 x:testCatTime_shard1_replica_n1 ] o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
[junit4] 2> 79206 INFO (qtp1478141265-1357) [n:127.0.0.1:59267_solr c:testCatTime s:shard1 r:core_node2 x:testCatTime_shard1_replica_n1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 79241 INFO (qtp1478141265-1357) [n:127.0.0.1:59267_solr c:testCatTime s:shard1 r:core_node2 x:testCatTime_shard1_replica_n1 ] o.a.s.s.DirectSolrSpellChecker init: {name=default,field=_text_,classname=solr.DirectSolrSpellChecker,distanceMeasure=internal,accuracy=0.5,maxEdits=2,minPrefix=1,maxInspections=5,minQueryLength=4,maxQueryFrequency=0.01}
[junit4] 2> 79279 INFO (qtp1478141265-1357) [n:127.0.0.1:59267_solr c:testCatTime s:shard1 r:core_node2 x:testCatTime_shard1_replica_n1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 79279 INFO (qtp1478141265-1357) [n:127.0.0.1:59267_solr c:testCatTime s:shard1 r:core_node2 x:testCatTime_shard1_replica_n1 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1646392621509115904
[junit4] 2> 79282 INFO (searcherExecutor-326-thread-1-processing-n:127.0.0.1:59267_solr x:testCatTime_shard1_replica_n1 c:testCatTime s:shard1 r:core_node2) [n:127.0.0.1:59267_solr c:testCatTime s:shard1 r:core_node2 x:testCatTime_shard1_replica_n1 ] o.a.s.c.QuerySenderListener QuerySenderListener sending requests to Searcher@1dfe438a[testCatTime_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 79282 INFO (searcherExecutor-326-thread-1-processing-n:127.0.0.1:59267_solr x:testCatTime_shard1_replica_n1 c:testCatTime s:shard1 r:core_node2) [n:127.0.0.1:59267_solr c:testCatTime s:shard1 r:core_node2 x:testCatTime_shard1_replica_n1 ] o.a.s.c.QuerySenderListener QuerySenderListener done.
[junit4] 2> 79282 INFO (searcherExecutor-326-thread-1-processing-n:127.0.0.1:59267_solr x:testCatTime_shard1_replica_n1 c:testCatTime s:shard1 r:core_node2) [n:127.0.0.1:59267_solr c:testCatTime s:shard1 r:core_node2 x:testCatTime_shard1_replica_n1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 79284 INFO (searcherExecutor-326-thread-1-processing-n:127.0.0.1:59267_solr x:testCatTime_shard1_replica_n1 c:testCatTime s:shard1 r:core_node2) [n:127.0.0.1:59267_solr c:testCatTime s:shard1 r:core_node2 x:testCatTime_shard1_replica_n1 ] o.a.s.c.SolrCore [testCatTime_shard1_replica_n1] Registered new searcher Searcher@1dfe438a[testCatTime_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 79288 INFO (qtp1478141265-1357) [n:127.0.0.1:59267_solr c:testCatTime s:shard1 r:core_node2 x:testCatTime_shard1_replica_n1 ] o.a.s.c.ZkShardTerms Successful update of terms at /collections/testCatTime/terms/shard1 to Terms{values={core_node2=0}, version=0}
[junit4] 2> 79288 INFO (qtp1478141265-1357) [n:127.0.0.1:59267_solr c:testCatTime s:shard1 r:core_node2 x:testCatTime_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/testCatTime/leaders/shard1
[junit4] 2> 79296 INFO (qtp1478141265-1357) [n:127.0.0.1:59267_solr c:testCatTime s:shard1 r:core_node2 x:testCatTime_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 79296 INFO (qtp1478141265-1357) [n:127.0.0.1:59267_solr c:testCatTime s:shard1 r:core_node2 x:testCatTime_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 79296 INFO (qtp1478141265-1357) [n:127.0.0.1:59267_solr c:testCatTime s:shard1 r:core_node2 x:testCatTime_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:59267/solr/testCatTime_shard1_replica_n1/
[junit4] 2> 79296 INFO (qtp1478141265-1357) [n:127.0.0.1:59267_solr c:testCatTime s:shard1 r:core_node2 x:testCatTime_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 79297 INFO (qtp1478141265-1357) [n:127.0.0.1:59267_solr c:testCatTime s:shard1 r:core_node2 x:testCatTime_shard1_replica_n1 ] o.a.s.c.SyncStrategy http://127.0.0.1:59267/solr/testCatTime_shard1_replica_n1/ has no replicas
[junit4] 2> 79297 INFO (qtp1478141265-1357) [n:127.0.0.1:59267_solr c:testCatTime s:shard1 r:core_node2 x:testCatTime_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/testCatTime/leaders/shard1/leader after winning as /collections/testCatTime/leader_elect/shard1/election/72148649486319629-core_node2-n_0000000000
[junit4] 2> 79301 INFO (qtp1478141265-1357) [n:127.0.0.1:59267_solr c:testCatTime s:shard1 r:core_node2 x:testCatTime_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:59267/solr/testCatTime_shard1_replica_n1/ shard1
[junit4] 2> 79304 INFO (zkCallback-583-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testCatTime/state.json] for collection [testCatTime] has occurred - updating... (live nodes size: [4])
[junit4] 2> 79304 INFO (zkCallback-583-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testCatTime/state.json] for collection [testCatTime] has occurred - updating... (live nodes size: [4])
[junit4] 2> 79306 INFO (qtp1478141265-1357) [n:127.0.0.1:59267_solr c:testCatTime s:shard1 r:core_node2 x:testCatTime_shard1_replica_n1 ] o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 79309 INFO (qtp1478141265-1357) [n:127.0.0.1:59267_solr c:testCatTime s:shard1 r:core_node2 x:testCatTime_shard1_replica_n1 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node2&collection.configName=testCatTime&newCollection=true&name=testCatTime_shard1_replica_n1&action=CREATE&numShards=1&collection=testCatTime&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=2329
[junit4] 2> 79313 INFO (qtp1478141265-1355) [n:127.0.0.1:59267_solr ] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 45 seconds. Check all shard replicas
[junit4] 2> 79420 INFO (zkCallback-583-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testCatTime/state.json] for collection [testCatTime] has occurred - updating... (live nodes size: [4])
[junit4] 2> 79420 INFO (zkCallback-583-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testCatTime/state.json] for collection [testCatTime] has occurred - updating... (live nodes size: [4])
[junit4] 2> 79421 INFO (zkCallback-583-thread-3) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testCatTime/state.json] for collection [testCatTime] has occurred - updating... (live nodes size: [4])
[junit4] 2> 79422 INFO (qtp1478141265-1355) [n:127.0.0.1:59267_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={collection.configName=testCatTime&name=testCatTime&nrtReplicas=1&action=CREATE&numShards=1&wt=javabin&version=2} status=0 QTime=2788
[junit4] 2> 79423 INFO (TEST-DimensionalRoutedAliasUpdateProcessorTest.testCatTime-seed#[44015EE4A14937C5]) [ ] o.a.s.c.SolrCloudTestCase waitForState (testCatTime): waiting for collections to be created
[junit4] 2> 80033 INFO (qtp1478141265-1352) [n:127.0.0.1:59267_solr c:testCatTime s:shard1 r:core_node2 x:testCatTime_shard1_replica_n1 ] o.a.s.h.SolrConfigHandler Executed config commands successfully and persisted to ZK [{"set-user-property":{"update.autoCreateFields":false}}, {"add-updateprocessor":{
[junit4] 2> "name":"tolerant",
[junit4] 2> "class":"solr.TolerantUpdateProcessorFactory"}}, {"add-updateprocessor":{
[junit4] 2> "name":"tracking-testSliceRouting",
[junit4] 2> "class":"solr.TrackingUpdateProcessorFactory",
[junit4] 2> "group":"testCatTime"}}, {"add-updateprocessor":{
[junit4] 2> "name":"inc",
[junit4] 2> "class":"org.apache.solr.update.processor.RoutedAliasUpdateProcessorTest$IncrementURPFactory",
[junit4] 2> "fieldName":"integer_i"}}]
[junit4] 2> 80033 INFO (qtp1478141265-1352) [n:127.0.0.1:59267_solr c:testCatTime s:shard1 r:core_node2 x:testCatTime_shard1_replica_n1 ] o.a.s.h.SolrConfigHandler Waiting up to 30 secs for 1 replicas to set the property overlay to be of version 0 for collection testCatTime
[junit4] 2> 80033 INFO (Thread-159) [ ] o.a.s.c.SolrCore config update listener called for core testCatTime_shard1_replica_n1
[junit4] 2> 80034 INFO (Thread-159) [ ] o.a.s.c.SolrCore core reload testCatTime_shard1_replica_n1
[junit4] 2> 80037 INFO (solrHandlerExecutor-331-thread-1-processing-n:127.0.0.1:59267_solr x:testCatTime_shard1_replica_n1 c:testCatTime s:shard1 r:core_node2) [n:127.0.0.1:59267_solr c:testCatTime s:shard1 r:core_node2 x:testCatTime_shard1_replica_n1 ] o.a.s.h.SolrConfigHandler Time elapsed : 0 secs, maxWait 30
[junit4] 2> 80056 INFO (Thread-159) [ ] o.a.s.c.RequestParams conf resource params.json loaded . version : 0
[junit4] 2> 80056 INFO (Thread-159) [ ] o.a.s.c.RequestParams request params refreshed to version 0
[junit4] 2> 80057 WARN (Thread-159) [ ] o.a.s.c.SolrConfig Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_44015EE4A14937C5-001/tempDir-001/node4/testCatTime_shard1_replica_n1/../../../../contrib/extraction/lib filtered by .*\.jar to classpath: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_44015EE4A14937C5-001/tempDir-001/node4/testCatTime_shard1_replica_n1/../../../../contrib/extraction/lib
[junit4] 2> 80057 WARN (Thread-159) [ ] o.a.s.c.SolrConfig Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_44015EE4A14937C5-001/tempDir-001/node4/testCatTime_shard1_replica_n1/../../../../dist filtered by solr-cell-\d.*\.jar to classpath: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_44015EE4A14937C5-001/tempDir-001/node4/testCatTime_shard1_replica_n1/../../../../dist
[junit4] 2> 80057 WARN (Thread-159) [ ] o.a.s.c.SolrConfig Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_44015EE4A14937C5-001/tempDir-001/node4/testCatTime_shard1_replica_n1/../../../../contrib/clustering/lib filtered by .*\.jar to classpath: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_44015EE4A14937C5-001/tempDir-001/node4/testCatTime_shard1_replica_n1/../../../../contrib/clustering/lib
[junit4] 2> 80057 WARN (Thread-159) [ ] o.a.s.c.SolrConfig Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_44015EE4A14937C5-001/tempDir-001/node4/testCatTime_shard1_replica_n1/../../../../dist filtered by solr-clustering-\d.*\.jar to classpath: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_44015EE4A14937C5-001/tempDir-001/node4/testCatTime_shard1_replica_n1/../../../../dist
[junit4] 2> 80058 WARN (Thread-159) [ ] o.a.s.c.SolrConfig Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_44015EE4A14937C5-001/tempDir-001/node4/testCatTime_shard1_replica_n1/../../../../contrib/langid/lib filtered by .*\.jar to classpath: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_44015EE4A14937C5-001/tempDir-001/node4/testCatTime_shard1_replica_n1/../../../../contrib/langid/lib
[junit4] 2> 80058 WARN (Thread-159) [ ] o.a.s.c.SolrConfig Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_44015EE4A14937C5-001/tempDir-001/node4/testCatTime_shard1_replica_n1/../../../../dist filtered by solr-langid-\d.*\.jar to classpath: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_44015EE4A14937C5-001/tempDir-001/node4/testCatTime_shard1_replica_n1/../../../../dist
[junit4] 2> 80059 WARN (Thread-159) [ ] o.a.s.c.SolrConfig Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_44015EE4A14937C5-001/tempDir-001/node4/testCatTime_shard1_replica_n1/../../../../contrib/velocity/lib filtered by .*\.jar to classpath: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_44015EE4A14937C5-001/tempDir-001/node4/testCatTime_shard1_replica_n1/../../../../contrib/velocity/lib
[junit4] 2> 80059 WARN (Thread-159) [ ] o.a.s.c.SolrConfig Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_44015EE4A14937C5-001/tempDir-001/node4/testCatTime_shard1_replica_n1/../../../../dist filtered by solr-velocity-\d.*\.jar to classpath: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_44015EE4A14937C5-001/tempDir-001/node4/testCatTime_shard1_replica_n1/../../../../dist
[junit4] 2> 80059 WARN (Thread-159) [ ] o.a.s.c.SolrConfig Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_44015EE4A14937C5-001/tempDir-001/node4/testCatTime_shard1_replica_n1/../../../../dist filtered by solr-ltr-\d.*\.jar to classpath: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_44015EE4A14937C5-001/tempDir-001/node4/testCatTime_shard1_replica_n1/../../../../dist
[junit4] 2> 80059 INFO (Thread-159) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.3.0
[junit4] 2> 80088 INFO (Thread-159) [ ] o.a.s.s.IndexSchema [testCatTime_shard1_replica_n1] Schema name=default-config
[junit4] 2> 80146 INFO (qtp1478141265-1356) [n:127.0.0.1:59267_solr c:testCatTime s:shard1 r:core_node2 x:testCatTime_shard1_replica_n1 ] o.a.s.h.SolrConfigHandler expecting overlay version 0 but my version is -1
[junit4] 2> 80146 INFO (qtp1478141265-1356) [n:127.0.0.1:59267_solr c:testCatTime s:shard1 r:core_node2 x:testCatTime_shard1_replica_n1 ] o.a.s.c.S.Request [testCatTime_shard1_replica_n1] webapp=/solr path=/config/znodeVersion params={overlay=0&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 80146 INFO (SolrConfigHandler-refreshconf) [ ] o.a.s.h.SolrConfigHandler Another reload is in progress . Not doing anything
[junit4] 2> 80147 INFO (solrHandlerExecutor-331-thread-1-processing-n:127.0.0.1:59267_solr x:testCatTime_shard1_replica_n1 c:testCatTime s:shard1 r:core_node2) [n:127.0.0.1:59267_solr c:testCatTime s:shard1 r:core_node2 x:testCatTime_shard1_replica_n1 ] o.a.s.h.SolrConfigHandler Could not get expectedVersion 0 from http://127.0.0.1:59267/solr/testCatTime_shard1_replica_n1/ for prop overlay after 0 attempts
[junit4] 2> 80147 INFO (solrHandlerExecutor-331-thread-1-processing-n:127.0.0.1:59267_solr x:testCatTime_shard1_replica_n1 c:testCatTime s:shard1 r:core_node2) [n:127.0.0.1:59267_solr c:testCatTime s:shard1 r:core_node2 x:testCatTime_shard1_replica_n1 ] o.a.s.h.SolrConfigHandler Time elapsed : 0 secs, maxWait 30
[junit4] 2> 80251 INFO (qtp1478141265-1357) [n:127.0.0.1:59267_solr c:testCatTime s:shard1 r:core_node2 x:testCatTime_shard1_replica_n1 ] o.a.s.h.SolrConfigHandler expecting overlay version 0 but my version is -1
[junit4] 2> 80252 INFO (qtp1478141265-1357) [n:127.0.0.1:59267_solr c:testCatTime s:shard1 r:core_node2 x:testCatTime_shard1_replica_n1 ] o.a.s.c.S.Request [testCatTime_shard1_replica_n1] webapp=/solr path=/config/znodeVersion params={overlay=0&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 80252 INFO (SolrConfigHandler-refreshconf) [ ] o.a.s.h.SolrConfigHandler Another reload is in progress . Not doing anything
[junit4] 2> 80252 INFO (Thread-159) [ ] o.a.s.s.IndexSchema Loaded schema default-config/1.6 with uniqueid field id
[junit4] 2> 80252 INFO (solrHandlerExecutor-331-thread-1-processing-n:127.0.0.1:59267_solr x:testCatTime_shard1_replica_n1 c:testCatTime s:shard1 r:core_node2) [n:127.0.0.1:59267_solr c:testCatTime s:shard1 r:core_node2 x:testCatTime_shard1_replica_n1 ] o.a.s.h.SolrConfigHandler Could not get expectedVersion 0 from http://127.0.0.1:59267/solr/testCatTime_shard1_replica_n1/ for prop overlay after 1 attempts
[junit4] 2> 80252 INFO (solrHandlerExecutor-331-thread-1-processing-n:127.0.0.1:59267_solr x:testCatTime_shard1_replica_n1 c:testCatTime s:shard1 r:core_node2) [n:127.0.0.1:59267_solr c:testCatTime s:shard1 r:core_node2 x:testCatTime_shard1_replica_n1 ] o.a.s.h.SolrConfigHandler Time elapsed : 0 secs, maxWait 30
[junit4] 2> 80325 INFO (Thread-159) [ ] o.a.s.c.CoreContainer Reloading SolrCore 'testCatTime_shard1_replica_n1' using configuration from collection testCatTime
[junit4] 2> 80344 INFO (Thread-159) [n:127.0.0.1:59267_solr c:testCatTime s:shard1 r:core_node2 x:testCatTime_shard1_replica_n1 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_59267.solr.core.testCatTime.shard1.replica_n1' (registry 'solr.core.testCatTime.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@290aad24
[junit4] 2> 80344 INFO (Thread-159) [n:127.0.0.1:59267_solr c:testCatTime s:shard1 r:core_node2 x:testCatTime_shard1_replica_n1 ] o.a.s.c.SolrCore [[testCatTime_shard1_replica_n1] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_44015EE4A14937C5-001/tempDir-001/node4/testCatTime_shard1_replica_n1], dataDir=[/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest_44015EE4A14937C5-001/tempDir-001/node4/./testCatTime_sh
[...truncated too long message...]
ins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test
[junit4:pickseed] Seed property 'tests.seed' already defined: 44015EE4A14937C5
[mkdir] Created dir: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/temp
[junit4] <JUnit4> says olá! Master seed: 44015EE4A14937C5
[junit4] Executing 5 suites with 2 JVMs.
[junit4]
[junit4] Started J0 PID(76625@serv1-vm2.sd-datasolutions.de).
[junit4] Started J1 PID(76624@serv1-vm2.sd-datasolutions.de).
[junit4] HEARTBEAT J0 PID(76625@serv1-vm2.sd-datasolutions.de): 2019-10-03T19:00:10, stalled for 61.6s at: DimensionalRoutedAliasUpdateProcessorTest.testCatTime
[junit4] HEARTBEAT J1 PID(76624@serv1-vm2.sd-datasolutions.de): 2019-10-03T19:00:10, stalled for 61.6s at: DimensionalRoutedAliasUpdateProcessorTest.testCatTime
[junit4] HEARTBEAT J0 PID(76625@serv1-vm2.sd-datasolutions.de): 2019-10-03T19:01:58, stalled for 69.1s at: DimensionalRoutedAliasUpdateProcessorTest.testTimeCat
[junit4] HEARTBEAT J1 PID(76624@serv1-vm2.sd-datasolutions.de): 2019-10-03T19:01:58, stalled for 68.2s at: DimensionalRoutedAliasUpdateProcessorTest.testTimeCat
[junit4] Suite: org.apache.solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest
[junit4] OK 101s J0 | DimensionalRoutedAliasUpdateProcessorTest.testCatTime
[junit4] OK 69.2s J0 | DimensionalRoutedAliasUpdateProcessorTest.testTimeCat
[junit4] Completed [1/5] on J0 in 178.79s, 2 tests
[junit4]
[junit4] Suite: org.apache.solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest
[junit4] OK 101s J1 | DimensionalRoutedAliasUpdateProcessorTest.testCatTime
[junit4] OK 69.6s J1 | DimensionalRoutedAliasUpdateProcessorTest.testTimeCat
[junit4] Completed [2/5] on J1 in 180.18s, 2 tests
[junit4]
[junit4] HEARTBEAT J1 PID(76624@serv1-vm2.sd-datasolutions.de): 2019-10-03T19:03:10, stalled for 69.2s at: DimensionalRoutedAliasUpdateProcessorTest.testCatTime
[junit4] HEARTBEAT J0 PID(76625@serv1-vm2.sd-datasolutions.de): 2019-10-03T19:04:10, stalled for 60.5s at: DimensionalRoutedAliasUpdateProcessorTest.testTimeCat
[junit4] HEARTBEAT J1 PID(76624@serv1-vm2.sd-datasolutions.de): 2019-10-03T19:04:22, stalled for 69.6s at: DimensionalRoutedAliasUpdateProcessorTest.testTimeCat
[junit4] Suite: org.apache.solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest
[junit4] OK 70.4s J0 | DimensionalRoutedAliasUpdateProcessorTest.testCatTime
[junit4] OK 82.4s J0 | DimensionalRoutedAliasUpdateProcessorTest.testTimeCat
[junit4] Completed [3/5] on J0 in 153.39s, 2 tests
[junit4]
[junit4] Suite: org.apache.solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest
[junit4] OK 71.6s J1 | DimensionalRoutedAliasUpdateProcessorTest.testCatTime
[junit4] OK 83.8s J1 | DimensionalRoutedAliasUpdateProcessorTest.testTimeCat
[junit4] Completed [4/5] on J1 in 156.13s, 2 tests
[junit4]
[junit4] HEARTBEAT J0 PID(76625@serv1-vm2.sd-datasolutions.de): 2019-10-03T19:05:34, stalled for 61.1s at: DimensionalRoutedAliasUpdateProcessorTest.testCatTime
[junit4] HEARTBEAT J0 PID(76625@serv1-vm2.sd-datasolutions.de): 2019-10-03T19:06:46, stalled for 60.2s at: DimensionalRoutedAliasUpdateProcessorTest.testTimeCat
[junit4] Suite: org.apache.solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest
[junit4] OK 72.9s J0 | DimensionalRoutedAliasUpdateProcessorTest.testCatTime
[junit4] OK 71.7s J0 | DimensionalRoutedAliasUpdateProcessorTest.testTimeCat
[junit4] Completed [5/5] on J0 in 145.19s, 2 tests
[junit4]
[junit4] JVM J0: 1.00 .. 480.93 = 479.92s
[junit4] JVM J1: 1.00 .. 339.69 = 338.68s
[junit4] Execution time total: 8 minutes 1 second
[junit4] Tests summary: 5 suites, 10 tests
[junit4] Could not remove temporary path: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0 (java.nio.file.DirectoryNotEmptyException: Remaining files: [/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp])
[junit4] Could not remove temporary path: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1 (java.nio.file.DirectoryNotEmptyException: Remaining files: [/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp])
[echo] 5 slowest tests:
[junit4:tophints] 273.13s | org.apache.solr.cloud.autoscaling.IndexSizeTriggerTest
[junit4:tophints] 262.03s | org.apache.solr.cloud.api.collections.ShardSplitTest
[junit4:tophints] 172.35s | org.apache.solr.cloud.CollectionsAPISolrJTest
[junit4:tophints] 156.43s | org.apache.solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest
[junit4:tophints] 146.47s | org.apache.solr.search.facet.TestJsonFacets
-check-totals:
test-nocompile:
BUILD SUCCESSFUL
Total time: 8 minutes 4 seconds
[repro] Failures:
[repro] 0/5 failed: org.apache.solr.update.processor.DimensionalRoutedAliasUpdateProcessorTest
[repro] Exiting with code 0
+ mv lucene/build lucene/build.repro
+ mv solr/build solr/build.repro
+ mv lucene/build.orig lucene/build
+ mv solr/build.orig solr/build
Archiving artifacts
Setting ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
java.lang.InterruptedException: no matches found within 10000
at hudson.FilePath$ValidateAntFileMask.hasMatch(FilePath.java:2822)
at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:2701)
at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:2682)
at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3069)
Also: hudson.remoting.Channel$CallSiteStackTrace: Remote call to MacOSX VBOX
at hudson.remoting.Channel.attachCallSiteStackTrace(Channel.java:1741)
at hudson.remoting.UserRequest$ExceptionResponse.retrieve(UserRequest.java:356)
at hudson.remoting.Channel.call(Channel.java:955)
at hudson.FilePath.act(FilePath.java:1069)
at hudson.FilePath.act(FilePath.java:1058)
at hudson.FilePath.validateAntFileMask(FilePath.java:2680)
at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:248)
at hudson.tasks.BuildStepCompatibilityLayer.perform(BuildStepCompatibilityLayer.java:79)
at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
at hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:741)
at hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:690)
at hudson.model.Build$BuildExecution.post2(Build.java:186)
at hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:635)
at hudson.model.Run.execute(Run.java:1860)
at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
at hudson.model.ResourceController.execute(ResourceController.java:97)
at hudson.model.Executor.run(Executor.java:429)
Caused: hudson.FilePath$TunneledInterruptedException
at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3071)
at hudson.remoting.UserRequest.perform(UserRequest.java:211)
at hudson.remoting.UserRequest.perform(UserRequest.java:54)
at hudson.remoting.Request$2.run(Request.java:369)
at hudson.remoting.InterceptingExecutorService$1.call(InterceptingExecutorService.java:72)
at java.util.concurrent.FutureTask.run(FutureTask.java:266)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
Caused: java.lang.InterruptedException: java.lang.InterruptedException: no matches found within 10000
at hudson.FilePath.act(FilePath.java:1071)
at hudson.FilePath.act(FilePath.java:1058)
at hudson.FilePath.validateAntFileMask(FilePath.java:2680)
at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:248)
at hudson.tasks.BuildStepCompatibilityLayer.perform(BuildStepCompatibilityLayer.java:79)
at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
at hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:741)
at hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:690)
at hudson.model.Build$BuildExecution.post2(Build.java:186)
at hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:635)
at hudson.model.Run.execute(Run.java:1860)
at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
at hudson.model.ResourceController.execute(ResourceController.java:97)
at hudson.model.Executor.run(Executor.java:429)
No artifacts found that match the file pattern "**/*.events,heapdumps/**,**/*_pid*.log". Configuration error?
[WARNINGS] Parsing warnings in console log with parser Java Compiler (javac)
Setting ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
No credentials specified
Setting ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
<Git Blamer> Using GitBlamer to create author and commit information for all warnings.
<Git Blamer> GIT_COMMIT=9d21418dfcc5c884f45ab668579b0391965a18bb, workspace=/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX
[WARNINGS] Computing warning deltas based on reference build #359
Recording test results
Setting ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Build step 'Publish JUnit test result report' changed build result to UNSTABLE
Email was triggered for: Unstable (Test Failures)
Sending email for trigger: Unstable (Test Failures)
Setting ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2