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/28 09:27:04 UTC
[JENKINS] Lucene-Solr-master-Linux (64bit/jdk1.8.0_131) - Build #
19726 - Still Unstable!
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/19726/
Java: 64bit/jdk1.8.0_131 -XX:-UseCompressedOops -XX:+UseSerialGC
3 tests failed.
FAILED: junit.framework.TestSuite.org.apache.solr.core.TestLazyCores
Error Message:
ObjectTracker found 6 object(s) that were not released!!! [MDCAwareThreadPoolExecutor, SolrIndexSearcher, MMapDirectory, MMapDirectory, MMapDirectory, SolrCore] 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:973) at org.apache.solr.core.CoreContainer.lambda$load$7(CoreContainer.java:605) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:197) at java.util.concurrent.FutureTask.run(FutureTask.java:266) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:188) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) at java.lang.Thread.run(Thread.java:748) 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:2047) 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:973) at org.apache.solr.core.CoreContainer.lambda$load$7(CoreContainer.java:605) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:197) at java.util.concurrent.FutureTask.run(FutureTask.java:266) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:188) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) at java.lang.Thread.run(Thread.java:748) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MMapDirectory 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:973) at org.apache.solr.core.CoreContainer.lambda$load$7(CoreContainer.java:605) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:197) at java.util.concurrent.FutureTask.run(FutureTask.java:266) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:188) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) at java.lang.Thread.run(Thread.java:748) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MMapDirectory 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:973) at org.apache.solr.core.CoreContainer.lambda$load$7(CoreContainer.java:605) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:197) at java.util.concurrent.FutureTask.run(FutureTask.java:266) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:188) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) at java.lang.Thread.run(Thread.java:748) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MMapDirectory 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:973) at org.apache.solr.core.CoreContainer.lambda$load$7(CoreContainer.java:605) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:197) at java.util.concurrent.FutureTask.run(FutureTask.java:266) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:188) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) at java.lang.Thread.run(Thread.java:748) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.solr.core.SolrCore at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:1033) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:855) at org.apache.solr.core.CoreContainer.create(CoreContainer.java:973) at org.apache.solr.core.CoreContainer.lambda$load$7(CoreContainer.java:605) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:197) at java.util.concurrent.FutureTask.run(FutureTask.java:266) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:188) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) at java.lang.Thread.run(Thread.java:748)
Stack Trace:
java.lang.AssertionError: ObjectTracker found 6 object(s) that were not released!!! [MDCAwareThreadPoolExecutor, SolrIndexSearcher, MMapDirectory, MMapDirectory, MMapDirectory, SolrCore]
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:973)
at org.apache.solr.core.CoreContainer.lambda$load$7(CoreContainer.java:605)
at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:197)
at java.util.concurrent.FutureTask.run(FutureTask.java:266)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:188)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:748)
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:2047)
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:973)
at org.apache.solr.core.CoreContainer.lambda$load$7(CoreContainer.java:605)
at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:197)
at java.util.concurrent.FutureTask.run(FutureTask.java:266)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:188)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:748)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MMapDirectory
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:973)
at org.apache.solr.core.CoreContainer.lambda$load$7(CoreContainer.java:605)
at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:197)
at java.util.concurrent.FutureTask.run(FutureTask.java:266)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:188)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:748)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MMapDirectory
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:973)
at org.apache.solr.core.CoreContainer.lambda$load$7(CoreContainer.java:605)
at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:197)
at java.util.concurrent.FutureTask.run(FutureTask.java:266)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:188)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:748)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MMapDirectory
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:973)
at org.apache.solr.core.CoreContainer.lambda$load$7(CoreContainer.java:605)
at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:197)
at java.util.concurrent.FutureTask.run(FutureTask.java:266)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:188)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:748)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.solr.core.SolrCore
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:1033)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:855)
at org.apache.solr.core.CoreContainer.create(CoreContainer.java:973)
at org.apache.solr.core.CoreContainer.lambda$load$7(CoreContainer.java:605)
at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:197)
at java.util.concurrent.FutureTask.run(FutureTask.java:266)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:188)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:748)
at __randomizedtesting.SeedInfo.seed([8D5B019F555F506]: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:303)
at sun.reflect.GeneratedMethodAccessor42.invoke(Unknown Source)
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$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 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)
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=11202, name=searcherExecutor-5719-thread-1, state=WAITING, group=TGRP-TestLazyCores] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) at java.lang.Thread.run(Thread.java:748)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE scope at org.apache.solr.core.TestLazyCores:
1) Thread[id=11202, name=searcherExecutor-5719-thread-1, state=WAITING, group=TGRP-TestLazyCores]
at sun.misc.Unsafe.park(Native Method)
at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:748)
at __randomizedtesting.SeedInfo.seed([8D5B019F555F506]: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=11202, name=searcherExecutor-5719-thread-1, state=WAITING, group=TGRP-TestLazyCores] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) at java.lang.Thread.run(Thread.java:748)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie threads that couldn't be terminated:
1) Thread[id=11202, name=searcherExecutor-5719-thread-1, state=WAITING, group=TGRP-TestLazyCores]
at sun.misc.Unsafe.park(Native Method)
at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:748)
at __randomizedtesting.SeedInfo.seed([8D5B019F555F506]:0)
Build Log:
[...truncated 12116 lines...]
[junit4] Suite: org.apache.solr.core.TestLazyCores
[junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestLazyCores_8D5B019F555F506-001/init-core-data-001
[junit4] 2> 1072476 WARN (SUITE-TestLazyCores-seed#[8D5B019F555F506]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=41 numCloses=41
[junit4] 2> 1072477 INFO (SUITE-TestLazyCores-seed#[8D5B019F555F506]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields
[junit4] 2> 1072477 INFO (SUITE-TestLazyCores-seed#[8D5B019F555F506]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 1072478 INFO (TEST-TestLazyCores.testLazyLoad-seed#[8D5B019F555F506]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testLazyLoad
[junit4] 2> 1072486 INFO (TEST-TestLazyCores.testLazyLoad-seed#[8D5B019F555F506]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestLazyCores_8D5B019F555F506-001/tempDir-001/solr.xml
[junit4] 2> 1072489 INFO (TEST-TestLazyCores.testLazyLoad-seed#[8D5B019F555F506]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@51ef1ee3, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 1072507 INFO (TEST-TestLazyCores.testLazyLoad-seed#[8D5B019F555F506]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@51ef1ee3
[junit4] 2> 1072510 INFO (TEST-TestLazyCores.testLazyLoad-seed#[8D5B019F555F506]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@51ef1ee3
[junit4] 2> 1072510 INFO (TEST-TestLazyCores.testLazyLoad-seed#[8D5B019F555F506]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@51ef1ee3
[junit4] 2> 1072511 INFO (TEST-TestLazyCores.testLazyLoad-seed#[8D5B019F555F506]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 1072517 WARN (coreLoadExecutor-5640-thread-2) [ x:collection2] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 1072517 INFO (coreLoadExecutor-5640-thread-2) [ x:collection2] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 1072517 WARN (coreLoadExecutor-5640-thread-1) [ x:collection1] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 1072517 WARN (coreLoadExecutor-5640-thread-3) [ x:collection5] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 1072518 INFO (coreLoadExecutor-5640-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 1072518 INFO (coreLoadExecutor-5640-thread-3) [ x:collection5] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 1072530 INFO (coreLoadExecutor-5640-thread-2) [ x:collection2] o.a.s.s.IndexSchema [collection2] Schema name=tiny
[junit4] 2> 1072532 INFO (coreLoadExecutor-5640-thread-2) [ x:collection2] o.a.s.s.IndexSchema Loaded schema tiny/1.1 with uniqueid field id
[junit4] 2> 1072532 INFO (coreLoadExecutor-5640-thread-2) [ x:collection2] o.a.s.c.CoreContainer Creating SolrCore 'collection2' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestLazyCores_8D5B019F555F506-001/tempDir-001/./collection2, trusted=true
[junit4] 2> 1072532 INFO (coreLoadExecutor-5640-thread-2) [ x:collection2] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection2' (registry 'solr.core.collection2') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@51ef1ee3
[junit4] 2> 1072532 INFO (coreLoadExecutor-5640-thread-2) [ x:collection2] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1072532 INFO (coreLoadExecutor-5640-thread-2) [ x:collection2] o.a.s.c.SolrCore [[collection2] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestLazyCores_8D5B019F555F506-001/tempDir-001/collection2], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestLazyCores_8D5B019F555F506-001/tempDir-001/./collection2/data/]
[junit4] 2> 1072533 INFO (coreLoadExecutor-5640-thread-3) [ x:collection5] o.a.s.s.IndexSchema [collection5] Schema name=tiny
[junit4] 2> 1072533 INFO (coreLoadExecutor-5640-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=tiny
[junit4] 2> 1072534 INFO (coreLoadExecutor-5640-thread-2) [ x:collection2] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=972245738, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
[junit4] 2> 1072535 INFO (coreLoadExecutor-5640-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema tiny/1.1 with uniqueid field id
[junit4] 2> 1072535 INFO (coreLoadExecutor-5640-thread-3) [ x:collection5] o.a.s.s.IndexSchema Loaded schema tiny/1.1 with uniqueid field id
[junit4] 2> 1072535 INFO (coreLoadExecutor-5640-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestLazyCores_8D5B019F555F506-001/tempDir-001/./collection1, trusted=true
[junit4] 2> 1072535 INFO (coreLoadExecutor-5640-thread-3) [ x:collection5] o.a.s.c.CoreContainer Creating SolrCore 'collection5' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestLazyCores_8D5B019F555F506-001/tempDir-001/./collection5, trusted=true
[junit4] 2> 1072535 INFO (coreLoadExecutor-5640-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@51ef1ee3
[junit4] 2> 1072535 INFO (coreLoadExecutor-5640-thread-3) [ x:collection5] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection5' (registry 'solr.core.collection5') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@51ef1ee3
[junit4] 2> 1072535 INFO (coreLoadExecutor-5640-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1072535 INFO (coreLoadExecutor-5640-thread-3) [ x:collection5] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1072535 INFO (coreLoadExecutor-5640-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestLazyCores_8D5B019F555F506-001/tempDir-001/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestLazyCores_8D5B019F555F506-001/tempDir-001/./collection1/data/]
[junit4] 2> 1072535 INFO (coreLoadExecutor-5640-thread-3) [ x:collection5] o.a.s.c.SolrCore [[collection5] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestLazyCores_8D5B019F555F506-001/tempDir-001/collection5], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestLazyCores_8D5B019F555F506-001/tempDir-001/./collection5/data/]
[junit4] 2> 1072538 INFO (coreLoadExecutor-5640-thread-3) [ x:collection5] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=972245738, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
[junit4] 2> 1072538 INFO (coreLoadExecutor-5640-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=972245738, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
[junit4] 2> 1072571 INFO (coreLoadExecutor-5640-thread-2) [ x:collection2] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1072571 INFO (coreLoadExecutor-5640-thread-2) [ x:collection2] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1072572 INFO (coreLoadExecutor-5640-thread-2) [ x:collection2] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=562719452, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
[junit4] 2> 1072573 INFO (coreLoadExecutor-5640-thread-2) [ x:collection2] o.a.s.s.SolrIndexSearcher Opening [Searcher@76cb5eed[collection2] main]
[junit4] 2> 1072573 INFO (coreLoadExecutor-5640-thread-3) [ x:collection5] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1072573 INFO (coreLoadExecutor-5640-thread-3) [ x:collection5] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1072573 INFO (coreLoadExecutor-5640-thread-2) [ x:collection2] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestLazyCores_8D5B019F555F506-001/tempDir-001/collection2/conf
[junit4] 2> 1072573 INFO (coreLoadExecutor-5640-thread-3) [ x:collection5] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=562719452, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
[junit4] 2> 1072573 INFO (coreLoadExecutor-5640-thread-2) [ x:collection2] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1072573 INFO (coreLoadExecutor-5640-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1072573 INFO (coreLoadExecutor-5640-thread-3) [ x:collection5] o.a.s.s.SolrIndexSearcher Opening [Searcher@62058f5c[collection5] main]
[junit4] 2> 1072573 INFO (coreLoadExecutor-5640-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1072574 INFO (coreLoadExecutor-5640-thread-3) [ x:collection5] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestLazyCores_8D5B019F555F506-001/tempDir-001/collection5/conf
[junit4] 2> 1072574 INFO (coreLoadExecutor-5640-thread-3) [ x:collection5] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1072574 INFO (searcherExecutor-5641-thread-1-processing-x:collection2) [ x:collection2] o.a.s.c.SolrCore [collection2] Registered new searcher Searcher@76cb5eed[collection2] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1072574 INFO (coreLoadExecutor-5640-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=562719452, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
[junit4] 2> 1072574 INFO (coreLoadExecutor-5640-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@5d4e9e8a[collection1] main]
[junit4] 2> 1072574 INFO (searcherExecutor-5643-thread-1-processing-x:collection5) [ x:collection5] o.a.s.c.SolrCore [collection5] Registered new searcher Searcher@62058f5c[collection5] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1072575 INFO (coreLoadExecutor-5640-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestLazyCores_8D5B019F555F506-001/tempDir-001/collection1/conf
[junit4] 2> 1072575 INFO (coreLoadExecutor-5640-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1072575 INFO (searcherExecutor-5642-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@5d4e9e8a[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1072581 WARN (TEST-TestLazyCores.testLazyLoad-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 1072582 INFO (TEST-TestLazyCores.testLazyLoad-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 1072597 INFO (TEST-TestLazyCores.testLazyLoad-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.s.IndexSchema [collection3] Schema name=tiny
[junit4] 2> 1072598 INFO (TEST-TestLazyCores.testLazyLoad-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.s.IndexSchema Loaded schema tiny/1.1 with uniqueid field id
[junit4] 2> 1072599 INFO (TEST-TestLazyCores.testLazyLoad-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.c.CoreContainer Creating SolrCore 'collection3' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestLazyCores_8D5B019F555F506-001/tempDir-001/./collection3, trusted=true
[junit4] 2> 1072599 INFO (TEST-TestLazyCores.testLazyLoad-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection3' (registry 'solr.core.collection3') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@51ef1ee3
[junit4] 2> 1072599 INFO (TEST-TestLazyCores.testLazyLoad-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1072599 INFO (TEST-TestLazyCores.testLazyLoad-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.c.SolrCore [[collection3] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestLazyCores_8D5B019F555F506-001/tempDir-001/collection3], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestLazyCores_8D5B019F555F506-001/tempDir-001/./collection3/data/]
[junit4] 2> 1072601 INFO (TEST-TestLazyCores.testLazyLoad-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=30, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.12290617405224653]
[junit4] 2> 1072634 INFO (TEST-TestLazyCores.testLazyLoad-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1072634 INFO (TEST-TestLazyCores.testLazyLoad-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1072635 INFO (TEST-TestLazyCores.testLazyLoad-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=308228417, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
[junit4] 2> 1072636 INFO (TEST-TestLazyCores.testLazyLoad-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.s.SolrIndexSearcher Opening [Searcher@519b87c7[collection3] main]
[junit4] 2> 1072636 INFO (TEST-TestLazyCores.testLazyLoad-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestLazyCores_8D5B019F555F506-001/tempDir-001/collection3/conf
[junit4] 2> 1072636 INFO (TEST-TestLazyCores.testLazyLoad-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1072637 INFO (searcherExecutor-5653-thread-1-processing-x:collection3) [ x:collection3] o.a.s.c.SolrCore [collection3] Registered new searcher Searcher@519b87c7[collection3] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1072642 WARN (TEST-TestLazyCores.testLazyLoad-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 1072642 INFO (TEST-TestLazyCores.testLazyLoad-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 1072645 INFO (TEST-TestLazyCores.testLazyLoad-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.s.IndexSchema [collection4] Schema name=tiny
[junit4] 2> 1072647 INFO (TEST-TestLazyCores.testLazyLoad-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.s.IndexSchema Loaded schema tiny/1.1 with uniqueid field id
[junit4] 2> 1072647 INFO (TEST-TestLazyCores.testLazyLoad-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.c.CoreContainer Creating SolrCore 'collection4' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestLazyCores_8D5B019F555F506-001/tempDir-001/./collection4, trusted=true
[junit4] 2> 1072647 INFO (TEST-TestLazyCores.testLazyLoad-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection4' (registry 'solr.core.collection4') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@51ef1ee3
[junit4] 2> 1072647 INFO (TEST-TestLazyCores.testLazyLoad-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1072647 INFO (TEST-TestLazyCores.testLazyLoad-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.c.SolrCore [[collection4] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestLazyCores_8D5B019F555F506-001/tempDir-001/collection4], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestLazyCores_8D5B019F555F506-001/tempDir-001/./collection4/data/]
[junit4] 2> 1072649 INFO (TEST-TestLazyCores.testLazyLoad-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=49, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.6781343061118819]
[junit4] 2> 1072682 INFO (TEST-TestLazyCores.testLazyLoad-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1072682 INFO (TEST-TestLazyCores.testLazyLoad-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1072683 INFO (TEST-TestLazyCores.testLazyLoad-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=466449071, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
[junit4] 2> 1072683 INFO (TEST-TestLazyCores.testLazyLoad-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.s.SolrIndexSearcher Opening [Searcher@5d8120a7[collection4] main]
[junit4] 2> 1072683 INFO (TEST-TestLazyCores.testLazyLoad-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestLazyCores_8D5B019F555F506-001/tempDir-001/collection4/conf
[junit4] 2> 1072684 INFO (TEST-TestLazyCores.testLazyLoad-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1072684 INFO (TEST-TestLazyCores.testLazyLoad-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.c.CoreContainer Shutting down CoreContainer instance=929815528
[junit4] 2> 1072684 INFO (TEST-TestLazyCores.testLazyLoad-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 1072685 INFO (searcherExecutor-5657-thread-1-processing-x:collection3) [ x:collection3] o.a.s.c.SolrCore [collection4] Registered new searcher Searcher@5d8120a7[collection4] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1072685 INFO (TEST-TestLazyCores.testLazyLoad-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 1072686 INFO (TEST-TestLazyCores.testLazyLoad-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 1072686 INFO (coreCloseExecutor-5661-thread-1-processing-x:collection3) [ x:collection5] o.a.s.c.SolrCore [collection5] CLOSING SolrCore org.apache.solr.core.SolrCore@4945dd80
[junit4] 2> 1072686 INFO (coreCloseExecutor-5661-thread-2-processing-x:collection3) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@5e7914c7
[junit4] 2> 1072686 INFO (coreCloseExecutor-5661-thread-3-processing-x:collection3) [ x:collection4] o.a.s.c.SolrCore [collection4] CLOSING SolrCore org.apache.solr.core.SolrCore@3c82c98c
[junit4] 2> 1072686 INFO (coreCloseExecutor-5661-thread-4-processing-x:collection3) [ x:collection2] o.a.s.c.SolrCore [collection2] CLOSING SolrCore org.apache.solr.core.SolrCore@331475d1
[junit4] 2> 1072686 INFO (coreCloseExecutor-5661-thread-5-processing-x:collection3) [ x:collection3] o.a.s.c.SolrCore [collection3] CLOSING SolrCore org.apache.solr.core.SolrCore@418f14d5
[junit4] 2> 1072687 INFO (coreCloseExecutor-5661-thread-4-processing-x:collection3) [ x:collection2] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection2, tag=856978897
[junit4] 2> 1072689 INFO (coreCloseExecutor-5661-thread-2-processing-x:collection3) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=1584993479
[junit4] 2> 1072690 INFO (coreCloseExecutor-5661-thread-3-processing-x:collection3) [ x:collection4] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection4, tag=1015204236
[junit4] 2> 1072691 INFO (coreCloseExecutor-5661-thread-5-processing-x:collection3) [ x:collection3] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection3, tag=1099896021
[junit4] 2> 1072693 INFO (coreCloseExecutor-5661-thread-1-processing-x:collection3) [ x:collection5] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection5, tag=1229315456
[junit4] 2> 1072694 INFO (TEST-TestLazyCores.testLazyLoad-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.SolrTestCaseJ4 ###Ending testLazyLoad
[junit4] IGNOR/A 0.00s J2 | TestLazyCores.testNoCommit
[junit4] > Assumption #1: 'badapple' test group is disabled (@BadApple(bugUrl=https://issues.apache.org/jira/browse/SOLR-10101))
[junit4] 2> 1072696 INFO (TEST-TestLazyCores.testCreateSame-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.SolrTestCaseJ4 ###Starting testCreateSame
[junit4] 2> 1072702 INFO (TEST-TestLazyCores.testCreateSame-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestLazyCores_8D5B019F555F506-001/tempDir-002/solr.xml
[junit4] 2> 1072714 INFO (TEST-TestLazyCores.testCreateSame-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@51ef1ee3, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 1072729 INFO (TEST-TestLazyCores.testCreateSame-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@51ef1ee3
[junit4] 2> 1072731 INFO (TEST-TestLazyCores.testCreateSame-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@51ef1ee3
[junit4] 2> 1072731 INFO (TEST-TestLazyCores.testCreateSame-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@51ef1ee3
[junit4] 2> 1072732 INFO (TEST-TestLazyCores.testCreateSame-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 1072738 WARN (coreLoadExecutor-5668-thread-2-processing-x:collection3) [ x:collection2] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 1072738 WARN (coreLoadExecutor-5668-thread-1-processing-x:collection3) [ x:collection1] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 1072738 WARN (coreLoadExecutor-5668-thread-3-processing-x:collection3) [ x:collection5] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 1072738 INFO (coreLoadExecutor-5668-thread-2-processing-x:collection3) [ x:collection2] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 1072739 INFO (coreLoadExecutor-5668-thread-1-processing-x:collection3) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 1072739 INFO (coreLoadExecutor-5668-thread-3-processing-x:collection3) [ x:collection5] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 1072754 INFO (coreLoadExecutor-5668-thread-1-processing-x:collection3) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=tiny
[junit4] 2> 1072754 INFO (coreLoadExecutor-5668-thread-2-processing-x:collection3) [ x:collection2] o.a.s.s.IndexSchema [collection2] Schema name=tiny
[junit4] 2> 1072755 INFO (coreLoadExecutor-5668-thread-3-processing-x:collection3) [ x:collection5] o.a.s.s.IndexSchema [collection5] Schema name=tiny
[junit4] 2> 1072756 INFO (coreLoadExecutor-5668-thread-1-processing-x:collection3) [ x:collection1] o.a.s.s.IndexSchema Loaded schema tiny/1.1 with uniqueid field id
[junit4] 2> 1072756 INFO (coreLoadExecutor-5668-thread-1-processing-x:collection3) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestLazyCores_8D5B019F555F506-001/tempDir-002/./collection1, trusted=true
[junit4] 2> 1072756 INFO (coreLoadExecutor-5668-thread-2-processing-x:collection3) [ x:collection2] o.a.s.s.IndexSchema Loaded schema tiny/1.1 with uniqueid field id
[junit4] 2> 1072756 INFO (coreLoadExecutor-5668-thread-2-processing-x:collection3) [ x:collection2] o.a.s.c.CoreContainer Creating SolrCore 'collection2' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestLazyCores_8D5B019F555F506-001/tempDir-002/./collection2, trusted=true
[junit4] 2> 1072756 INFO (coreLoadExecutor-5668-thread-1-processing-x:collection3) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@51ef1ee3
[junit4] 2> 1072756 INFO (coreLoadExecutor-5668-thread-2-processing-x:collection3) [ x:collection2] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection2' (registry 'solr.core.collection2') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@51ef1ee3
[junit4] 2> 1072756 INFO (coreLoadExecutor-5668-thread-2-processing-x:collection3) [ x:collection2] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1072756 INFO (coreLoadExecutor-5668-thread-1-processing-x:collection3) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1072756 INFO (coreLoadExecutor-5668-thread-2-processing-x:collection3) [ x:collection2] o.a.s.c.SolrCore [[collection2] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestLazyCores_8D5B019F555F506-001/tempDir-002/collection2], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestLazyCores_8D5B019F555F506-001/tempDir-002/./collection2/data/]
[junit4] 2> 1072756 INFO (coreLoadExecutor-5668-thread-1-processing-x:collection3) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestLazyCores_8D5B019F555F506-001/tempDir-002/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestLazyCores_8D5B019F555F506-001/tempDir-002/./collection1/data/]
[junit4] 2> 1072757 INFO (coreLoadExecutor-5668-thread-3-processing-x:collection3) [ x:collection5] o.a.s.s.IndexSchema Loaded schema tiny/1.1 with uniqueid field id
[junit4] 2> 1072757 INFO (coreLoadExecutor-5668-thread-3-processing-x:collection3) [ x:collection5] o.a.s.c.CoreContainer Creating SolrCore 'collection5' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestLazyCores_8D5B019F555F506-001/tempDir-002/./collection5, trusted=true
[junit4] 2> 1072757 INFO (coreLoadExecutor-5668-thread-3-processing-x:collection3) [ x:collection5] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection5' (registry 'solr.core.collection5') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@51ef1ee3
[junit4] 2> 1072757 INFO (coreLoadExecutor-5668-thread-3-processing-x:collection3) [ x:collection5] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1072757 INFO (coreLoadExecutor-5668-thread-3-processing-x:collection3) [ x:collection5] o.a.s.c.SolrCore [[collection5] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestLazyCores_8D5B019F555F506-001/tempDir-002/collection5], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestLazyCores_8D5B019F555F506-001/tempDir-002/./collection5/data/]
[junit4] 2> 1072758 INFO (coreLoadExecutor-5668-thread-1-processing-x:collection3) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=972245738, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
[junit4] 2> 1072758 INFO (coreLoadExecutor-5668-thread-2-processing-x:collection3) [ x:collection2] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=972245738, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
[junit4] 2> 1072759 INFO (coreLoadExecutor-5668-thread-3-processing-x:collection3) [ x:collection5] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=972245738, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
[junit4] 2> 1072795 INFO (coreLoadExecutor-5668-thread-1-processing-x:collection3) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1072795 INFO (coreLoadExecutor-5668-thread-1-processing-x:collection3) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1072796 INFO (coreLoadExecutor-5668-thread-3-processing-x:collection3) [ x:collection5] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1072796 INFO (coreLoadExecutor-5668-thread-1-processing-x:collection3) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=562719452, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
[junit4] 2> 1072796 INFO (coreLoadExecutor-5668-thread-3-processing-x:collection3) [ x:collection5] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1072796 INFO (coreLoadExecutor-5668-thread-1-processing-x:collection3) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@2fffc72a[collection1] main]
[junit4] 2> 1072796 INFO (coreLoadExecutor-5668-thread-1-processing-x:collection3) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestLazyCores_8D5B019F555F506-001/tempDir-002/collection1/conf
[junit4] 2> 1072797 INFO (coreLoadExecutor-5668-thread-3-processing-x:collection3) [ x:collection5] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=562719452, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
[junit4] 2> 1072797 INFO (coreLoadExecutor-5668-thread-1-processing-x:collection3) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1072797 INFO (coreLoadExecutor-5668-thread-3-processing-x:collection3) [ x:collection5] o.a.s.s.SolrIndexSearcher Opening [Searcher@16f35761[collection5] main]
[junit4] 2> 1072797 INFO (coreLoadExecutor-5668-thread-3-processing-x:collection3) [ x:collection5] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestLazyCores_8D5B019F555F506-001/tempDir-002/collection5/conf
[junit4] 2> 1072797 INFO (searcherExecutor-5669-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@2fffc72a[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1072797 INFO (coreLoadExecutor-5668-thread-3-processing-x:collection3) [ x:collection5] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1072798 INFO (searcherExecutor-5671-thread-1-processing-x:collection5) [ x:collection5] o.a.s.c.SolrCore [collection5] Registered new searcher Searcher@16f35761[collection5] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1072805 INFO (coreLoadExecutor-5668-thread-2-processing-x:collection3) [ x:collection2] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1072805 INFO (coreLoadExecutor-5668-thread-2-processing-x:collection3) [ x:collection2] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1072806 INFO (coreLoadExecutor-5668-thread-2-processing-x:collection3) [ x:collection2] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=562719452, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
[junit4] 2> 1072806 INFO (coreLoadExecutor-5668-thread-2-processing-x:collection3) [ x:collection2] o.a.s.s.SolrIndexSearcher Opening [Searcher@7d1456ec[collection2] main]
[junit4] 2> 1072807 INFO (coreLoadExecutor-5668-thread-2-processing-x:collection3) [ x:collection2] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestLazyCores_8D5B019F555F506-001/tempDir-002/collection2/conf
[junit4] 2> 1072807 INFO (coreLoadExecutor-5668-thread-2-processing-x:collection3) [ x:collection2] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1072808 INFO (searcherExecutor-5670-thread-1-processing-x:collection2) [ x:collection2] o.a.s.c.SolrCore [collection2] Registered new searcher Searcher@7d1456ec[collection2] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1072813 WARN (TEST-TestLazyCores.testCreateSame-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 1072814 INFO (TEST-TestLazyCores.testCreateSame-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 1072819 INFO (TEST-TestLazyCores.testCreateSame-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.s.IndexSchema [collection4] Schema name=tiny
[junit4] 2> 1072834 INFO (TEST-TestLazyCores.testCreateSame-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.s.IndexSchema Loaded schema tiny/1.1 with uniqueid field id
[junit4] 2> 1072834 INFO (TEST-TestLazyCores.testCreateSame-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.c.CoreContainer Creating SolrCore 'collection4' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestLazyCores_8D5B019F555F506-001/tempDir-002/./collection4, trusted=true
[junit4] 2> 1072834 INFO (TEST-TestLazyCores.testCreateSame-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection4' (registry 'solr.core.collection4') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@51ef1ee3
[junit4] 2> 1072834 INFO (TEST-TestLazyCores.testCreateSame-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1072834 INFO (TEST-TestLazyCores.testCreateSame-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.c.SolrCore [[collection4] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestLazyCores_8D5B019F555F506-001/tempDir-002/collection4], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestLazyCores_8D5B019F555F506-001/tempDir-002/./collection4/data/]
[junit4] 2> 1072836 INFO (TEST-TestLazyCores.testCreateSame-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=18, maxMergeAtOnceExplicit=47, maxMergedSegmentMB=16.3701171875, floorSegmentMB=1.5029296875, forceMergeDeletesPctAllowed=11.171641794276962, segmentsPerTier=11.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 1072872 INFO (TEST-TestLazyCores.testCreateSame-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1072872 INFO (TEST-TestLazyCores.testCreateSame-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1072873 INFO (TEST-TestLazyCores.testCreateSame-seed#[8D5B019F555F506]) [ x:collection3] 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=0.24553720060308298]
[junit4] 2> 1072873 INFO (TEST-TestLazyCores.testCreateSame-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.s.SolrIndexSearcher Opening [Searcher@aa60ecd[collection4] main]
[junit4] 2> 1072874 INFO (TEST-TestLazyCores.testCreateSame-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestLazyCores_8D5B019F555F506-001/tempDir-002/collection4/conf
[junit4] 2> 1072874 INFO (TEST-TestLazyCores.testCreateSame-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1072874 INFO (searcherExecutor-5682-thread-1-processing-x:collection3) [ x:collection3] o.a.s.c.SolrCore [collection4] Registered new searcher Searcher@aa60ecd[collection4] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1072879 WARN (TEST-TestLazyCores.testCreateSame-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 1072879 INFO (TEST-TestLazyCores.testCreateSame-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 1072883 INFO (TEST-TestLazyCores.testCreateSame-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.s.IndexSchema [collection6] Schema name=tiny
[junit4] 2> 1072884 INFO (TEST-TestLazyCores.testCreateSame-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.s.IndexSchema Loaded schema tiny/1.1 with uniqueid field id
[junit4] 2> 1072884 INFO (TEST-TestLazyCores.testCreateSame-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.c.CoreContainer Creating SolrCore 'collection6' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestLazyCores_8D5B019F555F506-001/tempDir-002/./collection6, trusted=true
[junit4] 2> 1072884 INFO (TEST-TestLazyCores.testCreateSame-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection6' (registry 'solr.core.collection6') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@51ef1ee3
[junit4] 2> 1072884 INFO (TEST-TestLazyCores.testCreateSame-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1072884 INFO (TEST-TestLazyCores.testCreateSame-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.c.SolrCore [[collection6] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestLazyCores_8D5B019F555F506-001/tempDir-002/collection6], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestLazyCores_8D5B019F555F506-001/tempDir-002/./collection6/data/]
[junit4] 2> 1072886 INFO (TEST-TestLazyCores.testCreateSame-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=19, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.20924166895556864]
[junit4] 2> 1072918 INFO (TEST-TestLazyCores.testCreateSame-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1072918 INFO (TEST-TestLazyCores.testCreateSame-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1072919 INFO (TEST-TestLazyCores.testCreateSame-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=354528196, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
[junit4] 2> 1072919 INFO (TEST-TestLazyCores.testCreateSame-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.s.SolrIndexSearcher Opening [Searcher@4610e41e[collection6] main]
[junit4] 2> 1072919 INFO (TEST-TestLazyCores.testCreateSame-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestLazyCores_8D5B019F555F506-001/tempDir-002/collection6/conf
[junit4] 2> 1072920 INFO (TEST-TestLazyCores.testCreateSame-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1072920 INFO (searcherExecutor-5686-thread-1-processing-x:collection3) [ x:collection3] o.a.s.c.SolrCore [collection6] Registered new searcher Searcher@4610e41e[collection6] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1072922 INFO (TEST-TestLazyCores.testCreateSame-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.h.a.CoreAdminOperation core create command schema=schema.xml&dataDir=t12&name=collection2&action=CREATE&config=solrconfig.xml&wt=xml
[junit4] 2> 1072923 WARN (TEST-TestLazyCores.testCreateSame-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.c.CoreContainer Creating a core with existing name is not allowed
[junit4] 2> 1072923 INFO (TEST-TestLazyCores.testCreateSame-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.h.a.CoreAdminOperation core create command schema=schema.xml&dataDir=t14&name=collection4&action=CREATE&config=solrconfig.xml&wt=xml
[junit4] 2> 1072923 WARN (TEST-TestLazyCores.testCreateSame-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.c.CoreContainer Creating a core with existing name is not allowed
[junit4] 2> 1072923 INFO (TEST-TestLazyCores.testCreateSame-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.h.a.CoreAdminOperation core create command schema=schema.xml&dataDir=t15&name=collection5&action=CREATE&config=solrconfig.xml&wt=xml
[junit4] 2> 1072923 WARN (TEST-TestLazyCores.testCreateSame-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.c.CoreContainer Creating a core with existing name is not allowed
[junit4] 2> 1072923 INFO (TEST-TestLazyCores.testCreateSame-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.h.a.CoreAdminOperation core create command schema=schema.xml&dataDir=t16&name=collection6&action=CREATE&config=solrconfig.xml&wt=xml
[junit4] 2> 1072923 WARN (TEST-TestLazyCores.testCreateSame-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.c.CoreContainer Creating a core with existing name is not allowed
[junit4] 2> 1072924 INFO (TEST-TestLazyCores.testCreateSame-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1797861558
[junit4] 2> 1072924 INFO (TEST-TestLazyCores.testCreateSame-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 1072924 INFO (TEST-TestLazyCores.testCreateSame-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 1072925 INFO (TEST-TestLazyCores.testCreateSame-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 1072925 INFO (coreCloseExecutor-5690-thread-1-processing-x:collection3) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@1508a956
[junit4] 2> 1072926 INFO (coreCloseExecutor-5690-thread-2-processing-x:collection3) [ x:collection5] o.a.s.c.SolrCore [collection5] CLOSING SolrCore org.apache.solr.core.SolrCore@76c406cb
[junit4] 2> 1072927 INFO (coreCloseExecutor-5690-thread-1-processing-x:collection3) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=352889174
[junit4] 2> 1072927 INFO (coreCloseExecutor-5690-thread-3-processing-x:collection3) [ x:collection4] o.a.s.c.SolrCore [collection4] CLOSING SolrCore org.apache.solr.core.SolrCore@3c6739e2
[junit4] 2> 1072931 INFO (coreCloseExecutor-5690-thread-4-processing-x:collection3) [ x:collection2] o.a.s.c.SolrCore [collection2] CLOSING SolrCore org.apache.solr.core.SolrCore@32600539
[junit4] 2> 1072931 INFO (coreCloseExecutor-5690-thread-5-processing-x:collection3) [ x:collection6] o.a.s.c.SolrCore [collection6] CLOSING SolrCore org.apache.solr.core.SolrCore@69a28b9d
[junit4] 2> 1072933 INFO (coreCloseExecutor-5690-thread-3-processing-x:collection3) [ x:collection4] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection4, tag=1013397986
[junit4] 2> 1072935 INFO (coreCloseExecutor-5690-thread-2-processing-x:collection3) [ x:collection5] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection5, tag=1992558283
[junit4] 2> 1072936 INFO (coreCloseExecutor-5690-thread-5-processing-x:collection3) [ x:collection6] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection6, tag=1772260253
[junit4] 2> 1072938 INFO (coreCloseExecutor-5690-thread-4-processing-x:collection3) [ x:collection2] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection2, tag=845153593
[junit4] 2> 1072939 INFO (TEST-TestLazyCores.testCreateSame-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.SolrTestCaseJ4 ###Ending testCreateSame
[junit4] 2> 1072940 INFO (TEST-TestLazyCores.testMidUseUnload-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.SolrTestCaseJ4 ###Starting testMidUseUnload
[junit4] 2> 1072946 INFO (TEST-TestLazyCores.testMidUseUnload-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestLazyCores_8D5B019F555F506-001/tempDir-003/solr.xml
[junit4] 2> 1072949 INFO (TEST-TestLazyCores.testMidUseUnload-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@51ef1ee3, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 1072964 INFO (TEST-TestLazyCores.testMidUseUnload-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@51ef1ee3
[junit4] 2> 1072966 INFO (TEST-TestLazyCores.testMidUseUnload-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@51ef1ee3
[junit4] 2> 1072967 INFO (TEST-TestLazyCores.testMidUseUnload-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@51ef1ee3
[junit4] 2> 1072968 INFO (TEST-TestLazyCores.testMidUseUnload-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 1072983 WARN (coreLoadExecutor-5697-thread-3-processing-x:collection3) [ x:collection5] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 1072983 WARN (coreLoadExecutor-5697-thread-1-processing-x:collection3) [ x:collection1] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 1072983 INFO (coreLoadExecutor-5697-thread-3-processing-x:collection3) [ x:collection5] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 1072984 INFO (coreLoadExecutor-5697-thread-1-processing-x:collection3) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 1072987 WARN (coreLoadExecutor-5697-thread-2-processing-x:collection3) [ x:collection2] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 1072987 INFO (coreLoadExecutor-5697-thread-2-processing-x:collection3) [ x:collection2] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 1072990 INFO (coreLoadExecutor-5697-thread-3-processing-x:collection3) [ x:collection5] o.a.s.s.IndexSchema [collection5] Schema name=tiny
[junit4] 2> 1072992 INFO (coreLoadExecutor-5697-thread-1-processing-x:collection3) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=tiny
[junit4] 2> 1072992 INFO (coreLoadExecutor-5697-thread-3-processing-x:collection3) [ x:collection5] o.a.s.s.IndexSchema Loaded schema tiny/1.1 with uniqueid field id
[junit4] 2> 1072992 INFO (coreLoadExecutor-5697-thread-3-processing-x:collection3) [ x:collection5] o.a.s.c.CoreContainer Creating SolrCore 'collection5' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestLazyCores_8D5B019F555F506-001/tempDir-003/./collection5, trusted=true
[junit4] 2> 1072992 INFO (coreLoadExecutor-5697-thread-3-processing-x:collection3) [ x:collection5] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection5' (registry 'solr.core.collection5') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@51ef1ee3
[junit4] 2> 1072992 INFO (coreLoadExecutor-5697-thread-3-processing-x:collection3) [ x:collection5] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1072992 INFO (coreLoadExecutor-5697-thread-3-processing-x:collection3) [ x:collection5] o.a.s.c.SolrCore [[collection5] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestLazyCores_8D5B019F555F506-001/tempDir-003/collection5], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestLazyCores_8D5B019F555F506-001/tempDir-003/./collection5/data/]
[junit4] 2> 1073003 INFO (coreLoadExecutor-5697-thread-2-processing-x:collection3) [ x:collection2] o.a.s.s.IndexSchema [collection2] Schema name=tiny
[junit4] 2> 1073004 INFO (coreLoadExecutor-5697-thread-3-processing-x:collection3) [ x:collection5] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=972245738, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
[junit4] 2> 1073004 INFO (coreLoadExecutor-5697-thread-1-processing-x:collection3) [ x:collection1] o.a.s.s.IndexSchema Loaded schema tiny/1.1 with uniqueid field id
[junit4] 2> 1073004 INFO (coreLoadExecutor-5697-thread-1-processing-x:collection3) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestLazyCores_8D5B019F555F506-001/tempDir-003/./collection1, trusted=true
[junit4] 2> 1073004 INFO (coreLoadExecutor-5697-thread-1-processing-x:collection3) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@51ef1ee3
[junit4] 2> 1073004 INFO (coreLoadExecutor-5697-thread-1-processing-x:collection3) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1073004 INFO (coreLoadExecutor-5697-thread-1-processing-x:collection3) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestLazyCores_8D5B019F555F506-001/tempDir-003/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestLazyCores_8D5B019F555F506-001/tempDir-003/./collection1/data/]
[junit4] 2> 1073005 INFO (coreLoadExecutor-5697-thread-2-processing-x:collection3) [ x:collection2] o.a.s.s.IndexSchema Loaded schema tiny/1.1 with uniqueid field id
[junit4] 2> 1073005 INFO (coreLoadExecutor-5697-thread-2-processing-x:collection3) [ x:collection2] o.a.s.c.CoreContainer Creating SolrCore 'collection2' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestLazyCores_8D5B019F555F506-001/tempDir-003/./collection2, trusted=true
[junit4] 2> 1073005 INFO (coreLoadExecutor-5697-thread-2-processing-x:collection3) [ x:collection2] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection2' (registry 'solr.core.collection2') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@51ef1ee3
[junit4] 2> 1073005 INFO (coreLoadExecutor-5697-thread-2-processing-x:collection3) [ x:collection2] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1073005 INFO (coreLoadExecutor-5697-thread-2-processing-x:collection3) [ x:collection2] o.a.s.c.SolrCore [[collection2] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestLazyCores_8D5B019F555F506-001/tempDir-003/collection2], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestLazyCores_8D5B019F555F506-001/tempDir-003/./collection2/data/]
[junit4] 2> 1073007 INFO (coreLoadExecutor-5697-thread-2-processing-x:collection3) [ x:collection2] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=972245738, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
[junit4] 2> 1073007 INFO (coreLoadExecutor-5697-thread-1-processing-x:collection3) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=972245738, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
[junit4] 2> 1073046 INFO (coreLoadExecutor-5697-thread-2-processing-x:collection3) [ x:collection2] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1073046 INFO (coreLoadExecutor-5697-thread-2-processing-x:collection3) [ x:collection2] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1073047 INFO (coreLoadExecutor-5697-thread-2-processing-x:collection3) [ x:collection2] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=562719452, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
[junit4] 2> 1073047 INFO (coreLoadExecutor-5697-thread-2-processing-x:collection3) [ x:collection2] o.a.s.s.SolrIndexSearcher Opening [Searcher@1df324b6[collection2] main]
[junit4] 2> 1073047 INFO (coreLoadExecutor-5697-thread-2-processing-x:collection3) [ x:collection2] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestLazyCores_8D5B019F555F506-001/tempDir-003/collection2/conf
[junit4] 2> 1073047 INFO (coreLoadExecutor-5697-thread-2-processing-x:collection3) [ x:collection2] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1073048 INFO (searcherExecutor-5700-thread-1-processing-x:collection2) [ x:collection2] o.a.s.c.SolrCore [collection2] Registered new searcher Searcher@1df324b6[collection2] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1073048 INFO (coreLoadExecutor-5697-thread-3-processing-x:collection3) [ x:collection5] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1073048 INFO (coreLoadExecutor-5697-thread-3-processing-x:collection3) [ x:collection5] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1073049 INFO (coreLoadExecutor-5697-thread-3-processing-x:collection3) [ x:collection5] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=562719452, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
[junit4] 2> 1073049 INFO (coreLoadExecutor-5697-thread-3-processing-x:collection3) [ x:collection5] o.a.s.s.SolrIndexSearcher Opening [Searcher@42a8c98[collection5] main]
[junit4] 2> 1073050 INFO (coreLoadExecutor-5697-thread-3-processing-x:collection3) [ x:collection5] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestLazyCores_8D5B019F555F506-001/tempDir-003/collection5/conf
[junit4] 2> 1073050 INFO (coreLoadExecutor-5697-thread-3-processing-x:collection3) [ x:collection5] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1073050 INFO (searcherExecutor-5698-thread-1-processing-x:collection5) [ x:collection5] o.a.s.c.SolrCore [collection5] Registered new searcher Searcher@42a8c98[collection5] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1073051 INFO (coreLoadExecutor-5697-thread-1-processing-x:collection3) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1073051 INFO (coreLoadExecutor-5697-thread-1-processing-x:collection3) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1073052 INFO (coreLoadExecutor-5697-thread-1-processing-x:collection3) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=562719452, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
[junit4] 2> 1073052 INFO (coreLoadExecutor-5697-thread-1-processing-x:collection3) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@72f5c96f[collection1] main]
[junit4] 2> 1073052 INFO (coreLoadExecutor-5697-thread-1-processing-x:collection3) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestLazyCores_8D5B019F555F506-001/tempDir-003/collection1/conf
[junit4] 2> 1073052 INFO (coreLoadExecutor-5697-thread-1-processing-x:collection3) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1073053 INFO (searcherExecutor-5699-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@72f5c96f[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1073054 INFO (TEST-TestLazyCores.testMidUseUnload-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=null
[junit4] 2> 1073056 INFO (TEST-TestLazyCores.testMidUseUnload-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.c.SolrCore Core collection1 is not yet closed, waiting 100 ms before checking again.
[junit4] 2> 1073156 INFO (TEST-TestLazyCores.testMidUseUnload-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.c.SolrCore Core collection1 is not yet closed, waiting 100 ms before checking again.
[junit4] 2> 1073257 INFO (TEST-TestLazyCores.testMidUseUnload-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.c.SolrCore Core collection1 is not yet closed, waiting 100 ms before checking again.
[junit4] 2> 1073357 INFO (TEST-TestLazyCores.testMidUseUnload-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.c.SolrCore Core collection1 is not yet closed, waiting 100 ms before checking again.
[junit4] 2> 1073457 INFO (TEST-TestLazyCores.testMidUseUnload-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.c.SolrCore Core collection1 is not yet closed, waiting 100 ms before checking again.
[junit4] 2> 1073557 INFO (TEST-TestLazyCores.testMidUseUnload-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.c.SolrCore Core collection1 is not yet closed, waiting 100 ms before checking again.
[junit4] 2> 1073657 INFO (TEST-TestLazyCores.testMidUseUnload-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.c.SolrCore Core collection1 is not yet closed, waiting 100 ms before checking again.
[junit4] 2> 1073757 INFO (TEST-TestLazyCores.testMidUseUnload-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.c.SolrCore Core collection1 is not yet closed, waiting 100 ms before checking again.
[junit4] 2> 1073858 INFO (TEST-TestLazyCores.testMidUseUnload-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.c.SolrCore Core collection1 is not yet closed, waiting 100 ms before checking again.
[junit4] 2> 1073958 INFO (TEST-TestLazyCores.testMidUseUnload-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.c.SolrCore Core collection1 is not yet closed, waiting 100 ms before checking again.
[junit4] 2> 1074058 INFO (TEST-TestLazyCores.testMidUseUnload-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.c.SolrCore Core collection1 is not yet closed, waiting 100 ms before checking again.
[junit4] 2> 1074158 INFO (TEST-TestLazyCores.testMidUseUnload-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.c.SolrCore Core collection1 is not yet closed, waiting 100 ms before checking again.
[junit4] 2> 1074258 INFO (TEST-TestLazyCores.testMidUseUnload-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.c.SolrCore Core collection1 is not yet closed, waiting 100 ms before checking again.
[junit4] 2> 1074358 INFO (TEST-TestLazyCores.testMidUseUnload-seed#[8D5B019F555F506]) [ x:collection3] o.a.s.c.SolrCore C
[...truncated too long message...]
java.util.concurrent.FutureTask.run(FutureTask.java:266)
[junit4] > at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:188)
[junit4] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
[junit4] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] > org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.solr.search.SolrIndexSearcher
[junit4] > at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
[junit4] > at org.apache.solr.search.SolrIndexSearcher.<init>(SolrIndexSearcher.java:323)
[junit4] > at org.apache.solr.core.SolrCore.openNewSearcher(SolrCore.java:2047)
[junit4] > at org.apache.solr.core.SolrCore.getSearcher(SolrCore.java:2199)
[junit4] > at org.apache.solr.core.SolrCore.initSearcher(SolrCore.java:1085)
[junit4] > at org.apache.solr.core.SolrCore.<init>(SolrCore.java:974)
[junit4] > at org.apache.solr.core.SolrCore.<init>(SolrCore.java:855)
[junit4] > at org.apache.solr.core.CoreContainer.create(CoreContainer.java:973)
[junit4] > at org.apache.solr.core.CoreContainer.lambda$load$7(CoreContainer.java:605)
[junit4] > at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:197)
[junit4] > at java.util.concurrent.FutureTask.run(FutureTask.java:266)
[junit4] > at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:188)
[junit4] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
[junit4] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] > org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MMapDirectory
[junit4] > at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
[junit4] > at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:347)
[junit4] > at org.apache.solr.core.SolrCore.initSnapshotMetaDataManager(SolrCore.java:490)
[junit4] > at org.apache.solr.core.SolrCore.<init>(SolrCore.java:942)
[junit4] > at org.apache.solr.core.SolrCore.<init>(SolrCore.java:855)
[junit4] > at org.apache.solr.core.CoreContainer.create(CoreContainer.java:973)
[junit4] > at org.apache.solr.core.CoreContainer.lambda$load$7(CoreContainer.java:605)
[junit4] > at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:197)
[junit4] > at java.util.concurrent.FutureTask.run(FutureTask.java:266)
[junit4] > at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:188)
[junit4] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
[junit4] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] > org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MMapDirectory
[junit4] > at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
[junit4] > at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:347)
[junit4] > at org.apache.solr.core.SolrCore.getNewIndexDir(SolrCore.java:361)
[junit4] > at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:721)
[junit4] > at org.apache.solr.core.SolrCore.<init>(SolrCore.java:948)
[junit4] > at org.apache.solr.core.SolrCore.<init>(SolrCore.java:855)
[junit4] > at org.apache.solr.core.CoreContainer.create(CoreContainer.java:973)
[junit4] > at org.apache.solr.core.CoreContainer.lambda$load$7(CoreContainer.java:605)
[junit4] > at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:197)
[junit4] > at java.util.concurrent.FutureTask.run(FutureTask.java:266)
[junit4] > at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:188)
[junit4] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
[junit4] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] > org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.MMapDirectory
[junit4] > at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
[junit4] > at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:347)
[junit4] > at org.apache.solr.update.SolrIndexWriter.create(SolrIndexWriter.java:92)
[junit4] > at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:753)
[junit4] > at org.apache.solr.core.SolrCore.<init>(SolrCore.java:948)
[junit4] > at org.apache.solr.core.SolrCore.<init>(SolrCore.java:855)
[junit4] > at org.apache.solr.core.CoreContainer.create(CoreContainer.java:973)
[junit4] > at org.apache.solr.core.CoreContainer.lambda$load$7(CoreContainer.java:605)
[junit4] > at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:197)
[junit4] > at java.util.concurrent.FutureTask.run(FutureTask.java:266)
[junit4] > at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:188)
[junit4] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
[junit4] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] > org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.solr.core.SolrCore
[junit4] > at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
[junit4] > at org.apache.solr.core.SolrCore.<init>(SolrCore.java:1033)
[junit4] > at org.apache.solr.core.SolrCore.<init>(SolrCore.java:855)
[junit4] > at org.apache.solr.core.CoreContainer.create(CoreContainer.java:973)
[junit4] > at org.apache.solr.core.CoreContainer.lambda$load$7(CoreContainer.java:605)
[junit4] > at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:197)
[junit4] > at java.util.concurrent.FutureTask.run(FutureTask.java:266)
[junit4] > at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:188)
[junit4] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
[junit4] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] > at __randomizedtesting.SeedInfo.seed([8D5B019F555F506]:0)
[junit4] > at org.apache.solr.SolrTestCaseJ4.teardownTestCases(SolrTestCaseJ4.java:303)
[junit4] > at java.lang.Thread.run(Thread.java:748)Throwable #2: com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE scope at org.apache.solr.core.TestLazyCores:
[junit4] > 1) Thread[id=11202, name=searcherExecutor-5719-thread-1, state=WAITING, group=TGRP-TestLazyCores]
[junit4] > at sun.misc.Unsafe.park(Native Method)
[junit4] > at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
[junit4] > at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
[junit4] > at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
[junit4] > at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
[junit4] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] > at __randomizedtesting.SeedInfo.seed([8D5B019F555F506]:0)Throwable #3: com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie threads that couldn't be terminated:
[junit4] > 1) Thread[id=11202, name=searcherExecutor-5719-thread-1, state=WAITING, group=TGRP-TestLazyCores]
[junit4] > at sun.misc.Unsafe.park(Native Method)
[junit4] > at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
[junit4] > at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
[junit4] > at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
[junit4] > at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
[junit4] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] > at __randomizedtesting.SeedInfo.seed([8D5B019F555F506]:0)
[junit4] Completed [368/715 (1!)] on J2 in 51.82s, 9 tests, 1 failure, 2 errors, 1 skipped <<< FAILURES!
[...truncated 44441 lines...]