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 2016/03/02 02:34:56 UTC
[JENKINS] Lucene-Solr-trunk-Windows (64bit/jdk1.8.0_72) - Build #
5659 - Failure!
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Windows/5659/
Java: 64bit/jdk1.8.0_72 -XX:-UseCompressedOops -XX:+UseParallelGC
3 tests failed.
FAILED: junit.framework.TestSuite.org.apache.solr.core.TestLazyCores
Error Message:
ObjectTracker found 4 object(s) that were not released!!! [MockDirectoryWrapper, MockDirectoryWrapper, MDCAwareThreadPoolExecutor, SolrCore]
Stack Trace:
java.lang.AssertionError: ObjectTracker found 4 object(s) that were not released!!! [MockDirectoryWrapper, MockDirectoryWrapper, MDCAwareThreadPoolExecutor, SolrCore]
at __randomizedtesting.SeedInfo.seed([D87562EDCED86797]: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.afterClass(SolrTestCaseJ4.java:238)
at sun.reflect.GeneratedMethodAccessor20.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:1764)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:834)
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:367)
at java.lang.Thread.run(Thread.java:745)
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=4577, name=searcherExecutor-2074-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:745)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE scope at org.apache.solr.core.TestLazyCores:
1) Thread[id=4577, name=searcherExecutor-2074-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:745)
at __randomizedtesting.SeedInfo.seed([D87562EDCED86797]: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=4577, name=searcherExecutor-2074-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:745)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie threads that couldn't be terminated:
1) Thread[id=4577, name=searcherExecutor-2074-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:745)
at __randomizedtesting.SeedInfo.seed([D87562EDCED86797]:0)
Build Log:
[...truncated 10950 lines...]
[junit4] Suite: org.apache.solr.core.TestLazyCores
[junit4] 2> Creating dataDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\init-core-data-001
[junit4] 2> 664093 INFO (SUITE-TestLazyCores-seed#[D87562EDCED86797]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false)
[junit4] 2> 664094 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testLazySearch
[junit4] 2> 664159 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001'
[junit4] 2> 664159 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 664159 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 664159 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ ] o.a.s.c.CoreContainer New CoreContainer 1341239233
[junit4] 2> 664159 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001]
[junit4] 2> 664159 WARN (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ ] o.a.s.c.CoreContainer Couldn't add files from C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\lib to classpath: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\lib
[junit4] 2> 664160 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 600000,connTimeout : 60000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,
[junit4] 2> 664161 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=600000&connTimeout=60000&retry=true
[junit4] 2> 664161 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ ] o.a.s.c.SolrCores Allocating transient cache for 4 transient cores
[junit4] 2> 664164 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 664164 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 664164 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module.
[junit4] 2> 664164 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ ] o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 664165 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection1, config=solrconfig.xml, loadOnStartup=true, schema=schema.xml, configSetProperties=configsetprops.json, transient=false, dataDir=data\}
[junit4] 2> 664165 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection2, config=solrconfig.xml, loadOnStartup=true, schema=schema.xml, configSetProperties=configsetprops.json, transient=true, dataDir=data\}
[junit4] 2> 664166 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection3, config=solrconfig.xml, loadOnStartup=false, schema=schema.xml, configSetProperties=configsetprops.json, transient=on, dataDir=data\}
[junit4] 2> 664166 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection4, config=solrconfig.xml, loadOnStartup=false, schema=schema.xml, configSetProperties=configsetprops.json, transient=false, dataDir=data\}
[junit4] 2> 664167 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection5, config=solrconfig.xml, loadOnStartup=true, schema=schema.xml, configSetProperties=configsetprops.json, transient=false, dataDir=data\}
[junit4] 2> 664167 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection6, config=solrconfig.xml, loadOnStartup=false, schema=schema.xml, configSetProperties=configsetprops.json, transient=true, dataDir=data\}
[junit4] 2> 664167 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection7, config=solrconfig.xml, loadOnStartup=false, schema=schema.xml, configSetProperties=configsetprops.json, transient=true, dataDir=data\}
[junit4] 2> 664168 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection8, config=solrconfig.xml, loadOnStartup=false, schema=schema.xml, configSetProperties=configsetprops.json, transient=true, dataDir=data\}
[junit4] 2> 664168 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection9, config=solrconfig.xml, loadOnStartup=false, schema=schema.xml, configSetProperties=configsetprops.json, transient=true, dataDir=data\}
[junit4] 2> 664169 INFO (coreLoadExecutor-2048-thread-1) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection1'
[junit4] 2> 664169 INFO (coreLoadExecutor-2048-thread-1) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 664169 INFO (coreLoadExecutor-2048-thread-1) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 664169 INFO (coreLoadExecutor-2048-thread-2) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection2'
[junit4] 2> 664169 INFO (coreLoadExecutor-2048-thread-3) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection5'
[junit4] 2> 664169 INFO (coreLoadExecutor-2048-thread-2) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 664169 INFO (coreLoadExecutor-2048-thread-3) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 664169 INFO (coreLoadExecutor-2048-thread-2) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 664169 INFO (coreLoadExecutor-2048-thread-3) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 664200 INFO (coreLoadExecutor-2048-thread-3) [ ] o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 664200 INFO (coreLoadExecutor-2048-thread-1) [ ] o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 664200 INFO (coreLoadExecutor-2048-thread-2) [ ] o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 664208 WARN (coreLoadExecutor-2048-thread-3) [ ] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 664208 WARN (coreLoadExecutor-2048-thread-1) [ ] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 664209 INFO (coreLoadExecutor-2048-thread-3) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0
[junit4] 2> 664209 INFO (coreLoadExecutor-2048-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0
[junit4] 2> 664209 WARN (coreLoadExecutor-2048-thread-2) [ ] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 664210 INFO (coreLoadExecutor-2048-thread-2) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0
[junit4] 2> 664215 INFO (coreLoadExecutor-2048-thread-3) [ ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
[junit4] 2> 664215 INFO (coreLoadExecutor-2048-thread-1) [ ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
[junit4] 2> 664215 INFO (coreLoadExecutor-2048-thread-2) [ ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
[junit4] 2> 664217 INFO (coreLoadExecutor-2048-thread-3) [ ] o.a.s.s.IndexSchema [collection5] Schema name=tiny
[junit4] 2> 664218 INFO (coreLoadExecutor-2048-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=tiny
[junit4] 2> 664221 INFO (coreLoadExecutor-2048-thread-2) [ ] o.a.s.s.IndexSchema [collection2] Schema name=tiny
[junit4] 2> 664222 INFO (coreLoadExecutor-2048-thread-1) [ ] o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 664223 INFO (coreLoadExecutor-2048-thread-2) [ ] o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 664226 INFO (coreLoadExecutor-2048-thread-3) [ ] o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 664229 INFO (coreLoadExecutor-2048-thread-1) [ ] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection1'
[junit4] 2> 664229 INFO (coreLoadExecutor-2048-thread-3) [ ] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection5'
[junit4] 2> 664229 INFO (coreLoadExecutor-2048-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection1
[junit4] 2> 664229 INFO (coreLoadExecutor-2048-thread-3) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection5' using configuration from instancedir C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection5
[junit4] 2> 664229 INFO (coreLoadExecutor-2048-thread-3) [ x:collection5] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 664229 INFO (coreLoadExecutor-2048-thread-1) [ x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 664229 INFO (coreLoadExecutor-2048-thread-3) [ x:collection5] o.a.s.c.SolrCore [[collection5] ] Opening new SolrCore at [C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection5], dataDir=[C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection5\data\]
[junit4] 2> 664229 INFO (coreLoadExecutor-2048-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection1], dataDir=[C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection1\data\]
[junit4] 2> 664229 INFO (coreLoadExecutor-2048-thread-3) [ x:collection5] o.a.s.c.SolrCore JMX monitoring not detected for core: collection5
[junit4] 2> 664229 INFO (coreLoadExecutor-2048-thread-1) [ x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core: collection1
[junit4] 2> 664229 INFO (coreLoadExecutor-2048-thread-3) [ x:collection5] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection5\data\
[junit4] 2> 664229 INFO (coreLoadExecutor-2048-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection1\data\
[junit4] 2> 664229 INFO (coreLoadExecutor-2048-thread-3) [ x:collection5] o.a.s.c.SolrCore New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection5\data\index/
[junit4] 2> 664229 INFO (coreLoadExecutor-2048-thread-1) [ x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection1\data\index/
[junit4] 2> 664229 WARN (coreLoadExecutor-2048-thread-3) [ x:collection5] o.a.s.c.SolrCore [collection5] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection5\data\index' doesn't exist. Creating new index...
[junit4] 2> 664229 WARN (coreLoadExecutor-2048-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection1\data\index' doesn't exist. Creating new index...
[junit4] 2> 664229 INFO (coreLoadExecutor-2048-thread-3) [ x:collection5] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection5\data\index
[junit4] 2> 664229 INFO (coreLoadExecutor-2048-thread-2) [ ] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection2'
[junit4] 2> 664229 INFO (coreLoadExecutor-2048-thread-3) [ x:collection5] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=43, maxMergeAtOnceExplicit=16, maxMergedSegmentMB=62.4345703125, floorSegmentMB=1.3134765625, forceMergeDeletesPctAllowed=10.961904359629022, segmentsPerTier=49.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 664230 INFO (coreLoadExecutor-2048-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection1\data\index
[junit4] 2> 664230 INFO (coreLoadExecutor-2048-thread-3) [ x:collection5] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1c230b39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@181df582),segFN=segments_1,generation=1}
[junit4] 2> 664230 INFO (coreLoadExecutor-2048-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=43, maxMergeAtOnceExplicit=16, maxMergedSegmentMB=62.4345703125, floorSegmentMB=1.3134765625, forceMergeDeletesPctAllowed=10.961904359629022, segmentsPerTier=49.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 664230 INFO (coreLoadExecutor-2048-thread-3) [ x:collection5] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 664230 INFO (coreLoadExecutor-2048-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@71bb0b4e lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@696e241a),segFN=segments_1,generation=1}
[junit4] 2> 664230 INFO (coreLoadExecutor-2048-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 664229 INFO (coreLoadExecutor-2048-thread-2) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection2' using configuration from instancedir C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection2
[junit4] 2> 664230 INFO (coreLoadExecutor-2048-thread-2) [ x:collection2] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 664230 INFO (coreLoadExecutor-2048-thread-2) [ x:collection2] o.a.s.c.SolrCore [[collection2] ] Opening new SolrCore at [C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection2], dataDir=[C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection2\data\]
[junit4] 2> 664230 INFO (coreLoadExecutor-2048-thread-2) [ x:collection2] o.a.s.c.SolrCore JMX monitoring not detected for core: collection2
[junit4] 2> 664231 INFO (coreLoadExecutor-2048-thread-2) [ x:collection2] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection2\data\
[junit4] 2> 664231 INFO (coreLoadExecutor-2048-thread-2) [ x:collection2] o.a.s.c.SolrCore New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection2\data\index/
[junit4] 2> 664231 WARN (coreLoadExecutor-2048-thread-2) [ x:collection2] o.a.s.c.SolrCore [collection2] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection2\data\index' doesn't exist. Creating new index...
[junit4] 2> 664231 INFO (coreLoadExecutor-2048-thread-2) [ x:collection2] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection2\data\index
[junit4] 2> 664231 INFO (coreLoadExecutor-2048-thread-2) [ x:collection2] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=43, maxMergeAtOnceExplicit=16, maxMergedSegmentMB=62.4345703125, floorSegmentMB=1.3134765625, forceMergeDeletesPctAllowed=10.961904359629022, segmentsPerTier=49.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 664231 INFO (coreLoadExecutor-2048-thread-1) [ x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 664232 INFO (coreLoadExecutor-2048-thread-3) [ x:collection5] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 664232 INFO (coreLoadExecutor-2048-thread-2) [ x:collection2] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@108f2517 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@368101d3),segFN=segments_1,generation=1}
[junit4] 2> 664232 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [ x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection1\data\
[junit4] 2> 664233 WARN (OldIndexDirectoryCleanupThreadForCore-collection1) [ x:collection1] o.a.s.c.DirectoryFactory C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection1\data\ does not point to a valid data directory; skipping clean-up of old index directories.
[junit4] 2> 664232 INFO (coreLoadExecutor-2048-thread-2) [ x:collection2] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 664234 INFO (OldIndexDirectoryCleanupThreadForCore-collection5) [ x:collection5] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection5 in C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection5\data\
[junit4] 2> 664236 WARN (OldIndexDirectoryCleanupThreadForCore-collection5) [ x:collection5] o.a.s.c.DirectoryFactory C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection5\data\ does not point to a valid data directory; skipping clean-up of old index directories.
[junit4] 2> 664237 INFO (coreLoadExecutor-2048-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 664237 INFO (coreLoadExecutor-2048-thread-3) [ x:collection5] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 664238 INFO (coreLoadExecutor-2048-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 664238 INFO (coreLoadExecutor-2048-thread-3) [ x:collection5] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 664239 INFO (coreLoadExecutor-2048-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 664239 INFO (coreLoadExecutor-2048-thread-3) [ x:collection5] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 664240 INFO (coreLoadExecutor-2048-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 664240 INFO (coreLoadExecutor-2048-thread-3) [ x:collection5] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 664242 INFO (OldIndexDirectoryCleanupThreadForCore-collection2) [ x:collection2] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection2 in C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection2\data\
[junit4] 2> 664242 INFO (coreLoadExecutor-2048-thread-2) [ x:collection2] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 664242 INFO (coreLoadExecutor-2048-thread-1) [ x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,/update/csv,/sql,/update/json/docs,/admin/luke,/export,/select,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/stream,/schema,/admin/plugins,/admin/logging,/update/json,/admin/ping,/admin/threads,/update,/admin/file
[junit4] 2> 664243 INFO (coreLoadExecutor-2048-thread-2) [ x:collection2] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 664243 INFO (coreLoadExecutor-2048-thread-1) [ x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 664243 INFO (coreLoadExecutor-2048-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 664243 INFO (coreLoadExecutor-2048-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 664243 INFO (coreLoadExecutor-2048-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=31, maxMergeAtOnceExplicit=46, maxMergedSegmentMB=84.9208984375, floorSegmentMB=0.7587890625, forceMergeDeletesPctAllowed=11.538020866612383, segmentsPerTier=37.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.42738863882235645
[junit4] 2> 664243 INFO (coreLoadExecutor-2048-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@71bb0b4e lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@696e241a),segFN=segments_1,generation=1}
[junit4] 2> 664243 INFO (coreLoadExecutor-2048-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 664243 INFO (coreLoadExecutor-2048-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@3af11073[collection1] main]
[junit4] 2> 664243 INFO (coreLoadExecutor-2048-thread-2) [ x:collection2] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 664244 INFO (coreLoadExecutor-2048-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection1\conf
[junit4] 2> 664244 INFO (coreLoadExecutor-2048-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection1\conf}
[junit4] 2> 664244 INFO (coreLoadExecutor-2048-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection1\conf
[junit4] 2> 664244 WARN (OldIndexDirectoryCleanupThreadForCore-collection2) [ x:collection2] o.a.s.c.DirectoryFactory C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection2\data\ does not point to a valid data directory; skipping clean-up of old index directories.
[junit4] 2> 664245 INFO (coreLoadExecutor-2048-thread-2) [ x:collection2] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 664246 INFO (coreLoadExecutor-2048-thread-2) [ x:collection2] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 664246 INFO (coreLoadExecutor-2048-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
[junit4] 2> 664246 INFO (coreLoadExecutor-2048-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 664247 INFO (coreLoadExecutor-2048-thread-1) [ x:collection1] o.a.s.c.CoreContainer registering core: collection1
[junit4] 2> 664247 INFO (coreLoadExecutor-2048-thread-3) [ x:collection5] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,/update/csv,/sql,/update/json/docs,/admin/luke,/export,/select,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/stream,/schema,/admin/plugins,/admin/logging,/update/json,/admin/ping,/admin/threads,/update,/admin/file
[junit4] 2> 664247 INFO (searcherExecutor-2049-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@3af11073[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 664247 INFO (coreLoadExecutor-2048-thread-3) [ x:collection5] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 664247 INFO (coreLoadExecutor-2048-thread-2) [ x:collection2] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,/update/csv,/sql,/update/json/docs,/admin/luke,/export,/select,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/stream,/schema,/admin/plugins,/admin/logging,/update/json,/admin/ping,/admin/threads,/update,/admin/file
[junit4] 2> 664247 INFO (coreLoadExecutor-2048-thread-2) [ x:collection2] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 664248 INFO (coreLoadExecutor-2048-thread-3) [ x:collection5] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 664248 INFO (coreLoadExecutor-2048-thread-3) [ x:collection5] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 664248 INFO (coreLoadExecutor-2048-thread-3) [ x:collection5] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=31, maxMergeAtOnceExplicit=46, maxMergedSegmentMB=84.9208984375, floorSegmentMB=0.7587890625, forceMergeDeletesPctAllowed=11.538020866612383, segmentsPerTier=37.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.42738863882235645
[junit4] 2> 664248 INFO (coreLoadExecutor-2048-thread-2) [ x:collection2] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 664248 INFO (coreLoadExecutor-2048-thread-2) [ x:collection2] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 664248 INFO (coreLoadExecutor-2048-thread-3) [ x:collection5] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1c230b39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@181df582),segFN=segments_1,generation=1}
[junit4] 2> 664248 INFO (coreLoadExecutor-2048-thread-3) [ x:collection5] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 664248 INFO (coreLoadExecutor-2048-thread-2) [ x:collection2] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=31, maxMergeAtOnceExplicit=46, maxMergedSegmentMB=84.9208984375, floorSegmentMB=0.7587890625, forceMergeDeletesPctAllowed=11.538020866612383, segmentsPerTier=37.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.42738863882235645
[junit4] 2> 664248 INFO (coreLoadExecutor-2048-thread-3) [ x:collection5] o.a.s.s.SolrIndexSearcher Opening [Searcher@3d01749[collection5] main]
[junit4] 2> 664248 INFO (coreLoadExecutor-2048-thread-2) [ x:collection2] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@108f2517 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@368101d3),segFN=segments_1,generation=1}
[junit4] 2> 664248 INFO (coreLoadExecutor-2048-thread-2) [ x:collection2] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 664248 INFO (coreLoadExecutor-2048-thread-2) [ x:collection2] o.a.s.s.SolrIndexSearcher Opening [Searcher@25d64aa4[collection2] main]
[junit4] 2> 664248 INFO (coreLoadExecutor-2048-thread-3) [ x:collection5] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection5\conf
[junit4] 2> 664248 INFO (coreLoadExecutor-2048-thread-3) [ x:collection5] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection5\conf}
[junit4] 2> 664248 INFO (coreLoadExecutor-2048-thread-3) [ x:collection5] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection5\conf
[junit4] 2> 664248 INFO (coreLoadExecutor-2048-thread-2) [ x:collection2] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection2\conf
[junit4] 2> 664249 INFO (coreLoadExecutor-2048-thread-2) [ x:collection2] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection2\conf}
[junit4] 2> 664249 INFO (coreLoadExecutor-2048-thread-2) [ x:collection2] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection2\conf
[junit4] 2> 664249 INFO (coreLoadExecutor-2048-thread-3) [ x:collection5] o.a.s.r.RestManager Initializing 0 registered ManagedResources
[junit4] 2> 664249 INFO (coreLoadExecutor-2048-thread-3) [ x:collection5] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 664249 INFO (coreLoadExecutor-2048-thread-2) [ x:collection2] o.a.s.r.RestManager Initializing 0 registered ManagedResources
[junit4] 2> 664249 INFO (coreLoadExecutor-2048-thread-3) [ x:collection5] o.a.s.c.CoreContainer registering core: collection5
[junit4] 2> 664249 INFO (coreLoadExecutor-2048-thread-2) [ x:collection2] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 664249 INFO (searcherExecutor-2051-thread-1-processing-x:collection2) [ x:collection2] o.a.s.c.SolrCore [collection2] Registered new searcher Searcher@25d64aa4[collection2] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 664249 INFO (searcherExecutor-2050-thread-1-processing-x:collection5) [ x:collection5] o.a.s.c.SolrCore [collection5] Registered new searcher Searcher@3d01749[collection5] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 664249 INFO (coreLoadExecutor-2048-thread-2) [ x:collection2] o.a.s.c.SolrCores Opening transient core collection2
[junit4] 2> 664250 INFO (coreLoadExecutor-2048-thread-2) [ x:collection2] o.a.s.c.CoreContainer registering core: collection2
[junit4] 2> 664252 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection4'
[junit4] 2> 664252 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 664252 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 664259 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ ] o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 664264 WARN (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ ] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 664265 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0
[junit4] 2> 664268 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
[junit4] 2> 664270 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ ] o.a.s.s.IndexSchema [collection4] Schema name=tiny
[junit4] 2> 664272 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ ] o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 664273 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ ] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection4'
[junit4] 2> 664273 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection4' using configuration from instancedir C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection4
[junit4] 2> 664274 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 664274 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.c.SolrCore [[collection4] ] Opening new SolrCore at [C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection4], dataDir=[C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection4\data\]
[junit4] 2> 664274 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.c.SolrCore JMX monitoring not detected for core: collection4
[junit4] 2> 664274 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection4\data\
[junit4] 2> 664274 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.c.SolrCore New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection4\data\index/
[junit4] 2> 664274 WARN (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.c.SolrCore [collection4] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection4\data\index' doesn't exist. Creating new index...
[junit4] 2> 664274 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection4\data\index
[junit4] 2> 664275 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=9, maxMergeAtOnceExplicit=8, maxMergedSegmentMB=12.9462890625, floorSegmentMB=2.0517578125, forceMergeDeletesPctAllowed=12.41490150734839, segmentsPerTier=23.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 664276 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@6906b5c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ebc2a6a),segFN=segments_1,generation=1}
[junit4] 2> 664276 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 664276 INFO (OldIndexDirectoryCleanupThreadForCore-collection4) [ x:collection4] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection4 in C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection4\data\
[junit4] 2> 664277 WARN (OldIndexDirectoryCleanupThreadForCore-collection4) [ x:collection4] o.a.s.c.DirectoryFactory C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection4\data\ does not point to a valid data directory; skipping clean-up of old index directories.
[junit4] 2> 664277 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 664278 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 664279 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 664279 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 664280 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 664281 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,/update/csv,/sql,/update/json/docs,/admin/luke,/export,/select,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/stream,/schema,/admin/plugins,/admin/logging,/update/json,/admin/ping,/admin/threads,/update,/admin/file
[junit4] 2> 664281 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 664282 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 664282 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 664282 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@5515022e
[junit4] 2> 664282 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@6906b5c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ebc2a6a),segFN=segments_1,generation=1}
[junit4] 2> 664282 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 664282 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.s.SolrIndexSearcher Opening [Searcher@420d33e4[collection4] main]
[junit4] 2> 664282 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection4\conf
[junit4] 2> 664282 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection4\conf}
[junit4] 2> 664282 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection4\conf
[junit4] 2> 664283 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.r.RestManager Initializing 0 registered ManagedResources
[junit4] 2> 664283 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 664283 INFO (searcherExecutor-2061-thread-1-processing-x:collection4) [ x:collection4] o.a.s.c.SolrCore [collection4] Registered new searcher Searcher@420d33e4[collection4] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 664283 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.c.CoreContainer registering core: collection4
[junit4] 2> 664284 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 664285 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@6906b5c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ebc2a6a),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@6906b5c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ebc2a6a),segFN=segments_2,generation=2}
[junit4] 2> 664285 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.c.SolrDeletionPolicy newest commit generation = 2
[junit4] 2> 664286 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.s.SolrIndexSearcher Opening [Searcher@422fa60e[collection4] main]
[junit4] 2> 664286 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 664286 INFO (searcherExecutor-2061-thread-1-processing-x:collection4) [ x:collection4] o.a.s.c.SolrCore [collection4] Registered new searcher Searcher@422fa60e[collection4] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):c7)))}
[junit4] 2> 664287 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.c.S.Request [collection4] webapp=null path=null params={q={!prefix+f%3Dv_t}hel&wt=xml} hits=2 status=0 QTime=0
[junit4] 2> 664289 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.c.S.Request [collection4] webapp=null path=null params={q={!raw+f%3Dv_t}hello&wt=xml} hits=2 status=0 QTime=0
[junit4] 2> 664289 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.c.S.Request [collection4] webapp=null path=null params={q={!raw+f%3Dv_t}Hello&wt=xml} hits=0 status=0 QTime=0
[junit4] 2> 664289 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.c.S.Request [collection4] webapp=null path=null params={q={!raw+f%3Dv_f}1.5&wt=xml} hits=0 status=0 QTime=0
[junit4] 2> 664290 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.c.S.Request [collection1] webapp=null path=null params={q={!raw+f%3Dv_t}hello&wt=xml} hits=0 status=0 QTime=0
[junit4] 2> 664290 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1341239233
[junit4] 2> 664291 INFO (coreCloseExecutor-2065-thread-1-processing-x:collection4) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@47a2b4a8
[junit4] 2> 664291 INFO (coreCloseExecutor-2065-thread-2-processing-x:collection4) [ x:collection5] o.a.s.c.SolrCore [collection5] CLOSING SolrCore org.apache.solr.core.SolrCore@46cab420
[junit4] 2> 664291 INFO (coreCloseExecutor-2065-thread-1-processing-x:collection4) [ x:collection1] o.a.s.u.DirectUpdateHandler2 closing DirectUpdateHandler2{commits=0,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
[junit4] 2> 664291 INFO (coreCloseExecutor-2065-thread-2-processing-x:collection4) [ x:collection5] o.a.s.u.DirectUpdateHandler2 closing DirectUpdateHandler2{commits=0,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
[junit4] 2> 664291 INFO (coreCloseExecutor-2065-thread-3-processing-x:collection4) [ x:collection4] o.a.s.c.SolrCore [collection4] CLOSING SolrCore org.apache.solr.core.SolrCore@3d3b32
[junit4] 2> 664291 INFO (coreCloseExecutor-2065-thread-3-processing-x:collection4) [ x:collection4] o.a.s.u.DirectUpdateHandler2 closing DirectUpdateHandler2{commits=1,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=7,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
[junit4] 2> 664291 INFO (coreCloseExecutor-2065-thread-4-processing-x:collection4) [ x:collection2] o.a.s.c.SolrCore [collection2] CLOSING SolrCore org.apache.solr.core.SolrCore@c9c71e9
[junit4] 2> 664292 INFO (coreCloseExecutor-2065-thread-2-processing-x:collection4) [ x:collection5] o.a.s.u.SolrCoreState Closing SolrCoreState
[junit4] 2> 664292 INFO (coreCloseExecutor-2065-thread-4-processing-x:collection4) [ x:collection2] o.a.s.u.DirectUpdateHandler2 closing DirectUpdateHandler2{commits=0,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
[junit4] 2> 664292 INFO (coreCloseExecutor-2065-thread-1-processing-x:collection4) [ x:collection1] o.a.s.u.SolrCoreState Closing SolrCoreState
[junit4] 2> 664292 INFO (coreCloseExecutor-2065-thread-3-processing-x:collection4) [ x:collection4] o.a.s.u.SolrCoreState Closing SolrCoreState
[junit4] 2> 664292 INFO (coreCloseExecutor-2065-thread-3-processing-x:collection4) [ x:collection4] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 664292 INFO (coreCloseExecutor-2065-thread-1-processing-x:collection4) [ x:collection1] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 664292 INFO (coreCloseExecutor-2065-thread-1-processing-x:collection4) [ x:collection1] o.a.s.u.DefaultSolrCoreState closing IndexWriter with IndexWriterCloser
[junit4] 2> 664292 INFO (coreCloseExecutor-2065-thread-4-processing-x:collection4) [ x:collection2] o.a.s.u.SolrCoreState Closing SolrCoreState
[junit4] 2> 664292 INFO (coreCloseExecutor-2065-thread-4-processing-x:collection4) [ x:collection2] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 664292 INFO (coreCloseExecutor-2065-thread-2-processing-x:collection4) [ x:collection5] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 664292 INFO (coreCloseExecutor-2065-thread-4-processing-x:collection4) [ x:collection2] o.a.s.u.DefaultSolrCoreState closing IndexWriter with IndexWriterCloser
[junit4] 2> 664293 INFO (coreCloseExecutor-2065-thread-2-processing-x:collection4) [ x:collection5] o.a.s.u.DefaultSolrCoreState closing IndexWriter with IndexWriterCloser
[junit4] 2> 664292 INFO (coreCloseExecutor-2065-thread-3-processing-x:collection4) [ x:collection4] o.a.s.u.DefaultSolrCoreState closing IndexWriter with IndexWriterCloser
[junit4] 2> 664293 INFO (coreCloseExecutor-2065-thread-1-processing-x:collection4) [ x:collection1] o.a.s.c.SolrCore [collection1] Closing main searcher on request.
[junit4] 2> 664293 INFO (coreCloseExecutor-2065-thread-1-processing-x:collection4) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 664293 INFO (coreCloseExecutor-2065-thread-4-processing-x:collection4) [ x:collection2] o.a.s.c.SolrCore [collection2] Closing main searcher on request.
[junit4] 2> 664293 INFO (coreCloseExecutor-2065-thread-1-processing-x:collection4) [ x:collection1] o.a.s.c.CachingDirectoryFactory looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection1\data\index [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection1\data\index;done=false>>]
[junit4] 2> 664294 INFO (coreCloseExecutor-2065-thread-1-processing-x:collection4) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection1\data\index
[junit4] 2> 664294 INFO (coreCloseExecutor-2065-thread-4-processing-x:collection4) [ x:collection2] o.a.s.c.CachingDirectoryFactory Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 664294 INFO (coreCloseExecutor-2065-thread-1-processing-x:collection4) [ x:collection1] o.a.s.c.CachingDirectoryFactory looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection1\data\ [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection1\data\;done=false>>]
[junit4] 2> 664294 INFO (coreCloseExecutor-2065-thread-4-processing-x:collection4) [ x:collection2] o.a.s.c.CachingDirectoryFactory looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection2\data\ [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection2\data\;done=false>>]
[junit4] 2> 664294 INFO (coreCloseExecutor-2065-thread-3-processing-x:collection4) [ x:collection4] o.a.s.c.SolrCore [collection4] Closing main searcher on request.
[junit4] 2> 664294 INFO (coreCloseExecutor-2065-thread-2-processing-x:collection4) [ x:collection5] o.a.s.c.SolrCore [collection5] Closing main searcher on request.
[junit4] 2> 664294 INFO (coreCloseExecutor-2065-thread-4-processing-x:collection4) [ x:collection2] o.a.s.c.CachingDirectoryFactory Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection2\data\
[junit4] 2> 664295 INFO (coreCloseExecutor-2065-thread-2-processing-x:collection4) [ x:collection5] o.a.s.c.CachingDirectoryFactory Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 664295 INFO (coreCloseExecutor-2065-thread-3-processing-x:collection4) [ x:collection4] o.a.s.c.CachingDirectoryFactory Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 664295 INFO (coreCloseExecutor-2065-thread-3-processing-x:collection4) [ x:collection4] o.a.s.c.CachingDirectoryFactory looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection4\data\ [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection4\data\;done=false>>]
[junit4] 2> 664295 INFO (coreCloseExecutor-2065-thread-3-processing-x:collection4) [ x:collection4] o.a.s.c.CachingDirectoryFactory Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection4\data\
[junit4] 2> 664294 INFO (coreCloseExecutor-2065-thread-1-processing-x:collection4) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection1\data\
[junit4] 2> 664295 INFO (coreCloseExecutor-2065-thread-3-processing-x:collection4) [ x:collection4] o.a.s.c.CachingDirectoryFactory looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection4\data\index [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection4\data\index;done=false>>]
[junit4] 2> 664295 INFO (coreCloseExecutor-2065-thread-3-processing-x:collection4) [ x:collection4] o.a.s.c.CachingDirectoryFactory Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection4\data\index
[junit4] 2> 664295 INFO (coreCloseExecutor-2065-thread-2-processing-x:collection4) [ x:collection5] o.a.s.c.CachingDirectoryFactory looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection5\data\index [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection5\data\index;done=false>>]
[junit4] 2> 664295 INFO (coreCloseExecutor-2065-thread-2-processing-x:collection4) [ x:collection5] o.a.s.c.CachingDirectoryFactory Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection5\data\index
[junit4] 2> 664295 INFO (coreCloseExecutor-2065-thread-4-processing-x:collection4) [ x:collection2] o.a.s.c.CachingDirectoryFactory looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection2\data\index [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection2\data\index;done=false>>]
[junit4] 2> 664295 INFO (coreCloseExecutor-2065-thread-4-processing-x:collection4) [ x:collection2] o.a.s.c.CachingDirectoryFactory Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection2\data\index
[junit4] 2> 664295 INFO (coreCloseExecutor-2065-thread-2-processing-x:collection4) [ x:collection5] o.a.s.c.CachingDirectoryFactory looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection5\data\ [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection5\data\;done=false>>]
[junit4] 2> 664295 INFO (coreCloseExecutor-2065-thread-2-processing-x:collection4) [ x:collection5] o.a.s.c.CachingDirectoryFactory Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-001\collection5\data\
[junit4] 2> 664296 INFO (TEST-TestLazyCores.testLazySearch-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.SolrTestCaseJ4 ###Ending testLazySearch
[junit4] 2> 664297 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.SolrTestCaseJ4 ###Starting testCachingLimit
[junit4] 2> 664360 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-002'
[junit4] 2> 664360 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 664360 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 664360 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.c.CoreContainer New CoreContainer 1890529521
[junit4] 2> 664360 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-002]
[junit4] 2> 664361 WARN (TEST-TestLazyCores.testCachingLimit-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.c.CoreContainer Couldn't add files from C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-002\lib to classpath: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-002\lib
[junit4] 2> 664361 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 600000,connTimeout : 60000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,
[junit4] 2> 664363 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=600000&connTimeout=60000&retry=true
[junit4] 2> 664363 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.c.SolrCores Allocating transient cache for 4 transient cores
[junit4] 2> 664363 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 664363 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 664364 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module.
[junit4] 2> 664364 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 664364 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection1, config=solrconfig.xml, loadOnStartup=true, schema=schema.xml, configSetProperties=configsetprops.json, transient=false, dataDir=data\}
[junit4] 2> 664365 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection2, config=solrconfig.xml, loadOnStartup=true, schema=schema.xml, configSetProperties=configsetprops.json, transient=true, dataDir=data\}
[junit4] 2> 664366 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection3, config=solrconfig.xml, loadOnStartup=false, schema=schema.xml, configSetProperties=configsetprops.json, transient=on, dataDir=data\}
[junit4] 2> 664367 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection4, config=solrconfig.xml, loadOnStartup=false, schema=schema.xml, configSetProperties=configsetprops.json, transient=false, dataDir=data\}
[junit4] 2> 664367 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection5, config=solrconfig.xml, loadOnStartup=true, schema=schema.xml, configSetProperties=configsetprops.json, transient=false, dataDir=data\}
[junit4] 2> 664367 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection6, config=solrconfig.xml, loadOnStartup=false, schema=schema.xml, configSetProperties=configsetprops.json, transient=true, dataDir=data\}
[junit4] 2> 664368 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection7, config=solrconfig.xml, loadOnStartup=false, schema=schema.xml, configSetProperties=configsetprops.json, transient=true, dataDir=data\}
[junit4] 2> 664368 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection8, config=solrconfig.xml, loadOnStartup=false, schema=schema.xml, configSetProperties=configsetprops.json, transient=true, dataDir=data\}
[junit4] 2> 664369 INFO (TEST-TestLazyCores.testCachingLimit-seed#[D87562EDCED86797]) [ x:collection4] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection9, config=solrconfig.xml, loadOnStartup=false, schema=schema.xml, configSetProperties=configsetprops.json, transient=true, dataDir=data\}
[junit4] 2> 664369 INFO (coreLoadExecutor-2072-thread-1-processing-x:collection4) [ x:collection4] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-002\collection1'
[junit4] 2> 664370 INFO (coreLoadExecutor-2072-thread-3-processing-x:collection4) [ x:collection4] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-002\collection5'
[junit4] 2> 664370 INFO (coreLoadExecutor-2072-thread-1-processing-x:collection4) [ x:collection4] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 664370 INFO (coreLoadExecutor-2072-thread-1-processing-x:collection4) [ x:collection4] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 664369 INFO (coreLoadExecutor-2072-thread-2-processing-x:collection4) [ x:collection4] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-002\collection2'
[junit4] 2> 664370 INFO (coreLoadExecutor-2072-thread-3-processing-x:collection4) [ x:collection4] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 664370 INFO (coreLoadExecutor-2072-thread-2-processing-x:collection4) [ x:collection4] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 664370 INFO (coreLoadExecutor-2072-thread-2-processing-x:collection4) [ x:collection4] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 664370 INFO (coreLoadExecutor-2072-thread-3-processing-x:collection4) [ x:collection4] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 664393 INFO (coreLoadExecutor-2072-thread-3-processing-x:collection4) [ x:collection4] o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 664393 INFO (coreLoadExecutor-2072-thread-2-processing-x:collection4) [ x:collection4] o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 664395 WARN (coreLoadExecutor-2072-thread-3-processing-x:collection4) [ x:collection4] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 664395 WARN (coreLoadExecutor-2072-thread-2-processing-x:collection4) [ x:collection4] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 664395 INFO (coreLoadExecutor-2072-thread-1-processing-x:collection4) [ x:collection4] o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 664396 INFO (coreLoadExecutor-2072-thread-2-processing-x:collection4) [ x:collection4] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0
[junit4] 2> 664397 WARN (coreLoadExecutor-2072-thread-1-processing-x:collection4) [ x:collection4] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 664398 INFO (coreLoadExecutor-2072-thread-1-processing-x:collection4) [ x:collection4] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0
[junit4] 2> 664400 INFO (coreLoadExecutor-2072-thread-2-processing-x:collection4) [ x:collection4] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
[junit4] 2> 664402 INFO (coreLoadExecutor-2072-thread-1-processing-x:collection4) [ x:collection4] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
[junit4] 2> 664403 INFO (coreLoadExecutor-2072-thread-2-processing-x:collection4) [ x:collection4] o.a.s.s.IndexSchema [collection2] Schema name=tiny
[junit4] 2> 664404 INFO (coreLoadExecutor-2072-thread-1-processing-x:collection4) [ x:collection4] o.a.s.s.IndexSchema [collection1] Schema name=tiny
[junit4] 2> 664395 INFO (coreLoadExecutor-2072-thread-3-processing-x:collection4) [ x:collection4] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0
[junit4] 2> 664411 INFO (coreLoadExecutor-2072-thread-2-processing-x:collection4) [ x:collection4] o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 664411 INFO (coreLoadExecutor-2072-thread-1-processing-x:collection4) [ x:collection4] o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 664417 INFO (coreLoadExecutor-2072-thread-3-processing-x:collection4) [ x:collection4] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
[junit4] 2> 664419 INFO (coreLoadExecutor-2072-thread-1-processing-x:collection4) [ x:collection4] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-002\collection1'
[junit4] 2> 664419 INFO (coreLoadExecutor-2072-thread-1-processing-x:collection4) [ x:collection4] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-002\collection1
[junit4] 2> 664419 INFO (coreLoadExecutor-2072-thread-1-processing-x:collection4) [ x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 664419 INFO (coreLoadExecutor-2072-thread-1-processing-x:collection4) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-002\collection1], dataDir=[C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-002\collection1\data\]
[junit4] 2> 664419 INFO (coreLoadExecutor-2072-thread-1-processing-x:collection4) [ x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core: collection1
[junit4] 2> 664419 INFO (coreLoadExecutor-2072-thread-3-processing-x:collection4) [ x:collection4] o.a.s.s.IndexSchema [collection5] Schema name=tiny
[junit4] 2> 664420 INFO (coreLoadExecutor-2072-thread-1-processing-x:collection4) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-002\collection1\data\
[junit4] 2> 664420 INFO (coreLoadExecutor-2072-thread-1-processing-x:collection4) [ x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-002\collection1\data\index/
[junit4] 2> 664420 WARN (coreLoadExecutor-2072-thread-1-processing-x:collection4) [ x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-002\collection1\data\index' doesn't exist. Creating new index...
[junit4] 2> 664420 INFO (coreLoadExecutor-2072-thread-1-processing-x:collection4) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-002\collection1\data\index
[junit4] 2> 664420 INFO (coreLoadExecutor-2072-thread-1-processing-x:collection4) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=43, maxMergeAtOnceExplicit=16, maxMergedSegmentMB=62.4345703125, floorSegmentMB=1.3134765625, forceMergeDeletesPctAllowed=10.961904359629022, segmentsPerTier=49.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 664420 INFO (coreLoadExecutor-2072-thread-1-processing-x:collection4) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1ffd579d lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@8d057de),segFN=segments_1,generation=1}
[junit4] 2> 664420 INFO (coreLoadExecutor-2072-thread-1-processing-x:collection4) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 664421 INFO (coreLoadExecutor-2072-thread-2-processing-x:collection4) [ x:collection4] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-002\collection2'
[junit4] 2> 664421 INFO (coreLoadExecutor-2072-thread-2-processing-x:collection4) [ x:collection4] o.a.s.c.CoreContainer Creating SolrCore 'collection2' using configuration from instancedir C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-002\collection2
[junit4] 2> 664421 INFO (coreLoadExecutor-2072-thread-3-processing-x:collection4) [ x:collection4] o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 664424 INFO (coreLoadExecutor-2072-thread-2-processing-x:collection4) [ x:collection2] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 664424 INFO (coreLoadExecutor-2072-thread-3-processing-x:collection4) [ x:collection4] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-002\collection5'
[junit4] 2> 664424 INFO (coreLoadExecutor-2072-thread-2-processing-x:collection4) [ x:collection2] o.a.s.c.SolrCore [[collection2] ] Opening new SolrCore at [C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-002\collection2], dataDir=[C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-002\collection2\data\]
[junit4] 2> 664424 INFO (coreLoadExecutor-2072-thread-2-processing-x:collection4) [ x:collection2] o.a.s.c.SolrCore JMX monitoring not detected for core: collection2
[junit4] 2> 664424 INFO (coreLoadExecutor-2072-thread-3-processing-x:collection4) [ x:collection4] o.a.s.c.CoreContainer Creating SolrCore 'collection5' using configuration from instancedir C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-002\collection5
[junit4] 2> 664424 INFO (coreLoadExecutor-2072-thread-2-processing-x:collection4) [ x:collection2] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-002\collection2\data\
[junit4] 2> 664424 INFO (coreLoadExecutor-2072-thread-3-processing-x:collection4) [ x:collection5] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 664424 INFO (coreLoadExecutor-2072-thread-2-processing-x:collection4) [ x:collection2] o.a.s.c.SolrCore New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-002\collection2\data\index/
[junit4] 2> 664424 WARN (coreLoadExecutor-2072-thread-2-processing-x:collection4) [ x:collection2] o.a.s.c.SolrCore [collection2] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-002\collection2\data\index' doesn't exist. Creating new index...
[junit4] 2> 664424 INFO (coreLoadExecutor-2072-thread-3-processing-x:collection4) [ x:collection5] o.a.s.c.SolrCore [[collection5] ] Opening new SolrCore at [C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestLazyCores_D87562EDCED86797-001\tempDir-002\collection5], dataDir=[C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-co
[...truncated too long message...]
[junit4] 2>
[junit4] 2> org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException
[junit4] 2> at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
[junit4] 2> at org.apache.solr.core.SolrCore.<init>(SolrCore.java:857)
[junit4] 2> at org.apache.solr.core.SolrCore.<init>(SolrCore.java:660)
[junit4] 2> at org.apache.solr.core.CoreContainer.create(CoreContainer.java:817)
[junit4] 2> at org.apache.solr.core.CoreContainer.access$000(CoreContainer.java:87)
[junit4] 2> at org.apache.solr.core.CoreContainer$1.call(CoreContainer.java:467)
[junit4] 2> at org.apache.solr.core.CoreContainer$1.call(CoreContainer.java:458)
[junit4] 2> at java.util.concurrent.FutureTask.run(FutureTask.java:266)
[junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1.run(ExecutorUtil.java:231)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2>
[junit4] 2> Mar 02, 2016 1:23:36 AM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 1 leaked thread(s).
[junit4] 2> Mar 02, 2016 1:23:56 AM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> SEVERE: 1 thread leaked from SUITE scope at org.apache.solr.core.TestLazyCores:
[junit4] 2> 1) Thread[id=4577, name=searcherExecutor-2074-thread-1, state=WAITING, group=TGRP-TestLazyCores]
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
[junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
[junit4] 2> at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> Mar 02, 2016 1:23:56 AM com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
[junit4] 2> INFO: Starting to interrupt leaked threads:
[junit4] 2> 1) Thread[id=4577, name=searcherExecutor-2074-thread-1, state=WAITING, group=TGRP-TestLazyCores]
[junit4] 2> Mar 02, 2016 1:23:59 AM com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
[junit4] 2> SEVERE: There are still zombie threads that couldn't be terminated:
[junit4] 2> 1) Thread[id=4577, name=searcherExecutor-2074-thread-1, state=WAITING, group=TGRP-TestLazyCores]
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
[junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
[junit4] 2> at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene60): {v_t=PostingsFormat(name=Asserting), id=PostingsFormat(name=Asserting), v_s=FST50, v_f=PostingsFormat(name=LuceneVarGapDocFreqInterval)}, docValues:{}, maxPointsInLeafNode=1166, maxMBSortInHeap=4.8928572197813915, sim=RandomSimilarity(queryNorm=false,coord=crazy): {}, locale=es-HN, timezone=Antarctica/South_Pole
[junit4] 2> NOTE: Windows 7 6.1 amd64/Oracle Corporation 1.8.0_72 (64-bit)/cpus=3,threads=2,free=153287336,total=346554368
[junit4] 2> NOTE: All tests run in this JVM: [TestMiniSolrCloudClusterSSL, TestSchemaSimilarityResource, TestCloudPivotFacet, TestSort, PathHierarchyTokenizerFactoryTest, BasicDistributedZkTest, DistributedSuggestComponentTest, TestReplicationHandler, SchemaVersionSpecificBehaviorTest, ZkControllerTest, TestUseDocValuesAsStored2, TestPostingsSolrHighlighter, TestRTimerTree, TestTolerantSearch, TestPseudoReturnFields, TestPKIAuthenticationPlugin, HttpPartitionTest, TestSolrDeletionPolicy1, TestDocumentBuilder, ShardRoutingTest, HdfsBasicDistributedZk2Test, UnloadDistributedZkTest, DocumentAnalysisRequestHandlerTest, TestCollationFieldDocValues, TestConfigSetsAPI, TestManagedStopFilterFactory, DistributedFacetPivotLongTailTest, HdfsCollectionsAPIDistributedZkTest, TestFaceting, TestLuceneMatchVersion, PrimUtilsTest, PolyFieldTest, SystemInfoHandlerTest, TestComponentsName, FastVectorHighlighterTest, TestCloudDeleteByQuery, TestSearcherReuse, BlockJoinFacetRandomTest, SortSpecParsingTest, BJQParserTest, RequiredFieldsTest, TestCopyFieldCollectionResource, TestClassicSimilarityFactory, TestLazyCores]
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestLazyCores -Dtests.seed=D87562EDCED86797 -Dtests.slow=true -Dtests.locale=es-HN -Dtests.timezone=Antarctica/South_Pole -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
[junit4] ERROR 0.00s J0 | TestLazyCores (suite) <<<
[junit4] > Throwable #1: java.lang.AssertionError: ObjectTracker found 4 object(s) that were not released!!! [MockDirectoryWrapper, MockDirectoryWrapper, MDCAwareThreadPoolExecutor, SolrCore]
[junit4] > at __randomizedtesting.SeedInfo.seed([D87562EDCED86797]:0)
[junit4] > at org.apache.solr.SolrTestCaseJ4.afterClass(SolrTestCaseJ4.java:238)
[junit4] > at java.lang.Thread.run(Thread.java:745)Throwable #2: com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE scope at org.apache.solr.core.TestLazyCores:
[junit4] > 1) Thread[id=4577, name=searcherExecutor-2074-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:745)
[junit4] > at __randomizedtesting.SeedInfo.seed([D87562EDCED86797]:0)Throwable #3: com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie threads that couldn't be terminated:
[junit4] > 1) Thread[id=4577, name=searcherExecutor-2074-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:745)
[junit4] > at __randomizedtesting.SeedInfo.seed([D87562EDCED86797]:0)
[junit4] Completed [132/582 (1!)] on J0 in 153.73s, 8 tests, 1 failure, 2 errors <<< FAILURES!
[...truncated 1436 lines...]
BUILD FAILED
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:740: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:684: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:59: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build.xml:233: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\common-build.xml:524: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:1457: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:1014: There were test failures: 582 suites (8 ignored), 2355 tests, 3 suite-level errors, 1560 ignored (67 assumptions) [seed: D87562EDCED86797]
Total time: 45 minutes 52 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
[WARNINGS] Skipping publisher since build result is FAILURE
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any