You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2017/05/04 08:31:12 UTC
[JENKINS-EA] Lucene-Solr-master-Linux (32bit/jdk-9-ea+164) - Build
# 19550 - Unstable!
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/19550/
Java: 32bit/jdk-9-ea+164 -client -XX:+UseParallelGC
4 tests failed.
FAILED: junit.framework.TestSuite.org.apache.solr.core.TestLazyCores
Error Message:
ObjectTracker found 6 object(s) that were not released!!! [NIOFSDirectory, NIOFSDirectory, MDCAwareThreadPoolExecutor, SolrIndexSearcher, SolrCore, NIOFSDirectory] org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.NIOFSDirectory at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:347) at org.apache.solr.update.SolrIndexWriter.create(SolrIndexWriter.java:92) at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:753) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:948) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:855) at org.apache.solr.core.CoreContainer.create(CoreContainer.java:959) at org.apache.solr.core.CoreContainer.lambda$load$7(CoreContainer.java:594) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:197) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:229) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1161) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) at java.base/java.lang.Thread.run(Thread.java:844) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.NIOFSDirectory at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:347) at org.apache.solr.core.SolrCore.initSnapshotMetaDataManager(SolrCore.java:490) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:942) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:855) at org.apache.solr.core.CoreContainer.create(CoreContainer.java:959) at org.apache.solr.core.CoreContainer.lambda$load$7(CoreContainer.java:594) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:197) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:229) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1161) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) at java.base/java.lang.Thread.run(Thread.java:844) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:884) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:855) at org.apache.solr.core.CoreContainer.create(CoreContainer.java:959) at org.apache.solr.core.CoreContainer.lambda$load$7(CoreContainer.java:594) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:197) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:229) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1161) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) at java.base/java.lang.Thread.run(Thread.java:844) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.solr.search.SolrIndexSearcher at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.search.SolrIndexSearcher.<init>(SolrIndexSearcher.java:323) at org.apache.solr.core.SolrCore.openNewSearcher(SolrCore.java:2048) at org.apache.solr.core.SolrCore.getSearcher(SolrCore.java:2199) at org.apache.solr.core.SolrCore.initSearcher(SolrCore.java:1085) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:974) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:855) at org.apache.solr.core.CoreContainer.create(CoreContainer.java:959) at org.apache.solr.core.CoreContainer.lambda$load$7(CoreContainer.java:594) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:197) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:229) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1161) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) at java.base/java.lang.Thread.run(Thread.java:844) 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:1033) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:855) at org.apache.solr.core.CoreContainer.create(CoreContainer.java:959) at org.apache.solr.core.CoreContainer.lambda$load$7(CoreContainer.java:594) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:197) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:229) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1161) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) at java.base/java.lang.Thread.run(Thread.java:844) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.NIOFSDirectory at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:347) at org.apache.solr.core.SolrCore.getNewIndexDir(SolrCore.java:361) at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:721) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:948) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:855) at org.apache.solr.core.CoreContainer.create(CoreContainer.java:959) at org.apache.solr.core.CoreContainer.lambda$load$7(CoreContainer.java:594) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:197) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:229) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1161) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) at java.base/java.lang.Thread.run(Thread.java:844)
Stack Trace:
java.lang.AssertionError: ObjectTracker found 6 object(s) that were not released!!! [NIOFSDirectory, NIOFSDirectory, MDCAwareThreadPoolExecutor, SolrIndexSearcher, SolrCore, NIOFSDirectory]
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.NIOFSDirectory
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:347)
at org.apache.solr.update.SolrIndexWriter.create(SolrIndexWriter.java:92)
at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:753)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:948)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:855)
at org.apache.solr.core.CoreContainer.create(CoreContainer.java:959)
at org.apache.solr.core.CoreContainer.lambda$load$7(CoreContainer.java:594)
at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:197)
at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:229)
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1161)
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635)
at java.base/java.lang.Thread.run(Thread.java:844)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.NIOFSDirectory
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:347)
at org.apache.solr.core.SolrCore.initSnapshotMetaDataManager(SolrCore.java:490)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:942)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:855)
at org.apache.solr.core.CoreContainer.create(CoreContainer.java:959)
at org.apache.solr.core.CoreContainer.lambda$load$7(CoreContainer.java:594)
at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:197)
at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:229)
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1161)
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635)
at java.base/java.lang.Thread.run(Thread.java:844)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:884)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:855)
at org.apache.solr.core.CoreContainer.create(CoreContainer.java:959)
at org.apache.solr.core.CoreContainer.lambda$load$7(CoreContainer.java:594)
at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:197)
at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:229)
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1161)
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635)
at java.base/java.lang.Thread.run(Thread.java:844)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.solr.search.SolrIndexSearcher
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.search.SolrIndexSearcher.<init>(SolrIndexSearcher.java:323)
at org.apache.solr.core.SolrCore.openNewSearcher(SolrCore.java:2048)
at org.apache.solr.core.SolrCore.getSearcher(SolrCore.java:2199)
at org.apache.solr.core.SolrCore.initSearcher(SolrCore.java:1085)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:974)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:855)
at org.apache.solr.core.CoreContainer.create(CoreContainer.java:959)
at org.apache.solr.core.CoreContainer.lambda$load$7(CoreContainer.java:594)
at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:197)
at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:229)
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1161)
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635)
at java.base/java.lang.Thread.run(Thread.java:844)
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:1033)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:855)
at org.apache.solr.core.CoreContainer.create(CoreContainer.java:959)
at org.apache.solr.core.CoreContainer.lambda$load$7(CoreContainer.java:594)
at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:197)
at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:229)
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1161)
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635)
at java.base/java.lang.Thread.run(Thread.java:844)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.NIOFSDirectory
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:347)
at org.apache.solr.core.SolrCore.getNewIndexDir(SolrCore.java:361)
at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:721)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:948)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:855)
at org.apache.solr.core.CoreContainer.create(CoreContainer.java:959)
at org.apache.solr.core.CoreContainer.lambda$load$7(CoreContainer.java:594)
at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:197)
at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:229)
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1161)
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635)
at java.base/java.lang.Thread.run(Thread.java:844)
at __randomizedtesting.SeedInfo.seed([D40A15219614436A]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.junit.Assert.assertNull(Assert.java:551)
at org.apache.solr.SolrTestCaseJ4.teardownTestCases(SolrTestCaseJ4.java:302)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:563)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:870)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:844)
FAILED: junit.framework.TestSuite.org.apache.solr.core.TestLazyCores
Error Message:
1 thread leaked from SUITE scope at org.apache.solr.core.TestLazyCores: 1) Thread[id=81, name=searcherExecutor-45-thread-1, state=WAITING, group=TGRP-TestLazyCores] at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) at java.base@9-ea/java.util.concurrent.locks.LockSupport.park(LockSupport.java:192) at java.base@9-ea/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2062) at java.base@9-ea/java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:435) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1086) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1146) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) at java.base@9-ea/java.lang.Thread.run(Thread.java:844)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE scope at org.apache.solr.core.TestLazyCores:
1) Thread[id=81, name=searcherExecutor-45-thread-1, state=WAITING, group=TGRP-TestLazyCores]
at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method)
at java.base@9-ea/java.util.concurrent.locks.LockSupport.park(LockSupport.java:192)
at java.base@9-ea/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2062)
at java.base@9-ea/java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:435)
at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1086)
at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1146)
at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635)
at java.base@9-ea/java.lang.Thread.run(Thread.java:844)
at __randomizedtesting.SeedInfo.seed([D40A15219614436A]:0)
FAILED: junit.framework.TestSuite.org.apache.solr.core.TestLazyCores
Error Message:
There are still zombie threads that couldn't be terminated: 1) Thread[id=81, name=searcherExecutor-45-thread-1, state=WAITING, group=TGRP-TestLazyCores] at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) at java.base@9-ea/java.util.concurrent.locks.LockSupport.park(LockSupport.java:192) at java.base@9-ea/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2062) at java.base@9-ea/java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:435) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1086) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1146) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) at java.base@9-ea/java.lang.Thread.run(Thread.java:844)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie threads that couldn't be terminated:
1) Thread[id=81, name=searcherExecutor-45-thread-1, state=WAITING, group=TGRP-TestLazyCores]
at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method)
at java.base@9-ea/java.util.concurrent.locks.LockSupport.park(LockSupport.java:192)
at java.base@9-ea/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2062)
at java.base@9-ea/java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:435)
at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1086)
at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1146)
at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635)
at java.base@9-ea/java.lang.Thread.run(Thread.java:844)
at __randomizedtesting.SeedInfo.seed([D40A15219614436A]:0)
FAILED: org.apache.solr.cloud.CollectionsAPIDistributedZkTest.testCollectionsAPI
Error Message:
expected:<3> but was:<1>
Stack Trace:
java.lang.AssertionError: expected:<3> but was:<1>
at __randomizedtesting.SeedInfo.seed([D40A15219614436A:9C7F619590276CFF]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.failNotEquals(Assert.java:647)
at org.junit.Assert.assertEquals(Assert.java:128)
at org.junit.Assert.assertEquals(Assert.java:472)
at org.junit.Assert.assertEquals(Assert.java:456)
at org.apache.solr.cloud.CollectionsAPIDistributedZkTest.testCollectionsAPI(CollectionsAPIDistributedZkTest.java:530)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:563)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:844)
Build Log:
[...truncated 11008 lines...]
[junit4] Suite: org.apache.solr.core.TestLazyCores
[junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/init-core-data-001
[junit4] 2> 12085 WARN (SUITE-TestLazyCores-seed#[D40A15219614436A]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=2 numCloses=2
[junit4] 2> 12085 INFO (SUITE-TestLazyCores-seed#[D40A15219614436A]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields
[junit4] 2> 12086 INFO (SUITE-TestLazyCores-seed#[D40A15219614436A]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason="", ssl=0.0/0.0, value=0.0/0.0, clientAuth=0.0/0.0)
[junit4] 2> 12090 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testCachingLimit
[junit4] 2> 12151 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 12151 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-001/solr.xml
[junit4] 2> 12261 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 12271 INFO (coreLoadExecutor-43-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 12274 INFO (coreLoadExecutor-43-thread-3) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 12274 INFO (coreLoadExecutor-43-thread-2) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 12283 INFO (coreLoadExecutor-43-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=tiny
[junit4] 2> 12286 INFO (coreLoadExecutor-43-thread-3) [ ] o.a.s.s.IndexSchema [collection5] Schema name=tiny
[junit4] 2> 12286 INFO (coreLoadExecutor-43-thread-2) [ ] o.a.s.s.IndexSchema [collection2] Schema name=tiny
[junit4] 2> 12287 INFO (coreLoadExecutor-43-thread-1) [ ] o.a.s.s.IndexSchema Loaded schema tiny/1.1 with uniqueid field id
[junit4] 2> 12287 INFO (coreLoadExecutor-43-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-001/./collection1, trusted=true
[junit4] 2> 12290 INFO (coreLoadExecutor-43-thread-2) [ ] o.a.s.s.IndexSchema Loaded schema tiny/1.1 with uniqueid field id
[junit4] 2> 12290 INFO (coreLoadExecutor-43-thread-2) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection2' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-001/./collection2, trusted=true
[junit4] 2> 12290 INFO (coreLoadExecutor-43-thread-3) [ ] o.a.s.s.IndexSchema Loaded schema tiny/1.1 with uniqueid field id
[junit4] 2> 12290 INFO (coreLoadExecutor-43-thread-3) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection5' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-001/./collection5, trusted=true
[junit4] 2> 12291 INFO (coreLoadExecutor-43-thread-1) [ ] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 12291 INFO (coreLoadExecutor-43-thread-1) [ ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-001/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-001/./collection1/data/]
[junit4] 2> 12293 INFO (coreLoadExecutor-43-thread-2) [ ] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 12293 INFO (coreLoadExecutor-43-thread-2) [ ] o.a.s.c.SolrCore [[collection2] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-001/collection2], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-001/./collection2/data/]
[junit4] 2> 12293 INFO (coreLoadExecutor-43-thread-3) [ ] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 12293 INFO (coreLoadExecutor-43-thread-3) [ ] o.a.s.c.SolrCore [[collection5] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-001/collection5], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-001/./collection5/data/]
[junit4] 2> 12303 INFO (coreLoadExecutor-43-thread-1) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=17, maxMergeAtOnceExplicit=50, maxMergedSegmentMB=85.71875, floorSegmentMB=1.423828125, forceMergeDeletesPctAllowed=27.10104168583299, segmentsPerTier=15.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 12303 INFO (coreLoadExecutor-43-thread-2) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=17, maxMergeAtOnceExplicit=50, maxMergedSegmentMB=85.71875, floorSegmentMB=1.423828125, forceMergeDeletesPctAllowed=27.10104168583299, segmentsPerTier=15.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 12303 INFO (coreLoadExecutor-43-thread-3) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=17, maxMergeAtOnceExplicit=50, maxMergedSegmentMB=85.71875, floorSegmentMB=1.423828125, forceMergeDeletesPctAllowed=27.10104168583299, segmentsPerTier=15.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 12571 INFO (coreLoadExecutor-43-thread-1) [ ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 12571 INFO (coreLoadExecutor-43-thread-1) [ ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 12573 INFO (coreLoadExecutor-43-thread-1) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=40, maxMergeAtOnceExplicit=30, maxMergedSegmentMB=30.1875, floorSegmentMB=0.509765625, forceMergeDeletesPctAllowed=17.41368372067086, segmentsPerTier=48.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.30314683913032675
[junit4] 2> 12574 INFO (coreLoadExecutor-43-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1ab5da9[collection1] main]
[junit4] 2> 12574 INFO (coreLoadExecutor-43-thread-1) [ ] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-001/collection1/conf
[junit4] 2> 12575 INFO (coreLoadExecutor-43-thread-1) [ ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 12576 INFO (searcherExecutor-44-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1ab5da9[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 12655 INFO (coreLoadExecutor-43-thread-2) [ ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 12655 INFO (coreLoadExecutor-43-thread-2) [ ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 12657 INFO (coreLoadExecutor-43-thread-2) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=40, maxMergeAtOnceExplicit=30, maxMergedSegmentMB=30.1875, floorSegmentMB=0.509765625, forceMergeDeletesPctAllowed=17.41368372067086, segmentsPerTier=48.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.30314683913032675
[junit4] 2> 12658 INFO (coreLoadExecutor-43-thread-2) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@192ed8c[collection2] main]
[junit4] 2> 12658 INFO (coreLoadExecutor-43-thread-2) [ ] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-001/collection2/conf
[junit4] 2> 12659 INFO (coreLoadExecutor-43-thread-3) [ ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 12659 INFO (coreLoadExecutor-43-thread-3) [ ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 12659 INFO (coreLoadExecutor-43-thread-2) [ ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 12659 INFO (searcherExecutor-45-thread-1) [ ] o.a.s.c.SolrCore [collection2] Registered new searcher Searcher@192ed8c[collection2] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 12660 INFO (coreLoadExecutor-43-thread-3) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=40, maxMergeAtOnceExplicit=30, maxMergedSegmentMB=30.1875, floorSegmentMB=0.509765625, forceMergeDeletesPctAllowed=17.41368372067086, segmentsPerTier=48.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.30314683913032675
[junit4] 2> 12660 INFO (coreLoadExecutor-43-thread-3) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@f25b41[collection5] main]
[junit4] 2> 12661 INFO (coreLoadExecutor-43-thread-3) [ ] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-001/collection5/conf
[junit4] 2> 12661 INFO (coreLoadExecutor-43-thread-3) [ ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 12662 INFO (searcherExecutor-46-thread-1) [ ] o.a.s.c.SolrCore [collection5] Registered new searcher Searcher@f25b41[collection5] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 12671 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 12679 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.s.IndexSchema [collection3] Schema name=tiny
[junit4] 2> 12682 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.s.IndexSchema Loaded schema tiny/1.1 with uniqueid field id
[junit4] 2> 12682 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection3' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-001/./collection3, trusted=true
[junit4] 2> 12682 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 12682 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.c.SolrCore [[collection3] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-001/collection3], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-001/./collection3/data/]
[junit4] 2> 12685 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=33, maxMergeAtOnceExplicit=41, maxMergedSegmentMB=46.62109375, floorSegmentMB=0.66015625, forceMergeDeletesPctAllowed=2.411138741972408, segmentsPerTier=23.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.8540566141698547
[junit4] 2> 12872 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 12872 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 12873 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=20, maxMergeAtOnceExplicit=34, maxMergedSegmentMB=51.173828125, floorSegmentMB=1.974609375, forceMergeDeletesPctAllowed=11.407433803108884, segmentsPerTier=41.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
[junit4] 2> 12874 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@19a95fb[collection3] main]
[junit4] 2> 12874 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-001/collection3/conf
[junit4] 2> 12875 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 12876 INFO (searcherExecutor-56-thread-1) [ ] o.a.s.c.SolrCore [collection3] Registered new searcher Searcher@19a95fb[collection3] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 12883 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 12891 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.s.IndexSchema [collection4] Schema name=tiny
[junit4] 2> 12893 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.s.IndexSchema Loaded schema tiny/1.1 with uniqueid field id
[junit4] 2> 12893 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection4' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-001/./collection4, trusted=true
[junit4] 2> 12894 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 12894 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.c.SolrCore [[collection4] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-001/collection4], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-001/./collection4/data/]
[junit4] 2> 12896 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=12, maxMergeAtOnceExplicit=13, maxMergedSegmentMB=12.5400390625, floorSegmentMB=1.8076171875, forceMergeDeletesPctAllowed=1.1045605378588508, segmentsPerTier=25.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.35509108313946036
[junit4] 2> 13191 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 13191 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 13193 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=22, maxMergeAtOnceExplicit=18, maxMergedSegmentMB=60.9775390625, floorSegmentMB=2.0849609375, forceMergeDeletesPctAllowed=2.4402352559010545, segmentsPerTier=28.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
[junit4] 2> 13194 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1cbed82[collection4] main]
[junit4] 2> 13194 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-001/collection4/conf
[junit4] 2> 13195 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 13196 INFO (searcherExecutor-60-thread-1) [ ] o.a.s.c.SolrCore [collection4] Registered new searcher Searcher@1cbed82[collection4] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 13207 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 13217 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.s.IndexSchema [collection6] Schema name=tiny
[junit4] 2> 13221 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.s.IndexSchema Loaded schema tiny/1.1 with uniqueid field id
[junit4] 2> 13221 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection6' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-001/./collection6, trusted=true
[junit4] 2> 13221 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 13222 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.c.SolrCore [[collection6] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-001/collection6], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-001/./collection6/data/]
[junit4] 2> 13226 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=12, maxMergeAtOnceExplicit=26, maxMergedSegmentMB=30.9677734375, floorSegmentMB=1.455078125, forceMergeDeletesPctAllowed=0.5230171447539322, segmentsPerTier=40.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 13428 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 13428 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 13429 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=28, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.31360133280406793]
[junit4] 2> 13429 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1cdf6c4[collection6] main]
[junit4] 2> 13430 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-001/collection6/conf
[junit4] 2> 13430 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 13431 INFO (searcherExecutor-64-thread-1) [ ] o.a.s.c.SolrCore [collection6] Registered new searcher Searcher@1cdf6c4[collection6] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 13441 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 13451 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.s.IndexSchema [collection7] Schema name=tiny
[junit4] 2> 13454 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.s.IndexSchema Loaded schema tiny/1.1 with uniqueid field id
[junit4] 2> 13455 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection7' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-001/./collection7, trusted=true
[junit4] 2> 13455 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 13455 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.c.SolrCore [[collection7] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-001/collection7], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-001/./collection7/data/]
[junit4] 2> 13459 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=32, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 13679 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 13679 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 13680 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=32, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.3043631980215954]
[junit4] 2> 13681 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@126d369[collection7] main]
[junit4] 2> 13682 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-001/collection7/conf
[junit4] 2> 13682 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 13683 INFO (searcherExecutor-68-thread-1) [ ] o.a.s.c.SolrCore [collection7] Registered new searcher Searcher@126d369[collection7] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 13691 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 13699 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.s.IndexSchema [collection8] Schema name=tiny
[junit4] 2> 13701 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.s.IndexSchema Loaded schema tiny/1.1 with uniqueid field id
[junit4] 2> 13701 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection8' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-001/./collection8, trusted=true
[junit4] 2> 13701 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 13701 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.c.SolrCore [[collection8] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-001/collection8], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-001/./collection8/data/]
[junit4] 2> 13704 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=45, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.501398433787497]
[junit4] 2> 13916 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 13916 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 13917 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=13, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
[junit4] 2> 13918 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@3ed182[collection8] main]
[junit4] 2> 13918 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-001/collection8/conf
[junit4] 2> 13919 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 13919 INFO (searcherExecutor-72-thread-1) [ ] o.a.s.c.SolrCore [collection8] Registered new searcher Searcher@3ed182[collection8] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 13919 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Closing transient core [collection3]
[junit4] 2> 13930 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 13944 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.s.IndexSchema [collection9] Schema name=tiny
[junit4] 2> 13947 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.s.IndexSchema Loaded schema tiny/1.1 with uniqueid field id
[junit4] 2> 13947 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection9' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-001/./collection9, trusted=true
[junit4] 2> 13948 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 13949 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.c.SolrCore [[collection9] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-001/collection9], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-001/./collection9/data/]
[junit4] 2> 13952 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=41, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 14173 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 14173 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 14174 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=34, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 14174 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@7fbb21[collection9] main]
[junit4] 2> 14175 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-001/collection9/conf
[junit4] 2> 14177 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 14177 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Closing transient core [collection2]
[junit4] 2> 14177 INFO (searcherExecutor-76-thread-1) [ ] o.a.s.c.SolrCore [collection9] Registered new searcher Searcher@7fbb21[collection9] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 14178 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.c.SolrCore [collection3] CLOSING SolrCore org.apache.solr.core.SolrCore@1b9ec63
[junit4] 2> 14179 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection3, tag=28961891
[junit4] 2> 14179 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=31688656
[junit4] 2> 14179 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 14179 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 14179 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 14181 INFO (coreCloseExecutor-80-thread-1) [ ] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@ba897
[junit4] 2> 14181 INFO (coreCloseExecutor-80-thread-2) [ ] o.a.s.c.SolrCore [collection5] CLOSING SolrCore org.apache.solr.core.SolrCore@1eaffe0
[junit4] 2> 14193 INFO (coreCloseExecutor-80-thread-3) [ ] o.a.s.c.SolrCore [collection4] CLOSING SolrCore org.apache.solr.core.SolrCore@e4512b
[junit4] 2> 14194 INFO (coreCloseExecutor-80-thread-4) [ ] o.a.s.c.SolrCore [collection6] CLOSING SolrCore org.apache.solr.core.SolrCore@13484f6
[junit4] 2> 14194 INFO (coreCloseExecutor-80-thread-5) [ ] o.a.s.c.SolrCore [collection7] CLOSING SolrCore org.apache.solr.core.SolrCore@836824
[junit4] 2> 14197 INFO (coreCloseExecutor-80-thread-6) [ ] o.a.s.c.SolrCore [collection8] CLOSING SolrCore org.apache.solr.core.SolrCore@1bcf1b5
[junit4] 2> 14197 INFO (coreCloseExecutor-80-thread-7) [ ] o.a.s.c.SolrCore [collection9] CLOSING SolrCore org.apache.solr.core.SolrCore@39a0eb
[junit4] 2> 14199 INFO (coreCloseExecutor-80-thread-2) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection5, tag=32178144
[junit4] 2> 14200 INFO (coreCloseExecutor-80-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=764055
[junit4] 2> 14202 INFO (coreCloseExecutor-80-thread-3) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection4, tag=14962987
[junit4] 2> 14202 INFO (coreCloseExecutor-80-thread-7) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection9, tag=3776747
[junit4] 2> 14202 INFO (coreCloseExecutor-80-thread-6) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection8, tag=29159861
[junit4] 2> 14208 INFO (coreCloseExecutor-80-thread-4) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection6, tag=20219126
[junit4] 2> 14208 INFO (coreCloseExecutor-80-thread-5) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection7, tag=8611876
[junit4] 2> 14209 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D40A15219614436A]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testCachingLimit
[junit4] 2> 14211 INFO (TEST-TestLazyCores.testRace-seed#[D40A15219614436A]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testRace
[junit4] 2> 14280 INFO (TEST-TestLazyCores.testRace-seed#[D40A15219614436A]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-002/solr.xml
[junit4] 2> 14393 INFO (TEST-TestLazyCores.testRace-seed#[D40A15219614436A]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 14402 INFO (coreLoadExecutor-87-thread-3) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 14402 INFO (coreLoadExecutor-87-thread-2) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 14402 INFO (coreLoadExecutor-87-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 14410 INFO (coreLoadExecutor-87-thread-3) [ ] o.a.s.s.IndexSchema [collection5] Schema name=tiny
[junit4] 2> 14411 INFO (coreLoadExecutor-87-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=tiny
[junit4] 2> 14411 INFO (coreLoadExecutor-87-thread-2) [ ] o.a.s.s.IndexSchema [collection2] Schema name=tiny
[junit4] 2> 14412 INFO (coreLoadExecutor-87-thread-3) [ ] o.a.s.s.IndexSchema Loaded schema tiny/1.1 with uniqueid field id
[junit4] 2> 14412 INFO (coreLoadExecutor-87-thread-3) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection5' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-002/./collection5, trusted=true
[junit4] 2> 14413 INFO (coreLoadExecutor-87-thread-3) [ ] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 14413 INFO (coreLoadExecutor-87-thread-3) [ ] o.a.s.c.SolrCore [[collection5] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-002/collection5], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-002/./collection5/data/]
[junit4] 2> 14413 INFO (coreLoadExecutor-87-thread-1) [ ] o.a.s.s.IndexSchema Loaded schema tiny/1.1 with uniqueid field id
[junit4] 2> 14413 INFO (coreLoadExecutor-87-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-002/./collection1, trusted=true
[junit4] 2> 14413 INFO (coreLoadExecutor-87-thread-2) [ ] o.a.s.s.IndexSchema Loaded schema tiny/1.1 with uniqueid field id
[junit4] 2> 14413 INFO (coreLoadExecutor-87-thread-2) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection2' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-002/./collection2, trusted=true
[junit4] 2> 14413 INFO (coreLoadExecutor-87-thread-1) [ ] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 14413 INFO (coreLoadExecutor-87-thread-1) [ ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-002/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-002/./collection1/data/]
[junit4] 2> 14413 INFO (coreLoadExecutor-87-thread-2) [ ] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 14413 INFO (coreLoadExecutor-87-thread-2) [ ] o.a.s.c.SolrCore [[collection2] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-002/collection2], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-002/./collection2/data/]
[junit4] 2> 14415 INFO (coreLoadExecutor-87-thread-3) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=17, maxMergeAtOnceExplicit=50, maxMergedSegmentMB=85.71875, floorSegmentMB=1.423828125, forceMergeDeletesPctAllowed=27.10104168583299, segmentsPerTier=15.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 14415 INFO (coreLoadExecutor-87-thread-1) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=17, maxMergeAtOnceExplicit=50, maxMergedSegmentMB=85.71875, floorSegmentMB=1.423828125, forceMergeDeletesPctAllowed=27.10104168583299, segmentsPerTier=15.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 14415 INFO (coreLoadExecutor-87-thread-2) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=17, maxMergeAtOnceExplicit=50, maxMergedSegmentMB=85.71875, floorSegmentMB=1.423828125, forceMergeDeletesPctAllowed=27.10104168583299, segmentsPerTier=15.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 14623 INFO (coreLoadExecutor-87-thread-1) [ ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 14623 INFO (coreLoadExecutor-87-thread-1) [ ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 14624 INFO (coreLoadExecutor-87-thread-1) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=40, maxMergeAtOnceExplicit=30, maxMergedSegmentMB=30.1875, floorSegmentMB=0.509765625, forceMergeDeletesPctAllowed=17.41368372067086, segmentsPerTier=48.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.30314683913032675
[junit4] 2> 14625 INFO (coreLoadExecutor-87-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@15c4c62[collection1] main]
[junit4] 2> 14625 INFO (coreLoadExecutor-87-thread-1) [ ] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-002/collection1/conf
[junit4] 2> 14626 INFO (coreLoadExecutor-87-thread-1) [ ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 14626 INFO (searcherExecutor-89-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@15c4c62[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 14633 INFO (coreLoadExecutor-87-thread-3) [ ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 14634 INFO (coreLoadExecutor-87-thread-3) [ ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 14634 INFO (coreLoadExecutor-87-thread-3) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=40, maxMergeAtOnceExplicit=30, maxMergedSegmentMB=30.1875, floorSegmentMB=0.509765625, forceMergeDeletesPctAllowed=17.41368372067086, segmentsPerTier=48.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.30314683913032675
[junit4] 2> 14635 INFO (coreLoadExecutor-87-thread-3) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@972eed[collection5] main]
[junit4] 2> 14636 INFO (coreLoadExecutor-87-thread-3) [ ] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-002/collection5/conf
[junit4] 2> 14636 INFO (coreLoadExecutor-87-thread-3) [ ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 14639 INFO (searcherExecutor-88-thread-1) [ ] o.a.s.c.SolrCore [collection5] Registered new searcher Searcher@972eed[collection5] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 14682 INFO (coreLoadExecutor-87-thread-2) [ ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 14682 INFO (coreLoadExecutor-87-thread-2) [ ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 14683 INFO (coreLoadExecutor-87-thread-2) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=40, maxMergeAtOnceExplicit=30, maxMergedSegmentMB=30.1875, floorSegmentMB=0.509765625, forceMergeDeletesPctAllowed=17.41368372067086, segmentsPerTier=48.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.30314683913032675
[junit4] 2> 14684 INFO (coreLoadExecutor-87-thread-2) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@44b530[collection2] main]
[junit4] 2> 14684 INFO (coreLoadExecutor-87-thread-2) [ ] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-002/collection2/conf
[junit4] 2> 14685 INFO (coreLoadExecutor-87-thread-2) [ ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 14685 INFO (searcherExecutor-90-thread-1) [ ] o.a.s.c.SolrCore [collection2] Registered new searcher Searcher@44b530[collection2] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 14694 INFO (Thread-14) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 14701 INFO (Thread-14) [ ] o.a.s.s.IndexSchema [collection3] Schema name=tiny
[junit4] 2> 14703 INFO (Thread-14) [ ] o.a.s.s.IndexSchema Loaded schema tiny/1.1 with uniqueid field id
[junit4] 2> 14703 INFO (Thread-14) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection3' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-002/./collection3, trusted=true
[junit4] 2> 14704 INFO (Thread-14) [ ] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 14704 INFO (Thread-14) [ ] o.a.s.c.SolrCore [[collection3] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-002/collection3], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-002/./collection3/data/]
[junit4] 2> 14706 INFO (Thread-14) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=17, maxMergeAtOnceExplicit=50, maxMergedSegmentMB=85.71875, floorSegmentMB=1.423828125, forceMergeDeletesPctAllowed=27.10104168583299, segmentsPerTier=15.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 14929 INFO (Thread-14) [ ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 14929 INFO (Thread-14) [ ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 14930 INFO (Thread-14) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=40, maxMergeAtOnceExplicit=30, maxMergedSegmentMB=30.1875, floorSegmentMB=0.509765625, forceMergeDeletesPctAllowed=17.41368372067086, segmentsPerTier=48.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.30314683913032675
[junit4] 2> 14930 INFO (Thread-14) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@438774[collection3] main]
[junit4] 2> 14931 INFO (Thread-14) [ ] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-002/collection3/conf
[junit4] 2> 14931 INFO (Thread-14) [ ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 14933 INFO (searcherExecutor-100-thread-1) [ ] o.a.s.c.SolrCore [collection3] Registered new searcher Searcher@438774[collection3] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 14934 INFO (TEST-TestLazyCores.testRace-seed#[D40A15219614436A]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=11525326
[junit4] 2> 14934 INFO (TEST-TestLazyCores.testRace-seed#[D40A15219614436A]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 14934 INFO (TEST-TestLazyCores.testRace-seed#[D40A15219614436A]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 14934 INFO (TEST-TestLazyCores.testRace-seed#[D40A15219614436A]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 14934 INFO (coreCloseExecutor-104-thread-1) [ ] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@345ced
[junit4] 2> 14934 INFO (coreCloseExecutor-104-thread-2) [ ] o.a.s.c.SolrCore [collection5] CLOSING SolrCore org.apache.solr.core.SolrCore@78e8d3
[junit4] 2> 14935 INFO (coreCloseExecutor-104-thread-3) [ ] o.a.s.c.SolrCore [collection2] CLOSING SolrCore org.apache.solr.core.SolrCore@281caf
[junit4] 2> 14938 INFO (coreCloseExecutor-104-thread-4) [ ] o.a.s.c.SolrCore [collection3] CLOSING SolrCore org.apache.solr.core.SolrCore@50bba0
[junit4] 2> 14941 INFO (coreCloseExecutor-104-thread-2) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection5, tag=7923923
[junit4] 2> 14941 INFO (coreCloseExecutor-104-thread-3) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection2, tag=2628783
[junit4] 2> 14941 INFO (coreCloseExecutor-104-thread-4) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection3, tag=5290912
[junit4] 2> 14941 INFO (coreCloseExecutor-104-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=3431661
[junit4] 2> 14942 INFO (TEST-TestLazyCores.testRace-seed#[D40A15219614436A]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testRace
[junit4] 2> 14946 INFO (TEST-TestLazyCores.testMidUseUnload-seed#[D40A15219614436A]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testMidUseUnload
[junit4] 2> 15025 INFO (TEST-TestLazyCores.testMidUseUnload-seed#[D40A15219614436A]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-003/solr.xml
[junit4] 2> 15133 INFO (TEST-TestLazyCores.testMidUseUnload-seed#[D40A15219614436A]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 15145 INFO (coreLoadExecutor-111-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 15163 INFO (coreLoadExecutor-111-thread-2) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 15166 INFO (coreLoadExecutor-111-thread-3) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 15168 INFO (coreLoadExecutor-111-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=tiny
[junit4] 2> 15173 INFO (coreLoadExecutor-111-thread-1) [ ] o.a.s.s.IndexSchema Loaded schema tiny/1.1 with uniqueid field id
[junit4] 2> 15173 INFO (coreLoadExecutor-111-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-003/./collection1, trusted=true
[junit4] 2> 15173 INFO (coreLoadExecutor-111-thread-1) [ ] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 15173 INFO (coreLoadExecutor-111-thread-2) [ ] o.a.s.s.IndexSchema [collection2] Schema name=tiny
[junit4] 2> 15173 INFO (coreLoadExecutor-111-thread-1) [ ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-003/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-003/./collection1/data/]
[junit4] 2> 15176 INFO (coreLoadExecutor-111-thread-2) [ ] o.a.s.s.IndexSchema Loaded schema tiny/1.1 with uniqueid field id
[junit4] 2> 15176 INFO (coreLoadExecutor-111-thread-2) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection2' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-003/./collection2, trusted=true
[junit4] 2> 15176 INFO (coreLoadExecutor-111-thread-1) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=17, maxMergeAtOnceExplicit=50, maxMergedSegmentMB=85.71875, floorSegmentMB=1.423828125, forceMergeDeletesPctAllowed=27.10104168583299, segmentsPerTier=15.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 15176 INFO (coreLoadExecutor-111-thread-3) [ ] o.a.s.s.IndexSchema [collection5] Schema name=tiny
[junit4] 2> 15176 INFO (coreLoadExecutor-111-thread-2) [ ] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 15176 INFO (coreLoadExecutor-111-thread-2) [ ] o.a.s.c.SolrCore [[collection2] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-003/collection2], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-003/./collection2/data/]
[junit4] 2> 15182 INFO (coreLoadExecutor-111-thread-2) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=17, maxMergeAtOnceExplicit=50, maxMergedSegmentMB=85.71875, floorSegmentMB=1.423828125, forceMergeDeletesPctAllowed=27.10104168583299, segmentsPerTier=15.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 15183 INFO (coreLoadExecutor-111-thread-3) [ ] o.a.s.s.IndexSchema Loaded schema tiny/1.1 with uniqueid field id
[junit4] 2> 15183 INFO (coreLoadExecutor-111-thread-3) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection5' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-003/./collection5, trusted=true
[junit4] 2> 15184 INFO (coreLoadExecutor-111-thread-3) [ ] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 15185 INFO (coreLoadExecutor-111-thread-3) [ ] o.a.s.c.SolrCore [[collection5] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-003/collection5], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-003/./collection5/data/]
[junit4] 2> 15214 INFO (coreLoadExecutor-111-thread-3) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=17, maxMergeAtOnceExplicit=50, maxMergedSegmentMB=85.71875, floorSegmentMB=1.423828125, forceMergeDeletesPctAllowed=27.10104168583299, segmentsPerTier=15.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 15443 INFO (coreLoadExecutor-111-thread-1) [ ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 15443 INFO (coreLoadExecutor-111-thread-1) [ ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 15444 INFO (coreLoadExecutor-111-thread-1) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=40, maxMergeAtOnceExplicit=30, maxMergedSegmentMB=30.1875, floorSegmentMB=0.509765625, forceMergeDeletesPctAllowed=17.41368372067086, segmentsPerTier=48.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.30314683913032675
[junit4] 2> 15444 INFO (coreLoadExecutor-111-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1142360[collection1] main]
[junit4] 2> 15445 INFO (coreLoadExecutor-111-thread-1) [ ] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-003/collection1/conf
[junit4] 2> 15445 INFO (coreLoadExecutor-111-thread-1) [ ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 15446 INFO (searcherExecutor-112-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1142360[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 15493 INFO (coreLoadExecutor-111-thread-2) [ ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 15493 INFO (coreLoadExecutor-111-thread-2) [ ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 15494 INFO (coreLoadExecutor-111-thread-2) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=40, maxMergeAtOnceExplicit=30, maxMergedSegmentMB=30.1875, floorSegmentMB=0.509765625, forceMergeDeletesPctAllowed=17.41368372067086, segmentsPerTier=48.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.30314683913032675
[junit4] 2> 15495 INFO (coreLoadExecutor-111-thread-2) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1c2584b[collection2] main]
[junit4] 2> 15495 INFO (coreLoadExecutor-111-thread-2) [ ] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-003/collection2/conf
[junit4] 2> 15496 INFO (coreLoadExecutor-111-thread-2) [ ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 15497 INFO (searcherExecutor-113-thread-1) [ ] o.a.s.c.SolrCore [collection2] Registered new searcher Searcher@1c2584b[collection2] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 15513 INFO (coreLoadExecutor-111-thread-3) [ ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 15513 INFO (coreLoadExecutor-111-thread-3) [ ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 15513 INFO (coreLoadExecutor-111-thread-3) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=40, maxMergeAtOnceExplicit=30, maxMergedSegmentMB=30.1875, floorSegmentMB=0.509765625, forceMergeDeletesPctAllowed=17.41368372067086, segmentsPerTier=48.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.30314683913032675
[junit4] 2> 15514 INFO (coreLoadExecutor-111-thread-3) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@5e4ec9[collection5] main]
[junit4] 2> 15514 INFO (coreLoadExecutor-111-thread-3) [ ] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_D40A15219614436A-001/tempDir-003/collection5/conf
[junit4] 2> 15515 INFO (coreLoadExecutor-111-thread-3) [ ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 15515 INFO (searcherExecutor-114-thread-1) [ ] o.a.s.c.SolrCore [collection5] Registered new searcher Searcher@5e4ec9[collection5] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 15518 INFO (TEST-TestLazyCores.testMidUseUnload-seed#[D40A15219614436A]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=null
[junit4] 2> 15518 INFO (TEST-TestLazyCores.testMidUseUnload-seed#[D40A15219614436A]) [ ] o.a.s.c.SolrCore Core collection1 is not yet closed, waiting 100 ms before checking again.
[junit4] 2> 15618 INFO (TEST-TestLazyCores.testMidUseUnload-seed#[D40A15219614436A]) [ ] o.a.s.c.SolrCore Core collection1 is not yet closed, waiting 100 ms before checking again.
[junit4] 2> 15719 INFO (TEST-TestLazyCores.testMidUseUnload-seed#[D40A15219614436A]) [ ] o.a.s.c.SolrCore Core collection1 is not yet closed, waiting 100 ms before checking again.
[junit4] 2> 15819 INFO (TEST-TestLazyCores.testMidUseUnload-seed#[D40A15219614436A]) [ ] o.a.s.c.SolrCore Core collection1 is not yet closed, waiting 100 ms before checking again.
[junit4] 2> 15919 INFO (TEST-TestLazyCores.testMidUseUnload-seed#[D40A15219614436A]) [ ] o.a.s.c.SolrCore Core collection1 is not yet closed, waiting 100 ms before checking again.
[junit4] 2> 15960 INFO (Thread-30) [ ] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@388d5b
[junit4] 2> 15960 INFO (Thread-30) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=3706203
[junit4] 2> 16019 INFO (TEST-TestLazyCores.testMidUseUnload-seed#[D40A15219614436A]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=22552029
[junit4] 2> 16020 INFO (TEST-TestLazyCores.testMidUseUnload-seed#[D40A15219614436A]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 16020 INFO (TEST-TestLazyCores.testMidUseUnload-seed#[D40A15219614436A]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 16020 INFO (TEST-TestLazyCores.testMidUseUnload-seed#[D40A15219614436A]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 16020 INFO (coreCloseExecutor-125-thread-1) [ ] o.a.s.c.SolrCore [collection5] CLOSING SolrCore org.apache.solr.core.SolrCore@103609e
[junit4] 2> 16020 INFO (coreCloseExecutor-125-thread-2) [ ] o.a.s.c.SolrCore [collection2] CLOSING SolrCore org.apache.solr.core.SolrCore@9fb075
[junit4] 2> 16021 INFO (coreCloseExecutor-125-thread-2) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection2, tag=10465397
[junit4] 2> 16021 INFO (coreCloseExecutor-125-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection5, tag=16998558
[junit4] 2> 16022 INFO (TEST-TestLazyCores.testMidUseUnload-seed#[D40A15219614436A]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testMidUseUnload
[junit4] IGNOR/A 0.00s J0 | TestLazyCores.testNoCommit
[junit4] > Assumption #1: 'badapple' test group is disabled (@BadApple(bugUrl="https://issues.apache.org/jira/browse/SOLR-10101"))
[junit4] 2> 16027 INFO (TEST-TestLazyCores.testLazySearch-seed#[D40A15219614436A]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testLazySearch
[junit4] 2> 16084 INFO (TEST-TestLazyCores.testLazySearch-seed#[D40A15219614436A]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace
[...truncated too long message...]
c reporters for registry=solr.jetty, tag=null
[junit4] 2> 471209 INFO (jetty-closer-501-thread-3) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 471209 INFO (jetty-closer-501-thread-2) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 471211 INFO (jetty-closer-501-thread-4) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null
[junit4] 2> 471211 INFO (jetty-closer-501-thread-3) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null
[junit4] 2> 471211 INFO (jetty-closer-501-thread-2) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null
[junit4] 2> 471212 INFO (jetty-closer-501-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 471213 INFO (jetty-closer-501-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 471214 INFO (coreCloseExecutor-1120-thread-1) [ ] o.a.s.c.SolrCore [nodes_used_collection_shard2_replica2] CLOSING SolrCore org.apache.solr.core.SolrCore@1a2fdd5
[junit4] 2> 471214 INFO (coreCloseExecutor-1119-thread-1) [ ] o.a.s.c.SolrCore [nodes_used_collection_shard1_replica2] CLOSING SolrCore org.apache.solr.core.SolrCore@116ace3
[junit4] 2> 471215 INFO (coreCloseExecutor-1121-thread-1) [ ] o.a.s.c.SolrCore [nodes_used_collection_shard1_replica1] CLOSING SolrCore org.apache.solr.core.SolrCore@1f24483
[junit4] 2> 471216 INFO (jetty-closer-501-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null
[junit4] 2> 471218 INFO (coreCloseExecutor-1120-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.nodes_used_collection.shard2.replica2, tag=27459029
[junit4] 2> 471219 INFO (coreCloseExecutor-1122-thread-1) [ ] o.a.s.c.SolrCore [nodes_used_collection_shard2_replica1] CLOSING SolrCore org.apache.solr.core.SolrCore@14a8c7b
[junit4] 2> 471224 INFO (coreCloseExecutor-1119-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.nodes_used_collection.shard1.replica2, tag=18263267
[junit4] 2> 471225 INFO (coreCloseExecutor-1120-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.nodes_used_collection.shard2.leader, tag=27459029
[junit4] 2> 471227 INFO (coreCloseExecutor-1119-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.nodes_used_collection.shard1.leader, tag=18263267
[junit4] 2> 471236 INFO (coreCloseExecutor-1122-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.nodes_used_collection.shard2.replica1, tag=21662843
[junit4] 2> 471238 INFO (coreCloseExecutor-1121-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.nodes_used_collection.shard1.replica1, tag=32654467
[junit4] 2> 471240 INFO (jetty-closer-501-thread-4) [ ] o.a.s.c.Overseer Overseer (id=97903265911341065-127.0.0.1:34727_solr-n_0000000000) closing
[junit4] 2> 471240 INFO (zkCallback-519-thread-5) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 471240 INFO (zkCallback-520-thread-7) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 471240 INFO (OverseerStateUpdate-97903265911341065-127.0.0.1:34727_solr-n_0000000000) [ ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:34727_solr
[junit4] 2> 471240 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:34317) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x15bd2806aff000c, likely client has closed socket
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
[junit4] 2> at java.base/java.lang.Thread.run(Thread.java:844)
[junit4] 2> 471240 INFO (zkCallback-521-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 471241 INFO (coreCloseExecutor-1122-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.nodes_used_collection.shard2.leader, tag=21662843
[junit4] 2> 471242 INFO (coreCloseExecutor-1121-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.nodes_used_collection.shard1.leader, tag=32654467
[junit4] 2> 471242 INFO (zkCallback-520-thread-7) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
[junit4] 2> 471242 INFO (zkCallback-519-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
[junit4] 2> 471243 INFO (zkCallback-519-thread-5) [ ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:38055_solr
[junit4] 2> 471243 INFO (jetty-closer-501-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@c96878{/solr,null,UNAVAILABLE}
[junit4] 2> 471243 INFO (zkCallback-519-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
[junit4] 2> 471244 WARN (zkCallback-519-thread-5) [ ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 471244 INFO (jetty-closer-501-thread-2) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@1e0398{/solr,null,UNAVAILABLE}
[junit4] 2> 472740 WARN (zkCallback-522-thread-1) [ ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 472740 INFO (jetty-closer-501-thread-3) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@21ac94{/solr,null,UNAVAILABLE}
[junit4] 2> 472743 WARN (zkCallback-520-thread-7) [ ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 472743 INFO (jetty-closer-501-thread-4) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@247da0{/solr,null,UNAVAILABLE}
[junit4] 2> 472743 ERROR (SUITE-CollectionsAPIDistributedZkTest-seed#[D40A15219614436A]-worker) [ ] o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
[junit4] 2> 472744 INFO (SUITE-CollectionsAPIDistributedZkTest-seed#[D40A15219614436A]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:34317 34317
[junit4] 2> 472758 INFO (Thread-701) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:34317 34317
[junit4] 2> 472759 WARN (Thread-701) [ ] o.a.s.c.ZkTestServer Watch limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 7 /solr/configs/conf
[junit4] 2> 3 /solr/aliases.json
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 57 /solr/clusterstate.json
[junit4] 2> 4 /solr/collections/nodes_used_collection/state.json
[junit4] 2> 3 /solr/clusterprops.json
[junit4] 2> 2 /solr/collections/halfdeletedcollection/state.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 153 /solr/collections
[junit4] 2> 3 /solr/live_nodes
[junit4] 2>
[junit4] 2> 472759 INFO (SUITE-CollectionsAPIDistributedZkTest-seed#[D40A15219614436A]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_D40A15219614436A-001
[junit4] 2> May 04, 2017 8:09:41 AM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 1 leaked thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {_version_=FST50, id=Lucene50(blocksize=128)}, docValues:{}, maxPointsInLeafNode=794, maxMBSortInHeap=6.559861027673675, sim=RandomSimilarity(queryNorm=true): {}, locale=en-GD, timezone=Asia/Sakhalin
[junit4] 2> NOTE: Linux 4.4.0-72-generic i386/Oracle Corporation 9-ea (32-bit)/cpus=12,threads=1,free=155553320,total=290193408
[junit4] 2> NOTE: All tests run in this JVM: [ScriptEngineTest, TestSchemaVersionResource, TestNoOpRegenerator, SolrGraphiteReporterTest, TestLRUCache, TestConfigSetsAPI, TestUnifiedSolrHighlighter, CSVRequestHandlerTest, ClassificationUpdateProcessorIntegrationTest, TestConfigReload, TermVectorComponentTest, HdfsBasicDistributedZk2Test, TestClusterStateMutator, TestCustomStream, TestReloadDeadlock, LeaderFailoverAfterPartitionTest, AnalyticsMergeStrategyTest, IndexBasedSpellCheckerTest, DistanceUnitsTest, TestFieldCacheSort, SolrIndexSplitterTest, TestDynamicFieldCollectionResource, SampleTest, DeleteInactiveReplicaTest, SliceStateTest, ConfigureRecoveryStrategyTest, DistributedQueueTest, TestComplexPhraseLeadingWildcard, QueryParsingTest, TestNamedUpdateProcessors, TestElisionMultitermQuery, TestRandomFlRTGCloud, TestSolrJ, LoggingHandlerTest, PreAnalyzedUpdateProcessorTest, CdcrRequestHandlerTest, MoreLikeThisHandlerTest, TestScoreJoinQPNoScore, CollectionsAPIDistributedZkTest]
[junit4] Completed [575/709 (2!)] on J1 in 99.14s, 20 tests, 1 failure <<< FAILURES!
[...truncated 36682 lines...]
[JENKINS] Lucene-Solr-master-Linux (64bit/jdk1.8.0_131) - Build #
19551 - Still Unstable!
Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/19551/
Java: 64bit/jdk1.8.0_131 -XX:+UseCompressedOops -XX:+UseParallelGC
1 tests failed.
FAILED: org.apache.solr.util.TestSolrCLIRunExample.testTechproductsExample
Error Message:
expected 32 docs in the techproducts example but found 0, output: Creating Solr home directory /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-004/techproducts/solr Starting up Solr on port 46625 using command: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/bin/solr start -p 46625 -s "temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-004/techproducts/solr" Copying configuration to new core instance directory: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-004/techproducts/solr/techproducts Creating new core 'techproducts' using command: http://localhost:46625/solr/admin/cores?action=CREATE&name=techproducts&instanceDir=techproducts { "responseHeader":{ "status":0, "QTime":359}, "core":"techproducts"} Indexing tech product example docs from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/example/exampledocs Solr techproducts example launched successfully. Direct your Web browser to http://localhost:46625/solr to visit the Solr Admin UI
Stack Trace:
java.lang.AssertionError: expected 32 docs in the techproducts example but found 0, output: Creating Solr home directory /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-004/techproducts/solr
Starting up Solr on port 46625 using command:
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/bin/solr start -p 46625 -s "temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-004/techproducts/solr"
Copying configuration to new core instance directory:
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-004/techproducts/solr/techproducts
Creating new core 'techproducts' using command:
http://localhost:46625/solr/admin/cores?action=CREATE&name=techproducts&instanceDir=techproducts
{
"responseHeader":{
"status":0,
"QTime":359},
"core":"techproducts"}
Indexing tech product example docs from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/example/exampledocs
Solr techproducts example launched successfully. Direct your Web browser to http://localhost:46625/solr to visit the Solr Admin UI
at __randomizedtesting.SeedInfo.seed([4313724179B479EA:C9C4A2F963564175]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.apache.solr.util.TestSolrCLIRunExample.testExample(TestSolrCLIRunExample.java:378)
at org.apache.solr.util.TestSolrCLIRunExample.testTechproductsExample(TestSolrCLIRunExample.java:302)
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:1713)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at 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 13322 lines...]
[junit4] Suite: org.apache.solr.util.TestSolrCLIRunExample
[junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/init-core-data-001
[junit4] 2> 1765439 INFO (SUITE-TestSolrCLIRunExample-seed#[4313724179B479EA]-worker) [ ] o.a.s.SolrTestCaseJ4 Using TrieFields
[junit4] 2> 1765441 INFO (SUITE-TestSolrCLIRunExample-seed#[4313724179B479EA]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl=https://issues.apache.org/jira/browse/SOLR-5776)
[junit4] 2> 1765442 INFO (TEST-TestSolrCLIRunExample.testFailExecuteScript-seed#[4313724179B479EA]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testFailExecuteScript
[junit4] 2>
[junit4] 2> ERROR: Cannot run program "/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-001/failExecuteScript" (in directory "."): error=13, Permission denied
[junit4] 2>
[junit4] 2> 1765480 INFO (TEST-TestSolrCLIRunExample.testFailExecuteScript-seed#[4313724179B479EA]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testFailExecuteScript
[junit4] 2> 1765481 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[4313724179B479EA]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testInteractiveSolrCloudExample
[junit4] 2> 1765491 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[4313724179B479EA]) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 1 servers in /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003
[junit4] 2> 1765491 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[4313724179B479EA]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1765491 INFO (Thread-4309) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1765491 INFO (Thread-4309) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 1765493 ERROR (Thread-4309) [ ] o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
[junit4] 2> 1765591 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[4313724179B479EA]) [ ] o.a.s.c.ZkTestServer start zk server on port:43626
[junit4] 2> 1765600 INFO (jetty-launcher-4520-thread-1) [ ] o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 1765600 INFO (jetty-launcher-4520-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1453cc21{/solr,null,AVAILABLE}
[junit4] 2> 1765601 INFO (jetty-launcher-4520-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@7e813b68{HTTP/1.1,[http/1.1]}{127.0.0.1:44067}
[junit4] 2> 1765601 INFO (jetty-launcher-4520-thread-1) [ ] o.e.j.s.Server Started @1767827ms
[junit4] 2> 1765601 INFO (jetty-launcher-4520-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=44067}
[junit4] 2> 1765601 ERROR (jetty-launcher-4520-thread-1) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1765601 INFO (jetty-launcher-4520-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.0.0
[junit4] 2> 1765601 INFO (jetty-launcher-4520-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port 44067
[junit4] 2> 1765601 INFO (jetty-launcher-4520-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1765601 INFO (jetty-launcher-4520-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-05-04T10:48:05.165Z
[junit4] 2> 1765602 INFO (jetty-launcher-4520-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1765606 INFO (jetty-launcher-4520-thread-1) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@4ba44f5, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 1765610 INFO (jetty-launcher-4520-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:43626/solr
[junit4] 2> 1765619 INFO (jetty-launcher-4520-thread-1) [n:localhost:44067_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1765619 INFO (jetty-launcher-4520-thread-1) [n:localhost:44067_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader localhost:44067_solr
[junit4] 2> 1765620 INFO (jetty-launcher-4520-thread-1) [n:localhost:44067_solr ] o.a.s.c.Overseer Overseer (id=97903895187030019-localhost:44067_solr-n_0000000000) starting
[junit4] 2> 1765631 INFO (jetty-launcher-4520-thread-1) [n:localhost:44067_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/localhost:44067_solr
[junit4] 2> 1765639 INFO (zkCallback-4527-thread-1-processing-n:localhost:44067_solr) [n:localhost:44067_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1765733 INFO (jetty-launcher-4520-thread-1) [n:localhost:44067_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4ba44f5
[junit4] 2> 1765738 INFO (jetty-launcher-4520-thread-1) [n:localhost:44067_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4ba44f5
[junit4] 2> 1765739 INFO (jetty-launcher-4520-thread-1) [n:localhost:44067_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4ba44f5
[junit4] 2> 1765740 INFO (jetty-launcher-4520-thread-1) [n:localhost:44067_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1
[junit4] 2> 1765774 INFO (qtp1441830342-24242) [n:localhost:44067_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/info/system params={wt=json} status=0 QTime=15
[junit4] 2> 1765778 INFO (qtp1441830342-24243) [n:localhost:44067_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :clusterstatus with params action=CLUSTERSTATUS&wt=json and sendToOCPQueue=true
[junit4] 2> 1765779 INFO (qtp1441830342-24243) [n:localhost:44067_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=CLUSTERSTATUS&wt=json} status=0 QTime=0
[junit4] 2> 1765782 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[4313724179B479EA]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1765782 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[4313724179B479EA]) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:43626/solr ready
[junit4] 2> 1765785 INFO (qtp1441830342-24242) [n:localhost:44067_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params action=list&wt=json and sendToOCPQueue=true
[junit4] 2> 1765785 INFO (qtp1441830342-24242) [n:localhost:44067_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=list&wt=json} status=0 QTime=0
[junit4] 2> 1765796 INFO (qtp1441830342-24239) [n:localhost:44067_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/info/system params={wt=json} status=0 QTime=6
[junit4] 2> 1765799 INFO (qtp1441830342-24239) [n:localhost:44067_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :clusterstatus with params action=CLUSTERSTATUS&wt=json and sendToOCPQueue=true
[junit4] 2> 1765799 INFO (qtp1441830342-24239) [n:localhost:44067_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=CLUSTERSTATUS&wt=json} status=0 QTime=0
[junit4] 2> 1765804 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[4313724179B479EA]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1765805 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[4313724179B479EA]) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:43626/solr ready
[junit4] 2> 1765849 INFO (qtp1441830342-24242) [n:localhost:44067_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params action=list&wt=json and sendToOCPQueue=true
[junit4] 2> 1765849 INFO (qtp1441830342-24242) [n:localhost:44067_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=list&wt=json} status=0 QTime=0
[junit4] 2> 1765851 INFO (qtp1441830342-24240) [n:localhost:44067_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params replicationFactor=2&maxShardsPerNode=4&collection.configName=testCloudExamplePrompt&name=testCloudExamplePrompt&action=CREATE&numShards=2&wt=json and sendToOCPQueue=true
[junit4] 2> 1765853 INFO (OverseerThreadFactory-8462-thread-1-processing-n:localhost:44067_solr) [n:localhost:44067_solr ] o.a.s.c.CreateCollectionCmd Create collection testCloudExamplePrompt
[junit4] 2> 1765853 WARN (OverseerThreadFactory-8462-thread-1-processing-n:localhost:44067_solr) [n:localhost:44067_solr ] o.a.s.c.CreateCollectionCmd Specified replicationFactor of 2 on collection testCloudExamplePrompt is higher than or equal to the number of Solr instances currently live or live and part of your createNodeSet(1). It's unusual to run two replica of the same slice on the same Solr-instance.
[junit4] 2> 1765962 INFO (qtp1441830342-24239) [n:localhost:44067_solr ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=testCloudExamplePrompt&newCollection=true&name=testCloudExamplePrompt_shard2_replica2&action=CREATE&numShards=2&collection=testCloudExamplePrompt&shard=shard2&wt=javabin&version=2
[junit4] 2> 1765962 INFO (qtp1441830342-24238) [n:localhost:44067_solr ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=testCloudExamplePrompt&newCollection=true&name=testCloudExamplePrompt_shard1_replica2&action=CREATE&numShards=2&collection=testCloudExamplePrompt&shard=shard1&wt=javabin&version=2
[junit4] 2> 1765962 INFO (qtp1441830342-24239) [n:localhost:44067_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 1765962 INFO (qtp1441830342-24243) [n:localhost:44067_solr ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=testCloudExamplePrompt&newCollection=true&name=testCloudExamplePrompt_shard2_replica1&action=CREATE&numShards=2&collection=testCloudExamplePrompt&shard=shard2&wt=javabin&version=2
[junit4] 2> 1765963 INFO (qtp1441830342-24288) [n:localhost:44067_solr ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=testCloudExamplePrompt&newCollection=true&name=testCloudExamplePrompt_shard1_replica1&action=CREATE&numShards=2&collection=testCloudExamplePrompt&shard=shard1&wt=javabin&version=2
[junit4] 2> 1766076 INFO (zkCallback-4527-thread-1-processing-n:localhost:44067_solr) [n:localhost:44067_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testCloudExamplePrompt/state.json] for collection [testCloudExamplePrompt] has occurred - updating... (live nodes size: [1])
[junit4] 2> 1766973 INFO (qtp1441830342-24243) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.RequestParams conf resource params.json loaded . version : 0
[junit4] 2> 1766974 INFO (qtp1441830342-24238) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.RequestParams conf resource params.json loaded . version : 0
[junit4] 2> 1766974 INFO (qtp1441830342-24239) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.RequestParams conf resource params.json loaded . version : 0
[junit4] 2> 1766975 INFO (qtp1441830342-24238) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.RequestParams request params refreshed to version 0
[junit4] 2> 1766987 INFO (qtp1441830342-24243) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.RequestParams request params refreshed to version 0
[junit4] 2> 1766987 INFO (qtp1441830342-24239) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.RequestParams request params refreshed to version 0
[junit4] 2> 1766990 WARN (qtp1441830342-24238) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard1_replica2/../../../../contrib/extraction/lib filtered by .*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard1_replica2/../../../../contrib/extraction/lib
[junit4] 2> 1766990 WARN (qtp1441830342-24239) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard2_replica2/../../../../contrib/extraction/lib filtered by .*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard2_replica2/../../../../contrib/extraction/lib
[junit4] 2> 1766990 WARN (qtp1441830342-24238) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard1_replica2/../../../../dist filtered by solr-cell-\d.*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard1_replica2/../../../../dist
[junit4] 2> 1766990 WARN (qtp1441830342-24239) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard2_replica2/../../../../dist filtered by solr-cell-\d.*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard2_replica2/../../../../dist
[junit4] 2> 1766991 WARN (qtp1441830342-24238) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard1_replica2/../../../../contrib/clustering/lib filtered by .*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard1_replica2/../../../../contrib/clustering/lib
[junit4] 2> 1766991 WARN (qtp1441830342-24239) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard2_replica2/../../../../contrib/clustering/lib filtered by .*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard2_replica2/../../../../contrib/clustering/lib
[junit4] 2> 1766991 WARN (qtp1441830342-24239) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard2_replica2/../../../../dist filtered by solr-clustering-\d.*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard2_replica2/../../../../dist
[junit4] 2> 1766991 WARN (qtp1441830342-24243) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard2_replica1/../../../../contrib/extraction/lib filtered by .*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard2_replica1/../../../../contrib/extraction/lib
[junit4] 2> 1766991 WARN (qtp1441830342-24239) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard2_replica2/../../../../contrib/langid/lib filtered by .*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard2_replica2/../../../../contrib/langid/lib
[junit4] 2> 1766991 WARN (qtp1441830342-24243) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard2_replica1/../../../../dist filtered by solr-cell-\d.*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard2_replica1/../../../../dist
[junit4] 2> 1766991 WARN (qtp1441830342-24239) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard2_replica2/../../../../dist filtered by solr-langid-\d.*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard2_replica2/../../../../dist
[junit4] 2> 1766992 WARN (qtp1441830342-24243) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard2_replica1/../../../../contrib/clustering/lib filtered by .*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard2_replica1/../../../../contrib/clustering/lib
[junit4] 2> 1766992 WARN (qtp1441830342-24239) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard2_replica2/../../../../contrib/velocity/lib filtered by .*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard2_replica2/../../../../contrib/velocity/lib
[junit4] 2> 1766992 WARN (qtp1441830342-24243) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard2_replica1/../../../../dist filtered by solr-clustering-\d.*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard2_replica1/../../../../dist
[junit4] 2> 1766992 WARN (qtp1441830342-24239) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard2_replica2/../../../../dist filtered by solr-velocity-\d.*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard2_replica2/../../../../dist
[junit4] 2> 1766992 WARN (qtp1441830342-24243) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard2_replica1/../../../../contrib/langid/lib filtered by .*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard2_replica1/../../../../contrib/langid/lib
[junit4] 2> 1766993 WARN (qtp1441830342-24243) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard2_replica1/../../../../dist filtered by solr-langid-\d.*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard2_replica1/../../../../dist
[junit4] 2> 1766993 WARN (qtp1441830342-24243) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard2_replica1/../../../../contrib/velocity/lib filtered by .*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard2_replica1/../../../../contrib/velocity/lib
[junit4] 2> 1766993 WARN (qtp1441830342-24243) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard2_replica1/../../../../dist filtered by solr-velocity-\d.*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard2_replica1/../../../../dist
[junit4] 2> 1766991 WARN (qtp1441830342-24238) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard1_replica2/../../../../dist filtered by solr-clustering-\d.*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard1_replica2/../../../../dist
[junit4] 2> 1766996 WARN (qtp1441830342-24238) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard1_replica2/../../../../contrib/langid/lib filtered by .*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard1_replica2/../../../../contrib/langid/lib
[junit4] 2> 1766997 WARN (qtp1441830342-24238) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard1_replica2/../../../../dist filtered by solr-langid-\d.*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard1_replica2/../../../../dist
[junit4] 2> 1766997 WARN (qtp1441830342-24238) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard1_replica2/../../../../contrib/velocity/lib filtered by .*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard1_replica2/../../../../contrib/velocity/lib
[junit4] 2> 1766997 WARN (qtp1441830342-24238) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard1_replica2/../../../../dist filtered by solr-velocity-\d.*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard1_replica2/../../../../dist
[junit4] 2> 1767010 INFO (qtp1441830342-24288) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.RequestParams conf resource params.json loaded . version : 0
[junit4] 2> 1767010 INFO (qtp1441830342-24288) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.RequestParams request params refreshed to version 0
[junit4] 2> 1767011 WARN (qtp1441830342-24288) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard1_replica1/../../../../contrib/extraction/lib filtered by .*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard1_replica1/../../../../contrib/extraction/lib
[junit4] 2> 1767011 INFO (qtp1441830342-24243) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 1767011 WARN (qtp1441830342-24288) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard1_replica1/../../../../dist filtered by solr-cell-\d.*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard1_replica1/../../../../dist
[junit4] 2> 1767012 WARN (qtp1441830342-24288) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard1_replica1/../../../../contrib/clustering/lib filtered by .*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard1_replica1/../../../../contrib/clustering/lib
[junit4] 2> 1767012 WARN (qtp1441830342-24288) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard1_replica1/../../../../dist filtered by solr-clustering-\d.*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard1_replica1/../../../../dist
[junit4] 2> 1767012 WARN (qtp1441830342-24288) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard1_replica1/../../../../contrib/langid/lib filtered by .*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard1_replica1/../../../../contrib/langid/lib
[junit4] 2> 1767013 WARN (qtp1441830342-24288) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard1_replica1/../../../../dist filtered by solr-langid-\d.*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard1_replica1/../../../../dist
[junit4] 2> 1767013 INFO (qtp1441830342-24239) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 1767013 WARN (qtp1441830342-24288) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard1_replica1/../../../../contrib/velocity/lib filtered by .*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard1_replica1/../../../../contrib/velocity/lib
[junit4] 2> 1767013 WARN (qtp1441830342-24288) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard1_replica1/../../../../dist filtered by solr-velocity-\d.*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard1_replica1/../../../../dist
[junit4] 2> 1767014 INFO (qtp1441830342-24238) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 1767022 INFO (qtp1441830342-24288) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 1767046 INFO (qtp1441830342-24243) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.s.IndexSchema [testCloudExamplePrompt_shard2_replica1] Schema name=example-data-driven-schema
[junit4] 2> 1767047 INFO (qtp1441830342-24239) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.s.IndexSchema [testCloudExamplePrompt_shard2_replica2] Schema name=example-data-driven-schema
[junit4] 2> 1767048 INFO (qtp1441830342-24238) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.s.IndexSchema [testCloudExamplePrompt_shard1_replica2] Schema name=example-data-driven-schema
[junit4] 2> 1767053 INFO (qtp1441830342-24288) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.s.IndexSchema [testCloudExamplePrompt_shard1_replica1] Schema name=example-data-driven-schema
[junit4] 2> 1767516 INFO (qtp1441830342-24288) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.s.IndexSchema Loaded schema example-data-driven-schema/1.6 with uniqueid field id
[junit4] 2> 1767516 INFO (qtp1441830342-24239) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.s.IndexSchema Loaded schema example-data-driven-schema/1.6 with uniqueid field id
[junit4] 2> 1767518 INFO (qtp1441830342-24243) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.s.IndexSchema Loaded schema example-data-driven-schema/1.6 with uniqueid field id
[junit4] 2> 1767520 INFO (qtp1441830342-24238) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.s.IndexSchema Loaded schema example-data-driven-schema/1.6 with uniqueid field id
[junit4] 2> 1767596 INFO (qtp1441830342-24243) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.CoreContainer Creating SolrCore 'testCloudExamplePrompt_shard2_replica1' using configuration from collection testCloudExamplePrompt, trusted=true
[junit4] 2> 1767597 INFO (qtp1441830342-24243) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.testCloudExamplePrompt.shard2.replica1' (registry 'solr.core.testCloudExamplePrompt.shard2.replica1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4ba44f5
[junit4] 2> 1767597 INFO (qtp1441830342-24243) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1767597 INFO (qtp1441830342-24243) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.SolrCore [[testCloudExamplePrompt_shard2_replica1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard2_replica1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard2_replica1/data/]
[junit4] 2> 1767610 INFO (qtp1441830342-24239) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.CoreContainer Creating SolrCore 'testCloudExamplePrompt_shard2_replica2' using configuration from collection testCloudExamplePrompt, trusted=true
[junit4] 2> 1767610 INFO (qtp1441830342-24239) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.testCloudExamplePrompt.shard2.replica2' (registry 'solr.core.testCloudExamplePrompt.shard2.replica2') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4ba44f5
[junit4] 2> 1767610 INFO (qtp1441830342-24239) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1767610 INFO (qtp1441830342-24239) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.SolrCore [[testCloudExamplePrompt_shard2_replica2] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard2_replica2], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard2_replica2/data/]
[junit4] 2> 1767628 INFO (qtp1441830342-24238) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.CoreContainer Creating SolrCore 'testCloudExamplePrompt_shard1_replica2' using configuration from collection testCloudExamplePrompt, trusted=true
[junit4] 2> 1767629 INFO (qtp1441830342-24238) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.testCloudExamplePrompt.shard1.replica2' (registry 'solr.core.testCloudExamplePrompt.shard1.replica2') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4ba44f5
[junit4] 2> 1767630 INFO (qtp1441830342-24238) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1767630 INFO (qtp1441830342-24238) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.SolrCore [[testCloudExamplePrompt_shard1_replica2] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard1_replica2], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard1_replica2/data/]
[junit4] 2> 1767630 INFO (qtp1441830342-24288) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.CoreContainer Creating SolrCore 'testCloudExamplePrompt_shard1_replica1' using configuration from collection testCloudExamplePrompt, trusted=true
[junit4] 2> 1767631 INFO (qtp1441830342-24288) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.testCloudExamplePrompt.shard1.replica1' (registry 'solr.core.testCloudExamplePrompt.shard1.replica1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4ba44f5
[junit4] 2> 1767631 INFO (qtp1441830342-24288) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1767631 INFO (qtp1441830342-24288) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.SolrCore [[testCloudExamplePrompt_shard1_replica1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard1_replica1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard1_replica1/data/]
[junit4] 2> 1767644 INFO (qtp1441830342-24243) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.r.XSLTResponseWriter xsltCacheLifetimeSeconds=5
[junit4] 2> 1767658 INFO (qtp1441830342-24238) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.r.XSLTResponseWriter xsltCacheLifetimeSeconds=5
[junit4] 2> 1767659 INFO (qtp1441830342-24239) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.r.XSLTResponseWriter xsltCacheLifetimeSeconds=5
[junit4] 2> 1767660 INFO (qtp1441830342-24288) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.r.XSLTResponseWriter xsltCacheLifetimeSeconds=5
[junit4] 2> 1767707 INFO (qtp1441830342-24243) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1767707 INFO (qtp1441830342-24243) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1767709 INFO (qtp1441830342-24243) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.u.CommitTracker Hard AutoCommit: if uncommited for 15000ms;
[junit4] 2> 1767709 INFO (qtp1441830342-24243) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1767709 INFO (qtp1441830342-24288) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1767710 INFO (qtp1441830342-24288) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1767710 INFO (qtp1441830342-24288) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.u.CommitTracker Hard AutoCommit: if uncommited for 15000ms;
[junit4] 2> 1767710 INFO (qtp1441830342-24288) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1767711 INFO (qtp1441830342-24243) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.s.SolrIndexSearcher Opening [Searcher@6b06c503[testCloudExamplePrompt_shard2_replica1] main]
[junit4] 2> 1767712 INFO (qtp1441830342-24243) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/testCloudExamplePrompt
[junit4] 2> 1767712 INFO (qtp1441830342-24243) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/testCloudExamplePrompt
[junit4] 2> 1767712 INFO (qtp1441830342-24288) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.s.SolrIndexSearcher Opening [Searcher@67e0a4d0[testCloudExamplePrompt_shard1_replica1] main]
[junit4] 2> 1767712 INFO (qtp1441830342-24243) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at /configs/testCloudExamplePrompt/managed-schema
[junit4] 2> 1767713 INFO (qtp1441830342-24243) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
[junit4] 2> 1767713 INFO (qtp1441830342-24288) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/testCloudExamplePrompt
[junit4] 2> 1767713 INFO (qtp1441830342-24288) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/testCloudExamplePrompt
[junit4] 2> 1767713 INFO (qtp1441830342-24288) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at /configs/testCloudExamplePrompt/managed-schema
[junit4] 2> 1767713 INFO (qtp1441830342-24243) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 1767713 INFO (qtp1441830342-24243) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] 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> 1767713 INFO (qtp1441830342-24288) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
[junit4] 2> 1767714 INFO (qtp1441830342-24288) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 1767714 INFO (qtp1441830342-24288) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] 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> 1767721 INFO (qtp1441830342-24243) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1767721 INFO (qtp1441830342-24288) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1767727 INFO (searcherExecutor-8465-thread-1-processing-n:localhost:44067_solr x:testCloudExamplePrompt_shard2_replica1 s:shard2 c:testCloudExamplePrompt) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.QuerySenderListener QuerySenderListener sending requests to Searcher@6b06c503[testCloudExamplePrompt_shard2_replica1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1767727 INFO (qtp1441830342-24243) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1566462325336047616
[junit4] 2> 1767727 INFO (searcherExecutor-8465-thread-1-processing-n:localhost:44067_solr x:testCloudExamplePrompt_shard2_replica1 s:shard2 c:testCloudExamplePrompt) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.QuerySenderListener QuerySenderListener done.
[junit4] 2> 1767727 INFO (searcherExecutor-8468-thread-1-processing-n:localhost:44067_solr x:testCloudExamplePrompt_shard1_replica1 s:shard1 c:testCloudExamplePrompt) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.QuerySenderListener QuerySenderListener sending requests to Searcher@67e0a4d0[testCloudExamplePrompt_shard1_replica1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1767727 INFO (searcherExecutor-8468-thread-1-processing-n:localhost:44067_solr x:testCloudExamplePrompt_shard1_replica1 s:shard1 c:testCloudExamplePrompt) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.QuerySenderListener QuerySenderListener done.
[junit4] 2> 1767727 INFO (searcherExecutor-8468-thread-1-processing-n:localhost:44067_solr x:testCloudExamplePrompt_shard1_replica1 s:shard1 c:testCloudExamplePrompt) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 1767727 INFO (searcherExecutor-8465-thread-1-processing-n:localhost:44067_solr x:testCloudExamplePrompt_shard2_replica1 s:shard2 c:testCloudExamplePrompt) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 1767727 INFO (qtp1441830342-24288) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1566462325336047616
[junit4] 2> 1767729 INFO (searcherExecutor-8465-thread-1-processing-n:localhost:44067_solr x:testCloudExamplePrompt_shard2_replica1 s:shard2 c:testCloudExamplePrompt) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.SolrCore [testCloudExamplePrompt_shard2_replica1] Registered new searcher Searcher@6b06c503[testCloudExamplePrompt_shard2_replica1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1767729 INFO (searcherExecutor-8468-thread-1-processing-n:localhost:44067_solr x:testCloudExamplePrompt_shard1_replica1 s:shard1 c:testCloudExamplePrompt) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.SolrCore [testCloudExamplePrompt_shard1_replica1] Registered new searcher Searcher@67e0a4d0[testCloudExamplePrompt_shard1_replica1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1767729 INFO (qtp1441830342-24238) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1767729 INFO (qtp1441830342-24238) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1767730 INFO (qtp1441830342-24238) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.u.CommitTracker Hard AutoCommit: if uncommited for 15000ms;
[junit4] 2> 1767730 INFO (qtp1441830342-24238) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1767732 INFO (qtp1441830342-24239) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1767732 INFO (qtp1441830342-24239) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1767732 INFO (qtp1441830342-24288) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for shard shard1: total=2 found=1 timeoutin=179999ms
[junit4] 2> 1767732 INFO (qtp1441830342-24243) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for shard shard2: total=2 found=1 timeoutin=179999ms
[junit4] 2> 1767733 INFO (qtp1441830342-24238) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.s.SolrIndexSearcher Opening [Searcher@5a4b158d[testCloudExamplePrompt_shard1_replica2] main]
[junit4] 2> 1767733 INFO (zkCallback-4527-thread-1-processing-n:localhost:44067_solr) [n:localhost:44067_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testCloudExamplePrompt/state.json] for collection [testCloudExamplePrompt] has occurred - updating... (live nodes size: [1])
[junit4] 2> 1767734 INFO (qtp1441830342-24238) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/testCloudExamplePrompt
[junit4] 2> 1767734 INFO (qtp1441830342-24239) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.u.CommitTracker Hard AutoCommit: if uncommited for 15000ms;
[junit4] 2> 1767734 INFO (qtp1441830342-24239) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1767734 INFO (qtp1441830342-24238) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/testCloudExamplePrompt
[junit4] 2> 1767734 INFO (qtp1441830342-24238) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at /configs/testCloudExamplePrompt/managed-schema
[junit4] 2> 1767735 INFO (qtp1441830342-24238) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
[junit4] 2> 1767735 INFO (qtp1441830342-24238) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 1767735 INFO (qtp1441830342-24238) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] 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> 1767737 INFO (qtp1441830342-24238) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1767737 INFO (qtp1441830342-24239) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.s.SolrIndexSearcher Opening [Searcher@6bbd0ad2[testCloudExamplePrompt_shard2_replica2] main]
[junit4] 2> 1767738 INFO (qtp1441830342-24239) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/testCloudExamplePrompt
[junit4] 2> 1767738 INFO (searcherExecutor-8467-thread-1-processing-n:localhost:44067_solr x:testCloudExamplePrompt_shard1_replica2 s:shard1 c:testCloudExamplePrompt) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.QuerySenderListener QuerySenderListener sending requests to Searcher@5a4b158d[testCloudExamplePrompt_shard1_replica2] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1767738 INFO (qtp1441830342-24239) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/testCloudExamplePrompt
[junit4] 2> 1767738 INFO (qtp1441830342-24238) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1566462325347581952
[junit4] 2> 1767738 INFO (qtp1441830342-24239) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at /configs/testCloudExamplePrompt/managed-schema
[junit4] 2> 1767738 INFO (searcherExecutor-8467-thread-1-processing-n:localhost:44067_solr x:testCloudExamplePrompt_shard1_replica2 s:shard1 c:testCloudExamplePrompt) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.QuerySenderListener QuerySenderListener done.
[junit4] 2> 1767738 INFO (searcherExecutor-8467-thread-1-processing-n:localhost:44067_solr x:testCloudExamplePrompt_shard1_replica2 s:shard1 c:testCloudExamplePrompt) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 1767739 INFO (qtp1441830342-24239) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
[junit4] 2> 1767739 INFO (searcherExecutor-8467-thread-1-processing-n:localhost:44067_solr x:testCloudExamplePrompt_shard1_replica2 s:shard1 c:testCloudExamplePrompt) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.SolrCore [testCloudExamplePrompt_shard1_replica2] Registered new searcher Searcher@5a4b158d[testCloudExamplePrompt_shard1_replica2] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1767739 INFO (qtp1441830342-24239) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 1767740 INFO (qtp1441830342-24239) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] 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> 1767742 INFO (qtp1441830342-24239) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1767742 INFO (searcherExecutor-8466-thread-1-processing-n:localhost:44067_solr x:testCloudExamplePrompt_shard2_replica2 s:shard2 c:testCloudExamplePrompt) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.QuerySenderListener QuerySenderListener sending requests to Searcher@6bbd0ad2[testCloudExamplePrompt_shard2_replica2] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1767742 INFO (searcherExecutor-8466-thread-1-processing-n:localhost:44067_solr x:testCloudExamplePrompt_shard2_replica2 s:shard2 c:testCloudExamplePrompt) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.QuerySenderListener QuerySenderListener done.
[junit4] 2> 1767742 INFO (qtp1441830342-24239) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1566462325351776256
[junit4] 2> 1767742 INFO (searcherExecutor-8466-thread-1-processing-n:localhost:44067_solr x:testCloudExamplePrompt_shard2_replica2 s:shard2 c:testCloudExamplePrompt) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 1767743 INFO (searcherExecutor-8466-thread-1-processing-n:localhost:44067_solr x:testCloudExamplePrompt_shard2_replica2 s:shard2 c:testCloudExamplePrompt) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.SolrCore [testCloudExamplePrompt_shard2_replica2] Registered new searcher Searcher@6bbd0ad2[testCloudExamplePrompt_shard2_replica2] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1767835 INFO (zkCallback-4527-thread-1-processing-n:localhost:44067_solr) [n:localhost:44067_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testCloudExamplePrompt/state.json] for collection [testCloudExamplePrompt] has occurred - updating... (live nodes size: [1])
[junit4] 2> 1768232 INFO (qtp1441830342-24288) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 1768232 INFO (qtp1441830342-24288) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 1768232 INFO (qtp1441830342-24288) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.SyncStrategy Sync replicas to http://localhost:44067/solr/testCloudExamplePrompt_shard1_replica1/
[junit4] 2> 1768233 INFO (qtp1441830342-24288) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.u.PeerSync PeerSync: core=testCloudExamplePrompt_shard1_replica1 url=http://localhost:44067/solr START replicas=[http://localhost:44067/solr/testCloudExamplePrompt_shard1_replica2/] nUpdates=100
[junit4] 2> 1768233 INFO (qtp1441830342-24243) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 1768233 INFO (qtp1441830342-24243) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 1768233 INFO (qtp1441830342-24243) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.SyncStrategy Sync replicas to http://localhost:44067/solr/testCloudExamplePrompt_shard2_replica1/
[junit4] 2> 1768233 INFO (qtp1441830342-24288) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.u.PeerSync PeerSync: core=testCloudExamplePrompt_shard1_replica1 url=http://localhost:44067/solr DONE. We have no versions. sync failed.
[junit4] 2> 1768234 INFO (qtp1441830342-24243) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.u.PeerSync PeerSync: core=testCloudExamplePrompt_shard2_replica1 url=http://localhost:44067/solr START replicas=[http://localhost:44067/solr/testCloudExamplePrompt_shard2_replica2/] nUpdates=100
[junit4] 2> 1768234 INFO (qtp1441830342-24243) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.u.PeerSync PeerSync: core=testCloudExamplePrompt_shard2_replica1 url=http://localhost:44067/solr DONE. We have no versions. sync failed.
[junit4] 2> 1768235 INFO (qtp1441830342-24289) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 r:core_node2 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.S.Request [testCloudExamplePrompt_shard1_replica2] webapp=/solr path=/get params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2} status=0 QTime=1
[junit4] 2> 1768235 INFO (qtp1441830342-24288) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.SyncStrategy Leader's attempt to sync with shard failed, moving to the next candidate
[junit4] 2> 1768235 INFO (qtp1441830342-24288) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.ShardLeaderElectionContext We failed sync, but we have no versions - we can't sync in that case - we were active before, so become leader anyway
[junit4] 2> 1768236 INFO (qtp1441830342-24288) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.ShardLeaderElectionContext Found all replicas participating in election, clear LIR
[junit4] 2> 1768237 INFO (qtp1441830342-24237) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 r:core_node1 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.S.Request [testCloudExamplePrompt_shard2_replica2] webapp=/solr path=/get params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2} status=0 QTime=1
[junit4] 2> 1768237 INFO (qtp1441830342-24243) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.SyncStrategy Leader's attempt to sync with shard failed, moving to the next candidate
[junit4] 2> 1768237 INFO (qtp1441830342-24243) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.ShardLeaderElectionContext We failed sync, but we have no versions - we can't sync in that case - we were active before, so become leader anyway
[junit4] 2> 1768237 INFO (qtp1441830342-24243) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.ShardLeaderElectionContext Found all replicas participating in election, clear LIR
[junit4] 2> 1768238 INFO (qtp1441830342-24288) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://localhost:44067/solr/testCloudExamplePrompt_shard1_replica1/ shard1
[junit4] 2> 1768238 INFO (qtp1441830342-24243) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://localhost:44067/solr/testCloudExamplePrompt_shard2_replica1/ shard2
[junit4] 2> 1768340 INFO (zkCallback-4527-thread-1-processing-n:localhost:44067_solr) [n:localhost:44067_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testCloudExamplePrompt/state.json] for collection [testCloudExamplePrompt] has occurred - updating... (live nodes size: [1])
[junit4] 2> 1768389 INFO (qtp1441830342-24288) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 1768389 INFO (qtp1441830342-24243) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 1768391 INFO (qtp1441830342-24243) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&collection.configName=testCloudExamplePrompt&newCollection=true&name=testCloudExamplePrompt_shard2_replica1&action=CREATE&numShards=2&collection=testCloudExamplePrompt&shard=shard2&wt=javabin&version=2} status=0 QTime=2428
[junit4] 2> 1768394 INFO (qtp1441830342-24288) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&collection.configName=testCloudExamplePrompt&newCollection=true&name=testCloudExamplePrompt_shard1_replica1&action=CREATE&numShards=2&collection=testCloudExamplePrompt&shard=shard1&wt=javabin&version=2} status=0 QTime=2430
[junit4] 2> 1768492 INFO (zkCallback-4527-thread-1-processing-n:localhost:44067_solr) [n:localhost:44067_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testCloudExamplePrompt/state.json] for collection [testCloudExamplePrompt] has occurred - updating... (live nodes size: [1])
[junit4] 2> 1768742 INFO (qtp1441830342-24238) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&collection.configName=testCloudExamplePrompt&newCollection=true&name=testCloudExamplePrompt_shard1_replica2&action=CREATE&numShards=2&collection=testCloudExamplePrompt&shard=shard1&wt=javabin&version=2} status=0 QTime=2780
[junit4] 2> 1768747 INFO (qtp1441830342-24239) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&collection.configName=testCloudExamplePrompt&newCollection=true&name=testCloudExamplePrompt_shard2_replica2&action=CREATE&numShards=2&collection=testCloudExamplePrompt&shard=shard2&wt=javabin&version=2} status=0 QTime=2785
[junit4] 2> 1768749 INFO (qtp1441830342-24240) [n:localhost:44067_solr ] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 30 seconds. Check all shard replicas
[junit4] 2> 1768848 INFO (zkCallback-4527-thread-1-processing-n:localhost:44067_solr) [n:localhost:44067_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testCloudExamplePrompt/state.json] for collection [testCloudExamplePrompt] has occurred - updating... (live nodes size: [1])
[junit4] 2> 1769749 INFO (qtp1441830342-24240) [n:localhost:44067_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={replicationFactor=2&maxShardsPerNode=4&collection.configName=testCloudExamplePrompt&name=testCloudExamplePrompt&action=CREATE&numShards=2&wt=json} status=0 QTime=3898
[junit4] 2> 1769756 INFO (qtp1441830342-24237) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 r:core_node2 x:testCloudExamplePrompt_shard1_replica2] o.a.s.h.SolrConfigHandler Executed config commands successfully and persisted to ZK [{"set-property":{"updateHandler.autoSoftCommit.maxTime":"3000"}}]
[junit4] 2> 1769756 INFO (qtp1441830342-24237) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 r:core_node2 x:testCloudExamplePrompt_shard1_replica2] o.a.s.h.SolrConfigHandler Waiting up to 30 secs for 4 replicas to set the property overlay to be of version 0 for collection testCloudExamplePrompt
[junit4] 2> 1769756 INFO (Thread-4325) [n:localhost:44067_solr ] o.a.s.c.SolrCore config update listener called for core testCloudExamplePrompt_shard2_replica1
[junit4] 2> 1769756 INFO (Thread-4325) [n:localhost:44067_solr ] o.a.s.c.SolrCore core reload testCloudExamplePrompt_shard2_replica1
[junit4] 2> 1769758 INFO (solrHandlerExecutor-8485-thread-1-processing-n:localhost:44067_solr x:testCloudExamplePrompt_shard1_replica2 s:shard1 c:testCloudExamplePrompt r:core_node2) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 r:core_node2 x:testCloudExamplePrompt_shard1_replica2] o.a.s.h.SolrConfigHandler Time elapsed : 0 secs, maxWait 30
[junit4] 2> 1769758 INFO (solrHandlerExecutor-8485-thread-4-processing-n:localhost:44067_solr x:testCloudExamplePrompt_shard1_replica2 s:shard1 c:testCloudExamplePrompt r:core_node2) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 r:core_node2 x:testCloudExamplePrompt_shard1_replica2] o.a.s.h.SolrConfigHandler Time elapsed : 0 secs, maxWait 30
[junit4] 2> 1769758 INFO (solrHandlerExecutor-8485-thread-3-processing-n:localhost:44067_solr x:testCloudExamplePrompt_shard1_replica2 s:shard1 c:testCloudExamplePrompt r:core_node2) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 r:core_node2 x:testCloudExamplePrompt_shard1_replica2] o.a.s.h.SolrConfigHandler Time elapsed : 0 secs, maxWait 30
[junit4] 2> 1769758 INFO (solrHandlerExecutor-8485-thread-2-processing-n:localhost:44067_solr x:testCloudExamplePrompt_shard1_replica2 s:shard1 c:testCloudExamplePrompt r:core_node2) [n:localhost:44067_solr c:testCloudExamplePrompt s:shard1 r:core_node2 x:testCloudExamplePrompt_shard1_replica2] o.a.s.h.SolrConfigHandler Time elapsed : 0 secs, maxWait 30
[junit4] 2> 1769765 INFO (Thread-4325) [n:localhost:44067_solr ] o.a.s.c.RequestParams conf resource params.json loaded . version : 0
[junit4] 2> 1769765 INFO (Thread-4325) [n:localhost:44067_solr ] o.a.s.c.RequestParams request params refreshed to version 0
[junit4] 2> 1769766 WARN (Thread-4325) [n:localhost:44067_solr ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard2_replica1/../../../../contrib/extraction/lib filtered by .*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard2_replica1/../../../../contrib/extraction/lib
[junit4] 2> 1769766 WARN (Thread-4325) [n:localhost:44067_solr ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard2_replica1/../../../../dist filtered by solr-cell-\d.*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard2_replica1/../../../../dist
[junit4] 2> 1769767 WARN (Thread-4325) [n:localhost:44067_solr ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard2_replica1/../../../../contrib/clustering/lib filtered by .*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard2_replica1/../../../../contrib/clustering/lib
[junit4] 2> 1769767 WARN (Thread-4325) [n:localhost:44067_solr ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard2_replica1/../../../../dist filtered by solr-clustering-\d.*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard2_replica1/../../../../dist
[junit4] 2> 1769767 WARN (Thread-4325) [n:localhost:44067_solr ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard2_replica1/../../../../contrib/langid/lib filtered by .*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard2_replica1/../../../../contrib/langid/lib
[junit4] 2> 1769767 WARN (Thread-4325) [n:localhost:44067_solr ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard2_replica1/../../../../dist filtered by solr-langid-\d.*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard2_replica1/../../../../dist
[junit4] 2> 1769768 WARN (Thread-4325) [n:localhost:44067_solr ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard2_replica1/../../../../contrib/velocity/lib filtered by .*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard2_replica1/../../../../contrib/velocity/lib
[junit4] 2> 1769768 WARN (Thread-4325) [n:localhost:44067_solr ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard2_replica1/../../../../dist filtered by solr-velocity-\d.*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001/tempDir-003/node1/testCloudExamplePrompt_shard2_replica1/../../../../dist
[...truncated too long message...]
yReader(UninvertingDirectoryReader())}
[junit4] 2> 1779761 INFO (coreLoadExecutor-8534-thread-1) [ x:gettingstarted] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1566462337954611200
[junit4] 2> 1779761 INFO (searcherExecutor-8535-thread-1-processing-x:gettingstarted) [ x:gettingstarted] o.a.s.c.QuerySenderListener QuerySenderListener done.
[junit4] 2> 1779762 INFO (searcherExecutor-8535-thread-1-processing-x:gettingstarted) [ x:gettingstarted] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 1779762 INFO (searcherExecutor-8535-thread-1-processing-x:gettingstarted) [ x:gettingstarted] o.a.s.c.SolrCore [gettingstarted] Registered new searcher Searcher@7e64417e[gettingstarted] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1784530 INFO (qtp539471318-24460) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/info/system params={wt=json} status=0 QTime=5
[junit4] 2> 1784534 INFO (qtp539471318-24460) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={core=gettingstarted&action=STATUS&wt=json} status=0 QTime=0
[junit4] 2> 1784535 INFO (TEST-TestSolrCLIRunExample.testSchemalessExample-seed#[4313724179B479EA]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@e22de87{HTTP/1.1,[http/1.1]}{127.0.0.1:32784}
[junit4] 2> 1784535 INFO (TEST-TestSolrCLIRunExample.testSchemalessExample-seed#[4313724179B479EA]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=635447301
[junit4] 2> 1784535 INFO (TEST-TestSolrCLIRunExample.testSchemalessExample-seed#[4313724179B479EA]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 1784536 INFO (TEST-TestSolrCLIRunExample.testSchemalessExample-seed#[4313724179B479EA]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 1784537 INFO (TEST-TestSolrCLIRunExample.testSchemalessExample-seed#[4313724179B479EA]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 1784538 INFO (TEST-TestSolrCLIRunExample.testSchemalessExample-seed#[4313724179B479EA]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 1784538 INFO (coreCloseExecutor-8540-thread-1) [ x:gettingstarted] o.a.s.c.SolrCore [gettingstarted] CLOSING SolrCore org.apache.solr.core.SolrCore@53fde3a6
[junit4] 2> 1784539 INFO (coreCloseExecutor-8540-thread-1) [ x:gettingstarted] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.gettingstarted, tag=1409147814
[junit4] 2> 1784541 INFO (TEST-TestSolrCLIRunExample.testSchemalessExample-seed#[4313724179B479EA]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@967141c{/solr,null,UNAVAILABLE}
[junit4] 2> 1784541 INFO (TEST-TestSolrCLIRunExample.testSchemalessExample-seed#[4313724179B479EA]) [ ] o.a.s.u.TestSolrCLIRunExample Stopped standalone Solr instance running on port 32784
[junit4] 2> 1784541 INFO (TEST-TestSolrCLIRunExample.testSchemalessExample-seed#[4313724179B479EA]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testSchemalessExample
[junit4] 2> 1785205 INFO (SUITE-TestSolrCLIRunExample-seed#[4313724179B479EA]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_4313724179B479EA-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {}, docValues:{}, maxPointsInLeafNode=415, maxMBSortInHeap=7.822101544367312, sim=RandomSimilarity(queryNorm=false): {}, locale=sr, timezone=America/North_Dakota/Beulah
[junit4] 2> NOTE: Linux 4.4.0-75-generic amd64/Oracle Corporation 1.8.0_131 (64-bit)/cpus=12,threads=1,free=260430832,total=529530880
[junit4] 2> NOTE: All tests run in this JVM: [TestSolrJ, TestReloadAndDeleteDocs, TestAuthenticationFramework, TestFieldCacheSort, TestManagedSchemaThreadSafety, TestTrieFacet, ResourceLoaderTest, TestBackupRepositoryFactory, ConjunctionSolrSpellCheckerTest, TestClusterStateMutator, TestBM25SimilarityFactory, TestLRUCache, AnalysisErrorHandlingTest, PrimUtilsTest, TestBinaryResponseWriter, TestCharFilters, TestSchemalessBufferedUpdates, TestQueryUtils, SimplePostToolTest, ZkSolrClientTest, TestSizeLimitedDistributedMap, TestInfoStreamLogging, DeleteReplicaTest, SharedFSAutoReplicaFailoverTest, DistributedQueueTest, HighlighterTest, ConfigureRecoveryStrategyTest, TestRTimerTree, ShardRoutingCustomTest, TestDistributedGrouping, TestSQLHandlerNonCloud, UpdateRequestProcessorFactoryTest, TestCursorMarkWithoutUniqueKey, DirectSolrSpellCheckerTest, DistributedFacetPivotSmallTest, DocExpirationUpdateProcessorFactoryTest, MoveReplicaTest, BlobRepositoryCloudTest, TermsComponentTest, LoggingHandlerTest, ShardRoutingTest, TestHighFrequencyDictionaryFactory, TestPostingsSolrHighlighter, TestTrie, SolrGraphiteReporterTest, TestFiltering, TestStressVersions, ConvertedLegacyTest, HdfsUnloadDistributedZkTest, MoreLikeThisHandlerTest, TestReplicaProperties, TestMacros, TestSurroundQueryParser, BufferStoreTest, SolrInfoBeanTest, TestExceedMaxTermLength, TestNamedUpdateProcessors, DocValuesTest, TestCryptoKeys, TestUnifiedSolrHighlighter, TestComplexPhraseLeadingWildcard, RecoveryAfterSoftCommitTest, IndexSchemaRuntimeFieldTest, TestSolrCoreSnapshots, DistributedFacetPivotLargeTest, TestOrdValues, AnalyticsMergeStrategyTest, TestBlendedInfixSuggestions, TestCloudJSONFacetJoinDomain, CollectionStateFormat2Test, IndexBasedSpellCheckerTest, DistanceUnitsTest, IndexSchemaTest, JsonLoaderTest, SpatialFilterTest, SpatialHeatmapFacetsTest, BasicAuthIntegrationTest, EnumFieldTest, ConnectionManagerTest, ZkControllerTest, PreAnalyzedUpdateProcessorTest, TestSearchPerf, DistributedTermsComponentTest, WordBreakSolrSpellCheckerTest, TestAuthorizationFramework, CleanupOldIndexTest, TestSystemCollAutoCreate, TestCloudRecovery, TestStressLiveNodes, TestSolrQueryResponse, TestDistributedStatsComponentCardinality, SortSpecParsingTest, TestSweetSpotSimilarityFactory, TestConfigSetsAPI, DistribCursorPagingTest, SampleTest, CdcrBootstrapTest, SolrMetricReporterTest, AddSchemaFieldsUpdateProcessorFactoryTest, MetricsHandlerTest, TestSolrFieldCacheBean, BadComponentTest, SolrIndexSplitterTest, SolrCloudReportersTest, ZkCLITest, SpellCheckCollatorTest, TestManagedResourceStorage, TestPushWriter, DistributedQueryComponentOptimizationTest, SuggesterFSTTest, WrapperMergePolicyFactoryTest, DOMUtilTest, LargeFieldTest, TestTrackingShardHandlerFactory, TestReplicationHandler, TestRandomFaceting, TestHashPartitioner, TestRealTimeGet, TestStressReorder, SolrCoreTest, SolrCmdDistributorTest, PeerSyncTest, SignatureUpdateProcessorFactoryTest, CoreAdminHandlerTest, PolyFieldTest, SchemaVersionSpecificBehaviorTest, TestUpdate, TestAtomicUpdateErrorCases, QueryEqualityTest, StatelessScriptUpdateProcessorFactoryTest, DocValuesMultiTest, DistanceFunctionTest, TestSolrDeletionPolicy1, DebugComponentTest, TestWriterPerf, FileBasedSpellCheckerTest, PathHierarchyTokenizerFactoryTest, TestIndexingPerformance, FastVectorHighlighterTest, QueryParsingTest, BinaryUpdateRequestHandlerTest, TestPartialUpdateDeduplication, PingRequestHandlerTest, SOLR749Test, TestQuerySenderListener, UpdateParamsTest, TestSolrIndexConfig, CopyFieldTest, TestStressRecovery, TestFuzzyAnalyzedSuggestions, DirectSolrConnectionTest, TestCodecSupport, EchoParamsTest, TestLMDirichletSimilarityFactory, TestIBSimilarityFactory, OpenExchangeRatesOrgProviderTest, PluginInfoTest, DateMathParserTest, TestSystemIdResolver, TestSuggestSpellingConverter, DateFieldTest, RAMDirectoryFactoryTest, ClusterStateTest, TestUtils, TestDocumentBuilder, ZkNodePropsTest, SliceStateTest, SystemInfoHandlerTest, FileUtilsTest, CircularListTest, DistributedMLTComponentTest, TestRTGBase, CursorPagingTest, DistributedIntervalFacetingTest, TestDistributedMissingSort, TestTolerantSearch, TestPathTrie, TestEmbeddedSolrServerConstructors, TestEmbeddedSolrServerSchemaAPI, TestJettySolrRunner, AssignTest, BaseCdcrDistributedZkTest, CdcrRequestHandlerTest, CloudExitableDirectoryReaderTest, CollectionReloadTest, CollectionsAPISolrJTest, HttpPartitionTest, LeaderInitiatedRecoveryOnShardRestartTest, MultiThreadedOCPTest, OutOfBoxZkACLAndCredentialsProvidersTest, OverseerStatusTest, SSLMigrationTest, SaslZkACLProviderTest, ShardSplitTest, V2ApiIntegrationTest, SecurityConfHandlerTest, SegmentsInfoRequestHandlerTest, DistributedDebugComponentTest, DistributedFacetExistsSmallTest, InfixSuggestersTest, SolrMetricManagerTest, SolrGangliaReporterTest, TestClassNameShortening, TestDynamicFieldCollectionResource, TestFieldResource, TestSchemaNameResource, TestSchemaVersionResource, TestSolrQueryParserResource, TestManagedStopFilterFactory, DocValuesMissingTest, SpatialRPTFieldTypeTest, TestCloudSchemaless, TestAddFieldRealTimeGet, TestCollapseQParserPlugin, TestFieldSortValues, TestFilteredDocIdSet, TestHashQParserPlugin, TestMaxScoreQueryParser, TestNoOpRegenerator, TestPayloadCheckQParserPlugin, TestPayloadScoreQParserPlugin, TestReloadDeadlock, TestSimpleQParserPlugin, TestSmileRequest, TestXmlQParserPlugin, TestJsonFacets, TestLRUStatsCache, TestFreeTextSuggestions, BlockDirectoryTest, TestFieldCacheWithThreads, TestNumericTerms32, CdcrUpdateLogTest, DataDrivenBlockJoinTest, PeerSyncWithIndexFingerprintCachingTest, SolrIndexMetricsTest, TestDocBasedVersionConstraints, AtomicUpdatesTest, ClassificationUpdateProcessorIntegrationTest, CloneFieldUpdateProcessorFactoryTest, ParsingFieldUpdateProcessorsTest, TemplateUpdateProcessorTest, TestSolrCLIRunExample]
[junit4] Completed [708/709 (1!)] on J1 in 19.78s, 4 tests, 1 failure <<< FAILURES!
[...truncated 43379 lines...]