Build: https://builds.apache.org/job/Lucene-Solr-Tests-6.x/56/
3 tests failed. FAILED: junit.framework.TestSuite.org.apache.solr.core.TestLazyCores Error Message: ObjectTracker found 4 object(s) that were not released!!! [SolrCore, MockDirectoryWrapper, MockDirectoryWrapper, MDCAwareThreadPoolExecutor] Stack Trace: java.lang.AssertionError: ObjectTracker found 4 object(s) that were not released!!! [SolrCore, MockDirectoryWrapper, MockDirectoryWrapper, MDCAwareThreadPoolExecutor] at __randomizedtesting.SeedInfo.seed([880A3006DEC3D869]:0) at org.junit.Assert.fail(Assert.java:93) at org.junit.Assert.assertTrue(Assert.java:43) at org.junit.Assert.assertNull(Assert.java:551) at org.apache.solr.SolrTestCaseJ4.afterClass(SolrTestCaseJ4.java:238) at sun.reflect.GeneratedMethodAccessor20.invoke(Unknown Source) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:497) 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=3677, name=searcherExecutor-1773-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=3677, name=searcherExecutor-1773-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([880A3006DEC3D869]: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=3677, name=searcherExecutor-1773-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=3677, name=searcherExecutor-1773-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([880A3006DEC3D869]:0) Build Log: [...truncated 11058 lines...] [junit4] Suite: org.apache.solr.core.TestLazyCores [junit4] 2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/init-core-data-001 [junit4] 2> 451754 INFO (SUITE-TestLazyCores-seed#[880A3006DEC3D869]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) [junit4] 2> 451767 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testLazySearch [junit4] 2> 451787 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001' [junit4] 2> 451787 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 451787 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 451788 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ ] o.a.s.c.CoreContainer New CoreContainer 670862872 [junit4] 2> 451788 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001] [junit4] 2> 451788 WARN (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ ] o.a.s.c.CoreContainer Couldn't add files from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/lib to classpath: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/lib [junit4] 2> 451788 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 600000,connTimeout : 60000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false, [junit4] 2> 451791 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=600000&connTimeout=60000&retry=true [junit4] 2> 451791 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ ] o.a.s.c.SolrCores Allocating transient cache for 4 transient cores [junit4] 2> 451793 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 451793 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 451793 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module. [junit4] 2> 451793 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ ] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 451794 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ ] 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> 451795 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ ] 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> 451795 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ ] 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> 451795 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ ] 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> 451795 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ ] 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> 451796 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ ] 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> 451796 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ ] 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> 451796 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ ] 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> 451796 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ ] 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> 451797 INFO (coreLoadExecutor-1703-thread-1) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection1' [junit4] 2> 451797 INFO (coreLoadExecutor-1703-thread-1) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 451797 INFO (coreLoadExecutor-1703-thread-1) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 451805 INFO (coreLoadExecutor-1703-thread-1) [ ] o.a.s.c.SolrConfig current version of requestparams : -1 [junit4] 2> 451807 INFO (coreLoadExecutor-1703-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.1.0 [junit4] 2> 451813 INFO (coreLoadExecutor-1703-thread-1) [ ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml [junit4] 2> 451816 INFO (coreLoadExecutor-1703-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=tiny [junit4] 2> 451819 INFO (coreLoadExecutor-1703-thread-1) [ ] o.a.s.s.IndexSchema unique key field: id [junit4] 2> 451821 INFO (coreLoadExecutor-1703-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-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection1' [junit4] 2> 451821 INFO (coreLoadExecutor-1703-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection1 [junit4] 2> 451821 INFO (coreLoadExecutor-1703-thread-1) [ x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory [junit4] 2> 451822 INFO (coreLoadExecutor-1703-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection1], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection1/data/] [junit4] 2> 451822 INFO (coreLoadExecutor-1703-thread-1) [ x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core: collection1 [junit4] 2> 451822 INFO (coreLoadExecutor-1703-thread-3) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection5' [junit4] 2> 451822 INFO (coreLoadExecutor-1703-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection1/data [junit4] 2> 451822 INFO (coreLoadExecutor-1703-thread-3) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 451822 INFO (coreLoadExecutor-1703-thread-1) [ x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection1/data/index/ [junit4] 2> 451822 INFO (coreLoadExecutor-1703-thread-3) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 451822 WARN (coreLoadExecutor-1703-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection1/data/index' doesn't exist. Creating new index... [junit4] 2> 451826 INFO (coreLoadExecutor-1703-thread-2) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection2' [junit4] 2> 451826 INFO (coreLoadExecutor-1703-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection1/data/index [junit4] 2> 451826 INFO (coreLoadExecutor-1703-thread-2) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 451826 INFO (coreLoadExecutor-1703-thread-2) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 451826 INFO (coreLoadExecutor-1703-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=24, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0] [junit4] 2> 451827 INFO (coreLoadExecutor-1703-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@234659a lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@20721b1d),segFN=segments_1,generation=1} [junit4] 2> 451827 INFO (coreLoadExecutor-1703-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1 [junit4] 2> 451828 INFO (coreLoadExecutor-1703-thread-1) [ x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 451831 INFO (coreLoadExecutor-1703-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 451831 INFO (coreLoadExecutor-1703-thread-2) [ ] o.a.s.c.SolrConfig current version of requestparams : -1 [junit4] 2> 451832 INFO (coreLoadExecutor-1703-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 451832 INFO (coreLoadExecutor-1703-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 451833 INFO (coreLoadExecutor-1703-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 451834 INFO (coreLoadExecutor-1703-thread-2) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.1.0 [junit4] 2> 451834 INFO (coreLoadExecutor-1703-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> 451835 INFO (coreLoadExecutor-1703-thread-1) [ x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache [junit4] 2> 451835 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-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection1/data/ [junit4] 2> 451835 WARN (OldIndexDirectoryCleanupThreadForCore-collection1) [ x:collection1] o.a.s.c.DirectoryFactory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection1/data/ does not point to a valid data directory; skipping clean-up of old index directories. [junit4] 2> 451835 INFO (coreLoadExecutor-1703-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 451835 INFO (coreLoadExecutor-1703-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 451836 INFO (coreLoadExecutor-1703-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=39, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0] [junit4] 2> 451836 INFO (coreLoadExecutor-1703-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@234659a lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@20721b1d),segFN=segments_1,generation=1} [junit4] 2> 451836 INFO (coreLoadExecutor-1703-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1 [junit4] 2> 451836 INFO (coreLoadExecutor-1703-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@6a0567a4[collection1] main] [junit4] 2> 451837 INFO (coreLoadExecutor-1703-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection1/conf [junit4] 2> 451837 INFO (coreLoadExecutor-1703-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection1/conf} [junit4] 2> 451837 INFO (coreLoadExecutor-1703-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using file:dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection1/conf [junit4] 2> 451837 INFO (coreLoadExecutor-1703-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources [junit4] 2> 451837 INFO (coreLoadExecutor-1703-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 451837 INFO (coreLoadExecutor-1703-thread-1) [ x:collection1] o.a.s.c.CoreContainer registering core: collection1 [junit4] 2> 451838 INFO (searcherExecutor-1704-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@6a0567a4[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 451838 INFO (coreLoadExecutor-1703-thread-3) [ ] o.a.s.c.SolrConfig current version of requestparams : -1 [junit4] 2> 451841 INFO (coreLoadExecutor-1703-thread-2) [ ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml [junit4] 2> 451841 INFO (coreLoadExecutor-1703-thread-3) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.1.0 [junit4] 2> 451844 INFO (coreLoadExecutor-1703-thread-2) [ ] o.a.s.s.IndexSchema [collection2] Schema name=tiny [junit4] 2> 451846 INFO (coreLoadExecutor-1703-thread-3) [ ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml [junit4] 2> 451847 INFO (coreLoadExecutor-1703-thread-2) [ ] o.a.s.s.IndexSchema unique key field: id [junit4] 2> 451848 INFO (coreLoadExecutor-1703-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-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection2' [junit4] 2> 451848 INFO (coreLoadExecutor-1703-thread-2) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection2' using configuration from instancedir /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection2 [junit4] 2> 451849 INFO (coreLoadExecutor-1703-thread-2) [ x:collection2] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory [junit4] 2> 451849 INFO (coreLoadExecutor-1703-thread-2) [ x:collection2] o.a.s.c.SolrCore [[collection2] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection2], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection2/data/] [junit4] 2> 451849 INFO (coreLoadExecutor-1703-thread-3) [ ] o.a.s.s.IndexSchema [collection5] Schema name=tiny [junit4] 2> 451849 INFO (coreLoadExecutor-1703-thread-2) [ x:collection2] o.a.s.c.SolrCore JMX monitoring not detected for core: collection2 [junit4] 2> 451849 INFO (coreLoadExecutor-1703-thread-2) [ x:collection2] o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection2/data [junit4] 2> 451849 INFO (coreLoadExecutor-1703-thread-2) [ x:collection2] o.a.s.c.SolrCore New index directory detected: old=null new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection2/data/index/ [junit4] 2> 451849 WARN (coreLoadExecutor-1703-thread-2) [ x:collection2] o.a.s.c.SolrCore [collection2] Solr index directory '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection2/data/index' doesn't exist. Creating new index... [junit4] 2> 451850 INFO (coreLoadExecutor-1703-thread-2) [ x:collection2] o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection2/data/index [junit4] 2> 451850 INFO (coreLoadExecutor-1703-thread-2) [ x:collection2] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=24, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0] [junit4] 2> 451850 INFO (coreLoadExecutor-1703-thread-2) [ x:collection2] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@7a764522 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@9cdeb69),segFN=segments_1,generation=1} [junit4] 2> 451850 INFO (coreLoadExecutor-1703-thread-2) [ x:collection2] o.a.s.c.SolrDeletionPolicy newest commit generation = 1 [junit4] 2> 451851 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-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection2/data/ [junit4] 2> 451851 WARN (OldIndexDirectoryCleanupThreadForCore-collection2) [ x:collection2] o.a.s.c.DirectoryFactory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection2/data/ does not point to a valid data directory; skipping clean-up of old index directories. [junit4] 2> 451855 INFO (coreLoadExecutor-1703-thread-3) [ ] o.a.s.s.IndexSchema unique key field: id [junit4] 2> 451856 INFO (coreLoadExecutor-1703-thread-2) [ x:collection2] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 451856 INFO (coreLoadExecutor-1703-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-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection5' [junit4] 2> 451856 INFO (coreLoadExecutor-1703-thread-3) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection5' using configuration from instancedir /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection5 [junit4] 2> 451856 INFO (coreLoadExecutor-1703-thread-3) [ x:collection5] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory [junit4] 2> 451856 INFO (coreLoadExecutor-1703-thread-3) [ x:collection5] o.a.s.c.SolrCore [[collection5] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection5], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection5/data/] [junit4] 2> 451857 INFO (coreLoadExecutor-1703-thread-3) [ x:collection5] o.a.s.c.SolrCore JMX monitoring not detected for core: collection5 [junit4] 2> 451857 INFO (coreLoadExecutor-1703-thread-3) [ x:collection5] o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection5/data [junit4] 2> 451857 INFO (coreLoadExecutor-1703-thread-3) [ x:collection5] o.a.s.c.SolrCore New index directory detected: old=null new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection5/data/index/ [junit4] 2> 451857 WARN (coreLoadExecutor-1703-thread-3) [ x:collection5] o.a.s.c.SolrCore [collection5] Solr index directory '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection5/data/index' doesn't exist. Creating new index... [junit4] 2> 451857 INFO (coreLoadExecutor-1703-thread-2) [ x:collection2] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 451857 INFO (coreLoadExecutor-1703-thread-3) [ x:collection5] o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection5/data/index [junit4] 2> 451857 INFO (coreLoadExecutor-1703-thread-3) [ x:collection5] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=24, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0] [junit4] 2> 451858 INFO (coreLoadExecutor-1703-thread-3) [ x:collection5] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@64e731dc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5678d4c4),segFN=segments_1,generation=1} [junit4] 2> 451858 INFO (coreLoadExecutor-1703-thread-2) [ x:collection2] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 451858 INFO (coreLoadExecutor-1703-thread-3) [ x:collection5] o.a.s.c.SolrDeletionPolicy newest commit generation = 1 [junit4] 2> 451858 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-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection5/data/ [junit4] 2> 451859 WARN (OldIndexDirectoryCleanupThreadForCore-collection5) [ x:collection5] o.a.s.c.DirectoryFactory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection5/data/ does not point to a valid data directory; skipping clean-up of old index directories. [junit4] 2> 451859 INFO (coreLoadExecutor-1703-thread-2) [ x:collection2] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 451860 INFO (coreLoadExecutor-1703-thread-3) [ x:collection5] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 451860 INFO (coreLoadExecutor-1703-thread-2) [ x:collection2] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 451861 INFO (coreLoadExecutor-1703-thread-3) [ x:collection5] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 451861 INFO (coreLoadExecutor-1703-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> 451861 INFO (coreLoadExecutor-1703-thread-2) [ x:collection2] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache [junit4] 2> 451861 INFO (coreLoadExecutor-1703-thread-2) [ x:collection2] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 451861 INFO (coreLoadExecutor-1703-thread-2) [ x:collection2] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 451862 INFO (coreLoadExecutor-1703-thread-3) [ x:collection5] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 451862 INFO (coreLoadExecutor-1703-thread-2) [ x:collection2] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=39, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0] [junit4] 2> 451862 INFO (coreLoadExecutor-1703-thread-2) [ x:collection2] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@7a764522 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@9cdeb69),segFN=segments_1,generation=1} [junit4] 2> 451862 INFO (coreLoadExecutor-1703-thread-2) [ x:collection2] o.a.s.c.SolrDeletionPolicy newest commit generation = 1 [junit4] 2> 451862 INFO (coreLoadExecutor-1703-thread-3) [ x:collection5] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 451862 INFO (coreLoadExecutor-1703-thread-2) [ x:collection2] o.a.s.s.SolrIndexSearcher Opening [Searcher@54336b42[collection2] main] [junit4] 2> 451863 INFO (coreLoadExecutor-1703-thread-2) [ x:collection2] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection2/conf [junit4] 2> 451863 INFO (coreLoadExecutor-1703-thread-2) [ x:collection2] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection2/conf} [junit4] 2> 451863 INFO (coreLoadExecutor-1703-thread-2) [ x:collection2] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using file:dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection2/conf [junit4] 2> 451863 INFO (coreLoadExecutor-1703-thread-2) [ x:collection2] o.a.s.r.RestManager Initializing 0 registered ManagedResources [junit4] 2> 451863 INFO (coreLoadExecutor-1703-thread-2) [ x:collection2] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 451863 INFO (coreLoadExecutor-1703-thread-3) [ x:collection5] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 451863 INFO (coreLoadExecutor-1703-thread-2) [ x:collection2] o.a.s.c.SolrCores Opening transient core collection2 [junit4] 2> 451863 INFO (coreLoadExecutor-1703-thread-2) [ x:collection2] o.a.s.c.CoreContainer registering core: collection2 [junit4] 2> 451864 INFO (searcherExecutor-1708-thread-1-processing-x:collection2) [ x:collection2] o.a.s.c.SolrCore [collection2] Registered new searcher Searcher@54336b42[collection2] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 451870 INFO (coreLoadExecutor-1703-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> 451870 INFO (coreLoadExecutor-1703-thread-3) [ x:collection5] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache [junit4] 2> 451870 INFO (coreLoadExecutor-1703-thread-3) [ x:collection5] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 451870 INFO (coreLoadExecutor-1703-thread-3) [ x:collection5] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 451870 INFO (coreLoadExecutor-1703-thread-3) [ x:collection5] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=39, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0] [junit4] 2> 451871 INFO (coreLoadExecutor-1703-thread-3) [ x:collection5] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@64e731dc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5678d4c4),segFN=segments_1,generation=1} [junit4] 2> 451871 INFO (coreLoadExecutor-1703-thread-3) [ x:collection5] o.a.s.c.SolrDeletionPolicy newest commit generation = 1 [junit4] 2> 451871 INFO (coreLoadExecutor-1703-thread-3) [ x:collection5] o.a.s.s.SolrIndexSearcher Opening [Searcher@530cc5cd[collection5] main] [junit4] 2> 451871 INFO (coreLoadExecutor-1703-thread-3) [ x:collection5] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection5/conf [junit4] 2> 451871 INFO (coreLoadExecutor-1703-thread-3) [ x:collection5] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection5/conf} [junit4] 2> 451871 INFO (coreLoadExecutor-1703-thread-3) [ x:collection5] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using file:dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection5/conf [junit4] 2> 451871 INFO (coreLoadExecutor-1703-thread-3) [ x:collection5] o.a.s.r.RestManager Initializing 0 registered ManagedResources [junit4] 2> 451872 INFO (coreLoadExecutor-1703-thread-3) [ x:collection5] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 451872 INFO (coreLoadExecutor-1703-thread-3) [ x:collection5] o.a.s.c.CoreContainer registering core: collection5 [junit4] 2> 451873 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection4' [junit4] 2> 451873 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 451873 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 451879 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ ] o.a.s.c.SolrConfig current version of requestparams : -1 [junit4] 2> 451882 INFO (searcherExecutor-1709-thread-1-processing-x:collection5) [ x:collection5] o.a.s.c.SolrCore [collection5] Registered new searcher Searcher@530cc5cd[collection5] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 451882 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.1.0 [junit4] 2> 451887 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml [junit4] 2> 451890 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ ] o.a.s.s.IndexSchema [collection4] Schema name=tiny [junit4] 2> 451898 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ ] o.a.s.s.IndexSchema unique key field: id [junit4] 2> 451899 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ ] 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-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection4' [junit4] 2> 451899 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection4' using configuration from instancedir /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection4 [junit4] 2> 451899 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory [junit4] 2> 451900 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.c.SolrCore [[collection4] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection4], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection4/data/] [junit4] 2> 451900 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.c.SolrCore JMX monitoring not detected for core: collection4 [junit4] 2> 451901 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection4/data [junit4] 2> 451902 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.c.SolrCore New index directory detected: old=null new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection4/data/index/ [junit4] 2> 451902 WARN (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.c.SolrCore [collection4] Solr index directory '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection4/data/index' doesn't exist. Creating new index... [junit4] 2> 451903 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection4/data/index [junit4] 2> 451903 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=18, maxMergeAtOnceExplicit=48, maxMergedSegmentMB=50.744140625, floorSegmentMB=1.6162109375, forceMergeDeletesPctAllowed=19.22326550459506, segmentsPerTier=32.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0 [junit4] 2> 451903 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@63ebca0b lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@135daf7),segFN=segments_1,generation=1} [junit4] 2> 451903 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.c.SolrDeletionPolicy newest commit generation = 1 [junit4] 2> 451904 INFO (OldIndexDirectoryCleanupThreadForCore-collection4) [ x:collection4] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection4 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection4/data/ [junit4] 2> 451904 WARN (OldIndexDirectoryCleanupThreadForCore-collection4) [ x:collection4] o.a.s.c.DirectoryFactory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection4/data/ does not point to a valid data directory; skipping clean-up of old index directories. [junit4] 2> 451906 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 451907 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 451908 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 451908 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 451909 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 451910 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,/update/csv,/sql,/update/json/docs,/admin/luke,/export,/select,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/stream,/schema,/admin/plugins,/admin/logging,/update/json,/admin/ping,/admin/threads,/update,/admin/file [junit4] 2> 451911 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache [junit4] 2> 451911 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 451911 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 451911 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=30, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0] [junit4] 2> 451912 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@63ebca0b lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@135daf7),segFN=segments_1,generation=1} [junit4] 2> 451912 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.c.SolrDeletionPolicy newest commit generation = 1 [junit4] 2> 451912 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.s.SolrIndexSearcher Opening [Searcher@37037e1a[collection4] main] [junit4] 2> 451913 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection4/conf [junit4] 2> 451913 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection4/conf} [junit4] 2> 451913 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using file:dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection4/conf [junit4] 2> 451913 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.r.RestManager Initializing 0 registered ManagedResources [junit4] 2> 451913 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 451913 INFO (searcherExecutor-1716-thread-1-processing-x:collection4) [ x:collection4] o.a.s.c.SolrCore [collection4] Registered new searcher Searcher@37037e1a[collection4] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 451913 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.c.CoreContainer registering core: collection4 [junit4] 2> 451914 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 451917 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@63ebca0b lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@135daf7),segFN=segments_1,generation=1} [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@63ebca0b lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@135daf7),segFN=segments_2,generation=2} [junit4] 2> 451917 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.c.SolrDeletionPolicy newest commit generation = 2 [junit4] 2> 451918 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.s.SolrIndexSearcher Opening [Searcher@7b72f3f3[collection4] main] [junit4] 2> 451919 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 451919 INFO (searcherExecutor-1716-thread-1-processing-x:collection4) [ x:collection4] o.a.s.c.SolrCore [collection4] Registered new searcher Searcher@7b72f3f3[collection4] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.1.0):c7)))} [junit4] 2> 451921 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.c.S.Request [collection4] webapp=null path=null params={q={!prefix+f%3Dv_t}hel&wt=xml} hits=2 status=0 QTime=0 [junit4] 2> 451924 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.c.S.Request [collection4] webapp=null path=null params={q={!raw+f%3Dv_t}hello&wt=xml} hits=2 status=0 QTime=0 [junit4] 2> 451924 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.c.S.Request [collection4] webapp=null path=null params={q={!raw+f%3Dv_t}Hello&wt=xml} hits=0 status=0 QTime=0 [junit4] 2> 451925 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.c.S.Request [collection4] webapp=null path=null params={q={!raw+f%3Dv_f}1.5&wt=xml} hits=0 status=0 QTime=0 [junit4] 2> 451925 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.c.S.Request [collection1] webapp=null path=null params={q={!raw+f%3Dv_t}hello&wt=xml} hits=0 status=0 QTime=0 [junit4] 2> 451925 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.c.CoreContainer Shutting down CoreContainer instance=670862872 [junit4] 2> 451926 INFO (coreCloseExecutor-1720-thread-1-processing-x:collection4) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@15880937 [junit4] 2> 451926 INFO (coreCloseExecutor-1720-thread-2-processing-x:collection4) [ x:collection5] o.a.s.c.SolrCore [collection5] CLOSING SolrCore org.apache.solr.core.SolrCore@36bfe71e [junit4] 2> 451926 INFO (coreCloseExecutor-1720-thread-1-processing-x:collection4) [ x:collection1] o.a.s.u.DirectUpdateHandler2 closing DirectUpdateHandler2{commits=0,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0} [junit4] 2> 451926 INFO (coreCloseExecutor-1720-thread-2-processing-x:collection4) [ x:collection5] o.a.s.u.DirectUpdateHandler2 closing DirectUpdateHandler2{commits=0,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0} [junit4] 2> 451929 INFO (coreCloseExecutor-1720-thread-2-processing-x:collection4) [ x:collection5] o.a.s.u.SolrCoreState Closing SolrCoreState [junit4] 2> 451929 INFO (coreCloseExecutor-1720-thread-2-processing-x:collection4) [ x:collection5] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached 0 - closing IndexWriter [junit4] 2> 451929 INFO (coreCloseExecutor-1720-thread-2-processing-x:collection4) [ x:collection5] o.a.s.u.DefaultSolrCoreState closing IndexWriter with IndexWriterCloser [junit4] 2> 451929 INFO (coreCloseExecutor-1720-thread-1-processing-x:collection4) [ x:collection1] o.a.s.u.SolrCoreState Closing SolrCoreState [junit4] 2> 451929 INFO (coreCloseExecutor-1720-thread-1-processing-x:collection4) [ x:collection1] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached 0 - closing IndexWriter [junit4] 2> 451929 INFO (coreCloseExecutor-1720-thread-1-processing-x:collection4) [ x:collection1] o.a.s.u.DefaultSolrCoreState closing IndexWriter with IndexWriterCloser [junit4] 2> 451934 INFO (coreCloseExecutor-1720-thread-2-processing-x:collection4) [ x:collection5] o.a.s.c.SolrCore [collection5] Closing main searcher on request. [junit4] 2> 451933 INFO (coreCloseExecutor-1720-thread-3-processing-x:collection4) [ x:collection4] o.a.s.c.SolrCore [collection4] CLOSING SolrCore org.apache.solr.core.SolrCore@1084c45b [junit4] 2> 451936 INFO (coreCloseExecutor-1720-thread-3-processing-x:collection4) [ x:collection4] o.a.s.u.DirectUpdateHandler2 closing DirectUpdateHandler2{commits=1,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=7,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0} [junit4] 2> 451933 INFO (coreCloseExecutor-1720-thread-4-processing-x:collection4) [ x:collection2] o.a.s.c.SolrCore [collection2] CLOSING SolrCore org.apache.solr.core.SolrCore@371f724f [junit4] 2> 451937 INFO (coreCloseExecutor-1720-thread-1-processing-x:collection4) [ x:collection1] o.a.s.c.SolrCore [collection1] Closing main searcher on request. [junit4] 2> 451937 INFO (coreCloseExecutor-1720-thread-4-processing-x:collection4) [ x:collection2] o.a.s.u.DirectUpdateHandler2 closing DirectUpdateHandler2{commits=0,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0} [junit4] 2> 451934 INFO (coreCloseExecutor-1720-thread-2-processing-x:collection4) [ x:collection5] o.a.s.c.CachingDirectoryFactory Closing MockDirectoryFactory - 2 directories currently being tracked [junit4] 2> 451937 INFO (coreCloseExecutor-1720-thread-1-processing-x:collection4) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing MockDirectoryFactory - 2 directories currently being tracked [junit4] 2> 451937 INFO (coreCloseExecutor-1720-thread-2-processing-x:collection4) [ x:collection5] o.a.s.c.CachingDirectoryFactory looking to close /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection5/data [CachedDir<<refCount=0;path=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection5/data;done=false>>] [junit4] 2> 451937 INFO (coreCloseExecutor-1720-thread-1-processing-x:collection4) [ x:collection1] o.a.s.c.CachingDirectoryFactory looking to close /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection1/data [CachedDir<<refCount=0;path=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection1/data;done=false>>] [junit4] 2> 451937 INFO (coreCloseExecutor-1720-thread-2-processing-x:collection4) [ x:collection5] o.a.s.c.CachingDirectoryFactory Closing directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection5/data [junit4] 2> 451937 INFO (coreCloseExecutor-1720-thread-1-processing-x:collection4) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection1/data [junit4] 2> 451937 INFO (coreCloseExecutor-1720-thread-2-processing-x:collection4) [ x:collection5] o.a.s.c.CachingDirectoryFactory looking to close /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection5/data/index [CachedDir<<refCount=0;path=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection5/data/index;done=false>>] [junit4] 2> 451937 INFO (coreCloseExecutor-1720-thread-1-processing-x:collection4) [ x:collection1] o.a.s.c.CachingDirectoryFactory looking to close /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection1/data/index [CachedDir<<refCount=0;path=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection1/data/index;done=false>>] [junit4] 2> 451937 INFO (coreCloseExecutor-1720-thread-2-processing-x:collection4) [ x:collection5] o.a.s.c.CachingDirectoryFactory Closing directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection5/data/index [junit4] 2> 451938 INFO (coreCloseExecutor-1720-thread-1-processing-x:collection4) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection1/data/index [junit4] 2> 451938 INFO (coreCloseExecutor-1720-thread-3-processing-x:collection4) [ x:collection4] o.a.s.u.SolrCoreState Closing SolrCoreState [junit4] 2> 451938 INFO (coreCloseExecutor-1720-thread-3-processing-x:collection4) [ x:collection4] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached 0 - closing IndexWriter [junit4] 2> 451938 INFO (coreCloseExecutor-1720-thread-3-processing-x:collection4) [ x:collection4] o.a.s.u.DefaultSolrCoreState closing IndexWriter with IndexWriterCloser [junit4] 2> 451938 INFO (coreCloseExecutor-1720-thread-4-processing-x:collection4) [ x:collection2] o.a.s.u.SolrCoreState Closing SolrCoreState [junit4] 2> 451938 INFO (coreCloseExecutor-1720-thread-4-processing-x:collection4) [ x:collection2] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached 0 - closing IndexWriter [junit4] 2> 451938 INFO (coreCloseExecutor-1720-thread-4-processing-x:collection4) [ x:collection2] o.a.s.u.DefaultSolrCoreState closing IndexWriter with IndexWriterCloser [junit4] 2> 451939 INFO (coreCloseExecutor-1720-thread-4-processing-x:collection4) [ x:collection2] o.a.s.c.SolrCore [collection2] Closing main searcher on request. [junit4] 2> 451939 INFO (coreCloseExecutor-1720-thread-4-processing-x:collection4) [ x:collection2] o.a.s.c.CachingDirectoryFactory Closing MockDirectoryFactory - 2 directories currently being tracked [junit4] 2> 451939 INFO (coreCloseExecutor-1720-thread-4-processing-x:collection4) [ x:collection2] o.a.s.c.CachingDirectoryFactory looking to close /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection2/data [CachedDir<<refCount=0;path=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection2/data;done=false>>] [junit4] 2> 451939 INFO (coreCloseExecutor-1720-thread-4-processing-x:collection4) [ x:collection2] o.a.s.c.CachingDirectoryFactory Closing directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection2/data [junit4] 2> 451939 INFO (coreCloseExecutor-1720-thread-4-processing-x:collection4) [ x:collection2] o.a.s.c.CachingDirectoryFactory looking to close /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection2/data/index [CachedDir<<refCount=0;path=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection2/data/index;done=false>>] [junit4] 2> 451939 INFO (coreCloseExecutor-1720-thread-4-processing-x:collection4) [ x:collection2] o.a.s.c.CachingDirectoryFactory Closing directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection2/data/index [junit4] 2> 451940 INFO (coreCloseExecutor-1720-thread-3-processing-x:collection4) [ x:collection4] o.a.s.c.SolrCore [collection4] Closing main searcher on request. [junit4] 2> 451940 INFO (coreCloseExecutor-1720-thread-3-processing-x:collection4) [ x:collection4] o.a.s.c.CachingDirectoryFactory Closing MockDirectoryFactory - 2 directories currently being tracked [junit4] 2> 451940 INFO (coreCloseExecutor-1720-thread-3-processing-x:collection4) [ x:collection4] o.a.s.c.CachingDirectoryFactory looking to close /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection4/data/index [CachedDir<<refCount=0;path=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection4/data/index;done=false>>] [junit4] 2> 451940 INFO (coreCloseExecutor-1720-thread-3-processing-x:collection4) [ x:collection4] o.a.s.c.CachingDirectoryFactory Closing directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection4/data/index [junit4] 2> 451940 INFO (coreCloseExecutor-1720-thread-3-processing-x:collection4) [ x:collection4] o.a.s.c.CachingDirectoryFactory looking to close /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection4/data [CachedDir<<refCount=0;path=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection4/data;done=false>>] [junit4] 2> 451940 INFO (coreCloseExecutor-1720-thread-3-processing-x:collection4) [ x:collection4] o.a.s.c.CachingDirectoryFactory Closing directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-001/collection4/data [junit4] 2> 451940 INFO (TEST-TestLazyCores.testLazySearch-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.SolrTestCaseJ4 ###Ending testLazySearch [junit4] 2> 451944 INFO (TEST-TestLazyCores.testRace-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.SolrTestCaseJ4 ###Starting testRace [junit4] 2> 451965 INFO (TEST-TestLazyCores.testRace-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-002' [junit4] 2> 451965 INFO (TEST-TestLazyCores.testRace-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 451965 INFO (TEST-TestLazyCores.testRace-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 451965 INFO (TEST-TestLazyCores.testRace-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.c.CoreContainer New CoreContainer 1357348479 [junit4] 2> 451965 INFO (TEST-TestLazyCores.testRace-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-002] [junit4] 2> 451965 WARN (TEST-TestLazyCores.testRace-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.c.CoreContainer Couldn't add files from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-002/lib to classpath: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-002/lib [junit4] 2> 451965 INFO (TEST-TestLazyCores.testRace-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 600000,connTimeout : 60000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false, [junit4] 2> 451967 INFO (TEST-TestLazyCores.testRace-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=600000&connTimeout=60000&retry=true [junit4] 2> 451967 INFO (TEST-TestLazyCores.testRace-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.c.SolrCores Allocating transient cache for 4 transient cores [junit4] 2> 451967 INFO (TEST-TestLazyCores.testRace-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 451967 INFO (TEST-TestLazyCores.testRace-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 451968 INFO (TEST-TestLazyCores.testRace-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module. [junit4] 2> 451968 INFO (TEST-TestLazyCores.testRace-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 451968 INFO (TEST-TestLazyCores.testRace-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection1, config=solrconfig.xml, loadOnStartup=true, schema=schema.xml, configSetProperties=configsetprops.json, transient=false, dataDir=data/} [junit4] 2> 451969 INFO (TEST-TestLazyCores.testRace-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection2, config=solrconfig.xml, loadOnStartup=true, schema=schema.xml, configSetProperties=configsetprops.json, transient=true, dataDir=data/} [junit4] 2> 451969 INFO (TEST-TestLazyCores.testRace-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection3, config=solrconfig.xml, loadOnStartup=false, schema=schema.xml, configSetProperties=configsetprops.json, transient=on, dataDir=data/} [junit4] 2> 451969 INFO (TEST-TestLazyCores.testRace-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection4, config=solrconfig.xml, loadOnStartup=false, schema=schema.xml, configSetProperties=configsetprops.json, transient=false, dataDir=data/} [junit4] 2> 451969 INFO (TEST-TestLazyCores.testRace-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection5, config=solrconfig.xml, loadOnStartup=true, schema=schema.xml, configSetProperties=configsetprops.json, transient=false, dataDir=data/} [junit4] 2> 451970 INFO (TEST-TestLazyCores.testRace-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection6, config=solrconfig.xml, loadOnStartup=false, schema=schema.xml, configSetProperties=configsetprops.json, transient=true, dataDir=data/} [junit4] 2> 451970 INFO (TEST-TestLazyCores.testRace-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection7, config=solrconfig.xml, loadOnStartup=false, schema=schema.xml, configSetProperties=configsetprops.json, transient=true, dataDir=data/} [junit4] 2> 451970 INFO (TEST-TestLazyCores.testRace-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection8, config=solrconfig.xml, loadOnStartup=false, schema=schema.xml, configSetProperties=configsetprops.json, transient=true, dataDir=data/} [junit4] 2> 451970 INFO (TEST-TestLazyCores.testRace-seed#[880A3006DEC3D869]) [ x:collection4] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection9, config=solrconfig.xml, loadOnStartup=false, schema=schema.xml, configSetProperties=configsetprops.json, transient=true, dataDir=data/} [junit4] 2> 451971 INFO (coreLoadExecutor-1727-thread-1-processing-x:collection4) [ x:collection4] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-002/collection1' [junit4] 2> 451971 INFO (coreLoadExecutor-1727-thread-2-processing-x:collection4) [ x:collection4] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-002/collection2' [junit4] 2> 451971 INFO (coreLoadExecutor-1727-thread-1-processing-x:collection4) [ x:collection4] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 451971 INFO (coreLoadExecutor-1727-thread-1-processing-x:collection4) [ x:collection4] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 451971 INFO (coreLoadExecutor-1727-thread-2-processing-x:collection4) [ x:collection4] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 451971 INFO (coreLoadExecutor-1727-thread-2-processing-x:collection4) [ x:collection4] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 451976 INFO (coreLoadExecutor-1727-thread-3-processing-x:collection4) [ x:collection4] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-002/collection5' [junit4] 2> 451976 INFO (coreLoadExecutor-1727-thread-3-processing-x:collection4) [ x:collection4] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 451976 INFO (coreLoadExecutor-1727-thread-3-processing-x:collection4) [ x:collection4] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 451984 INFO (coreLoadExecutor-1727-thread-2-processing-x:collection4) [ x:collection4] o.a.s.c.SolrConfig current version of requestparams : -1 [junit4] 2> 451986 INFO (coreLoadExecutor-1727-thread-2-processing-x:collection4) [ x:collection4] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.1.0 [junit4] 2> 451987 INFO (coreLoadExecutor-1727-thread-3-processing-x:collection4) [ x:collection4] o.a.s.c.SolrConfig current version of requestparams : -1 [junit4] 2> 451990 INFO (coreLoadExecutor-1727-thread-3-processing-x:collection4) [ x:collection4] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.1.0 [junit4] 2> 451991 INFO (coreLoadExecutor-1727-thread-1-processing-x:collection4) [ x:collection4] o.a.s.c.SolrConfig current version of requestparams : -1 [junit4] 2> 451992 INFO (coreLoadExecutor-1727-thread-2-processing-x:collection4) [ x:collection4] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml [junit4] 2> 451994 INFO (coreLoadExecutor-1727-thread-1-processing-x:collection4) [ x:collection4] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.1.0 [junit4] 2> 451995 INFO (coreLoadExecutor-1727-thread-2-processing-x:collection4) [ x:collection4] o.a.s.s.IndexSchema [collection2] Schema name=tiny [junit4] 2> 451996 INFO (coreLoadExecutor-1727-thread-3-processing-x:collection4) [ x:collection4] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml [junit4] 2> 451998 INFO (coreLoadExecutor-1727-thread-2-processing-x:collection4) [ x:collection4] o.a.s.s.IndexSchema unique key field: id [junit4] 2> 451998 INFO (coreLoadExecutor-1727-thread-3-processing-x:collection4) [ x:collection4] o.a.s.s.IndexSchema [collection5] Schema name=tiny [junit4] 2> 451999 INFO (coreLoadExecutor-1727-thread-1-processing-x:collection4) [ x:collection4] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml [junit4] 2> 452000 INFO (coreLoadExecutor-1727-thread-2-processing-x:collection4) [ x:collection4] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-002/collection2' [junit4] 2> 452000 INFO (coreLoadExecutor-1727-thread-2-processing-x:collection4) [ x:collection4] o.a.s.c.CoreContainer Creating SolrCore 'collection2' using configuration from instancedir /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-002/collection2 [junit4] 2> 452000 INFO (coreLoadExecutor-1727-thread-2-processing-x:collection4) [ x:collection2] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory [junit4] 2> 452000 INFO (coreLoadExecutor-1727-thread-2-processing-x:collection4) [ x:collection2] o.a.s.c.SolrCore [[collection2] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-002/collection2], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-002/collection2/data/] [junit4] 2> 452001 INFO (coreLoadExecutor-1727-thread-2-processing-x:collection4) [ x:collection2] o.a.s.c.SolrCore JMX monitoring not detected for core: collection2 [junit4] 2> 452001 INFO (coreLoadExecutor-1727-thread-2-processing-x:collection4) [ x:collection2] o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-002/collection2/data [junit4] 2> 452001 INFO (coreLoadExecutor-1727-thread-2-processing-x:collection4) [ x:collection2] o.a.s.c.SolrCore New index directory detected: old=null new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-002/collection2/data/index/ [junit4] 2> 452001 INFO (coreLoadExecutor-1727-thread-3-processing-x:collection4) [ x:collection4] o.a.s.s.IndexSchema unique key field: id [junit4] 2> 452001 WARN (coreLoadExecutor-1727-thread-2-processing-x:collection4) [ x:collection2] o.a.s.c.SolrCore [collection2] Solr index directory '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-002/collection2/data/index' doesn't exist. Creating new index... [junit4] 2> 452001 INFO (coreLoadExecutor-1727-thread-2-processing-x:collection4) [ x:collection2] o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-002/collection2/data/index [junit4] 2> 452002 INFO (coreLoadExecutor-1727-thread-2-processing-x:collection4) [ x:collection2] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=24, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0] [junit4] 2> 452002 INFO (coreLoadExecutor-1727-thread-1-processing-x:collection4) [ x:collection4] o.a.s.s.IndexSchema [collection1] Schema name=tiny [junit4] 2> 452002 INFO (coreLoadExecutor-1727-thread-2-processing-x:collection4) [ x:collection2] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@38961c1f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ff553ce),segFN=segments_1,generation=1} [junit4] 2> 452002 INFO (coreLoadExecutor-1727-thread-2-processing-x:collection4) [ x:collection2] o.a.s.c.SolrDeletionPolicy newest commit generation = 1 [junit4] 2> 452002 INFO (coreLoadExecutor-1727-thread-3-processing-x:collection4) [ x:collection4] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-002/collection5' [junit4] 2> 452002 INFO (coreLoadExecutor-1727-thread-3-processing-x:collection4) [ x:collection4] o.a.s.c.CoreContainer Creating SolrCore 'collection5' using configuration from instancedir /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-002/collection5 [junit4] 2> 452003 INFO (coreLoadExecutor-1727-thread-3-processing-x:collection4) [ x:collection5] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory [junit4] 2> 452003 INFO (coreLoadExecutor-1727-thread-3-processing-x:collection4) [ x:collection5] o.a.s.c.SolrCore [[collection5] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-002/collection5], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-002/collection5/data/] [junit4] 2> 452003 INFO (coreLoadExecutor-1727-thread-3-processing-x:collection4) [ x:collection5] o.a.s.c.SolrCore JMX monitoring not detected for core: collection5 [junit4] 2> 452003 INFO (coreLoadExecutor-1727-thread-3-processing-x:collection4) [ x:collection5] o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-002/collection5/data [junit4] 2> 452003 INFO (coreLoadExecutor-1727-thread-3-processing-x:collection4) [ x:collection5] o.a.s.c.SolrCore New index directory detected: old=null new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-002/collection5/data/index/ [junit4] 2> 452003 WARN (coreLoadExecutor-1727-thread-3-processing-x:collection4) [ x:collection5] o.a.s.c.SolrCore [collection5] Solr index directory '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-002/collection5/data/index' doesn't exist. Creating new index... [junit4] 2> 452004 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-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-002/collection2/data/ [junit4] 2> 452004 INFO (coreLoadExecutor-1727-thread-3-processing-x:collection4) [ x:collection5] o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-002/collection5/data/index [junit4] 2> 452004 WARN (OldIndexDirectoryCleanupThreadForCore-collection2) [ x:collection2] o.a.s.c.DirectoryFactory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-002/collection2/data/ does not point to a valid data directory; skipping clean-up of old index directories. [junit4] 2> 452004 INFO (coreLoadExecutor-1727-thread-3-processing-x:collection4) [ x:collection5] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=24, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0] [junit4] 2> 452004 INFO (coreLoadExecutor-1727-thread-3-processing-x:collection4) [ x:collection5] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@5aaafa60 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@8b9b040),segFN=segments_1,generation=1} [junit4] 2> 452004 INFO (coreLoadExecutor-1727-thread-3-processing-x:collection4) [ x:collection5] o.a.s.c.SolrDeletionPolicy newest commit generation = 1 [junit4] 2> 452005 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-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-002/collection5/data/ [junit4] 2> 452005 WARN (OldIndexDirectoryCleanupThreadForCore-collection5) [ x:collection5] o.a.s.c.DirectoryFactory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.core.TestLazyCores_880A3006DEC3D869-001/tempDir-002/collection5/data/ does not point to a valid data directory; skipping clean-up of old index directories. [junit4] 2> 452006 INFO (coreLoadExecutor-1727-thread-2-processing-x:collection4) [ x:collection2] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 452006 INFO (coreLoadExecutor-1727-thread-3-processing-x:collection4) [ x:collection5] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 452008 INFO (coreLoadExecutor-1727-thread-2-processing-x:collection4) [ x:collection2] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 452 [...truncated too long message...] it4] 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:665) [junit4] 2> at org.apache.solr.core.SolrCore.<init>(SolrCore.java:642) [junit4] 2> at org.apache.solr.core.CoreContainer.create(CoreContainer.java:815) [junit4] 2> at org.apache.solr.core.CoreContainer.access$000(CoreContainer.java:88) [junit4] 2> at org.apache.solr.core.CoreContainer$1.call(CoreContainer.java:468) [junit4] 2> at org.apache.solr.core.CoreContainer$1.call(CoreContainer.java:459) [junit4] 2> at java.util.concurrent.FutureTask.run(FutureTask.java:266) [junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$6(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> Mar 14, 2016 10:47:57 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks [junit4] 2> WARNING: Will linger awaiting termination of 1 leaked thread(s). [junit4] 2> Mar 14, 2016 10:48:17 PM 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=3677, name=searcherExecutor-1773-thread-1, state=WAITING, group=TGRP-TestLazyCores] [junit4] 2> at sun.misc.Unsafe.park(Native Method) [junit4] 2> at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) [junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039) [junit4] 2> at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [junit4] 2> at java.lang.Thread.run(Thread.java:745) [junit4] 2> Mar 14, 2016 10:48:17 PM com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll [junit4] 2> INFO: Starting to interrupt leaked threads: [junit4] 2> 1) Thread[id=3677, name=searcherExecutor-1773-thread-1, state=WAITING, group=TGRP-TestLazyCores] [junit4] 2> Mar 14, 2016 10:48:20 PM com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll [junit4] 2> SEVERE: There are still zombie threads that couldn't be terminated: [junit4] 2> 1) Thread[id=3677, name=searcherExecutor-1773-thread-1, state=WAITING, group=TGRP-TestLazyCores] [junit4] 2> at sun.misc.Unsafe.park(Native Method) [junit4] 2> at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) [junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039) [junit4] 2> at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [junit4] 2> at java.lang.Thread.run(Thread.java:745) [junit4] 2> NOTE: test params are: codec=Asserting(Lucene60): {v_t=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), id=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), v_s=PostingsFormat(name=MockRandom), v_f=PostingsFormat(name=Asserting)}, docValues:{}, maxPointsInLeafNode=838, maxMBSortInHeap=6.295180489247228, sim=ClassicSimilarity, locale=sr-ME, timezone=Asia/Katmandu [junit4] 2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation 1.8.0_66 (64-bit)/cpus=4,threads=2,free=257726880,total=513277952 [junit4] 2> NOTE: All tests run in this JVM: [TestValueSourceCache, TestFoldingMultitermQuery, SyncSliceTest, TestDynamicLoading, ZkNodePropsTest, CursorPagingTest, DefaultValueUpdateProcessorTest, TestTrieFacet, TlogReplayBufferedWhileIndexingTest, BasicDistributedZkTest, DistribCursorPagingTest, TestHashQParserPlugin, PrimUtilsTest, TestConfig, TestAnalyzedSuggestions, SignatureUpdateProcessorFactoryTest, JsonLoaderTest, RestartWhileUpdatingTest, BlockJoinFacetSimpleTest, HdfsChaosMonkeySafeLeaderTest, TestConfigSetImmutable, TestQueryWrapperFilter, HdfsDirectoryFactoryTest, TestCustomSort, DisMaxRequestHandlerTest, LeaderElectionIntegrationTest, TestShortCircuitedRequests, SpatialHeatmapFacetsTest, TestSolr4Spatial, BitVectorTest, TestPhraseSuggestions, TestMiniSolrCloudClusterSSL, TestFaceting, DistributedSpellCheckComponentTest, TestBlendedInfixSuggestions, TestLazyCores] [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestLazyCores -Dtests.seed=880A3006DEC3D869 -Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=sr-ME -Dtests.timezone=Asia/Katmandu -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!!! [SolrCore, MockDirectoryWrapper, MockDirectoryWrapper, MDCAwareThreadPoolExecutor] [junit4] > at __randomizedtesting.SeedInfo.seed([880A3006DEC3D869]:0) [junit4] > at org.apache.solr.SolrTestCaseJ4.afterClass(SolrTestCaseJ4.java:238) [junit4] > at java.lang.Thread.run(Thread.java:745)Throwable #2: com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE scope at org.apache.solr.core.TestLazyCores: [junit4] > 1) Thread[id=3677, name=searcherExecutor-1773-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([880A3006DEC3D869]:0)Throwable #3: com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie threads that couldn't be terminated: [junit4] > 1) Thread[id=3677, name=searcherExecutor-1773-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([880A3006DEC3D869]:0) [junit4] Completed [164/579 (1!)] on J0 in 148.47s, 8 tests, 1 failure, 2 errors <<< FAILURES! [...truncated 1304 lines...] BUILD FAILED /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/build.xml:740: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/build.xml:684: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/build.xml:59: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build.xml:233: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/common-build.xml:524: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/lucene/common-build.xml:1457: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/lucene/common-build.xml:1014: There were test failures: 579 suites (10 ignored), 2314 tests, 3 suite-level errors, 1295 ignored (65 assumptions) [seed: 880A3006DEC3D869] Total time: 44 minutes 54 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
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org