You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2017/10/02 08:27:11 UTC
[JENKINS] Lucene-Solr-master-Linux (64bit/jdk1.8.0_144) - Build #
20593 - Failure!
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/20593/
Java: 64bit/jdk1.8.0_144 -XX:+UseCompressedOops -XX:+UseConcMarkSweepGC
3 tests failed.
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=20321, name=searcherExecutor-5815-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:1074) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE scope at org.apache.solr.core.TestLazyCores:
1) Thread[id=20321, name=searcherExecutor-5815-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:1074)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
at __randomizedtesting.SeedInfo.seed([71B3730F6B051170]: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=20321, name=searcherExecutor-5815-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:1074) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie threads that couldn't be terminated:
1) Thread[id=20321, name=searcherExecutor-5815-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:1074)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
at __randomizedtesting.SeedInfo.seed([71B3730F6B051170]:0)
FAILED: org.apache.solr.core.TestLazyCores.testNoCommit
Error Message:
Exception during query
Stack Trace:
java.lang.RuntimeException: Exception during query
at __randomizedtesting.SeedInfo.seed([71B3730F6B051170:AED3D2DEA02272D5]:0)
at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:884)
at org.apache.solr.core.TestLazyCores.check10(TestLazyCores.java:847)
at org.apache.solr.core.TestLazyCores.testNoCommit(TestLazyCores.java:829)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
Caused by: java.lang.RuntimeException: REQUEST FAILED: xpath=//result[@numFound='10']
xml response was: <?xml version="1.0" encoding="UTF-8"?>
<response>
<lst name="responseHeader"><int name="status">0</int><int name="QTime">1</int><lst name="params"><str name="q">*:*</str></lst></lst><result name="response" numFound="0" start="0"></result>
</response>
request was:q=*:*
at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:877)
... 41 more
Build Log:
[...truncated 12892 lines...]
[junit4] Suite: org.apache.solr.core.TestLazyCores
[junit4] 2> 1410062 INFO (SUITE-TestLazyCores-seed#[71B3730F6B051170]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/init-core-data-001
[junit4] 2> 1410062 WARN (SUITE-TestLazyCores-seed#[71B3730F6B051170]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=39 numCloses=39
[junit4] 2> 1410063 INFO (SUITE-TestLazyCores-seed#[71B3730F6B051170]-worker) [ ] o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 1410064 INFO (SUITE-TestLazyCores-seed#[71B3730F6B051170]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 1410066 INFO (TEST-TestLazyCores.testLazyLoad-seed#[71B3730F6B051170]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testLazyLoad
[junit4] 2> 1410083 INFO (TEST-TestLazyCores.testLazyLoad-seed#[71B3730F6B051170]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-001/solr.xml
[junit4] 2> 1410087 INFO (TEST-TestLazyCores.testLazyLoad-seed#[71B3730F6B051170]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@36f3e7d1, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 1410131 INFO (TEST-TestLazyCores.testLazyLoad-seed#[71B3730F6B051170]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@36f3e7d1
[junit4] 2> 1410141 INFO (TEST-TestLazyCores.testLazyLoad-seed#[71B3730F6B051170]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@36f3e7d1
[junit4] 2> 1410142 INFO (TEST-TestLazyCores.testLazyLoad-seed#[71B3730F6B051170]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@36f3e7d1
[junit4] 2> 1410158 INFO (TEST-TestLazyCores.testLazyLoad-seed#[71B3730F6B051170]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 1410168 INFO (coreLoadExecutor-5662-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 1410189 INFO (coreLoadExecutor-5662-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=tiny
[junit4] 2> 1410191 INFO (coreLoadExecutor-5662-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema tiny/1.1 with uniqueid field id
[junit4] 2> 1410191 INFO (coreLoadExecutor-5662-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-001/./collection1, trusted=true
[junit4] 2> 1410191 INFO (coreLoadExecutor-5662-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@36f3e7d1
[junit4] 2> 1410192 INFO (coreLoadExecutor-5662-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1410192 INFO (coreLoadExecutor-5662-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-001/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-001/./collection1/data/]
[junit4] 2> 1410194 INFO (coreLoadExecutor-5662-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=32, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 1410208 INFO (coreLoadExecutor-5662-thread-2) [ x:collection2] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 1410211 INFO (coreLoadExecutor-5662-thread-2) [ x:collection2] o.a.s.s.IndexSchema [collection2] Schema name=tiny
[junit4] 2> 1410212 INFO (coreLoadExecutor-5662-thread-2) [ x:collection2] o.a.s.s.IndexSchema Loaded schema tiny/1.1 with uniqueid field id
[junit4] 2> 1410212 INFO (coreLoadExecutor-5662-thread-2) [ x:collection2] o.a.s.c.CoreContainer Creating SolrCore 'collection2' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-001/./collection2, trusted=true
[junit4] 2> 1410212 INFO (coreLoadExecutor-5662-thread-3) [ x:collection5] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 1410213 INFO (coreLoadExecutor-5662-thread-2) [ x:collection2] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection2' (registry 'solr.core.collection2') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@36f3e7d1
[junit4] 2> 1410213 INFO (coreLoadExecutor-5662-thread-2) [ x:collection2] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1410213 INFO (coreLoadExecutor-5662-thread-2) [ x:collection2] o.a.s.c.SolrCore [[collection2] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-001/collection2], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-001/./collection2/data/]
[junit4] 2> 1410215 INFO (coreLoadExecutor-5662-thread-2) [ x:collection2] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=32, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 1410217 INFO (coreLoadExecutor-5662-thread-3) [ x:collection5] o.a.s.s.IndexSchema [collection5] Schema name=tiny
[junit4] 2> 1410219 INFO (coreLoadExecutor-5662-thread-3) [ x:collection5] o.a.s.s.IndexSchema Loaded schema tiny/1.1 with uniqueid field id
[junit4] 2> 1410219 INFO (coreLoadExecutor-5662-thread-3) [ x:collection5] o.a.s.c.CoreContainer Creating SolrCore 'collection5' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-001/./collection5, trusted=true
[junit4] 2> 1410219 INFO (coreLoadExecutor-5662-thread-3) [ x:collection5] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection5' (registry 'solr.core.collection5') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@36f3e7d1
[junit4] 2> 1410219 INFO (coreLoadExecutor-5662-thread-3) [ x:collection5] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1410219 INFO (coreLoadExecutor-5662-thread-3) [ x:collection5] o.a.s.c.SolrCore [[collection5] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-001/collection5], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-001/./collection5/data/]
[junit4] 2> 1410220 INFO (coreLoadExecutor-5662-thread-3) [ x:collection5] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=32, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 1410282 INFO (coreLoadExecutor-5662-thread-2) [ x:collection2] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1410282 INFO (coreLoadExecutor-5662-thread-2) [ x:collection2] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1410283 INFO (coreLoadExecutor-5662-thread-2) [ x:collection2] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=18, maxMergeAtOnceExplicit=39, maxMergedSegmentMB=36.9541015625, floorSegmentMB=0.9619140625, forceMergeDeletesPctAllowed=28.725589271660635, segmentsPerTier=38.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.8456667067745006
[junit4] 2> 1410284 INFO (coreLoadExecutor-5662-thread-2) [ x:collection2] o.a.s.s.SolrIndexSearcher Opening [Searcher@7ed7e3c0[collection2] main]
[junit4] 2> 1410284 INFO (coreLoadExecutor-5662-thread-2) [ x:collection2] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-001/collection2/conf
[junit4] 2> 1410285 INFO (coreLoadExecutor-5662-thread-2) [ x:collection2] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1410286 INFO (searcherExecutor-5664-thread-1-processing-x:collection2) [ x:collection2] o.a.s.c.SolrCore [collection2] Registered new searcher Searcher@7ed7e3c0[collection2] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1410290 INFO (coreLoadExecutor-5662-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1410290 INFO (coreLoadExecutor-5662-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1410291 INFO (coreLoadExecutor-5662-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=18, maxMergeAtOnceExplicit=39, maxMergedSegmentMB=36.9541015625, floorSegmentMB=0.9619140625, forceMergeDeletesPctAllowed=28.725589271660635, segmentsPerTier=38.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.8456667067745006
[junit4] 2> 1410292 INFO (coreLoadExecutor-5662-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@3b07819c[collection1] main]
[junit4] 2> 1410292 INFO (coreLoadExecutor-5662-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-001/collection1/conf
[junit4] 2> 1410293 INFO (coreLoadExecutor-5662-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1410293 INFO (searcherExecutor-5663-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@3b07819c[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1410295 INFO (coreLoadExecutor-5662-thread-3) [ x:collection5] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1410295 INFO (coreLoadExecutor-5662-thread-3) [ x:collection5] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1410296 INFO (coreLoadExecutor-5662-thread-3) [ x:collection5] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=18, maxMergeAtOnceExplicit=39, maxMergedSegmentMB=36.9541015625, floorSegmentMB=0.9619140625, forceMergeDeletesPctAllowed=28.725589271660635, segmentsPerTier=38.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.8456667067745006
[junit4] 2> 1410297 INFO (coreLoadExecutor-5662-thread-3) [ x:collection5] o.a.s.s.SolrIndexSearcher Opening [Searcher@672eb83e[collection5] main]
[junit4] 2> 1410297 INFO (coreLoadExecutor-5662-thread-3) [ x:collection5] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-001/collection5/conf
[junit4] 2> 1410298 INFO (coreLoadExecutor-5662-thread-3) [ x:collection5] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1410299 INFO (searcherExecutor-5665-thread-1-processing-x:collection5) [ x:collection5] o.a.s.c.SolrCore [collection5] Registered new searcher Searcher@672eb83e[collection5] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1410309 INFO (TEST-TestLazyCores.testLazyLoad-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 1410315 INFO (TEST-TestLazyCores.testLazyLoad-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.s.IndexSchema [collection3] Schema name=tiny
[junit4] 2> 1410317 INFO (TEST-TestLazyCores.testLazyLoad-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.s.IndexSchema Loaded schema tiny/1.1 with uniqueid field id
[junit4] 2> 1410317 INFO (TEST-TestLazyCores.testLazyLoad-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.c.CoreContainer Creating SolrCore 'collection3' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-001/./collection3, trusted=true
[junit4] 2> 1410317 INFO (TEST-TestLazyCores.testLazyLoad-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection3' (registry 'solr.core.collection3') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@36f3e7d1
[junit4] 2> 1410317 INFO (TEST-TestLazyCores.testLazyLoad-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1410317 INFO (TEST-TestLazyCores.testLazyLoad-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.c.SolrCore [[collection3] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-001/collection3], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-001/./collection3/data/]
[junit4] 2> 1410320 INFO (TEST-TestLazyCores.testLazyLoad-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@41dbc219
[junit4] 2> 1410373 INFO (TEST-TestLazyCores.testLazyLoad-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1410373 INFO (TEST-TestLazyCores.testLazyLoad-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1410375 INFO (TEST-TestLazyCores.testLazyLoad-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=788734717, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
[junit4] 2> 1410375 INFO (TEST-TestLazyCores.testLazyLoad-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.s.SolrIndexSearcher Opening [Searcher@7fb0795a[collection3] main]
[junit4] 2> 1410376 INFO (TEST-TestLazyCores.testLazyLoad-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-001/collection3/conf
[junit4] 2> 1410376 INFO (TEST-TestLazyCores.testLazyLoad-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1410378 INFO (searcherExecutor-5675-thread-1-processing-x:collection3) [ x:collection3] o.a.s.c.SolrCore [collection3] Registered new searcher Searcher@7fb0795a[collection3] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1410384 INFO (TEST-TestLazyCores.testLazyLoad-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 1410388 INFO (TEST-TestLazyCores.testLazyLoad-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.s.IndexSchema [collection4] Schema name=tiny
[junit4] 2> 1410389 INFO (TEST-TestLazyCores.testLazyLoad-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.s.IndexSchema Loaded schema tiny/1.1 with uniqueid field id
[junit4] 2> 1410389 INFO (TEST-TestLazyCores.testLazyLoad-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.c.CoreContainer Creating SolrCore 'collection4' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-001/./collection4, trusted=true
[junit4] 2> 1410390 INFO (TEST-TestLazyCores.testLazyLoad-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection4' (registry 'solr.core.collection4') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@36f3e7d1
[junit4] 2> 1410390 INFO (TEST-TestLazyCores.testLazyLoad-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1410390 INFO (TEST-TestLazyCores.testLazyLoad-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.c.SolrCore [[collection4] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-001/collection4], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-001/./collection4/data/]
[junit4] 2> 1410392 INFO (TEST-TestLazyCores.testLazyLoad-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=1608511632, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
[junit4] 2> 1410451 INFO (TEST-TestLazyCores.testLazyLoad-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1410451 INFO (TEST-TestLazyCores.testLazyLoad-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1410452 INFO (TEST-TestLazyCores.testLazyLoad-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=1560008162, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
[junit4] 2> 1410453 INFO (TEST-TestLazyCores.testLazyLoad-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.s.SolrIndexSearcher Opening [Searcher@57901367[collection4] main]
[junit4] 2> 1410453 INFO (TEST-TestLazyCores.testLazyLoad-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-001/collection4/conf
[junit4] 2> 1410454 INFO (TEST-TestLazyCores.testLazyLoad-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1410454 INFO (TEST-TestLazyCores.testLazyLoad-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1611518897
[junit4] 2> 1410454 INFO (TEST-TestLazyCores.testLazyLoad-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 1410455 INFO (TEST-TestLazyCores.testLazyLoad-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@55497295: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@4dcec2ba
[junit4] 2> 1410455 INFO (searcherExecutor-5679-thread-1-processing-x:collection3) [ x:collection3] o.a.s.c.SolrCore [collection4] Registered new searcher Searcher@57901367[collection4] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1410459 INFO (TEST-TestLazyCores.testLazyLoad-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 1410459 INFO (TEST-TestLazyCores.testLazyLoad-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@55e409d7: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@1f6084f7
[junit4] 2> 1410463 INFO (TEST-TestLazyCores.testLazyLoad-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 1410463 INFO (TEST-TestLazyCores.testLazyLoad-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@550a12a9: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@304f802e
[junit4] 2> 1410464 INFO (coreCloseExecutor-5683-thread-1-processing-x:collection3) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@34d76a9e
[junit4] 2> 1410464 INFO (coreCloseExecutor-5683-thread-1-processing-x:collection3) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=886532766
[junit4] 2> 1410464 INFO (coreCloseExecutor-5683-thread-1-processing-x:collection3) [ x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@3866c532: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@2831b48c
[junit4] 2> 1410473 INFO (coreCloseExecutor-5683-thread-3-processing-x:collection3) [ x:collection4] o.a.s.c.SolrCore [collection4] CLOSING SolrCore org.apache.solr.core.SolrCore@4bc4dbaa
[junit4] 2> 1410473 INFO (coreCloseExecutor-5683-thread-3-processing-x:collection3) [ x:collection4] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection4, tag=1271192490
[junit4] 2> 1410474 INFO (coreCloseExecutor-5683-thread-3-processing-x:collection3) [ x:collection4] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@8c8c3b4: rootName = null, domain = solr.core.collection4, service url = null, agent id = null] for registry solr.core.collection4 / com.codahale.metrics.MetricRegistry@cd4becc
[junit4] 2> 1410475 INFO (coreCloseExecutor-5683-thread-4-processing-x:collection3) [ x:collection2] o.a.s.c.SolrCore [collection2] CLOSING SolrCore org.apache.solr.core.SolrCore@6078c7d7
[junit4] 2> 1410475 INFO (coreCloseExecutor-5683-thread-2-processing-x:collection3) [ x:collection5] o.a.s.c.SolrCore [collection5] CLOSING SolrCore org.apache.solr.core.SolrCore@79a543c9
[junit4] 2> 1410489 INFO (coreCloseExecutor-5683-thread-5-processing-x:collection3) [ x:collection3] o.a.s.c.SolrCore [collection3] CLOSING SolrCore org.apache.solr.core.SolrCore@3434b932
[junit4] 2> 1410494 INFO (coreCloseExecutor-5683-thread-4-processing-x:collection3) [ x:collection2] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection2, tag=1618528215
[junit4] 2> 1410494 INFO (coreCloseExecutor-5683-thread-4-processing-x:collection3) [ x:collection2] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@4c685c25: rootName = null, domain = solr.core.collection2, service url = null, agent id = null] for registry solr.core.collection2 / com.codahale.metrics.MetricRegistry@3cbdb721
[junit4] 2> 1410501 INFO (coreCloseExecutor-5683-thread-5-processing-x:collection3) [ x:collection3] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection3, tag=875870514
[junit4] 2> 1410502 INFO (coreCloseExecutor-5683-thread-5-processing-x:collection3) [ x:collection3] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@7a695c4d: rootName = null, domain = solr.core.collection3, service url = null, agent id = null] for registry solr.core.collection3 / com.codahale.metrics.MetricRegistry@694d1ea7
[junit4] 2> 1410544 INFO (coreCloseExecutor-5683-thread-2-processing-x:collection3) [ x:collection5] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection5, tag=2040873929
[junit4] 2> 1410546 INFO (coreCloseExecutor-5683-thread-2-processing-x:collection3) [ x:collection5] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@7f8884d6: rootName = null, domain = solr.core.collection5, service url = null, agent id = null] for registry solr.core.collection5 / com.codahale.metrics.MetricRegistry@31c7575c
[junit4] 2> 1410553 INFO (TEST-TestLazyCores.testLazyLoad-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.SolrTestCaseJ4 ###Ending testLazyLoad
[junit4] 2> 1410556 INFO (TEST-TestLazyCores.testLazySearch-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.SolrTestCaseJ4 ###Starting testLazySearch
[junit4] 2> 1410568 INFO (TEST-TestLazyCores.testLazySearch-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-002/solr.xml
[junit4] 2> 1410572 INFO (TEST-TestLazyCores.testLazySearch-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@36f3e7d1, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 1410616 INFO (TEST-TestLazyCores.testLazySearch-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@36f3e7d1
[junit4] 2> 1410626 INFO (TEST-TestLazyCores.testLazySearch-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@36f3e7d1
[junit4] 2> 1410627 INFO (TEST-TestLazyCores.testLazySearch-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@36f3e7d1
[junit4] 2> 1410629 INFO (TEST-TestLazyCores.testLazySearch-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 1410640 INFO (coreLoadExecutor-5690-thread-1-processing-x:collection3) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 1410640 INFO (coreLoadExecutor-5690-thread-2-processing-x:collection3) [ x:collection2] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 1410640 INFO (coreLoadExecutor-5690-thread-3-processing-x:collection3) [ x:collection5] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 1410647 INFO (coreLoadExecutor-5690-thread-3-processing-x:collection3) [ x:collection5] o.a.s.s.IndexSchema [collection5] Schema name=tiny
[junit4] 2> 1410647 INFO (coreLoadExecutor-5690-thread-2-processing-x:collection3) [ x:collection2] o.a.s.s.IndexSchema [collection2] Schema name=tiny
[junit4] 2> 1410647 INFO (coreLoadExecutor-5690-thread-1-processing-x:collection3) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=tiny
[junit4] 2> 1410664 INFO (coreLoadExecutor-5690-thread-3-processing-x:collection3) [ x:collection5] o.a.s.s.IndexSchema Loaded schema tiny/1.1 with uniqueid field id
[junit4] 2> 1410664 INFO (coreLoadExecutor-5690-thread-1-processing-x:collection3) [ x:collection1] o.a.s.s.IndexSchema Loaded schema tiny/1.1 with uniqueid field id
[junit4] 2> 1410664 INFO (coreLoadExecutor-5690-thread-3-processing-x:collection3) [ x:collection5] o.a.s.c.CoreContainer Creating SolrCore 'collection5' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-002/./collection5, trusted=true
[junit4] 2> 1410664 INFO (coreLoadExecutor-5690-thread-1-processing-x:collection3) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-002/./collection1, trusted=true
[junit4] 2> 1410664 INFO (coreLoadExecutor-5690-thread-2-processing-x:collection3) [ x:collection2] o.a.s.s.IndexSchema Loaded schema tiny/1.1 with uniqueid field id
[junit4] 2> 1410665 INFO (coreLoadExecutor-5690-thread-2-processing-x:collection3) [ x:collection2] o.a.s.c.CoreContainer Creating SolrCore 'collection2' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-002/./collection2, trusted=true
[junit4] 2> 1410665 INFO (coreLoadExecutor-5690-thread-2-processing-x:collection3) [ x:collection2] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection2' (registry 'solr.core.collection2') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@36f3e7d1
[junit4] 2> 1410665 INFO (coreLoadExecutor-5690-thread-3-processing-x:collection3) [ x:collection5] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection5' (registry 'solr.core.collection5') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@36f3e7d1
[junit4] 2> 1410665 INFO (coreLoadExecutor-5690-thread-2-processing-x:collection3) [ x:collection2] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1410665 INFO (coreLoadExecutor-5690-thread-1-processing-x:collection3) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@36f3e7d1
[junit4] 2> 1410665 INFO (coreLoadExecutor-5690-thread-3-processing-x:collection3) [ x:collection5] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1410665 INFO (coreLoadExecutor-5690-thread-2-processing-x:collection3) [ x:collection2] o.a.s.c.SolrCore [[collection2] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-002/collection2], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-002/./collection2/data/]
[junit4] 2> 1410665 INFO (coreLoadExecutor-5690-thread-3-processing-x:collection3) [ x:collection5] o.a.s.c.SolrCore [[collection5] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-002/collection5], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-002/./collection5/data/]
[junit4] 2> 1410665 INFO (coreLoadExecutor-5690-thread-1-processing-x:collection3) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1410665 INFO (coreLoadExecutor-5690-thread-1-processing-x:collection3) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-002/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-002/./collection1/data/]
[junit4] 2> 1410667 INFO (coreLoadExecutor-5690-thread-2-processing-x:collection3) [ x:collection2] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=32, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 1410667 INFO (coreLoadExecutor-5690-thread-1-processing-x:collection3) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=32, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 1410667 INFO (coreLoadExecutor-5690-thread-3-processing-x:collection3) [ x:collection5] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=32, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 1410721 INFO (coreLoadExecutor-5690-thread-1-processing-x:collection3) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1410721 INFO (coreLoadExecutor-5690-thread-1-processing-x:collection3) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1410722 INFO (coreLoadExecutor-5690-thread-1-processing-x:collection3) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=18, maxMergeAtOnceExplicit=39, maxMergedSegmentMB=36.9541015625, floorSegmentMB=0.9619140625, forceMergeDeletesPctAllowed=28.725589271660635, segmentsPerTier=38.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.8456667067745006
[junit4] 2> 1410722 INFO (coreLoadExecutor-5690-thread-1-processing-x:collection3) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@5b72b08c[collection1] main]
[junit4] 2> 1410722 INFO (coreLoadExecutor-5690-thread-1-processing-x:collection3) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-002/collection1/conf
[junit4] 2> 1410723 INFO (coreLoadExecutor-5690-thread-1-processing-x:collection3) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1410724 INFO (searcherExecutor-5692-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@5b72b08c[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1410727 INFO (coreLoadExecutor-5690-thread-2-processing-x:collection3) [ x:collection2] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1410727 INFO (coreLoadExecutor-5690-thread-2-processing-x:collection3) [ x:collection2] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1410728 INFO (coreLoadExecutor-5690-thread-2-processing-x:collection3) [ x:collection2] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=18, maxMergeAtOnceExplicit=39, maxMergedSegmentMB=36.9541015625, floorSegmentMB=0.9619140625, forceMergeDeletesPctAllowed=28.725589271660635, segmentsPerTier=38.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.8456667067745006
[junit4] 2> 1410728 INFO (coreLoadExecutor-5690-thread-2-processing-x:collection3) [ x:collection2] o.a.s.s.SolrIndexSearcher Opening [Searcher@2d633c38[collection2] main]
[junit4] 2> 1410729 INFO (coreLoadExecutor-5690-thread-3-processing-x:collection3) [ x:collection5] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1410729 INFO (coreLoadExecutor-5690-thread-2-processing-x:collection3) [ x:collection2] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-002/collection2/conf
[junit4] 2> 1410729 INFO (coreLoadExecutor-5690-thread-3-processing-x:collection3) [ x:collection5] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1410729 INFO (coreLoadExecutor-5690-thread-2-processing-x:collection3) [ x:collection2] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1410729 INFO (coreLoadExecutor-5690-thread-3-processing-x:collection3) [ x:collection5] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=18, maxMergeAtOnceExplicit=39, maxMergedSegmentMB=36.9541015625, floorSegmentMB=0.9619140625, forceMergeDeletesPctAllowed=28.725589271660635, segmentsPerTier=38.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.8456667067745006
[junit4] 2> 1410730 INFO (coreLoadExecutor-5690-thread-3-processing-x:collection3) [ x:collection5] o.a.s.s.SolrIndexSearcher Opening [Searcher@1e57d1e3[collection5] main]
[junit4] 2> 1410730 INFO (searcherExecutor-5693-thread-1-processing-x:collection2) [ x:collection2] o.a.s.c.SolrCore [collection2] Registered new searcher Searcher@2d633c38[collection2] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1410730 INFO (coreLoadExecutor-5690-thread-3-processing-x:collection3) [ x:collection5] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-002/collection5/conf
[junit4] 2> 1410730 INFO (coreLoadExecutor-5690-thread-3-processing-x:collection3) [ x:collection5] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1410731 INFO (searcherExecutor-5691-thread-1-processing-x:collection5) [ x:collection5] o.a.s.c.SolrCore [collection5] Registered new searcher Searcher@1e57d1e3[collection5] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1410740 INFO (TEST-TestLazyCores.testLazySearch-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 1410747 INFO (TEST-TestLazyCores.testLazySearch-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.s.IndexSchema [collection4] Schema name=tiny
[junit4] 2> 1410749 INFO (TEST-TestLazyCores.testLazySearch-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.s.IndexSchema Loaded schema tiny/1.1 with uniqueid field id
[junit4] 2> 1410749 INFO (TEST-TestLazyCores.testLazySearch-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.c.CoreContainer Creating SolrCore 'collection4' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-002/./collection4, trusted=true
[junit4] 2> 1410749 INFO (TEST-TestLazyCores.testLazySearch-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection4' (registry 'solr.core.collection4') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@36f3e7d1
[junit4] 2> 1410750 INFO (TEST-TestLazyCores.testLazySearch-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1410750 INFO (TEST-TestLazyCores.testLazySearch-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.c.SolrCore [[collection4] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-002/collection4], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-002/./collection4/data/]
[junit4] 2> 1410753 INFO (TEST-TestLazyCores.testLazySearch-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=13, maxMergeAtOnceExplicit=24, maxMergedSegmentMB=82.244140625, floorSegmentMB=0.9619140625, forceMergeDeletesPctAllowed=23.328909937947873, segmentsPerTier=43.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.4732662365510557
[junit4] 2> 1410834 INFO (TEST-TestLazyCores.testLazySearch-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1410834 INFO (TEST-TestLazyCores.testLazySearch-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1410835 INFO (TEST-TestLazyCores.testLazySearch-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=31, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.28593886496642285]
[junit4] 2> 1410835 INFO (TEST-TestLazyCores.testLazySearch-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.s.SolrIndexSearcher Opening [Searcher@7d53e658[collection4] main]
[junit4] 2> 1410836 INFO (TEST-TestLazyCores.testLazySearch-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-002/collection4/conf
[junit4] 2> 1410836 INFO (TEST-TestLazyCores.testLazySearch-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1410837 INFO (TEST-TestLazyCores.testLazySearch-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1410837 INFO (TEST-TestLazyCores.testLazySearch-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@235e45f4 commitCommandVersion:0
[junit4] 2> 1410838 INFO (searcherExecutor-5703-thread-1-processing-x:collection3) [ x:collection3] o.a.s.c.SolrCore [collection4] Registered new searcher Searcher@7d53e658[collection4] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1410870 INFO (TEST-TestLazyCores.testLazySearch-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.s.SolrIndexSearcher Opening [Searcher@791e1f1c[collection4] main]
[junit4] 2> 1410871 INFO (TEST-TestLazyCores.testLazySearch-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1410872 INFO (searcherExecutor-5703-thread-1-processing-x:collection3) [ x:collection3] o.a.s.c.SolrCore [collection4] Registered new searcher Searcher@791e1f1c[collection4] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):c7)))}
[junit4] 2> 1410873 INFO (TEST-TestLazyCores.testLazySearch-seed#[71B3730F6B051170]) [ x:collection3] 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> 1410875 INFO (TEST-TestLazyCores.testLazySearch-seed#[71B3730F6B051170]) [ x:collection3] 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> 1410876 INFO (TEST-TestLazyCores.testLazySearch-seed#[71B3730F6B051170]) [ x:collection3] 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> 1410876 INFO (TEST-TestLazyCores.testLazySearch-seed#[71B3730F6B051170]) [ x:collection3] 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> 1410876 INFO (TEST-TestLazyCores.testLazySearch-seed#[71B3730F6B051170]) [ x:collection3] 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> 1410876 INFO (TEST-TestLazyCores.testLazySearch-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.c.CoreContainer Shutting down CoreContainer instance=220443246
[junit4] 2> 1410876 INFO (TEST-TestLazyCores.testLazySearch-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 1410876 INFO (TEST-TestLazyCores.testLazySearch-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1518a5a9: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@3fdfd389
[junit4] 2> 1410881 INFO (TEST-TestLazyCores.testLazySearch-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 1410881 INFO (TEST-TestLazyCores.testLazySearch-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@580a0477: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@1f6084f7
[junit4] 2> 1410885 INFO (TEST-TestLazyCores.testLazySearch-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 1410885 INFO (TEST-TestLazyCores.testLazySearch-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@703d4ec5: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@304f802e
[junit4] 2> 1410900 INFO (coreCloseExecutor-5707-thread-2-processing-x:collection3) [ x:collection5] o.a.s.c.SolrCore [collection5] CLOSING SolrCore org.apache.solr.core.SolrCore@5892057d
[junit4] 2> 1410900 INFO (coreCloseExecutor-5707-thread-2-processing-x:collection3) [ x:collection5] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection5, tag=1485964669
[junit4] 2> 1410900 INFO (coreCloseExecutor-5707-thread-2-processing-x:collection3) [ x:collection5] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@4b58765a: rootName = null, domain = solr.core.collection5, service url = null, agent id = null] for registry solr.core.collection5 / com.codahale.metrics.MetricRegistry@6326b266
[junit4] 2> 1410903 INFO (coreCloseExecutor-5707-thread-3-processing-x:collection3) [ x:collection4] o.a.s.c.SolrCore [collection4] CLOSING SolrCore org.apache.solr.core.SolrCore@73a625a5
[junit4] 2> 1410907 INFO (coreCloseExecutor-5707-thread-1-processing-x:collection3) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@6c9b3815
[junit4] 2> 1410907 INFO (coreCloseExecutor-5707-thread-1-processing-x:collection3) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=1822111765
[junit4] 2> 1410907 INFO (coreCloseExecutor-5707-thread-1-processing-x:collection3) [ x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@75a0093b: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@66ceeec7
[junit4] 2> 1410910 INFO (coreCloseExecutor-5707-thread-4-processing-x:collection3) [ x:collection2] o.a.s.c.SolrCore [collection2] CLOSING SolrCore org.apache.solr.core.SolrCore@9e326a6
[junit4] 2> 1410916 INFO (coreCloseExecutor-5707-thread-3-processing-x:collection3) [ x:collection4] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection4, tag=1940268453
[junit4] 2> 1410916 INFO (coreCloseExecutor-5707-thread-3-processing-x:collection3) [ x:collection4] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@162900d4: rootName = null, domain = solr.core.collection4, service url = null, agent id = null] for registry solr.core.collection4 / com.codahale.metrics.MetricRegistry@487be28f
[junit4] 2> 1410925 INFO (coreCloseExecutor-5707-thread-4-processing-x:collection3) [ x:collection2] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection2, tag=165881510
[junit4] 2> 1410927 INFO (coreCloseExecutor-5707-thread-4-processing-x:collection3) [ x:collection2] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@323b397c: rootName = null, domain = solr.core.collection2, service url = null, agent id = null] for registry solr.core.collection2 / com.codahale.metrics.MetricRegistry@ce823be
[junit4] 2> 1410949 INFO (TEST-TestLazyCores.testLazySearch-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.SolrTestCaseJ4 ###Ending testLazySearch
[junit4] 2> 1410952 INFO (TEST-TestLazyCores.testRace-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.SolrTestCaseJ4 ###Starting testRace
[junit4] 2> 1410958 INFO (TEST-TestLazyCores.testRace-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-003/solr.xml
[junit4] 2> 1410961 INFO (TEST-TestLazyCores.testRace-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@36f3e7d1, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 1410983 INFO (TEST-TestLazyCores.testRace-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@36f3e7d1
[junit4] 2> 1410992 INFO (TEST-TestLazyCores.testRace-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@36f3e7d1
[junit4] 2> 1410993 INFO (TEST-TestLazyCores.testRace-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@36f3e7d1
[junit4] 2> 1410995 INFO (TEST-TestLazyCores.testRace-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 1411018 INFO (coreLoadExecutor-5714-thread-3-processing-x:collection3) [ x:collection5] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 1411018 INFO (coreLoadExecutor-5714-thread-1-processing-x:collection3) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 1411019 INFO (coreLoadExecutor-5714-thread-2-processing-x:collection3) [ x:collection2] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 1411024 INFO (coreLoadExecutor-5714-thread-3-processing-x:collection3) [ x:collection5] o.a.s.s.IndexSchema [collection5] Schema name=tiny
[junit4] 2> 1411024 INFO (coreLoadExecutor-5714-thread-1-processing-x:collection3) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=tiny
[junit4] 2> 1411026 INFO (coreLoadExecutor-5714-thread-3-processing-x:collection3) [ x:collection5] o.a.s.s.IndexSchema Loaded schema tiny/1.1 with uniqueid field id
[junit4] 2> 1411026 INFO (coreLoadExecutor-5714-thread-1-processing-x:collection3) [ x:collection1] o.a.s.s.IndexSchema Loaded schema tiny/1.1 with uniqueid field id
[junit4] 2> 1411026 INFO (coreLoadExecutor-5714-thread-3-processing-x:collection3) [ x:collection5] o.a.s.c.CoreContainer Creating SolrCore 'collection5' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-003/./collection5, trusted=true
[junit4] 2> 1411026 INFO (coreLoadExecutor-5714-thread-1-processing-x:collection3) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-003/./collection1, trusted=true
[junit4] 2> 1411026 INFO (coreLoadExecutor-5714-thread-1-processing-x:collection3) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@36f3e7d1
[junit4] 2> 1411026 INFO (coreLoadExecutor-5714-thread-3-processing-x:collection3) [ x:collection5] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection5' (registry 'solr.core.collection5') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@36f3e7d1
[junit4] 2> 1411027 INFO (coreLoadExecutor-5714-thread-1-processing-x:collection3) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1411027 INFO (coreLoadExecutor-5714-thread-3-processing-x:collection3) [ x:collection5] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1411027 INFO (coreLoadExecutor-5714-thread-1-processing-x:collection3) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-003/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-003/./collection1/data/]
[junit4] 2> 1411027 INFO (coreLoadExecutor-5714-thread-3-processing-x:collection3) [ x:collection5] o.a.s.c.SolrCore [[collection5] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-003/collection5], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-003/./collection5/data/]
[junit4] 2> 1411028 INFO (coreLoadExecutor-5714-thread-2-processing-x:collection3) [ x:collection2] o.a.s.s.IndexSchema [collection2] Schema name=tiny
[junit4] 2> 1411029 INFO (coreLoadExecutor-5714-thread-3-processing-x:collection3) [ x:collection5] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=32, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 1411029 INFO (coreLoadExecutor-5714-thread-1-processing-x:collection3) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=32, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 1411030 INFO (coreLoadExecutor-5714-thread-2-processing-x:collection3) [ x:collection2] o.a.s.s.IndexSchema Loaded schema tiny/1.1 with uniqueid field id
[junit4] 2> 1411030 INFO (coreLoadExecutor-5714-thread-2-processing-x:collection3) [ x:collection2] o.a.s.c.CoreContainer Creating SolrCore 'collection2' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-003/./collection2, trusted=true
[junit4] 2> 1411031 INFO (coreLoadExecutor-5714-thread-2-processing-x:collection3) [ x:collection2] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection2' (registry 'solr.core.collection2') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@36f3e7d1
[junit4] 2> 1411031 INFO (coreLoadExecutor-5714-thread-2-processing-x:collection3) [ x:collection2] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1411031 INFO (coreLoadExecutor-5714-thread-2-processing-x:collection3) [ x:collection2] o.a.s.c.SolrCore [[collection2] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-003/collection2], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-003/./collection2/data/]
[junit4] 2> 1411032 INFO (coreLoadExecutor-5714-thread-2-processing-x:collection3) [ x:collection2] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=32, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 1411107 INFO (coreLoadExecutor-5714-thread-1-processing-x:collection3) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1411107 INFO (coreLoadExecutor-5714-thread-1-processing-x:collection3) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1411108 INFO (coreLoadExecutor-5714-thread-3-processing-x:collection3) [ x:collection5] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1411108 INFO (coreLoadExecutor-5714-thread-3-processing-x:collection3) [ x:collection5] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1411108 INFO (coreLoadExecutor-5714-thread-1-processing-x:collection3) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=18, maxMergeAtOnceExplicit=39, maxMergedSegmentMB=36.9541015625, floorSegmentMB=0.9619140625, forceMergeDeletesPctAllowed=28.725589271660635, segmentsPerTier=38.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.8456667067745006
[junit4] 2> 1411108 INFO (coreLoadExecutor-5714-thread-3-processing-x:collection3) [ x:collection5] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=18, maxMergeAtOnceExplicit=39, maxMergedSegmentMB=36.9541015625, floorSegmentMB=0.9619140625, forceMergeDeletesPctAllowed=28.725589271660635, segmentsPerTier=38.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.8456667067745006
[junit4] 2> 1411109 INFO (coreLoadExecutor-5714-thread-1-processing-x:collection3) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@63eacfac[collection1] main]
[junit4] 2> 1411109 INFO (coreLoadExecutor-5714-thread-3-processing-x:collection3) [ x:collection5] o.a.s.s.SolrIndexSearcher Opening [Searcher@7bf0bd37[collection5] main]
[junit4] 2> 1411109 INFO (coreLoadExecutor-5714-thread-1-processing-x:collection3) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-003/collection1/conf
[junit4] 2> 1411109 INFO (coreLoadExecutor-5714-thread-3-processing-x:collection3) [ x:collection5] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-003/collection5/conf
[junit4] 2> 1411109 INFO (coreLoadExecutor-5714-thread-1-processing-x:collection3) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1411109 INFO (coreLoadExecutor-5714-thread-3-processing-x:collection3) [ x:collection5] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1411110 INFO (searcherExecutor-5716-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@63eacfac[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1411111 INFO (searcherExecutor-5715-thread-1-processing-x:collection5) [ x:collection5] o.a.s.c.SolrCore [collection5] Registered new searcher Searcher@7bf0bd37[collection5] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1411120 INFO (coreLoadExecutor-5714-thread-2-processing-x:collection3) [ x:collection2] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1411120 INFO (coreLoadExecutor-5714-thread-2-processing-x:collection3) [ x:collection2] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1411121 INFO (coreLoadExecutor-5714-thread-2-processing-x:collection3) [ x:collection2] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=18, maxMergeAtOnceExplicit=39, maxMergedSegmentMB=36.9541015625, floorSegmentMB=0.9619140625, forceMergeDeletesPctAllowed=28.725589271660635, segmentsPerTier=38.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.8456667067745006
[junit4] 2> 1411121 INFO (coreLoadExecutor-5714-thread-2-processing-x:collection3) [ x:collection2] o.a.s.s.SolrIndexSearcher Opening [Searcher@4f78c689[collection2] main]
[junit4] 2> 1411121 INFO (coreLoadExecutor-5714-thread-2-processing-x:collection3) [ x:collection2] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-003/collection2/conf
[junit4] 2> 1411122 INFO (coreLoadExecutor-5714-thread-2-processing-x:collection3) [ x:collection2] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1411124 INFO (searcherExecutor-5717-thread-1-processing-x:collection2) [ x:collection2] o.a.s.c.SolrCore [collection2] Registered new searcher Searcher@4f78c689[collection2] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1411129 INFO (Thread-2809) [ x:collection3] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 1411132 INFO (Thread-2809) [ x:collection3] o.a.s.s.IndexSchema [collection3] Schema name=tiny
[junit4] 2> 1411133 INFO (Thread-2809) [ x:collection3] o.a.s.s.IndexSchema Loaded schema tiny/1.1 with uniqueid field id
[junit4] 2> 1411133 INFO (Thread-2809) [ x:collection3] o.a.s.c.CoreContainer Creating SolrCore 'collection3' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-003/./collection3, trusted=true
[junit4] 2> 1411133 INFO (Thread-2809) [ x:collection3] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection3' (registry 'solr.core.collection3') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@36f3e7d1
[junit4] 2> 1411133 INFO (Thread-2809) [ x:collection3] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1411134 INFO (Thread-2809) [ x:collection3] o.a.s.c.SolrCore [[collection3] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-003/collection3], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-003/./collection3/data/]
[junit4] 2> 1411149 INFO (Thread-2809) [ x:collection3] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=32, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 1411181 INFO (Thread-2809) [ x:collection3] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1411181 INFO (Thread-2809) [ x:collection3] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1411182 INFO (Thread-2809) [ x:collection3] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=18, maxMergeAtOnceExplicit=39, maxMergedSegmentMB=36.9541015625, floorSegmentMB=0.9619140625, forceMergeDeletesPctAllowed=28.725589271660635, segmentsPerTier=38.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.8456667067745006
[junit4] 2> 1411183 INFO (Thread-2809) [ x:collection3] o.a.s.s.SolrIndexSearcher Opening [Searcher@68b7acbc[collection3] main]
[junit4] 2> 1411183 INFO (Thread-2809) [ x:collection3] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-003/collection3/conf
[junit4] 2> 1411183 INFO (Thread-2809) [ x:collection3] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1411189 INFO (searcherExecutor-5727-thread-1-processing-x:collection3) [ x:collection3] o.a.s.c.SolrCore [collection3] Registered new searcher Searcher@68b7acbc[collection3] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1411191 INFO (TEST-TestLazyCores.testRace-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.c.CoreContainer Shutting down CoreContainer instance=132956906
[junit4] 2> 1411191 INFO (TEST-TestLazyCores.testRace-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 1411191 INFO (TEST-TestLazyCores.testRace-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@16cc2726: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@3779f1a1
[junit4] 2> 1411196 INFO (TEST-TestLazyCores.testRace-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 1411196 INFO (TEST-TestLazyCores.testRace-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@61432f5d: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@1f6084f7
[junit4] 2> 1411202 INFO (TEST-TestLazyCores.testRace-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 1411202 INFO (TEST-TestLazyCores.testRace-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@48b7f479: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@304f802e
[junit4] 2> 1411203 INFO (coreCloseExecutor-5731-thread-1-processing-x:collection3) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@2ab713e7
[junit4] 2> 1411203 INFO (coreCloseExecutor-5731-thread-1-processing-x:collection3) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=716641255
[junit4] 2> 1411203 INFO (coreCloseExecutor-5731-thread-1-processing-x:collection3) [ x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@cd1bdbe: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@134f73d7
[junit4] 2> 1411209 INFO (coreCloseExecutor-5731-thread-2-processing-x:collection3) [ x:collection5] o.a.s.c.SolrCore [collection5] CLOSING SolrCore org.apache.solr.core.SolrCore@12f91802
[junit4] 2> 1411209 INFO (coreCloseExecutor-5731-thread-3-processing-x:collection3) [ x:collection2] o.a.s.c.SolrCore [collection2] CLOSING SolrCore org.apache.solr.core.SolrCore@358070ea
[junit4] 2> 1411209 INFO (coreCloseExecutor-5731-thread-2-processing-x:collection3) [ x:collection5] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection5, tag=318314498
[junit4] 2> 1411211 INFO (coreCloseExecutor-5731-thread-2-processing-x:collection3) [ x:collection5] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@56dcbe38: rootName = null, domain = solr.core.collection5, service url = null, agent id = null] for registry solr.core.collection5 / com.codahale.metrics.MetricRegistry@6a2a3db9
[junit4] 2> 1411212 INFO (coreCloseExecutor-5731-thread-4-processing-x:collection3) [ x:collection3] o.a.s.c.SolrCore [collection3] CLOSING SolrCore org.apache.solr.core.SolrCore@770bca90
[junit4] 2> 1411219 INFO (coreCloseExecutor-5731-thread-3-processing-x:collection3) [ x:collection2] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection2, tag=897609962
[junit4] 2> 1411220 INFO (coreCloseExecutor-5731-thread-3-processing-x:collection3) [ x:collection2] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@ce26b71: rootName = null, domain = solr.core.collection2, service url = null, agent id = null] for registry solr.core.collection2 / com.codahale.metrics.MetricRegistry@79edf159
[junit4] 2> 1411226 INFO (coreCloseExecutor-5731-thread-4-processing-x:collection3) [ x:collection3] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection3, tag=1997261456
[junit4] 2> 1411226 INFO (coreCloseExecutor-5731-thread-4-processing-x:collection3) [ x:collection3] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1721f9c6: rootName = null, domain = solr.core.collection3, service url = null, agent id = null] for registry solr.core.collection3 / com.codahale.metrics.MetricRegistry@e04e4bc
[junit4] 2> 1411257 INFO (TEST-TestLazyCores.testRace-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.SolrTestCaseJ4 ###Ending testRace
[junit4] 2> 1411263 INFO (TEST-TestLazyCores.testCachingLimit-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.SolrTestCaseJ4 ###Starting testCachingLimit
[junit4] 2> 1411272 INFO (TEST-TestLazyCores.testCachingLimit-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-004/solr.xml
[junit4] 2> 1411276 INFO (TEST-TestLazyCores.testCachingLimit-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@36f3e7d1, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 1411338 INFO (TEST-TestLazyCores.testCachingLimit-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@36f3e7d1
[junit4] 2> 1411346 INFO (TEST-TestLazyCores.testCachingLimit-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@36f3e7d1
[junit4] 2> 1411347 INFO (TEST-TestLazyCores.testCachingLimit-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@36f3e7d1
[junit4] 2> 1411349 INFO (TEST-TestLazyCores.testCachingLimit-seed#[71B3730F6B051170]) [ x:collection3] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 1411357 INFO (coreLoadExecutor-5738-thread-2-processing-x:collection3) [ x:collection2] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 1411366 INFO (coreLoadExecutor-5738-thread-2-processing-x:collection3) [ x:collection2] o.a.s.s.IndexSchema [collection2] Schema name=tiny
[junit4] 2> 1411368 INFO (coreLoadExecutor-5738-thread-2-processing-x:collection3) [ x:collection2] o.a.s.s.IndexSchema Loaded schema tiny/1.1 with uniqueid field id
[junit4] 2> 1411368 INFO (coreLoadExecutor-5738-thread-2-processing-x:collection3) [ x:collection2] o.a.s.c.CoreContainer Creating SolrCore 'collection2' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-004/./collection2, trusted=true
[junit4] 2> 1411368 INFO (coreLoadExecutor-5738-thread-1-processing-x:collection3) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 1411369 INFO (coreLoadExecutor-5738-thread-2-processing-x:collection3) [ x:collection2] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection2' (registry 'solr.core.collection2') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@36f3e7d1
[junit4] 2> 1411369 INFO (coreLoadExecutor-5738-thread-2-processing-x:collection3) [ x:collection2] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1411369 INFO (coreLoadExecutor-5738-thread-2-processing-x:collection3) [ x:collection2] o.a.s.c.SolrCore [[collection2] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-004/collection2], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-004/./collection2/data/]
[junit4] 2> 1411371 INFO (coreLoadExecutor-5738-thread-2-processing-x:collection3) [ x:collection2] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=32, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 1411375 INFO (coreLoadExecutor-5738-thread-3-processing-x:collection3) [ x:collection5] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 1411376 INFO (coreLoadExecutor-5738-thread-1-processing-x:collection3) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=tiny
[junit4] 2> 1411378 INFO (coreLoadExecutor-5738-thread-1-processing-x:collection3) [ x:collection1] o.a.s.s.IndexSchema Loaded schema tiny/1.1 with uniqueid field id
[junit4] 2> 1411378 INFO (coreLoadExecutor-5738-thread-1-processing-x:collection3) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-004/./collection1, trusted=true
[junit4] 2> 1411378 INFO (coreLoadExecutor-5738-thread-1-processing-x:collection3) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@36f3e7d1
[junit4] 2> 1411380 INFO (coreLoadExecutor-5738-thread-3-processing-x:collection3) [ x:collection5] o.a.s.s.IndexSchema [collection5] Schema name=tiny
[junit4] 2> 1411381 INFO (coreLoadExecutor-5738-thread-3-processing-x:collection3) [ x:collection5] o.a.s.s.IndexSchema Loaded schema tiny/1.1 with uniqueid field id
[junit4] 2> 1411381 INFO (coreLoadExecutor-5738-thread-3-processing-x:collection3) [ x:collection5] o.a.s.c.CoreContainer Creating SolrCore 'collection5' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-004/./collection5, trusted=true
[junit4] 2> 1411381 INFO (coreLoadExecutor-5738-thread-3-processing-x:collection3) [ x:collection5] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection5' (registry 'solr.core.collection5') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@36f3e7d1
[junit4] 2> 1411381 INFO (coreLoadExecutor-5738-thread-3-processing-x:collection3) [ x:collection5] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1411381 INFO (coreLoadExecutor-5738-thread-3-processing-x:collection3) [ x:collection5] o.a.s.c.SolrCore [[collection5] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_71B3730F6B051170-001/tempDir-004/collection5], dataDi
[...truncated too long message...]
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:1074)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> Oct 02, 2017 8:15:10 AM com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
[junit4] 2> INFO: Starting to interrupt leaked threads:
[junit4] 2> 1) Thread[id=20321, name=searcherExecutor-5815-thread-1, state=WAITING, group=TGRP-TestLazyCores]
[junit4] 2> Oct 02, 2017 8:15:13 AM com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
[junit4] 2> SEVERE: There are still zombie threads that couldn't be terminated:
[junit4] 2> 1) Thread[id=20321, name=searcherExecutor-5815-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:1074)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> NOTE: test params are: codec=Lucene70, sim=RandomSimilarity(queryNorm=true): {}, locale=en-US, timezone=Asia/Dhaka
[junit4] 2> NOTE: Linux 4.10.0-33-generic amd64/Oracle Corporation 1.8.0_144 (64-bit)/cpus=8,threads=2,free=143253440,total=518979584
[junit4] 2> NOTE: All tests run in this JVM: [TestObjectReleaseTracker, SystemInfoHandlerTest, TestSSLRandomization, OverseerCollectionConfigSetProcessorTest, TestCloudJSONFacetJoinDomain, TestCollectionAPIs, TestSolrCloudWithSecureImpersonation, TestSubQueryTransformer, TestSortByMinMaxFunction, SuggesterTSTTest, TestBinaryResponseWriter, TestStandardQParsers, TestHashPartitioner, TestXmlQParser, OverseerStatusTest, TestDefaultStatsCache, TestSearchPerf, TestCloudSchemaless, TestPushWriter, TestInPlaceUpdatesStandalone, SpellCheckComponentTest, TestSchemaResource, TestSolrCloudSnapshots, BigEndianAscendingWordDeserializerTest, TestUseDocValuesAsStored, TestLegacyField, VMParamsZkACLAndCredentialsProvidersTest, RecoveryAfterSoftCommitTest, TestPerFieldSimilarity, QueryParsingTest, SegmentsInfoRequestHandlerTest, ShardRoutingCustomTest, DistributedIntervalFacetingTest, TestReplicaProperties, FileUtilsTest, V2ApiIntegrationTest, HighlighterTest, TemplateUpdateProcessorTest, AddSchemaFieldsUpdateProcessorFactoryTest, TestXIncludeConfig, DistribJoinFromCollectionTest, DateRangeFieldTest, MetricsHandlerTest, ChaosMonkeySafeLeaderTest, QueryResultKeyTest, LoggingHandlerTest, TestAuthenticationFramework, TestNonDefinedSimilarityFactory, TestSimpleTextCodec, TestExactStatsCache, HighlighterMaxOffsetTest, SoftAutoCommitTest, HdfsChaosMonkeyNothingIsSafeTest, TestDelegationWithHadoopAuth, CdcrReplicationDistributedZkTest, LeaderFailureAfterFreshStartTest, ConjunctionSolrSpellCheckerTest, SearchHandlerTest, TestCoreContainer, JvmMetricsTest, TestFieldCacheWithThreads, LukeRequestHandlerTest, AliasIntegrationTest, ClusterStateUpdateTest, TestAddFieldRealTimeGet, ReplicationFactorTest, SOLR749Test, TestManagedSchema, HLLUtilTest, TestHdfsBackupRestoreCore, SharedFSAutoReplicaFailoverTest, TestTestInjection, TestSearcherReuse, TestDistributedGrouping, BufferStoreTest, AsyncCallRequestStatusResponseTest, SimpleMLTQParserTest, TestJettySolrRunner, TestStressLiveNodes, TestGeoJSONResponseWriter, TestConfigSetImmutable, DistributedQueryComponentOptimizationTest, SolrCLIZkUtilsTest, ParsingFieldUpdateProcessorsTest, TestHighFrequencyDictionaryFactory, TestSizeLimitedDistributedMap, ExplicitHLLTest, ShardRoutingTest, TestMacros, TestExclusionRuleCollectionAccess, HttpPartitionTest, CollectionReloadTest, TestFieldTypeCollectionResource, TestConfigSetsAPIExclusivity, SolrCmdDistributorTest, AnalysisErrorHandlingTest, ZkSolrClientTest, DistributedFacetPivotLargeTest, ResourceLoaderTest, TestReRankQParserPlugin, ConfigSetsAPITest, TestFuzzyAnalyzedSuggestions, NodeMutatorTest, FileBasedSpellCheckerTest, TestFastLRUCache, TestCloudNestedDocsSort, DocValuesTest, TestPointFields, TestCloudRecovery, ClassificationUpdateProcessorFactoryTest, TestZkAclsWithHadoopAuth, DistanceFunctionTest, ManagedSchemaRoundRobinCloudTest, TestInitQParser, CdcrVersionReplicationTest, IndexSchemaRuntimeFieldTest, TestExceedMaxTermLength, TestPartialUpdateDeduplication, TestRTGBase, DistributedDebugComponentTest, TestOverriddenPrefixQueryForCustomFieldType, CustomCollectionTest, SolrJmxReporterTest, BasicDistributedZk2Test, CollectionsAPIDistributedZkTest, BasicZkTest, TestReplicationHandler, TestRangeQuery, BasicFunctionalityTest, TestLazyCores]
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestLazyCores -Dtests.seed=71B3730F6B051170 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=en-US -Dtests.timezone=Asia/Dhaka -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] ERROR 0.00s J1 | TestLazyCores (suite) <<<
[junit4] > Throwable #1: com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE scope at org.apache.solr.core.TestLazyCores:
[junit4] > 1) Thread[id=20321, name=searcherExecutor-5815-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:1074)
[junit4] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
[junit4] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] > at __randomizedtesting.SeedInfo.seed([71B3730F6B051170]:0)Throwable #2: com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie threads that couldn't be terminated:
[junit4] > 1) Thread[id=20321, name=searcherExecutor-5815-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:1074)
[junit4] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
[junit4] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] > at __randomizedtesting.SeedInfo.seed([71B3730F6B051170]:0)
[junit4] Completed [444/734 (1!)] on J1 in 33.73s, 9 tests, 3 errors <<< FAILURES!
[...truncated 38106 lines...]
-documentation-lint:
[echo] checking for broken html...
[jtidy] Checking for broken html (such as invalid tags)...
[delete] Deleting directory /home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/build/jtidy_tmp
[echo] Checking for broken links...
[exec]
[exec] Crawl/parse...
[exec]
[exec] Verify...
[exec]
[exec] file:///build/docs/sandbox/org/apache/lucene/document/FloatPointNearestNeighbor.html
[exec] BROKEN LINK: file:///build/docs/core/org/apache/lucene/document/FloatPointNearestNeighbor.NearestHit.html
[exec] BROKEN LINK: file:///build/docs/core/org/apache/lucene/document/FloatPointNearestNeighbor.NearestHit.html
[exec]
[exec] Broken javadocs links were found! Common root causes:
[exec] * A typo of some sort for manually created links.
[exec] * Public methods referencing non-public classes in their signature.
BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-master-Linux/build.xml:826: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-master-Linux/build.xml:101: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/build.xml:142: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/build.xml:155: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/common-build.xml:2570: exec returned: 1
Total time: 55 minutes 56 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
[WARNINGS] Skipping publisher since build result is FAILURE
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any