You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2016/04/13 06:36:44 UTC
[JENKINS] Lucene-Solr-Tests-master - Build # 1075 - Still Failing
Build: https://builds.apache.org/job/Lucene-Solr-Tests-master/1075/
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, SolrCore, MDCAwareThreadPoolExecutor]
Stack Trace:
java.lang.AssertionError: ObjectTracker found 4 object(s) that were not released!!! [MockDirectoryWrapper, MockDirectoryWrapper, SolrCore, MDCAwareThreadPoolExecutor]
at __randomizedtesting.SeedInfo.seed([952118D85F046B29]: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:255)
at sun.reflect.GeneratedMethodAccessor14.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=2181, name=searcherExecutor-1258-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=2181, name=searcherExecutor-1258-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([952118D85F046B29]: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=2181, name=searcherExecutor-1258-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=2181, name=searcherExecutor-1258-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([952118D85F046B29]:0)
Build Log:
[...truncated 10954 lines...]
[junit4] Suite: org.apache.solr.core.TestLazyCores
[junit4] 2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/init-core-data-001
[junit4] 2> 429220 INFO (SUITE-TestLazyCores-seed#[952118D85F046B29]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false)
[junit4] 2> 429227 INFO (TEST-TestLazyCores.testRace-seed#[952118D85F046B29]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testRace
[junit4] 2> 429236 INFO (TEST-TestLazyCores.testRace-seed#[952118D85F046B29]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001'
[junit4] 2> 429236 INFO (TEST-TestLazyCores.testRace-seed#[952118D85F046B29]) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 429236 INFO (TEST-TestLazyCores.testRace-seed#[952118D85F046B29]) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 429237 INFO (TEST-TestLazyCores.testRace-seed#[952118D85F046B29]) [ ] o.a.s.c.CoreContainer New CoreContainer 233357032
[junit4] 2> 429237 INFO (TEST-TestLazyCores.testRace-seed#[952118D85F046B29]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001]
[junit4] 2> 429237 WARN (TEST-TestLazyCores.testRace-seed#[952118D85F046B29]) [ ] o.a.s.c.CoreContainer Couldn't add files from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/lib to classpath: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/lib
[junit4] 2> 429238 INFO (TEST-TestLazyCores.testRace-seed#[952118D85F046B29]) [ ] 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,
[junit4] 2> 429254 INFO (TEST-TestLazyCores.testRace-seed#[952118D85F046B29]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
[junit4] 2> 429263 INFO (TEST-TestLazyCores.testRace-seed#[952118D85F046B29]) [ ] o.a.s.c.SolrCores Allocating transient cache for 4 transient cores
[junit4] 2> 429265 INFO (TEST-TestLazyCores.testRace-seed#[952118D85F046B29]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 429265 INFO (TEST-TestLazyCores.testRace-seed#[952118D85F046B29]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 429266 INFO (TEST-TestLazyCores.testRace-seed#[952118D85F046B29]) [ ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module.
[junit4] 2> 429266 INFO (TEST-TestLazyCores.testRace-seed#[952118D85F046B29]) [ ] o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 429266 INFO (TEST-TestLazyCores.testRace-seed#[952118D85F046B29]) [ ] 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> 429266 INFO (TEST-TestLazyCores.testRace-seed#[952118D85F046B29]) [ ] 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> 429266 INFO (TEST-TestLazyCores.testRace-seed#[952118D85F046B29]) [ ] 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> 429267 INFO (TEST-TestLazyCores.testRace-seed#[952118D85F046B29]) [ ] 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> 429267 INFO (TEST-TestLazyCores.testRace-seed#[952118D85F046B29]) [ ] 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> 429267 INFO (TEST-TestLazyCores.testRace-seed#[952118D85F046B29]) [ ] 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> 429275 INFO (TEST-TestLazyCores.testRace-seed#[952118D85F046B29]) [ ] 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> 429275 INFO (TEST-TestLazyCores.testRace-seed#[952118D85F046B29]) [ ] 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> 429275 INFO (TEST-TestLazyCores.testRace-seed#[952118D85F046B29]) [ ] 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> 429293 INFO (coreLoadExecutor-1061-thread-1) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection1'
[junit4] 2> 429327 INFO (coreLoadExecutor-1061-thread-1) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 429327 INFO (coreLoadExecutor-1061-thread-1) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 429328 INFO (coreLoadExecutor-1061-thread-3) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection5'
[junit4] 2> 429328 INFO (coreLoadExecutor-1061-thread-3) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 429328 INFO (coreLoadExecutor-1061-thread-3) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 429323 INFO (coreLoadExecutor-1061-thread-2) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection2'
[junit4] 2> 429329 INFO (coreLoadExecutor-1061-thread-2) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 429329 INFO (coreLoadExecutor-1061-thread-2) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 429349 INFO (coreLoadExecutor-1061-thread-3) [ ] o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 429350 WARN (coreLoadExecutor-1061-thread-3) [ ] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 429351 INFO (coreLoadExecutor-1061-thread-3) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 429355 INFO (coreLoadExecutor-1061-thread-2) [ ] o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 429357 WARN (coreLoadExecutor-1061-thread-2) [ ] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 429379 INFO (coreLoadExecutor-1061-thread-2) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 429384 INFO (coreLoadExecutor-1061-thread-1) [ ] o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 429386 WARN (coreLoadExecutor-1061-thread-1) [ ] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 429386 INFO (coreLoadExecutor-1061-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 429393 INFO (coreLoadExecutor-1061-thread-3) [ ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
[junit4] 2> 429394 INFO (coreLoadExecutor-1061-thread-2) [ ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
[junit4] 2> 429596 INFO (coreLoadExecutor-1061-thread-2) [ ] o.a.s.s.IndexSchema [collection2] Schema name=tiny
[junit4] 2> 429597 INFO (coreLoadExecutor-1061-thread-3) [ ] o.a.s.s.IndexSchema [collection5] Schema name=tiny
[junit4] 2> 429604 INFO (coreLoadExecutor-1061-thread-2) [ ] o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 429605 INFO (coreLoadExecutor-1061-thread-2) [ ] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection2'
[junit4] 2> 429605 INFO (coreLoadExecutor-1061-thread-2) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection2' using configuration from instancedir /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection2
[junit4] 2> 429605 INFO (coreLoadExecutor-1061-thread-2) [ x:collection2] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 429605 INFO (coreLoadExecutor-1061-thread-2) [ x:collection2] o.a.s.c.SolrCore [[collection2] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection2], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection2/data/]
[junit4] 2> 429605 INFO (coreLoadExecutor-1061-thread-2) [ x:collection2] o.a.s.c.SolrCore JMX monitoring not detected for core: collection2
[junit4] 2> 429606 INFO (coreLoadExecutor-1061-thread-2) [ x:collection2] o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection2/data
[junit4] 2> 429606 INFO (coreLoadExecutor-1061-thread-2) [ x:collection2] o.a.s.c.SolrCore New index directory detected: old=null new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection2/data/index/
[junit4] 2> 429606 WARN (coreLoadExecutor-1061-thread-2) [ x:collection2] o.a.s.c.SolrCore [collection2] Solr index directory '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection2/data/index' doesn't exist. Creating new index...
[junit4] 2> 429606 INFO (coreLoadExecutor-1061-thread-2) [ x:collection2] o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection2/data/index
[junit4] 2> 429606 INFO (coreLoadExecutor-1061-thread-2) [ x:collection2] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=44, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 429611 INFO (coreLoadExecutor-1061-thread-2) [ x:collection2] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@4fe75b5b lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@54ff5cf9),segFN=segments_1,generation=1}
[junit4] 2> 429611 INFO (coreLoadExecutor-1061-thread-2) [ x:collection2] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 429612 INFO (coreLoadExecutor-1061-thread-3) [ ] o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 429612 INFO (coreLoadExecutor-1061-thread-3) [ ] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection5'
[junit4] 2> 429613 INFO (coreLoadExecutor-1061-thread-3) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection5' using configuration from instancedir /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection5
[junit4] 2> 429613 INFO (coreLoadExecutor-1061-thread-3) [ x:collection5] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 429613 INFO (coreLoadExecutor-1061-thread-3) [ x:collection5] o.a.s.c.SolrCore [[collection5] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection5], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection5/data/]
[junit4] 2> 429613 INFO (coreLoadExecutor-1061-thread-3) [ x:collection5] o.a.s.c.SolrCore JMX monitoring not detected for core: collection5
[junit4] 2> 429613 INFO (coreLoadExecutor-1061-thread-3) [ x:collection5] o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection5/data
[junit4] 2> 429613 INFO (coreLoadExecutor-1061-thread-3) [ x:collection5] o.a.s.c.SolrCore New index directory detected: old=null new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection5/data/index/
[junit4] 2> 429613 WARN (coreLoadExecutor-1061-thread-3) [ x:collection5] o.a.s.c.SolrCore [collection5] Solr index directory '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection5/data/index' doesn't exist. Creating new index...
[junit4] 2> 429679 INFO (coreLoadExecutor-1061-thread-3) [ x:collection5] o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection5/data/index
[junit4] 2> 429675 INFO (coreLoadExecutor-1061-thread-2) [ x:collection2] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 429681 INFO (coreLoadExecutor-1061-thread-2) [ x:collection2] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 429681 INFO (coreLoadExecutor-1061-thread-3) [ x:collection5] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=44, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 429683 INFO (coreLoadExecutor-1061-thread-1) [ ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
[junit4] 2> 429684 INFO (coreLoadExecutor-1061-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=tiny
[junit4] 2> 429686 INFO (OldIndexDirectoryCleanupThreadForCore-collection2) [ x:collection2] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection2 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection2/data/
[junit4] 2> 429686 WARN (OldIndexDirectoryCleanupThreadForCore-collection2) [ x:collection2] o.a.s.c.DirectoryFactory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection2/data/ does not point to a valid data directory; skipping clean-up of old index directories.
[junit4] 2> 429692 INFO (coreLoadExecutor-1061-thread-2) [ x:collection2] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 429692 INFO (coreLoadExecutor-1061-thread-2) [ x:collection2] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 429693 INFO (coreLoadExecutor-1061-thread-3) [ x:collection5] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@72b9d2b0 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5f8b02ca),segFN=segments_1,generation=1}
[junit4] 2> 429693 INFO (coreLoadExecutor-1061-thread-3) [ x:collection5] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 429693 INFO (coreLoadExecutor-1061-thread-2) [ x:collection2] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 429693 INFO (coreLoadExecutor-1061-thread-1) [ ] o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 429694 INFO (coreLoadExecutor-1061-thread-1) [ ] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection1'
[junit4] 2> 429694 INFO (coreLoadExecutor-1061-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> 429694 INFO (coreLoadExecutor-1061-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection1
[junit4] 2> 429694 INFO (coreLoadExecutor-1061-thread-2) [ x:collection2] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 429694 INFO (coreLoadExecutor-1061-thread-1) [ x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 429694 INFO (coreLoadExecutor-1061-thread-3) [ x:collection5] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 429694 INFO (coreLoadExecutor-1061-thread-2) [ x:collection2] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 429694 INFO (coreLoadExecutor-1061-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection1], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection1/data/]
[junit4] 2> 429694 INFO (coreLoadExecutor-1061-thread-1) [ x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core: collection1
[junit4] 2> 429695 INFO (coreLoadExecutor-1061-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection1/data
[junit4] 2> 429695 INFO (coreLoadExecutor-1061-thread-1) [ x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection1/data/index/
[junit4] 2> 429695 WARN (coreLoadExecutor-1061-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection1/data/index' doesn't exist. Creating new index...
[junit4] 2> 429695 INFO (coreLoadExecutor-1061-thread-3) [ x:collection5] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 429695 INFO (coreLoadExecutor-1061-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection1/data/index
[junit4] 2> 429695 INFO (coreLoadExecutor-1061-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=44, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 429695 INFO (coreLoadExecutor-1061-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@28b5bf2e lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5d3adb87),segFN=segments_1,generation=1}
[junit4] 2> 429695 INFO (coreLoadExecutor-1061-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 429695 INFO (coreLoadExecutor-1061-thread-3) [ x:collection5] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 429695 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [ x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection1/data/
[junit4] 2> 429696 WARN (OldIndexDirectoryCleanupThreadForCore-collection1) [ x:collection1] o.a.s.c.DirectoryFactory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection1/data/ does not point to a valid data directory; skipping clean-up of old index directories.
[junit4] 2> 429694 INFO (OldIndexDirectoryCleanupThreadForCore-collection5) [ x:collection5] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection5 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection5/data/
[junit4] 2> 429696 INFO (coreLoadExecutor-1061-thread-1) [ x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 429697 WARN (OldIndexDirectoryCleanupThreadForCore-collection5) [ x:collection5] o.a.s.c.DirectoryFactory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection5/data/ does not point to a valid data directory; skipping clean-up of old index directories.
[junit4] 2> 429696 INFO (coreLoadExecutor-1061-thread-2) [ x:collection2] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 429696 INFO (coreLoadExecutor-1061-thread-3) [ x:collection5] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 429697 INFO (coreLoadExecutor-1061-thread-2) [ x:collection2] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=47, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.39480723919896754]
[junit4] 2> 429697 INFO (coreLoadExecutor-1061-thread-2) [ x:collection2] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@4fe75b5b lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@54ff5cf9),segFN=segments_1,generation=1}
[junit4] 2> 429697 INFO (coreLoadExecutor-1061-thread-2) [ x:collection2] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 429697 INFO (coreLoadExecutor-1061-thread-2) [ x:collection2] o.a.s.s.SolrIndexSearcher Opening [Searcher@41d452a[collection2] main]
[junit4] 2> 429697 INFO (coreLoadExecutor-1061-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 429698 INFO (coreLoadExecutor-1061-thread-3) [ x:collection5] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 429698 INFO (coreLoadExecutor-1061-thread-2) [ x:collection2] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection2/conf
[junit4] 2> 429698 INFO (coreLoadExecutor-1061-thread-2) [ x:collection2] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection2/conf}
[junit4] 2> 429698 INFO (coreLoadExecutor-1061-thread-2) [ x:collection2] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using file:dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection2/conf
[junit4] 2> 429698 INFO (coreLoadExecutor-1061-thread-2) [ x:collection2] o.a.s.r.RestManager Initializing 0 registered ManagedResources
[junit4] 2> 429698 INFO (coreLoadExecutor-1061-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 429698 INFO (coreLoadExecutor-1061-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> 429698 INFO (coreLoadExecutor-1061-thread-3) [ x:collection5] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 429699 INFO (coreLoadExecutor-1061-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 429699 INFO (coreLoadExecutor-1061-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 429700 INFO (coreLoadExecutor-1061-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> 429700 INFO (coreLoadExecutor-1061-thread-1) [ x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 429701 INFO (coreLoadExecutor-1061-thread-2) [ x:collection2] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 429701 INFO (searcherExecutor-1062-thread-1-processing-x:collection2) [ x:collection2] o.a.s.c.SolrCore [collection2] Registered new searcher Searcher@41d452a[collection2] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 429701 INFO (coreLoadExecutor-1061-thread-2) [ x:collection2] o.a.s.c.SolrCores Opening transient core collection2
[junit4] 2> 429701 INFO (coreLoadExecutor-1061-thread-2) [ x:collection2] o.a.s.c.CoreContainer registering core: collection2
[junit4] 2> 429702 INFO (coreLoadExecutor-1061-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 429702 INFO (coreLoadExecutor-1061-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 429702 INFO (coreLoadExecutor-1061-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=47, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.39480723919896754]
[junit4] 2> 429702 INFO (coreLoadExecutor-1061-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@28b5bf2e lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5d3adb87),segFN=segments_1,generation=1}
[junit4] 2> 429702 INFO (coreLoadExecutor-1061-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 429702 INFO (coreLoadExecutor-1061-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@14a7105f[collection1] main]
[junit4] 2> 429702 INFO (coreLoadExecutor-1061-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection1/conf
[junit4] 2> 429702 INFO (coreLoadExecutor-1061-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection1/conf}
[junit4] 2> 429702 INFO (coreLoadExecutor-1061-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using file:dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection1/conf
[junit4] 2> 429702 INFO (coreLoadExecutor-1061-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
[junit4] 2> 429702 INFO (coreLoadExecutor-1061-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 429703 INFO (coreLoadExecutor-1061-thread-1) [ x:collection1] o.a.s.c.CoreContainer registering core: collection1
[junit4] 2> 429704 INFO (coreLoadExecutor-1061-thread-3) [ x:collection5] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 429704 INFO (coreLoadExecutor-1061-thread-3) [ x:collection5] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 429704 INFO (coreLoadExecutor-1061-thread-3) [ x:collection5] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=47, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.39480723919896754]
[junit4] 2> 429704 INFO (coreLoadExecutor-1061-thread-3) [ x:collection5] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@72b9d2b0 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5f8b02ca),segFN=segments_1,generation=1}
[junit4] 2> 429704 INFO (coreLoadExecutor-1061-thread-3) [ x:collection5] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 429704 INFO (coreLoadExecutor-1061-thread-3) [ x:collection5] o.a.s.s.SolrIndexSearcher Opening [Searcher@9c35f31[collection5] main]
[junit4] 2> 429704 INFO (coreLoadExecutor-1061-thread-3) [ x:collection5] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection5/conf
[junit4] 2> 429704 INFO (coreLoadExecutor-1061-thread-3) [ x:collection5] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection5/conf}
[junit4] 2> 429704 INFO (coreLoadExecutor-1061-thread-3) [ x:collection5] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using file:dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection5/conf
[junit4] 2> 429705 INFO (coreLoadExecutor-1061-thread-3) [ x:collection5] o.a.s.r.RestManager Initializing 0 registered ManagedResources
[junit4] 2> 429705 INFO (coreLoadExecutor-1061-thread-3) [ x:collection5] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 429705 INFO (searcherExecutor-1063-thread-1-processing-x:collection5) [ x:collection5] o.a.s.c.SolrCore [collection5] Registered new searcher Searcher@9c35f31[collection5] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 429705 INFO (coreLoadExecutor-1061-thread-3) [ x:collection5] o.a.s.c.CoreContainer registering core: collection5
[junit4] 2> 429705 INFO (searcherExecutor-1065-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@14a7105f[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 429706 INFO (Thread-770) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection3'
[junit4] 2> 429706 INFO (Thread-770) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 429706 INFO (Thread-770) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 429710 INFO (Thread-770) [ ] o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 429711 WARN (Thread-770) [ ] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 429712 INFO (Thread-770) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 429716 INFO (Thread-770) [ ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
[junit4] 2> 429717 INFO (Thread-770) [ ] o.a.s.s.IndexSchema [collection3] Schema name=tiny
[junit4] 2> 429719 INFO (Thread-770) [ ] o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 429720 INFO (Thread-770) [ ] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection3'
[junit4] 2> 429720 INFO (Thread-770) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection3' using configuration from instancedir /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection3
[junit4] 2> 429720 INFO (Thread-770) [ x:collection3] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 429720 INFO (Thread-770) [ x:collection3] o.a.s.c.SolrCore [[collection3] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection3], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection3/data/]
[junit4] 2> 429720 INFO (Thread-770) [ x:collection3] o.a.s.c.SolrCore JMX monitoring not detected for core: collection3
[junit4] 2> 429721 INFO (Thread-770) [ x:collection3] o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection3/data
[junit4] 2> 429721 INFO (Thread-770) [ x:collection3] o.a.s.c.SolrCore New index directory detected: old=null new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection3/data/index/
[junit4] 2> 429721 WARN (Thread-770) [ x:collection3] o.a.s.c.SolrCore [collection3] Solr index directory '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection3/data/index' doesn't exist. Creating new index...
[junit4] 2> 429721 INFO (Thread-770) [ x:collection3] o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection3/data/index
[junit4] 2> 429721 INFO (Thread-770) [ x:collection3] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=44, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 429721 INFO (Thread-770) [ x:collection3] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@476c82c1 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@67a18a59),segFN=segments_1,generation=1}
[junit4] 2> 429721 INFO (Thread-770) [ x:collection3] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 429722 INFO (OldIndexDirectoryCleanupThreadForCore-collection3) [ x:collection3] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection3 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection3/data/
[junit4] 2> 429722 WARN (OldIndexDirectoryCleanupThreadForCore-collection3) [ x:collection3] o.a.s.c.DirectoryFactory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection3/data/ does not point to a valid data directory; skipping clean-up of old index directories.
[junit4] 2> 429723 INFO (Thread-770) [ x:collection3] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 429724 INFO (Thread-770) [ x:collection3] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 429724 INFO (Thread-770) [ x:collection3] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 429725 INFO (Thread-770) [ x:collection3] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 429725 INFO (Thread-770) [ x:collection3] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 429726 INFO (Thread-770) [ x:collection3] 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> 429726 INFO (Thread-770) [ x:collection3] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 429726 INFO (Thread-770) [ x:collection3] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 429726 INFO (Thread-770) [ x:collection3] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 429726 INFO (Thread-770) [ x:collection3] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=47, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.39480723919896754]
[junit4] 2> 429726 INFO (Thread-770) [ x:collection3] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@476c82c1 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@67a18a59),segFN=segments_1,generation=1}
[junit4] 2> 429726 INFO (Thread-770) [ x:collection3] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 429727 INFO (Thread-770) [ x:collection3] o.a.s.s.SolrIndexSearcher Opening [Searcher@52395a1c[collection3] main]
[junit4] 2> 429727 INFO (Thread-770) [ x:collection3] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection3/conf
[junit4] 2> 429727 INFO (Thread-770) [ x:collection3] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection3/conf}
[junit4] 2> 429727 INFO (Thread-770) [ x:collection3] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using file:dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection3/conf
[junit4] 2> 429727 INFO (Thread-770) [ x:collection3] o.a.s.r.RestManager Initializing 0 registered ManagedResources
[junit4] 2> 429727 INFO (Thread-770) [ x:collection3] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 429727 INFO (searcherExecutor-1074-thread-1-processing-x:collection3) [ x:collection3] o.a.s.c.SolrCore [collection3] Registered new searcher Searcher@52395a1c[collection3] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 429727 INFO (Thread-770) [ x:collection3] o.a.s.c.SolrCores Opening transient core collection3
[junit4] 2> 429727 INFO (Thread-770) [ x:collection3] o.a.s.c.CoreContainer registering core: collection3
[junit4] 2> 429730 INFO (TEST-TestLazyCores.testRace-seed#[952118D85F046B29]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=233357032
[junit4] 2> 429730 INFO (coreCloseExecutor-1078-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@414d9b2e
[junit4] 2> 429730 INFO (coreCloseExecutor-1078-thread-1) [ 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> 429730 INFO (coreCloseExecutor-1078-thread-1) [ x:collection1] o.a.s.u.SolrCoreState Closing SolrCoreState
[junit4] 2> 429730 INFO (coreCloseExecutor-1078-thread-1) [ x:collection1] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 429730 INFO (coreCloseExecutor-1078-thread-1) [ x:collection1] o.a.s.u.DefaultSolrCoreState closing IndexWriter with IndexWriterCloser
[junit4] 2> 429731 INFO (coreCloseExecutor-1078-thread-3) [ x:collection2] o.a.s.c.SolrCore [collection2] CLOSING SolrCore org.apache.solr.core.SolrCore@650ee0ca
[junit4] 2> 429731 INFO (coreCloseExecutor-1078-thread-3) [ 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> 429731 INFO (coreCloseExecutor-1078-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] Closing main searcher on request.
[junit4] 2> 429732 INFO (coreCloseExecutor-1078-thread-3) [ x:collection2] o.a.s.u.SolrCoreState Closing SolrCoreState
[junit4] 2> 429732 INFO (coreCloseExecutor-1078-thread-3) [ x:collection2] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 429732 INFO (coreCloseExecutor-1078-thread-3) [ x:collection2] o.a.s.u.DefaultSolrCoreState closing IndexWriter with IndexWriterCloser
[junit4] 2> 429733 INFO (coreCloseExecutor-1078-thread-2) [ x:collection5] o.a.s.c.SolrCore [collection5] CLOSING SolrCore org.apache.solr.core.SolrCore@529222b
[junit4] 2> 429733 INFO (coreCloseExecutor-1078-thread-2) [ 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> 429733 INFO (coreCloseExecutor-1078-thread-2) [ x:collection5] o.a.s.u.SolrCoreState Closing SolrCoreState
[junit4] 2> 429733 INFO (coreCloseExecutor-1078-thread-2) [ x:collection5] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 429733 INFO (coreCloseExecutor-1078-thread-2) [ x:collection5] o.a.s.u.DefaultSolrCoreState closing IndexWriter with IndexWriterCloser
[junit4] 2> 429734 INFO (coreCloseExecutor-1078-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 429734 INFO (coreCloseExecutor-1078-thread-3) [ x:collection2] o.a.s.c.SolrCore [collection2] Closing main searcher on request.
[junit4] 2> 429735 INFO (coreCloseExecutor-1078-thread-3) [ x:collection2] o.a.s.c.CachingDirectoryFactory Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 429735 INFO (coreCloseExecutor-1078-thread-3) [ x:collection2] o.a.s.c.CachingDirectoryFactory looking to close /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection2/data [CachedDir<<refCount=0;path=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection2/data;done=false>>]
[junit4] 2> 429735 INFO (coreCloseExecutor-1078-thread-3) [ x:collection2] o.a.s.c.CachingDirectoryFactory Closing directory, CoreContainer#isShutdown=true
[junit4] 2> 429735 INFO (coreCloseExecutor-1078-thread-3) [ x:collection2] o.a.s.c.CachingDirectoryFactory Closing directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection2/data
[junit4] 2> 429735 INFO (coreCloseExecutor-1078-thread-3) [ x:collection2] o.a.s.c.CachingDirectoryFactory looking to close /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection2/data/index [CachedDir<<refCount=0;path=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection2/data/index;done=false>>]
[junit4] 2> 429735 INFO (coreCloseExecutor-1078-thread-3) [ x:collection2] o.a.s.c.CachingDirectoryFactory Closing directory, CoreContainer#isShutdown=true
[junit4] 2> 429736 INFO (coreCloseExecutor-1078-thread-3) [ x:collection2] o.a.s.c.CachingDirectoryFactory Closing directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection2/data/index
[junit4] 2> 429735 INFO (coreCloseExecutor-1078-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory looking to close /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection1/data/index [CachedDir<<refCount=0;path=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection1/data/index;done=false>>]
[junit4] 2> 429735 INFO (coreCloseExecutor-1078-thread-2) [ x:collection5] o.a.s.c.SolrCore [collection5] Closing main searcher on request.
[junit4] 2> 429736 INFO (coreCloseExecutor-1078-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory, CoreContainer#isShutdown=true
[junit4] 2> 429736 INFO (coreCloseExecutor-1078-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection1/data/index
[junit4] 2> 429736 INFO (coreCloseExecutor-1078-thread-2) [ x:collection5] o.a.s.c.CachingDirectoryFactory Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 429736 INFO (coreCloseExecutor-1078-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory looking to close /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection1/data [CachedDir<<refCount=0;path=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection1/data;done=false>>]
[junit4] 2> 429736 INFO (coreCloseExecutor-1078-thread-2) [ x:collection5] o.a.s.c.CachingDirectoryFactory looking to close /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection5/data [CachedDir<<refCount=0;path=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection5/data;done=false>>]
[junit4] 2> 429736 INFO (coreCloseExecutor-1078-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory, CoreContainer#isShutdown=true
[junit4] 2> 429736 INFO (coreCloseExecutor-1078-thread-2) [ x:collection5] o.a.s.c.CachingDirectoryFactory Closing directory, CoreContainer#isShutdown=true
[junit4] 2> 429736 INFO (coreCloseExecutor-1078-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection1/data
[junit4] 2> 429736 INFO (coreCloseExecutor-1078-thread-2) [ x:collection5] o.a.s.c.CachingDirectoryFactory Closing directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection5/data
[junit4] 2> 429736 INFO (coreCloseExecutor-1078-thread-2) [ x:collection5] o.a.s.c.CachingDirectoryFactory looking to close /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection5/data/index [CachedDir<<refCount=0;path=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection5/data/index;done=false>>]
[junit4] 2> 429736 INFO (coreCloseExecutor-1078-thread-2) [ x:collection5] o.a.s.c.CachingDirectoryFactory Closing directory, CoreContainer#isShutdown=true
[junit4] 2> 429736 INFO (coreCloseExecutor-1078-thread-2) [ x:collection5] o.a.s.c.CachingDirectoryFactory Closing directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection5/data/index
[junit4] 2> 429743 INFO (coreCloseExecutor-1078-thread-4) [ x:collection3] o.a.s.c.SolrCore [collection3] CLOSING SolrCore org.apache.solr.core.SolrCore@209ff63
[junit4] 2> 429743 INFO (coreCloseExecutor-1078-thread-4) [ x:collection3] 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> 429744 INFO (coreCloseExecutor-1078-thread-4) [ x:collection3] o.a.s.u.SolrCoreState Closing SolrCoreState
[junit4] 2> 429744 INFO (coreCloseExecutor-1078-thread-4) [ x:collection3] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 429744 INFO (coreCloseExecutor-1078-thread-4) [ x:collection3] o.a.s.u.DefaultSolrCoreState closing IndexWriter with IndexWriterCloser
[junit4] 2> 429746 INFO (coreCloseExecutor-1078-thread-4) [ x:collection3] o.a.s.c.SolrCore [collection3] Closing main searcher on request.
[junit4] 2> 429746 INFO (coreCloseExecutor-1078-thread-4) [ x:collection3] o.a.s.c.CachingDirectoryFactory Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 429746 INFO (coreCloseExecutor-1078-thread-4) [ x:collection3] o.a.s.c.CachingDirectoryFactory looking to close /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection3/data/index [CachedDir<<refCount=0;path=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection3/data/index;done=false>>]
[junit4] 2> 429746 INFO (coreCloseExecutor-1078-thread-4) [ x:collection3] o.a.s.c.CachingDirectoryFactory Closing directory, CoreContainer#isShutdown=true
[junit4] 2> 429746 INFO (coreCloseExecutor-1078-thread-4) [ x:collection3] o.a.s.c.CachingDirectoryFactory Closing directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection3/data/index
[junit4] 2> 429746 INFO (coreCloseExecutor-1078-thread-4) [ x:collection3] o.a.s.c.CachingDirectoryFactory looking to close /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection3/data [CachedDir<<refCount=0;path=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection3/data;done=false>>]
[junit4] 2> 429746 INFO (coreCloseExecutor-1078-thread-4) [ x:collection3] o.a.s.c.CachingDirectoryFactory Closing directory, CoreContainer#isShutdown=true
[junit4] 2> 429746 INFO (coreCloseExecutor-1078-thread-4) [ x:collection3] o.a.s.c.CachingDirectoryFactory Closing directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-001/collection3/data
[junit4] 2> 429747 INFO (TEST-TestLazyCores.testRace-seed#[952118D85F046B29]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testRace
[junit4] 2> 429749 INFO (TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[952118D85F046B29]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testBadConfigsGenerateErrors
[junit4] 2> 429756 INFO (TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[952118D85F046B29]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-002'
[junit4] 2> 429756 INFO (TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[952118D85F046B29]) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 429756 INFO (TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[952118D85F046B29]) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 429760 INFO (TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[952118D85F046B29]) [ ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-002
[junit4] 2> 429760 INFO (TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[952118D85F046B29]) [ ] o.a.s.c.CoreContainer New CoreContainer 973039516
[junit4] 2> 429760 INFO (TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[952118D85F046B29]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-002]
[junit4] 2> 429760 WARN (TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[952118D85F046B29]) [ ] o.a.s.c.CoreContainer Couldn't add files from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-002/lib to classpath: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-002/lib
[junit4] 2> 429761 INFO (TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[952118D85F046B29]) [ ] 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,
[junit4] 2> 429762 INFO (TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[952118D85F046B29]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
[junit4] 2> 429762 INFO (TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[952118D85F046B29]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 429762 INFO (TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[952118D85F046B29]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 429762 INFO (TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[952118D85F046B29]) [ ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module.
[junit4] 2> 429762 INFO (TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[952118D85F046B29]) [ ] o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 429763 INFO (TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[952118D85F046B29]) [ ] o.a.s.c.CorePropertiesLocator Looking for core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-002
[junit4] 2> 429763 INFO (TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[952118D85F046B29]) [ ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=badSchema1, config=solrconfig.xml, loadOnStartup=true, schema=schema.xml, configSetProperties=configsetprops.json, transient=true, dataDir=data/}
[junit4] 2> 429763 INFO (TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[952118D85F046B29]) [ ] o.a.s.c.CorePropertiesLocator Found core badSchema1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-002/badSchema1
[junit4] 2> 429764 INFO (TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[952118D85F046B29]) [ ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=badSchema2, config=solrconfig.xml, loadOnStartup=true, schema=schema.xml, configSetProperties=configsetprops.json, transient=true, dataDir=data/}
[junit4] 2> 429764 INFO (TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[952118D85F046B29]) [ ] o.a.s.c.CorePropertiesLocator Found core badSchema2 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-002/badSchema2
[junit4] 2> 429764 INFO (TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[952118D85F046B29]) [ ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=badConfig1, config=solrconfig.xml, loadOnStartup=true, schema=schema.xml, configSetProperties=configsetprops.json, transient=true, dataDir=data/}
[junit4] 2> 429764 INFO (TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[952118D85F046B29]) [ ] o.a.s.c.CorePropertiesLocator Found core badConfig1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-002/badConfig1
[junit4] 2> 429764 INFO (TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[952118D85F046B29]) [ ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=badConfig2, config=solrconfig.xml, loadOnStartup=true, schema=schema.xml, configSetProperties=configsetprops.json, transient=true, dataDir=data/}
[junit4] 2> 429764 INFO (TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[952118D85F046B29]) [ ] o.a.s.c.CorePropertiesLocator Found core badConfig2 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-002/badConfig2
[junit4] 2> 429765 INFO (TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[952118D85F046B29]) [ ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=core1, config=solrconfig.xml, loadOnStartup=true, schema=schema.xml, configSetProperties=configsetprops.json, transient=false, dataDir=data/}
[junit4] 2> 429765 INFO (TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[952118D85F046B29]) [ ] o.a.s.c.CorePropertiesLocator Found core core1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-002/core1
[junit4] 2> 429765 INFO (TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[952118D85F046B29]) [ ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=core2, config=solrconfig.xml, loadOnStartup=true, schema=schema.xml, configSetProperties=configsetprops.json, transient=false, dataDir=data/}
[junit4] 2> 429765 INFO (TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[952118D85F046B29]) [ ] o.a.s.c.CorePropertiesLocator Found core core2 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-002/core2
[junit4] 2> 429765 INFO (TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[952118D85F046B29]) [ ] o.a.s.c.CorePropertiesLocator Found 6 core definitions
[junit4] 2> 429765 INFO (coreLoadExecutor-1085-thread-1) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-002/badSchema1'
[junit4] 2> 429766 INFO (coreLoadExecutor-1085-thread-3) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-002/badConfig1'
[junit4] 2> 429766 INFO (coreLoadExecutor-1085-thread-2) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-002/badSchema2'
[junit4] 2> 429771 INFO (coreLoadExecutor-1085-thread-3) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 429771 INFO (coreLoadExecutor-1085-thread-3) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 429771 INFO (coreLoadExecutor-1085-thread-2) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 429771 INFO (coreLoadExecutor-1085-thread-2) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 429782 INFO (coreLoadExecutor-1085-thread-1) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 429782 INFO (coreLoadExecutor-1085-thread-1) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 429785 INFO (coreLoadExecutor-1085-thread-2) [ ] o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 429786 WARN (coreLoadExecutor-1085-thread-2) [ ] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 429787 INFO (coreLoadExecutor-1085-thread-2) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 429833 INFO (coreLoadExecutor-1085-thread-2) [ ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
[junit4] 2> 429850 INFO (coreLoadExecutor-1085-thread-3) [ ] o.a.s.c.Config Ignoring exception matching \QSAXParseException\E
[junit4] 2> 429850 ERROR (coreLoadExecutor-1085-thread-3) [ ] o.a.s.c.CoreContainer Error creating core [badConfig1]: Could not load conf for core badConfig1: Error loading solr config from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-002/badConfig1/conf/solrconfig.xml
[junit4] 2> org.apache.solr.common.SolrException: Could not load conf for core badConfig1: Error loading solr config from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-002/badConfig1/conf/solrconfig.xml
[junit4] 2> at org.apache.solr.core.ConfigSetService.getConfig(ConfigSetService.java:86)
[junit4] 2> at org.apache.solr.core.CoreContainer.create(CoreContainer.java:834)
[junit4] 2> at org.apache.solr.core.CoreContainer.lambda$load$0(CoreContainer.java:490)
[junit4] 2> at java.util.concurrent.FutureTask.run(FutureTask.java:266)
[junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:229)
[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> Caused by: org.apache.solr.common.SolrException: Error loading solr config from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-002/badConfig1/conf/solrconfig.xml
[junit4] 2> at org.apache.solr.core.SolrConfig.readFromResourceLoader(SolrConfig.java:172)
[junit4] 2> at org.apache.solr.core.ConfigSetService.createSolrConfig(ConfigSetService.java:98)
[junit4] 2> at org.apache.solr.core.ConfigSetService.getConfig(ConfigSetService.java:78)
[junit4] 2> ... 7 more
[junit4] 2> Caused by: org.apache.solr.common.SolrException: org.xml.sax.SAXParseException; systemId: solrres:/solrconfig.xml; lineNumber: 56; columnNumber: 5; The element type "reqsthalr" must be terminated by the matching end-tag "</reqsthalr>".
[junit4] 2> at org.apache.solr.core.Config.<init>(Config.java:154)
[junit4] 2> at org.apache.solr.core.Config.<init>(Config.java:90)
[junit4] 2> at org.apache.solr.core.SolrConfig.<init>(SolrConfig.java:187)
[junit4] 2> at org.apache.solr.core.SolrConfig.readFromResourceLoader(SolrConfig.java:164)
[junit4] 2> ... 9 more
[junit4] 2> Caused by: org.xml.sax.SAXParseException; systemId: solrres:/solrconfig.xml; lineNumber: 56; columnNumber: 5; The element type "reqsthalr" must be terminated by the matching end-tag "</reqsthalr>".
[junit4] 2> at com.sun.org.apache.xerces.internal.util.ErrorHandlerWrapper.createSAXParseException(ErrorHandlerWrapper.java:203)
[junit4] 2> at com.sun.org.apache.xerces.internal.util.ErrorHandlerWrapper.fatalError(ErrorHandlerWrapper.java:177)
[junit4] 2> at com.sun.org.apache.xerces.internal.impl.XMLErrorReporter.reportError(XMLErrorReporter.java:400)
[junit4] 2> at com.sun.org.apache.xerces.internal.impl.XMLErrorReporter.reportError(XMLErrorReporter.java:327)
[junit4] 2> at com.sun.org.apache.xerces.internal.impl.XMLScanner.reportFatalError(XMLScanner.java:1437)
[junit4] 2> at com.sun.org.apache.xerces.internal.impl.XMLDocumentFragmentScannerImpl.scanEndElement(XMLDocumentFragmentScannerImpl.java:1750)
[junit4] 2> at com.sun.org.apache.xerces.internal.impl.XMLDocumentFragmentScannerImpl$FragmentContentDriver.next(XMLDocumentFragmentScannerImpl.java:2970)
[junit4] 2> at com.sun.org.apache.xerces.internal.impl.XMLDocumentScannerImpl.next(XMLDocumentScannerImpl.java:606)
[junit4] 2> at com.sun.org.apache.xerces.internal.impl.XMLNSDocumentScannerImpl.next(XMLNSDocumentScannerImpl.java:118)
[junit4] 2> at com.sun.org.apache.xerces.internal.impl.XMLDocumentFragmentScannerImpl.scanDocument(XMLDocumentFragmentScannerImpl.java:510)
[junit4] 2> at com.sun.org.apache.xerces.internal.parsers.XML11Configuration.parse(XML11Configuration.java:848)
[junit4] 2> at com.sun.org.apache.xerces.internal.parsers.XML11Configuration.parse(XML11Configuration.java:777)
[junit4] 2> at com.sun.org.apache.xerces.internal.parsers.XMLParser.parse(XMLParser.java:141)
[junit4] 2> at com.sun.org.apache.xerces.internal.parsers.DOMParser.parse(DOMParser.java:243)
[junit4] 2> at com.sun.org.apache.xerces.internal.jaxp.DocumentBuilderImpl.parse(DocumentBuilderImpl.java:339)
[junit4] 2> at org.apache.solr.core.Config.<init>(Config.java:143)
[junit4] 2> ... 12 more
[junit4] 2> 429859 INFO (coreLoadExecutor-1085-thread-3) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-002/badConfig2'
[junit4] 2> 429859 INFO (coreLoadExecutor-1085-thread-3) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 429859 INFO (coreLoadExecutor-1085-thread-3) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 429861 INFO (coreLoadExecutor-1085-thread-3) [ ] o.a.s.c.Config Ignoring exception matching \QSAXParseException\E
[junit4] 2> 429861 ERROR (coreLoadExecutor-1085-thread-3) [ ] o.a.s.c.CoreContainer Error creating core [badConfig2]: Could not load conf for core badConfig2: Error loading solr config from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-002/badConfig2/conf/solrconfig.xml
[junit4] 2> org.apache.solr.common.SolrException: Could not load conf for core badConfig2: Error loading solr config from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-002/badConfig2/conf/solrconfig.xml
[junit4] 2> at org.apache.solr.core.ConfigSetService.getConfig(ConfigSetService.java:86)
[junit4] 2> at org.apache.solr.core.CoreContainer.create(CoreContainer.java:834)
[junit4] 2> at org.apache.solr.core.CoreContainer.lambda$load$0(CoreContainer.java:490)
[junit4] 2> at java.util.concurrent.FutureTask.run(FutureTask.java:266)
[junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:229)
[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> Caused by: org.apache.solr.common.SolrException: Error loading solr config from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-002/badConfig2/conf/solrconfig.xml
[junit4] 2> at org.apache.solr.core.SolrConfig.readFromResourceLoader(SolrConfig.java:172)
[junit4] 2> at org.apache.solr.core.ConfigSetService.createSolrConfig(ConfigSetService.java:98)
[junit4] 2> at org.apache.solr.core.ConfigSetService.getConfig(ConfigSetService.java:78)
[junit4] 2> ... 7 more
[junit4] 2> Caused by: org.apache.solr.common.SolrException: org.xml.sax.SAXParseException; systemId: solrres:/solrconfig.xml; lineNumber: 56; columnNumber: 5; The element type "reqsthalr" must be terminated by the matching end-tag "</reqsthalr>".
[junit4] 2> at org.apache.solr.core.Config.<init>(Config.java:154)
[junit4] 2> at org.apache.solr.core.Config.<init>(Config.java:90)
[junit4] 2> at org.apache.solr.core.SolrConfig.<init>(SolrConfig.java:187)
[junit4] 2> at org.apache.solr.core.SolrConfig.readFromResourceLoader(SolrConfig.java:164)
[junit4] 2> ... 9 more
[junit4] 2> Caused by: org.xml.sax.SAXParseException; systemId: solrres:/solrconfig.xml; lineNumber: 56; columnNumber: 5; The element type "reqsthalr" must be terminated by the matching end-tag "</reqsthalr>".
[junit4] 2> at com.sun.org.apache.xerces.internal.util.ErrorHandlerWrapper.createSAXParseException(ErrorHandlerWrapper.java:203)
[junit4] 2> at com.sun.org.apache.xerces.internal.util.ErrorHandlerWrapper.fatalError(ErrorHandlerWrapper.java:177)
[junit4] 2> at com.sun.org.apache.xerces.internal.impl.XMLErrorReporter.reportError(XMLErrorReporter.java:400)
[junit4] 2> at com.sun.org.apache.xerces.internal.impl.XMLErrorReporter.reportError(XMLErrorReporter.java:327)
[junit4] 2> at com.sun.org.apache.xerces.internal.impl.XMLScanner.reportFatalError(XMLScanner.java:1437)
[junit4] 2> at com.sun.org.apache.xerces.internal.impl.XMLDocumentFragmentScannerImpl.scanEndElement(XMLDocumentFragmentScannerImpl.java:1750)
[junit4] 2> at com.sun.org.apache.xerces.internal.impl.XMLDocumentFragmentScannerImpl$FragmentContentDriver.next(XMLDocumentFragmentScannerImpl.java:2970)
[junit4] 2> at com.sun.org.apache.xerces.internal.impl.XMLDocumentScannerImpl.next(XMLDocumentScannerImpl.java:606)
[junit4] 2> at com.sun.org.apache.xerces.internal.impl.XMLNSDocumentScannerImpl.next(XMLNSDocumentScannerImpl.java:118)
[junit4] 2> at com.sun.org.apache.xerces.internal.impl.XMLDocumentFragmentScannerImpl.scanDocument(XMLDocumentFragmentScannerImpl.java:510)
[junit4] 2> at com.sun.org.apache.xerces.internal.parsers.XML11Configuration.parse(XML11Configuration.java:848)
[junit4] 2> at com.sun.org.apache.xerces.internal.parsers.XML11Configuration.parse(XML11Configuration.java:777)
[junit4] 2> at com.sun.org.apache.xerces.internal.parsers.XMLParser.parse(XMLParser.java:141)
[junit4] 2> at com.sun.org.apache.xerces.internal.parsers.DOMParser.parse(DOMParser.java:243)
[junit4] 2> at com.sun.org.apache.xerces.internal.jaxp.DocumentBuilderImpl.parse(DocumentBuilderImpl.java:339)
[junit4] 2> at org.apache.solr.core.Config.<init>(Config.java:143)
[junit4] 2> ... 12 more
[junit4] 2> 429861 INFO (coreLoadExecutor-1085-thread-3) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-002/core1'
[junit4] 2> 429861 INFO (coreLoadExecutor-1085-thread-3) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 429861 INFO (coreLoadExecutor-1085-thread-3) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 429856 INFO (coreLoadExecutor-1085-thread-2) [ ] o.a.s.c.Config Ignoring exception matching \QSAXParseException\E
[junit4] 2> 429863 ERROR (coreLoadExecutor-1085-thread-2) [ ] o.a.s.c.CoreContainer Error creating core [badSchema2]: Could not load conf for core badSchema2: Can't load schema /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-002/badSchema2/conf/schema.xml: org.xml.sax.SAXParseException; systemId: solrres:/schema.xml; lineNumber: 35; columnNumber: 7; The element type "filedType" must be terminated by the matching end-tag "</filedType>".
[junit4] 2> org.apache.solr.common.SolrException: Could not load conf for core badSchema2: Can't load schema /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-002/badSchema2/conf/schema.xml: org.xml.sax.SAXParseException; systemId: solrres:/schema.xml; lineNumber: 35; columnNumber: 7; The element type "filedType" must be terminated by the matching end-tag "</filedType>".
[junit4] 2> at org.apache.solr.core.ConfigSetService.getConfig(ConfigSetService.java:86)
[junit4] 2> at org.apache.solr.core.CoreContainer.create(CoreContainer.java:834)
[junit4] 2> at org.apache.solr.core.CoreContainer.lambda$load$0(CoreContainer.java:490)
[junit4] 2> at java.util.concurrent.FutureTask.run(FutureTask.java:266)
[junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:229)
[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> Caused by: org.apache.solr.common.SolrException: Can't load schema /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_952118D85F046B29-001/tempDir-002/badSchema2/conf/schema.xml: org.xml.sax.SAXParseException; systemId: solrres:/schema.xml; lineNumber: 35; columnNumber: 7; The element type "filedType" must be terminated by the matching end-tag "</filedType>".
[junit4] 2> at org.apache.solr.schema.IndexSchema.readSchema(IndexSchema.java:580)
[junit4] 2> at org.apache.solr.schema.IndexSchema.<init>(IndexSchema.java:163)
[junit4] 2> at org.apache.solr.schema.IndexSchemaFactory.create(IndexSchemaFactory.java:56)
[...truncated too long message...]
] 2> at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
[junit4] 2> at org.apache.solr.core.SolrCore.<init>(SolrCore.java:807)
[junit4] 2> at org.apache.solr.core.SolrCore.<init>(SolrCore.java:646)
[junit4] 2> at org.apache.solr.core.CoreContainer.create(CoreContainer.java:836)
[junit4] 2> at org.apache.solr.core.CoreContainer.lambda$load$0(CoreContainer.java:490)
[junit4] 2> at java.util.concurrent.FutureTask.run(FutureTask.java:266)
[junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:229)
[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> 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:669)
[junit4] 2> at org.apache.solr.core.SolrCore.<init>(SolrCore.java:646)
[junit4] 2> at org.apache.solr.core.CoreContainer.create(CoreContainer.java:836)
[junit4] 2> at org.apache.solr.core.CoreContainer.lambda$load$0(CoreContainer.java:490)
[junit4] 2> at java.util.concurrent.FutureTask.run(FutureTask.java:266)
[junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:229)
[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> Apr 13, 2016 4:14:22 AM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 1 leaked thread(s).
[junit4] 2> Apr 13, 2016 4:14:42 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=2181, name=searcherExecutor-1258-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> Apr 13, 2016 4:14:42 AM com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
[junit4] 2> INFO: Starting to interrupt leaked threads:
[junit4] 2> 1) Thread[id=2181, name=searcherExecutor-1258-thread-1, state=WAITING, group=TGRP-TestLazyCores]
[junit4] 2> Apr 13, 2016 4:14:45 AM com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
[junit4] 2> SEVERE: There are still zombie threads that couldn't be terminated:
[junit4] 2> 1) Thread[id=2181, name=searcherExecutor-1258-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=CheapBastard, sim=RandomSimilarity(queryNorm=false,coord=no): {}, locale=ru-RU, timezone=Antarctica/Syowa
[junit4] 2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation 1.8.0_74 (64-bit)/cpus=4,threads=2,free=226728408,total=509083648
[junit4] 2> NOTE: All tests run in this JVM: [AsyncCallRequestStatusResponseTest, EchoParamsTest, QueryEqualityTest, SharedFSAutoReplicaFailoverUtilsTest, TestSolr4Spatial, ConnectionReuseTest, TestManagedStopFilterFactory, TestDefaultSearchFieldResource, TestDFISimilarityFactory, TestCustomDocTransformer, TestReplicationHandlerBackup, TestExactSharedStatsCache, ActionThrottleTest, JsonLoaderTest, TestPKIAuthenticationPlugin, DistributedDebugComponentTest, TestSchemaSimilarityResource, CustomCollectionTest, TestShortCircuitedRequests, TestSolrConfigHandler, ZkNodePropsTest, TestBinaryField, JSONWriterTest, TestDistributedSearch, FileBasedSpellCheckerTest, TestLuceneMatchVersion, TestLazyCores]
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestLazyCores -Dtests.seed=952118D85F046B29 -Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=ru-RU -Dtests.timezone=Antarctica/Syowa -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] ERROR 0.00s J0 | TestLazyCores (suite) <<<
[junit4] > Throwable #1: java.lang.AssertionError: ObjectTracker found 4 object(s) that were not released!!! [MockDirectoryWrapper, MockDirectoryWrapper, SolrCore, MDCAwareThreadPoolExecutor]
[junit4] > at __randomizedtesting.SeedInfo.seed([952118D85F046B29]:0)
[junit4] > at org.apache.solr.SolrTestCaseJ4.afterClass(SolrTestCaseJ4.java:255)
[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=2181, name=searcherExecutor-1258-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([952118D85F046B29]:0)Throwable #3: com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie threads that couldn't be terminated:
[junit4] > 1) Thread[id=2181, name=searcherExecutor-1258-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([952118D85F046B29]:0)
[junit4] Completed [91/584 (1!)] on J0 in 150.91s, 8 tests, 1 failure, 2 errors <<< FAILURES!
[...truncated 1550 lines...]
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/build.xml:740: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/build.xml:684: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/build.xml:59: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build.xml:233: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/common-build.xml:529: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/common-build.xml:1457: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/common-build.xml:1014: There were test failures: 584 suites (10 ignored), 2356 tests, 3 suite-level errors, 1338 ignored (65 assumptions) [seed: 952118D85F046B29]
Total time: 69 minutes 9 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any