Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Windows/7215/
Java: 32bit/jdk1.8.0_144 -server -XX:+UseConcMarkSweepGC

2 tests failed.
FAILED:  
junit.framework.TestSuite.org.apache.solr.search.stats.TestExactStatsCache

Error Message:
Could not remove the following files (in the order of attempts):    
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactStatsCache_122C8868088CF657-001\tempDir-001\control\collection1:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactStatsCache_122C8868088CF657-001\tempDir-001\control\collection1
    
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactStatsCache_122C8868088CF657-001\tempDir-001\control:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactStatsCache_122C8868088CF657-001\tempDir-001\control
    
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactStatsCache_122C8868088CF657-001\tempDir-001:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactStatsCache_122C8868088CF657-001\tempDir-001
 

Stack Trace:
java.io.IOException: Could not remove the following files (in the order of 
attempts):
   
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactStatsCache_122C8868088CF657-001\tempDir-001\control\collection1:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactStatsCache_122C8868088CF657-001\tempDir-001\control\collection1
   
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactStatsCache_122C8868088CF657-001\tempDir-001\control:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactStatsCache_122C8868088CF657-001\tempDir-001\control
   
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactStatsCache_122C8868088CF657-001\tempDir-001:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactStatsCache_122C8868088CF657-001\tempDir-001

        at __randomizedtesting.SeedInfo.seed([122C8868088CF657]:0)
        at org.apache.lucene.util.IOUtils.rm(IOUtils.java:329)
        at 
org.apache.lucene.util.TestRuleTemporaryFilesCleanup.afterAlways(TestRuleTemporaryFilesCleanup.java:216)
        at 
com.carrotsearch.randomizedtesting.rules.TestRuleAdapter$1.afterAlways(TestRuleAdapter.java:31)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:43)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.lang.Thread.run(Thread.java:748)


FAILED:  junit.framework.TestSuite.org.apache.lucene.index.TestLongPostings

Error Message:
Could not remove the following files (in the order of attempts):    
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\core\test\J1\temp\lucene.index.TestLongPostings_B6FA22691B178CCE-001\longpostings.199787120905034483-001:
 java.nio.file.AccessDeniedException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\core\test\J1\temp\lucene.index.TestLongPostings_B6FA22691B178CCE-001\longpostings.199787120905034483-001
    
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\core\test\J1\temp\lucene.index.TestLongPostings_B6FA22691B178CCE-001:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\core\test\J1\temp\lucene.index.TestLongPostings_B6FA22691B178CCE-001
 

Stack Trace:
java.io.IOException: Could not remove the following files (in the order of 
attempts):
   
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\core\test\J1\temp\lucene.index.TestLongPostings_B6FA22691B178CCE-001\longpostings.199787120905034483-001:
 java.nio.file.AccessDeniedException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\core\test\J1\temp\lucene.index.TestLongPostings_B6FA22691B178CCE-001\longpostings.199787120905034483-001
   
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\core\test\J1\temp\lucene.index.TestLongPostings_B6FA22691B178CCE-001:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\core\test\J1\temp\lucene.index.TestLongPostings_B6FA22691B178CCE-001

        at __randomizedtesting.SeedInfo.seed([B6FA22691B178CCE]:0)
        at org.apache.lucene.util.IOUtils.rm(IOUtils.java:329)
        at 
org.apache.lucene.util.TestRuleTemporaryFilesCleanup.afterAlways(TestRuleTemporaryFilesCleanup.java:216)
        at 
com.carrotsearch.randomizedtesting.rules.TestRuleAdapter$1.afterAlways(TestRuleAdapter.java:31)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:43)
        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)




Build Log:
[...truncated 956 lines...]
   [junit4] Suite: org.apache.lucene.index.TestLongPostings
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): 
{field=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128)))},
 docValues:{}, maxPointsInLeafNode=34, maxMBSortInHeap=7.212237802915656, 
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@4ad150),
 locale=ms-MY, timezone=Antarctica/Macquarie
   [junit4]   2> NOTE: Windows 10 10.0 x86/Oracle Corporation 1.8.0_144 
(32-bit)/cpus=3,threads=1,free=245697096,total=356347904
   [junit4]   2> NOTE: All tests run in this JVM: [TestStressIndexing, 
TestConjunctions, TestMultiCollector, TestUniqueTermCount, TestCharArraySet, 
TestFieldInfos, TestDirectMonotonic, TestPerFieldPostingsFormat, 
TestComplexExplanationsOfNonMatches, TestIndexWriterMaxDocs, 
TestAxiomaticSimilarity, TestSearchAfter, MultiCollectorTest, 
TestIndexWriterExceptions2, TestNearSpansOrdered, TestNRTThreads, 
TestMultiFields, TestBytesRef, TestSloppyMath, TestPhraseQuery, 
TestShardSearching, TestPerFieldPostingsFormat2, TestFilterCodecReader, 
TestIndexWriterDelete, TestSpanBoostQuery, 
TestSimpleExplanationsWithFillerDocs, TestTerm, TestIndexingSequenceNumbers, 
TestIndependenceChiSquared, TestNRTReaderWithThreads, 
FuzzyTermOnShortTermsTest, TestPerFieldDocValuesFormat, 
TestFastCompressionMode, TestDelegatingAnalyzerWrapper, TestSpanNotQuery, 
TestRollingUpdates, TestIndexWriterOutOfFileDescriptors, 
TestConcurrentMergeScheduler, TestPositionIncrement, TestByteArrayDataInput, 
TestPerSegmentDeletes, TestSentinelIntSet, TestSpanTermQuery, 
TestDemoParallelLeafReader, TestCharFilter, TestNoDeletionPolicy, 
TestTwoPhaseCommitTool, TestSimilarityBase, TestLucene60PointsFormat, 
TestAutomatonQueryUnicode, TestSegmentMerger, TestTermsEnum, TestSimilarity, 
Test2BPostings, TestSleepingLockWrapper, TestReadOnlyIndex, 
TestIndexWriterNRTIsCurrent, TestRegexpRandom, TestLongRangeFieldQueries, 
TestNoMergePolicy, TestSimpleExplanations, TestRollingBuffer, 
TestIndexOrDocValuesQuery, TestDocumentsWriterStallControl, 
TestCloseableThreadLocal, TestFieldMaskingSpanQuery, TestCharTermAttributeImpl, 
TestScoreCachingWrappingScorer, TestSimpleAttributeImpl, TestVirtualMethod, 
TestReqOptSumScorer, TestCompetitiveFreqNormAccumulator, 
TestSloppyPhraseQuery2, TestBasicModelG, TestCodecHoldsOpenFiles, 
TestWeakIdentityMap, TestForUtil, TestSortedSetSortField, 
TestDoubleRangeFieldQueries, TestMultiTermsEnum, TestPostingsOffsets, 
TestRoaringDocIdSet, TestBytesRefAttImpl, TestLongPostings]
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestLongPostings 
-Dtests.seed=B6FA22691B178CCE -Dtests.slow=true -Dtests.locale=ms-MY 
-Dtests.timezone=Antarctica/Macquarie -Dtests.asserts=true 
-Dtests.file.encoding=UTF-8
   [junit4] ERROR   0.00s J1 | TestLongPostings (suite) <<<
   [junit4]    > Throwable #1: java.io.IOException: Could not remove the 
following files (in the order of attempts):
   [junit4]    >    
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\core\test\J1\temp\lucene.index.TestLongPostings_B6FA22691B178CCE-001\longpostings.199787120905034483-001:
 java.nio.file.AccessDeniedException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\core\test\J1\temp\lucene.index.TestLongPostings_B6FA22691B178CCE-001\longpostings.199787120905034483-001
   [junit4]    >    
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\core\test\J1\temp\lucene.index.TestLongPostings_B6FA22691B178CCE-001:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\core\test\J1\temp\lucene.index.TestLongPostings_B6FA22691B178CCE-001
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([B6FA22691B178CCE]:0)
   [junit4]    >        at org.apache.lucene.util.IOUtils.rm(IOUtils.java:329)
   [junit4]    >        at java.lang.Thread.run(Thread.java:748)
   [junit4] Completed [212/486 (1!)] on J1 in 0.96s, 2 tests, 1 error <<< 
FAILURES!

[...truncated 12185 lines...]
   [junit4] Suite: org.apache.solr.search.stats.TestExactStatsCache
   [junit4]   2> Creating dataDir: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactStatsCache_122C8868088CF657-001\init-core-data-001
   [junit4]   2> 1474188 WARN  
(SUITE-TestExactStatsCache-seed#[122C8868088CF657]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=39 numCloses=39
   [junit4]   2> 1474188 INFO  
(SUITE-TestExactStatsCache-seed#[122C8868088CF657]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 1474218 INFO  
(SUITE-TestExactStatsCache-seed#[122C8868088CF657]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: 
@org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
   [junit4]   2> 1474218 INFO  
(SUITE-TestExactStatsCache-seed#[122C8868088CF657]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 1474219 INFO  
(SUITE-TestExactStatsCache-seed#[122C8868088CF657]-worker) [    ] 
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /tl_lk/
   [junit4]   2> 1474920 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactStatsCache_122C8868088CF657-001\tempDir-001\control\cores\collection1
   [junit4]   2> 1474922 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] o.e.j.s.Server 
jetty-9.4.8.v20171121, build timestamp: 2017-11-21T16:27:37-05:00, git hash: 
82b8fb23f757335bb3329d540ce37a2a2615f0a8
   [junit4]   2> 1474923 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] o.e.j.s.session 
DefaultSessionIdManager workerName=node0
   [junit4]   2> 1474923 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] o.e.j.s.session 
No SessionScavenger set, using defaults
   [junit4]   2> 1474923 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] o.e.j.s.session 
Scavenging every 660000ms
   [junit4]   2> 1474923 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@1827d5e{/tl_lk,null,AVAILABLE}
   [junit4]   2> 1474925 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@d0aa4{HTTP/1.1,[http/1.1]}{127.0.0.1:49533}
   [junit4]   2> 1474925 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] o.e.j.s.Server 
Started @1482543ms
   [junit4]   2> 1474926 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/tl_lk, 
hostPort=49533, 
coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactStatsCache_122C8868088CF657-001\tempDir-001\control\cores}
   [junit4]   2> 1474926 ERROR 
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1474926 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.0.0
   [junit4]   2> 1474926 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 1474926 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1474926 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-03-11T08:53:21.985Z
   [junit4]   2> 1474928 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactStatsCache_122C8868088CF657-001\tempDir-001\control\solr.xml
   [junit4]   2> 1474937 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay 
is ignored
   [junit4]   2> 1474938 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 1474938 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@453406, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 1475132 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@453406
   [junit4]   2> 1475196 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@453406
   [junit4]   2> 1475196 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@453406
   [junit4]   2> 1475207 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactStatsCache_122C8868088CF657-001\tempDir-001\control\cores
   [junit4]   2> 1475207 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 1475211 INFO  (coreLoadExecutor-4844-thread-1) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 1475216 INFO  (coreLoadExecutor-4844-thread-1) [    
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, 
from paths: 
[/C:/Users/jenkins/workspace/Lucene-Solr-master-Windows/solr/core/src/test-files/solr/collection1/lib,
 
/C:/Users/jenkins/workspace/Lucene-Solr-master-Windows/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1475311 INFO  (coreLoadExecutor-4844-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 1475358 INFO  (coreLoadExecutor-4844-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1475516 INFO  (coreLoadExecutor-4844-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1475549 INFO  (coreLoadExecutor-4844-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from configset 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\collection1,
 trusted=true
   [junit4]   2> 1475549 INFO  (coreLoadExecutor-4844-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@453406
   [junit4]   2> 1475549 INFO  (coreLoadExecutor-4844-thread-1) [    
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 1475549 INFO  (coreLoadExecutor-4844-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\collection1],
 
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactStatsCache_122C8868088CF657-001\tempDir-001\control\cores\collection1\data\]
   [junit4]   2> 1475552 INFO  (coreLoadExecutor-4844-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=49, maxMergeAtOnceExplicit=10, maxMergedSegmentMB=56.478515625, 
floorSegmentMB=1.4189453125, forceMergeDeletesPctAllowed=26.71068873528499, 
segmentsPerTier=19.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.6774781922784532
   [junit4]   2> 1475787 INFO  (coreLoadExecutor-4844-thread-1) [    
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1475787 INFO  (coreLoadExecutor-4844-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 1475788 INFO  (coreLoadExecutor-4844-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1475788 INFO  (coreLoadExecutor-4844-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1475797 INFO  (coreLoadExecutor-4844-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=10, maxMergeAtOnceExplicit=34, maxMergedSegmentMB=95.525390625, 
floorSegmentMB=2.0712890625, forceMergeDeletesPctAllowed=28.058961882398968, 
segmentsPerTier=39.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.15909547591445056
   [junit4]   2> 1475797 INFO  (coreLoadExecutor-4844-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1254f19[collection1] 
main]
   [junit4]   2> 1475816 INFO  (coreLoadExecutor-4844-thread-1) [    
x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1475995 INFO  (coreLoadExecutor-4844-thread-1) [    
x:collection1] o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 1476145 INFO  (coreLoadExecutor-4844-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 1476145 INFO  
(searcherExecutor-4845-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1476145 INFO  (coreLoadExecutor-4844-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1594630763398037504
   [junit4]   2> 1476146 INFO  
(searcherExecutor-4845-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1476146 INFO  
(searcherExecutor-4845-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1476146 INFO  
(searcherExecutor-4845-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 1476146 INFO  
(searcherExecutor-4845-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1476146 INFO  
(searcherExecutor-4845-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1476146 INFO  
(searcherExecutor-4845-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1476147 INFO  
(searcherExecutor-4845-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 1476147 INFO  
(searcherExecutor-4845-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 1476148 INFO  
(searcherExecutor-4845-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@1254f19[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1476976 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactStatsCache_122C8868088CF657-001\tempDir-001\shard0\cores\collection1
   [junit4]   2> 1476979 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] o.e.j.s.Server 
jetty-9.4.8.v20171121, build timestamp: 2017-11-21T16:27:37-05:00, git hash: 
82b8fb23f757335bb3329d540ce37a2a2615f0a8
   [junit4]   2> 1476979 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] o.e.j.s.session 
DefaultSessionIdManager workerName=node0
   [junit4]   2> 1476979 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] o.e.j.s.session 
No SessionScavenger set, using defaults
   [junit4]   2> 1476979 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] o.e.j.s.session 
Scavenging every 660000ms
   [junit4]   2> 1476980 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@16ea46a{/tl_lk,null,AVAILABLE}
   [junit4]   2> 1476981 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@5902e8{HTTP/1.1,[http/1.1]}{127.0.0.1:49536}
   [junit4]   2> 1476981 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] o.e.j.s.Server 
Started @1484598ms
   [junit4]   2> 1476981 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/tl_lk, 
hostPort=49536, 
coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactStatsCache_122C8868088CF657-001\tempDir-001\shard0\cores}
   [junit4]   2> 1476981 ERROR 
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1476981 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.0.0
   [junit4]   2> 1476981 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 1476982 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1476982 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-03-11T08:53:24.041Z
   [junit4]   2> 1476983 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactStatsCache_122C8868088CF657-001\tempDir-001\shard0\solr.xml
   [junit4]   2> 1476995 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay 
is ignored
   [junit4]   2> 1476995 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 1476996 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@453406, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 1477178 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@453406
   [junit4]   2> 1477189 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@453406
   [junit4]   2> 1477189 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@453406
   [junit4]   2> 1477195 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactStatsCache_122C8868088CF657-001\tempDir-001\shard0\cores
   [junit4]   2> 1477195 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 1477203 INFO  (coreLoadExecutor-4855-thread-1) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 1477213 INFO  (coreLoadExecutor-4855-thread-1) [    
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, 
from paths: 
[/C:/Users/jenkins/workspace/Lucene-Solr-master-Windows/solr/core/src/test-files/solr/collection1/lib,
 
/C:/Users/jenkins/workspace/Lucene-Solr-master-Windows/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1477326 INFO  (coreLoadExecutor-4855-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 1477366 INFO  (coreLoadExecutor-4855-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1477502 INFO  (coreLoadExecutor-4855-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1477518 INFO  (coreLoadExecutor-4855-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from configset 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\collection1,
 trusted=true
   [junit4]   2> 1477518 INFO  (coreLoadExecutor-4855-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@453406
   [junit4]   2> 1477518 INFO  (coreLoadExecutor-4855-thread-1) [    
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 1477519 INFO  (coreLoadExecutor-4855-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\collection1],
 
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactStatsCache_122C8868088CF657-001\tempDir-001\shard0\cores\collection1\data\]
   [junit4]   2> 1477522 INFO  (coreLoadExecutor-4855-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=49, maxMergeAtOnceExplicit=10, maxMergedSegmentMB=56.478515625, 
floorSegmentMB=1.4189453125, forceMergeDeletesPctAllowed=26.71068873528499, 
segmentsPerTier=19.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.6774781922784532
   [junit4]   2> 1477745 INFO  (coreLoadExecutor-4855-thread-1) [    
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1477745 INFO  (coreLoadExecutor-4855-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 1477751 INFO  (coreLoadExecutor-4855-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1477751 INFO  (coreLoadExecutor-4855-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1477752 INFO  (coreLoadExecutor-4855-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=10, maxMergeAtOnceExplicit=34, maxMergedSegmentMB=95.525390625, 
floorSegmentMB=2.0712890625, forceMergeDeletesPctAllowed=28.058961882398968, 
segmentsPerTier=39.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.15909547591445056
   [junit4]   2> 1477752 INFO  (coreLoadExecutor-4855-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@34e204[collection1] 
main]
   [junit4]   2> 1477753 INFO  (coreLoadExecutor-4855-thread-1) [    
x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1477784 INFO  (coreLoadExecutor-4855-thread-1) [    
x:collection1] o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 1477857 INFO  (coreLoadExecutor-4855-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 1477857 INFO  (coreLoadExecutor-4855-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1594630765193199616
   [junit4]   2> 1477857 INFO  
(searcherExecutor-4856-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1477857 INFO  
(searcherExecutor-4856-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1477857 INFO  
(searcherExecutor-4856-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1477857 INFO  
(searcherExecutor-4856-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 1477857 INFO  
(searcherExecutor-4856-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1477862 INFO  
(searcherExecutor-4856-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1477863 INFO  
(searcherExecutor-4856-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1477863 INFO  
(searcherExecutor-4856-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 1477863 INFO  
(searcherExecutor-4856-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 1477864 INFO  
(searcherExecutor-4856-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@34e204[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1477867 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting test
   [junit4]   2> 1477880 INFO  (qtp16199897-16884) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/tl_lk path=/update 
params={wt=javabin&version=2}{deleteByQuery=*:* (-1594630765211025408)} 0 5
   [junit4]   2> 1477893 INFO  (qtp18039840-16904) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/tl_lk path=/update 
params={wt=javabin&version=2}{deleteByQuery=*:* (-1594630765225705472)} 0 5
   [junit4]   2> 1477897 INFO  (qtp16199897-16887) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/tl_lk path=/update 
params={wt=javabin&version=2}{add=[0 (1594630765231996928)]} 0 3
   [junit4]   2> 1477899 INFO  (qtp18039840-16907) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/tl_lk path=/update 
params={wt=javabin&version=2}{add=[0 (1594630765236191232)]} 0 1
   [junit4]   2> 1477899 INFO  (qtp16199897-16889) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1594630765237239808,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1477900 INFO  (qtp16199897-16889) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@1dbc50d 
commitCommandVersion:1594630765237239808
   [junit4]   2> 1477927 INFO  (qtp16199897-16889) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@1c783df[collection1] main]
   [junit4]   2> 1477929 INFO  (qtp16199897-16889) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1477931 INFO  
(searcherExecutor-4845-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@1c783df[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):c1)))}
   [junit4]   2> 1477931 INFO  (qtp16199897-16889) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/tl_lk path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 32
   [junit4]   2> 1477931 INFO  (qtp18039840-16909) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1594630765270794240,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1477931 INFO  (qtp18039840-16909) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@ffd7de 
commitCommandVersion:1594630765270794240
   [junit4]   2> 1477947 INFO  (qtp18039840-16909) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@cc9a52[collection1] main]
   [junit4]   2> 1477949 INFO  (qtp18039840-16909) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1477951 INFO  
(searcherExecutor-4856-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@cc9a52[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):c1)))}
   [junit4]   2> 1477951 INFO  (qtp18039840-16909) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/tl_lk path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 19
   [junit4]   2> 1477953 INFO  (qtp16199897-16887) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/tl_lk path=/select 
params={q=a_t:one&fl=*,score&wt=javabin&version=2&debugQuery=true} hits=1 
status=0 QTime=0
   [junit4]   2> 1477958 INFO  (qtp18039840-16910) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/tl_lk path=/select 
params={df=text&distrib=false&debug=false&debug=timing&debug=track&fl=*,score&shards.purpose=32768&shard.url=http://127.0.0.1:49536/tl_lk/collection1&rid=127.0.0.1-collection1-1520758405013-22&version=2&q=a_t:one&requestPurpose=GET_TERM_STATS&NOW=1520758405013&isShard=true&wt=javabin&debugQuery=false}
 status=0 QTime=0
   [junit4]   2> 1477959 INFO  (qtp18039840-16911) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/tl_lk path=/select 
params={df=text&distrib=false&debug=false&debug=timing&debug=track&fl=id&fl=score&shards.purpose=16388&start=0&fsv=true&org.apache.solr.stats.termStats=a_t:on,1,1&shard.url=http://127.0.0.1:49536/tl_lk/collection1&rid=127.0.0.1-collection1-1520758405013-22&rows=10&version=2&org.apache.solr.stats.colStats=a_t,1,1,3,3&q=a_t:one&requestPurpose=GET_TOP_IDS,SET_TERM_STATS&NOW=1520758405013&isShard=true&org.apache.solr.stats.terms=a_t:on&wt=javabin&debugQuery=false}
 hits=1 status=0 QTime=0
   [junit4]   2> 1477961 INFO  (qtp18039840-16910) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/tl_lk path=/select 
params={df=text&distrib=false&debug=timing&debug=track&fl=*,score&shards.purpose=320&shard.url=http://127.0.0.1:49536/tl_lk/collection1&rid=127.0.0.1-collection1-1520758405013-22&version=2&q=a_t:one&requestPurpose=GET_FIELDS,GET_DEBUG&NOW=1520758405013&ids=0&isShard=true&wt=javabin&debugQuery=true}
 status=0 QTime=0
   [junit4]   2> 1477962 INFO  (qtp18039840-16907) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/tl_lk path=/select 
params={q=a_t:one&shards=http://127.0.0.1:49536/tl_lk/collection1&fl=*,score&wt=javabin&version=2&debugQuery=true}
 rid=127.0.0.1-collection1-1520758405013-22 hits=1 status=0 QTime=7
   [junit4]   1> ======================= Control Response 
=======================
   [junit4]   1> 
{responseHeader={status=0,QTime=0},response={numFound=1,start=0,maxScore=0.57735026,docs=[SolrDocument{id=0,
 range_facet_l=[0], id_i1=0, range_facet_l_dv=[0], range_facet_i_dv=[0], 
a_t=[one two three], shard_i=[1], multiDefault=[muLti-Default], intDefault=42, 
timestamp=Sun Mar 11 00:53:24 PST 2018, _version_=1594630765231996928, 
intDvoDefault=42, 
score=0.57735026}]},debug={rawquerystring=a_t:one,querystring=a_t:one,parsedquery=a_t:on,parsedquery_toString=a_t:on,explain={0=
   [junit4]   1> 0.57735026 = weight(a_t:on in 0) [MockConfigurableSimilarity], 
result of:
   [junit4]   1>   0.57735026 = score(freq=1.0), product of:
   [junit4]   1>     1.0 = idf, computed as log((docCount+1)/(docFreq+1)) + 1 
from:
   [junit4]   1>       1 = docFreq, number of documents containing term
   [junit4]   1>       1 = docCount, total number of documents with field
   [junit4]   1>     1.0 = tf(freq=1.0), with freq of:
   [junit4]   1>       1.0 = freq, occurrences of term within document
   [junit4]   1>     0.57735026 = fieldNorm
   [junit4]   1> 
},QParser=LuceneQParser,timing={time=0.0,prepare={time=0.0,query={time=0.0},facet={time=0.0},facet_module={time=0.0},mlt={time=0.0},highlight={time=0.0},stats={time=0.0},expand={time=0.0},terms={time=0.0},debug={time=0.0}},process={time=0.0,query={time=0.0},facet={time=0.0},facet_module={time=0.0},mlt={time=0.0},highlight={time=0.0},stats={time=0.0},expand={time=0.0},terms={time=0.0},debug={time=0.0}}}}}
   [junit4]   1> 
   [junit4]   1> 
   [junit4]   1> ======================= Shard Response =======================
   [junit4]   1> 
   [junit4]   1> 
{responseHeader={status=0,QTime=7},response={numFound=1,start=0,maxScore=0.57735026,docs=[SolrDocument{id=0,
 range_facet_l=[0], id_i1=0, range_facet_l_dv=[0], range_facet_i_dv=[0], 
a_t=[one two three], shard_i=[1], multiDefault=[muLti-Default], intDefault=42, 
timestamp=Sun Mar 11 00:53:24 PST 2018, _version_=1594630765236191232, 
intDvoDefault=42, 
score=0.57735026}]},debug={track={rid=127.0.0.1-collection1-1520758405013-22,PARSE_QUERY={http://127.0.0.1:49536/tl_lk/collection1={QTime=0,ElapsedTime=2,RequestPurpose=GET_TERM_STATS,Response={responseHeader={status=0,QTime=0},org.apache.solr.stats.terms=a_t:on,org.apache.solr.stats.termStats=a_t:on,1,1,org.apache.solr.stats.colStats=a_t,1,1,3,3,debug={timing={time=0.0,prepare={time=0.0,query={time=0.0},facet={time=0.0},facet_module={time=0.0},mlt={time=0.0},highlight={time=0.0},stats={time=0.0},expand={time=0.0},terms={time=0.0},debug={time=0.0}},process={time=0.0,query={time=0.0},facet={time=0.0},facet_module={time=0.0},mlt={time=0.0},highlight={time=0.0},stats={time=0.0},expand={time=0.0},terms={time=0.0},debug={time=0.0}}}}}}},EXECUTE_QUERY={http://127.0.0.1:49536/tl_lk/collection1={QTime=0,ElapsedTime=1,RequestPurpose=GET_TOP_IDS,SET_TERM_STATS,NumFound=1,Response={responseHeader={status=0,QTime=0},response={numFound=1,start=0,maxScore=0.57735026,docs=[SolrDocument{id=0,
 
score=0.57735026}]},sort_values={},debug={timing={time=0.0,prepare={time=0.0,query={time=0.0},facet={time=0.0},facet_module={time=0.0},mlt={time=0.0},highlight={time=0.0},stats={time=0.0},expand={time=0.0},terms={time=0.0},debug={time=0.0}},process={time=0.0,query={time=0.0},facet={time=0.0},facet_module={time=0.0},mlt={time=0.0},highlight={time=0.0},stats={time=0.0},expand={time=0.0},terms={time=0.0},debug={time=0.0}}}}}}},GET_FIELDS={http://127.0.0.1:49536/tl_lk/collection1={QTime=0,ElapsedTime=1,RequestPurpose=GET_FIELDS,GET_DEBUG,NumFound=1,Response={responseHeader={status=0,QTime=0},response={numFound=1,start=0,docs=[SolrDocument{id=0,
 range_facet_l=[0], id_i1=0, range_facet_l_dv=[0], range_facet_i_dv=[0], 
a_t=[one two three], shard_i=[1], multiDefault=[muLti-Default], intDefault=42, 
timestamp=Sun Mar 11 00:53:24 PST 2018, _version_=1594630765236191232, 
intDvoDefault=42, 
score=0.57735026}]},debug={rawquerystring=a_t:one,querystring=a_t:one,parsedquery=a_t:on,parsedquery_toString=a_t:on,explain={0=
   [junit4]   1> 0.57735026 = weight(a_t:on in 0) [MockConfigurableSimilarity], 
result of:
   [junit4]   1>   0.57735026 = score(freq=1.0), product of:
   [junit4]   1>     1.0 = idf, computed as log((docCount+1)/(docFreq+1)) + 1 
from:
   [junit4]   1>       1 = docFreq, number of documents containing term
   [junit4]   1>       1 = docCount, total number of documents with field
   [junit4]   1>     1.0 = tf(freq=1.0), with freq of:
   [junit4]   1>       1.0 = freq, occurrences of term within document
   [junit4]   1>     0.57735026 = fieldNorm
   [junit4]   1> 
},QParser=LuceneQParser,timing={time=0.0,prepare={time=0.0,query={time=0.0},facet={time=0.0},facet_module={time=0.0},mlt={time=0.0},highlight={time=0.0},stats={time=0.0},expand={time=0.0},terms={time=0.0},debug={time=0.0}},process={time=0.0,query={time=0.0},facet={time=0.0},facet_module={time=0.0},mlt={time=0.0},highlight={time=0.0},stats={time=0.0},expand={time=0.0},terms={time=0.0},debug={time=0.0}}}}}}}},timing={time=0.0,prepare={time=0.0,query={time=0.0},facet={time=0.0},facet_module={time=0.0},mlt={time=0.0},highlight={time=0.0},stats={time=0.0},expand={time=0.0},terms={time=0.0},debug={time=0.0}},process={time=0.0,query={time=0.0},facet={time=0.0},facet_module={time=0.0},mlt={time=0.0},highlight={time=0.0},stats={time=0.0},expand={time=0.0},terms={time=0.0},debug={time=0.0}}},rawquerystring=a_t:one,querystring=a_t:one,parsedquery=a_t:on,parsedquery_toString=a_t:on,QParser=LuceneQParser,explain={0=
   [junit4]   1> 0.57735026 = weight(a_t:on in 0) [MockConfigurableSimilarity], 
result of:
   [junit4]   1>   0.57735026 = score(freq=1.0), product of:
   [junit4]   1>     1.0 = idf, computed as log((docCount+1)/(docFreq+1)) + 1 
from:
   [junit4]   1>       1 = docFreq, number of documents containing term
   [junit4]   1>       1 = docCount, total number of documents with field
   [junit4]   1>     1.0 = tf(freq=1.0), with freq of:
   [junit4]   1>       1.0 = freq, occurrences of term within document
   [junit4]   1>     0.57735026 = fieldNorm
   [junit4]   1> }}}
   [junit4]   2> 1477972 INFO  (qtp16199897-16889) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/tl_lk path=/update 
params={wt=javabin&version=2}{add=[1 (1594630765304348672)]} 0 8
   [junit4]   2> 1477978 INFO  (qtp18039840-16911) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/tl_lk path=/update 
params={wt=javabin&version=2}{add=[1 (1594630765313785856)]} 0 6
   [junit4]   2> 1477979 INFO  (qtp16199897-16887) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1594630765321125888,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1477979 INFO  (qtp16199897-16887) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@1dbc50d 
commitCommandVersion:1594630765321125888
   [junit4]   2> 1477991 INFO  (qtp16199897-16887) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@a21d2b[collection1] main]
   [junit4]   2> 1477995 INFO  
(searcherExecutor-4845-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@a21d2b[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):c1)
 Uninverting(_1(8.0.0):c1)))}
   [junit4]   2> 1477995 INFO  (qtp16199897-16887) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1477995 INFO  (qtp16199897-16887) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/tl_lk path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 16
   [junit4]   2> 1477996 INFO  (qtp18039840-16907) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1594630765338951680,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1477997 INFO  (qtp18039840-16907) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@ffd7de 
commitCommandVersion:1594630765338951680
   [junit4]   2> 1478006 INFO  (qtp18039840-16907) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@8c1930[collection1] main]
   [junit4]   2> 1478009 INFO  (qtp18039840-16907) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1478011 INFO  
(searcherExecutor-4856-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@8c1930[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):c1)
 Uninverting(_1(8.0.0):c1)))}
   [junit4]   2> 1478011 INFO  (qtp18039840-16907) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/tl_lk path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 15
   [junit4]   2> 1478013 INFO  (qtp16199897-16889) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/tl_lk path=/select 
params={q=a_t:one+a_t:four&fl=*,score&wt=javabin&version=2&debugQuery=true} 
hits=2 status=0 QTime=0
   [junit4]   2> 1478015 INFO  (qtp18039840-16907) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/tl_lk path=/select 
params={df=text&distrib=false&debug=false&debug=timing&debug=track&fl=*,score&shards.purpose=32768&shard.url=http://127.0.0.1:49536/tl_lk/collection1&rid=127.0.0.1-collection1-1520758405073-23&version=2&q=a_t:one+a_t:four&requestPurpose=GET_TERM_STATS&NOW=1520758405073&isShard=true&wt=javabin&debugQuery=false}
 status=0 QTime=0
   [junit4]   2> 1478016 INFO  (qtp18039840-16910) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/tl_lk path=/select 
params={df=text&distrib=false&debug=false&debug=timing&debug=track&fl=id&fl=score&shards.purpose=16388&start=0&fsv=true&org.apache.solr.stats.termStats=a_t:on,2,2!a_t:four,1,1&shard.url=http://127.0.0.1:49536/tl_lk/collection1&rid=127.0.0.1-collection1-1520758405073-23&rows=10&version=2&org.apache.solr.stats.colStats=a_t,2,2,8,8&q=a_t:one+a_t:four&requestPurpose=GET_TOP_IDS,SET_TERM_STATS&NOW=1520758405073&isShard=true&org.apache.solr.stats.terms=a_t:on&org.apache.solr.stats.terms=a_t:four&wt=javabin&debugQuery=false}
 hits=2 status=0 QTime=0
   [junit4]   2> 1478017 INFO  (qtp18039840-16907) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/tl_lk path=/select 
params={df=text&distrib=false&debug=timing&debug=track&fl=*,score&shards.purpose=320&shard.url=http://127.0.0.1:49536/tl_lk/collection1&rid=127.0.0.1-collection1-1520758405073-23&version=2&q=a_t:one+a_t:four&requestPurpose=GET_FIELDS,GET_DEBUG&NOW=1520758405073&ids=0,1&isShard=true&wt=javabin&debugQuery=true}
 status=0 QTime=0
   [junit4]   2> 1478018 INFO  (qtp18039840-16911) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/tl_lk path=/select 
params={q=a_t:one+a_t:four&shards=http://127.0.0.1:49536/tl_lk/collection1&fl=*,score&wt=javabin&version=2&debugQuery=true}
 rid=127.0.0.1-collection1-1520758405073-23 hits=2 status=0 QTime=4
   [junit4]   1> ======================= Control Response 
=======================
   [junit4]   1> 
{responseHeader={status=0,QTime=0},response={numFound=2,start=0,maxScore=1.0757567,docs=[SolrDocument{id=1,
 range_facet_l=[1], id_i1=1, range_facet_l_dv=[1], range_facet_i_dv=[1], 
a_t=[one two three four five], shard_i=[1], multiDefault=[muLti-Default], 
intDefault=42, timestamp=Sun Mar 11 00:53:25 PST 2018, 
_version_=1594630765304348672, intDvoDefault=42, score=1.0757567}, 
SolrDocument{id=0, range_facet_l=[0], id_i1=0, range_facet_l_dv=[0], 
range_facet_i_dv=[0], a_t=[one two three], shard_i=[1], 
multiDefault=[muLti-Default], intDefault=42, timestamp=Sun Mar 11 00:53:24 PST 
2018, _version_=1594630765231996928, intDvoDefault=42, 
score=0.57735026}]},debug={rawquerystring=a_t:one a_t:four,querystring=a_t:one 
a_t:four,parsedquery=a_t:on a_t:four,parsedquery_toString=a_t:on 
a_t:four,explain={1=
   [junit4]   1> 1.0757567 = sum of:
   [junit4]   1>   0.4472136 = weight(a_t:on in 0) 
[MockConfigurableSimilarity], result of:
   [junit4]   1>     0.4472136 = score(freq=1.0), product of:
   [junit4]   1>       1.0 = idf, computed as log((docCount+1)/(docFreq+1)) + 1 
from:
   [junit4]   1>         2 = docFreq, number of documents containing term
   [junit4]   1>         2 = docCount, total number of documents with field
   [junit4]   1>       1.0 = tf(freq=1.0), with freq of:
   [junit4]   1>         1.0 = freq, occurrences of term within document
   [junit4]   1>       0.4472136 = fieldNorm
   [junit4]   1>   0.6285431 = weight(a_t:four in 0) 
[MockConfigurableSimilarity], result of:
   [junit4]   1>     0.6285431 = score(freq=1.0), product of:
   [junit4]   1>       1.4054651 = idf, computed as 
log((docCount+1)/(docFreq+1)) + 1 from:
   [junit4]   1>         1 = docFreq, number of documents containing term
   [junit4]   1>         2 = docCount, total number of documents with field
   [junit4]   1>       1.0 = tf(freq=1.0), with freq of:
   [junit4]   1>         1.0 = freq, occurrences of term within document
   [junit4]   1>       0.4472136 = fieldNorm
   [junit4]   1> ,0=
   [junit4]   1> 0.57735026 = sum of:
   [junit4]   1>   0.57735026 = weight(a_t:on in 0) 
[MockConfigurableSimilarity], result of:
   [junit4]   1>     0.57735026 = score(freq=1.0), product of:
   [junit4]   1>       1.0 = idf, computed as log((docCount+1)/(docFreq+1)) + 1 
from:
   [junit4]   1>         2 = docFreq, number of documents containing term
   [junit4]   1>         2 = docCount, total number of documents with field
   [junit4]   1>       1.0 = tf(freq=1.0), with freq of:
   [junit4]   1>         1.0 = freq, occurrences of term within document
   [junit4]   1>       0.57735026 = fieldNorm
   [junit4]   1> 
},QParser=LuceneQParser,timing={time=0.0,prepare={time=0.0,query={time=0.0},facet={time=0.0},facet_module={time=0.0},mlt={time=0.0},highlight={time=0.0},stats={time=0.0},expand={time=0.0},terms={time=0.0},debug={time=0.0}},process={time=0.0,query={time=0.0},facet={time=0.0},facet_module={time=0.0},mlt={time=0.0},highlight={time=0.0},stats={time=0.0},expand={time=0.0},terms={time=0.0},debug={time=0.0}}}}}
   [junit4]   1> 
   [junit4]   1> 
   [junit4]   1> ======================= Shard Response =======================
   [junit4]   1> 
   [junit4]   1> 
{responseHeader={status=0,QTime=4},response={numFound=2,start=0,maxScore=1.0757567,docs=[SolrDocument{id=1,
 range_facet_l=[1], id_i1=1, range_facet_l_dv=[1], range_facet_i_dv=[1], 
a_t=[one two three four five], shard_i=[1], multiDefault=[muLti-Default], 
intDefault=42, timestamp=Sun Mar 11 00:53:25 PST 2018, 
_version_=1594630765313785856, intDvoDefault=42, score=1.0757567}, 
SolrDocument{id=0, range_facet_l=[0], id_i1=0, range_facet_l_dv=[0], 
range_facet_i_dv=[0], a_t=[one two three], shard_i=[1], 
multiDefault=[muLti-Default], intDefault=42, timestamp=Sun Mar 11 00:53:24 PST 
2018, _version_=1594630765236191232, intDvoDefault=42, 
score=0.57735026}]},debug={track={rid=127.0.0.1-collection1-1520758405073-23,PARSE_QUERY={http://127.0.0.1:49536/tl_lk/collection1={QTime=0,ElapsedTime=0,RequestPurpose=GET_TERM_STATS,Response={responseHeader={status=0,QTime=0},org.apache.solr.stats.terms=a_t:on,org.apache.solr.stats.terms=a_t:four,org.apache.solr.stats.termStats=a_t:on,2,2!a_t:four,1,1,org.apache.solr.stats.colStats=a_t,2,2,8,8,debug={timing={time=0.0,prepare={time=0.0,query={time=0.0},facet={time=0.0},facet_module={time=0.0},mlt={time=0.0},highlight={time=0.0},stats={time=0.0},expand={time=0.0},terms={time=0.0},debug={time=0.0}},process={time=0.0,query={time=0.0},facet={time=0.0},facet_module={time=0.0},mlt={time=0.0},highlight={time=0.0},stats={time=0.0},expand={time=0.0},terms={time=0.0},debug={time=0.0}}}}}}},EXECUTE_QUERY={http://127.0.0.1:49536/tl_lk/collection1={QTime=0,ElapsedTime=1,RequestPurpose=GET_TOP_IDS,SET_TERM_STATS,NumFound=2,Response={responseHeader={status=0,QTime=0},response={numFound=2,start=0,maxScore=1.0757567,docs=[SolrDocument{id=1,
 score=1.0757567}, SolrDocument{id=0, 
score=0.57735026}]},sort_values={},debug={timing={time=0.0,prepare={time=0.0,query={time=0.0},facet={time=0.0},facet_module={time=0.0},mlt={time=0.0},highlight={time=0.0},stats={time=0.0},expand={time=0.0},terms={time=0.0},debug={time=0.0}},process={time=0.0,query={time=0.0},facet={time=0.0},facet_module={time=0.0},mlt={time=0.0},highlight={time=0.0},stats={time=0.0},expand={time=0.0},terms={time=0.0},debug={time=0.0}}}}}}},GET_FIELDS={http://127.0.0.1:49536/tl_lk/collection1={QTime=0,ElapsedTime=1,RequestPurpose=GET_FIELDS,GET_DEBUG,NumFound=2,Response={responseHeader={status=0,QTime=0},response={numFound=2,start=0,docs=[SolrDocument{id=0,
 range_facet_l=[0], id_i1=0, range_facet_l_dv=[0], range_facet_i_dv=[0], 
a_t=[one two three], shard_i=[1], multiDefault=[muLti-Default], intDefault=42, 
timestamp=Sun Mar 11 00:53:24 PST 2018, _version_=1594630765236191232, 
intDvoDefault=42, score=0.57735026}, SolrDocument{id=1, range_facet_l=[1], 
id_i1=1, range_facet_l_dv=[1], range_facet_i_dv=[1], a_t=[one two three four 
five], shard_i=[1], multiDefault=[muLti-Default], intDefault=42, timestamp=Sun 
Mar 11 00:53:25 PST 2018, _version_=1594630765313785856, intDvoDefault=42, 
score=1.0757567}]},debug={rawquerystring=a_t:one a_t:four,querystring=a_t:one 
a_t:four,parsedquery=a_t:on a_t:four,parsedquery_toString=a_t:on 
a_t:four,explain={0=
   [junit4]   1> 0.57735026 = sum of:
   [junit4]   1>   0.57735026 = weight(a_t:on in 0) 
[MockConfigurableSimilarity], result of:
   [junit4]   1>     0.57735026 = score(freq=1.0), product of:
   [junit4]   1>       1.0 = idf, computed as log((docCount+1)/(docFreq+1)) + 1 
from:
   [junit4]   1>         2 = docFreq, number of documents containing term
   [junit4]   1>         2 = docCount, total number of documents with field
   [junit4]   1>       1.0 = tf(freq=1.0), with freq of:
   [junit4]   1>         1.0 = freq, occurrences of term within document
   [junit4]   1>       0.57735026 = fieldNorm
   [junit4]   1> ,1=
   [junit4]   1> 1.0757567 = sum of:
   [junit4]   1>   0.4472136 = weight(a_t:on in 0) 
[MockConfigurableSimilarity], result of:
   [junit4]   1>     0.4472136 = score(freq=1.0), product of:
   [junit4]   1>       1.0 = idf, computed as log((docCount+1)/(docFreq+1)) + 1 
from:
   [junit4]   1>         2 = docFreq, number of documents containing term
   [junit4]   1>         2 = docCount, total number of documents with field
   [junit4]   1>       1.0 = tf(freq=1.0), with freq of:
   [junit4]   1>         1.0 = freq, occurrences of term within document
   [junit4]   1>       0.4472136 = fieldNorm
   [junit4]   1>   0.6285431 = weight(a_t:four in 0) 
[MockConfigurableSimilarity], result of:
   [junit4]   1>     0.6285431 = score(freq=1.0), product of:
   [junit4]   1>       1.4054651 = idf, computed as 
log((docCount+1)/(docFreq+1)) + 1 from:
   [junit4]   1>         1 = docFreq, number of documents containing term
   [junit4]   1>         2 = docCount, total number of documents with field
   [junit4]   1>       1.0 = tf(freq=1.0), with freq of:
   [junit4]   1>         1.0 = freq, occurrences of term within document
   [junit4]   1>       0.4472136 = fieldNorm
   [junit4]   1> 
},QParser=LuceneQParser,timing={time=0.0,prepare={time=0.0,query={time=0.0},facet={time=0.0},facet_module={time=0.0},mlt={time=0.0},highlight={time=0.0},stats={time=0.0},expand={time=0.0},terms={time=0.0},debug={time=0.0}},process={time=0.0,query={time=0.0},facet={time=0.0},facet_module={time=0.0},mlt={time=0.0},highlight={time=0.0},stats={time=0.0},expand={time=0.0},terms={time=0.0},debug={time=0.0}}}}}}}},timing={time=0.0,prepare={time=0.0,query={time=0.0},facet={time=0.0},facet_module={time=0.0},mlt={time=0.0},highlight={time=0.0},stats={time=0.0},expand={time=0.0},terms={time=0.0},debug={time=0.0}},process={time=0.0,query={time=0.0},facet={time=0.0},facet_module={time=0.0},mlt={time=0.0},highlight={time=0.0},stats={time=0.0},expand={time=0.0},terms={time=0.0},debug={time=0.0}}},rawquerystring=a_t:one
 a_t:four,querystring=a_t:one a_t:four,parsedquery=a_t:on 
a_t:four,parsedquery_toString=a_t:on a_t:four,QParser=LuceneQParser,explain={1=
   [junit4]   1> 1.0757567 = sum of:
   [junit4]   1>   0.4472136 = weight(a_t:on in 0) 
[MockConfigurableSimilarity], result of:
   [junit4]   1>     0.4472136 = score(freq=1.0), product of:
   [junit4]   1>       1.0 = idf, computed as log((docCount+1)/(docFreq+1)) + 1 
from:
   [junit4]   1>         2 = docFreq, number of documents containing term
   [junit4]   1>         2 = docCount, total number of documents with field
   [junit4]   1>       1.0 = tf(freq=1.0), with freq of:
   [junit4]   1>         1.0 = freq, occurrences of term within document
   [junit4]   1>       0.4472136 = fieldNorm
   [junit4]   1>   0.6285431 = weight(a_t:four in 0) 
[MockConfigurableSimilarity], result of:
   [junit4]   1>     0.6285431 = score(freq=1.0), product of:
   [junit4]   1>       1.4054651 = idf, computed as 
log((docCount+1)/(docFreq+1)) + 1 from:
   [junit4]   1>         1 = docFreq, number of documents containing term
   [junit4]   1>         2 = docCount, total number of documents with field
   [junit4]   1>       1.0 = tf(freq=1.0), with freq of:
   [junit4]   1>         1.0 = freq, occurrences of term within document
   [junit4]   1>       0.4472136 = fieldNorm
   [junit4]   1> ,0=
   [junit4]   1> 0.57735026 = sum of:
   [junit4]   1>   0.57735026 = weight(a_t:on in 0) 
[MockConfigurableSimilarity], result of:
   [junit4]   1>     0.57735026 = score(freq=1.0), product of:
   [junit4]   1>       1.0 = idf, computed as log((docCount+1)/(docFreq+1)) + 1 
from:
   [junit4]   1>         2 = docFreq, number of documents containing term
   [junit4]   1>         2 = docCount, total number of documents with field
   [junit4]   1>       1.0 = tf(freq=1.0), with freq of:
   [junit4]   1>         1.0 = freq, occurrences of term within document
   [junit4]   1>       0.57735026 = fieldNorm
   [junit4]   1> }}}
   [junit4]   2> 1478019 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending test
   [junit4]   2> 1478020 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.e.j.s.AbstractConnector Stopped 
ServerConnector@d0aa4{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 1478021 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=3054206
   [junit4]   2> 1478021 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 1478021 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@a6b2b6: rootName = null, 
domain = solr.node, service url = null, agent id = null] for registry solr.node 
/ com.codahale.metrics.MetricRegistry@196cdba
   [junit4]   2> 1478026 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 1478026 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@1ec48c5: rootName = null, 
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / 
com.codahale.metrics.MetricRegistry@12dcb5f
   [junit4]   2> 1478029 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 1478029 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@1b2c7c: rootName = null, 
domain = solr.jetty, service url = null, agent id = null] for registry 
solr.jetty / com.codahale.metrics.MetricRegistry@16f8066
   [junit4]   2> 1478031 INFO  (coreCloseExecutor-4861-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@b30832
   [junit4]   2> 1478031 INFO  (coreCloseExecutor-4861-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=11733042
   [junit4]   2> 1478031 INFO  (coreCloseExecutor-4861-thread-1) [    
x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@19962fb: rootName = null, 
domain = solr.core.collection1, service url = null, agent id = null] for 
registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@8de3bd
   [junit4]   2> 1478045 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@1827d5e{/tl_lk,null,UNAVAILABLE}
   [junit4]   2> 1478045 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] o.e.j.s.session 
Stopped scavenging
   [junit4]   2> 1478047 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.e.j.s.AbstractConnector Stopped 
ServerConnector@5902e8{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 1478047 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1010741
   [junit4]   2> 1478047 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 1478047 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@12c7b5: rootName = null, 
domain = solr.node, service url = null, agent id = null] for registry solr.node 
/ com.codahale.metrics.MetricRegistry@1a6c63d
   [junit4]   2> 1478077 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 1478077 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@e67c5b: rootName = null, 
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / 
com.codahale.metrics.MetricRegistry@12dcb5f
   [junit4]   2> 1478081 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 1478081 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@18b218d: rootName = null, 
domain = solr.jetty, service url = null, agent id = null] for registry 
solr.jetty / com.codahale.metrics.MetricRegistry@16f8066
   [junit4]   2> 1478088 INFO  (coreCloseExecutor-4863-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@1f94113
   [junit4]   2> 1478088 INFO  (coreCloseExecutor-4863-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=33112339
   [junit4]   2> 1478088 INFO  (coreCloseExecutor-4863-thread-1) [    
x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@129d060: rootName = null, 
domain = solr.core.collection1, service url = null, agent id = null] for 
registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@17cf588
   [junit4]   2> 1478128 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@16ea46a{/tl_lk,null,UNAVAILABLE}
   [junit4]   2> 1478128 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] o.e.j.s.session 
Stopped scavenging
   [junit4]   2> 1478971 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] o.e.j.s.Server 
jetty-9.4.8.v20171121, build timestamp: 2017-11-21T16:27:37-05:00, git hash: 
82b8fb23f757335bb3329d540ce37a2a2615f0a8
   [junit4]   2> 1478973 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] o.e.j.s.session 
DefaultSessionIdManager workerName=node0
   [junit4]   2> 1478973 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] o.e.j.s.session 
No SessionScavenger set, using defaults
   [junit4]   2> 1478973 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] o.e.j.s.session 
Scavenging every 660000ms
   [junit4]   2> 1478973 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@701556{/tl_lk,null,AVAILABLE}
   [junit4]   2> 1478973 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@833184{HTTP/1.1,[http/1.1]}{127.0.0.1:49542}
   [junit4]   2> 1478973 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] o.e.j.s.Server 
Started @1486591ms
   [junit4]   2> 1478973 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/tl_lk, 
hostPort=49542, 
coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactStatsCache_122C8868088CF657-001\tempDir-001\control\cores}
   [junit4]   2> 1478974 ERROR 
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1478974 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.0.0
   [junit4]   2> 1478974 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 1478974 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1478974 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-03-11T08:53:26.033Z
   [junit4]   2> 1478975 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactStatsCache_122C8868088CF657-001\tempDir-001\control\solr.xml
   [junit4]   2> 1478987 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay 
is ignored
   [junit4]   2> 1478987 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 1478989 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@453406, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 1479178 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@453406
   [junit4]   2> 1479196 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@453406
   [junit4]   2> 1479197 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@453406
   [junit4]   2> 1479207 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactStatsCache_122C8868088CF657-001\tempDir-001\control\cores
   [junit4]   2> 1479207 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 1479208 INFO  (coreLoadExecutor-4870-thread-1) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 1479214 INFO  (coreLoadExecutor-4870-thread-1) [    
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, 
from paths: 
[/C:/Users/jenkins/workspace/Lucene-Solr-master-Windows/solr/core/src/test-files/solr/collection1/lib,
 
/C:/Users/jenkins/workspace/Lucene-Solr-master-Windows/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1479317 INFO  (coreLoadExecutor-4870-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 1479351 INFO  (coreLoadExecutor-4870-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1479500 INFO  (coreLoadExecutor-4870-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1479534 INFO  (coreLoadExecutor-4870-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from configset 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\collection1,
 trusted=true
   [junit4]   2> 1479534 INFO  (coreLoadExecutor-4870-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@453406
   [junit4]   2> 1479534 INFO  (coreLoadExecutor-4870-thread-1) [    
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 1479534 INFO  (coreLoadExecutor-4870-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\collection1],
 
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactStatsCache_122C8868088CF657-001\tempDir-001\control\cores\collection1\data\]
   [junit4]   2> 1479539 INFO  (coreLoadExecutor-4870-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=49, maxMergeAtOnceExplicit=10, maxMergedSegmentMB=56.478515625, 
floorSegmentMB=1.4189453125, forceMergeDeletesPctAllowed=26.71068873528499, 
segmentsPerTier=19.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.6774781922784532
   [junit4]   2> 1479755 INFO  (coreLoadExecutor-4870-thread-1) [    
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1479755 INFO  (coreLoadExecutor-4870-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 1479756 INFO  (coreLoadExecutor-4870-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1479756 INFO  (coreLoadExecutor-4870-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1479758 INFO  (coreLoadExecutor-4870-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=10, maxMergeAtOnceExplicit=34, maxMergedSegmentMB=95.525390625, 
floorSegmentMB=2.0712890625, forceMergeDeletesPctAllowed=28.058961882398968, 
segmentsPerTier=39.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.15909547591445056
   [junit4]   2> 1479758 INFO  (coreLoadExecutor-4870-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@ae8139[collection1] 
main]
   [junit4]   2> 1479760 INFO  (coreLoadExecutor-4870-thread-1) [    
x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1479763 INFO  (coreLoadExecutor-4870-thread-1) [    
x:collection1] o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 1479815 INFO  (coreLoadExecutor-4870-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 1479815 INFO  
(searcherExecutor-4871-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1479815 INFO  (coreLoadExecutor-4870-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1594630767246311424
   [junit4]   2> 1479816 INFO  
(searcherExecutor-4871-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1479816 INFO  
(searcherExecutor-4871-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1479816 INFO  
(searcherExecutor-4871-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 1479816 INFO  
(searcherExecutor-4871-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1479816 INFO  
(searcherExecutor-4871-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1479816 INFO  
(searcherExecutor-4871-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1479816 INFO  
(searcherExecutor-4871-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 1479817 INFO  
(searcherExecutor-4871-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 1479818 INFO  
(searcherExecutor-4871-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@ae8139[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1481006 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] o.e.j.s.Server 
jetty-9.4.8.v20171121, build timestamp: 2017-11-21T16:27:37-05:00, git hash: 
82b8fb23f757335bb3329d540ce37a2a2615f0a8
   [junit4]   2> 1481006 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] o.e.j.s.session 
DefaultSessionIdManager workerName=node0
   [junit4]   2> 1481006 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] o.e.j.s.session 
No SessionScavenger set, using defaults
   [junit4]   2> 1481006 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] o.e.j.s.session 
Scavenging every 600000ms
   [junit4]   2> 1481006 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@1afe5d8{/tl_lk,null,AVAILABLE}
   [junit4]   2> 1481009 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@82504c{HTTP/1.1,[http/1.1]}{127.0.0.1:49545}
   [junit4]   2> 1481009 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] o.e.j.s.Server 
Started @1488626ms
   [junit4]   2> 1481009 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/tl_lk, 
hostPort=49545, 
coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactStatsCache_122C8868088CF657-001\tempDir-001\shard0\cores}
   [junit4]   2> 1481009 ERROR 
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1481009 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.0.0
   [junit4]   2> 1481009 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 1481009 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1481009 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-03-11T08:53:28.068Z
   [junit4]   2> 1481011 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactStatsCache_122C8868088CF657-001\tempDir-001\shard0\solr.xml
   [junit4]   2> 1481024 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay 
is ignored
   [junit4]   2> 1481024 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 1481027 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@453406, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 1481210 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@453406
   [junit4]   2> 1481222 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@453406
   [junit4]   2> 1481223 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@453406
   [junit4]   2> 1481227 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactStatsCache_122C8868088CF657-001\tempDir-001\shard0\cores
   [junit4]   2> 1481227 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 1481272 INFO  (coreLoadExecutor-4881-thread-1) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 1481274 INFO  (coreLoadExecutor-4881-thread-1) [    
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, 
from paths: 
[/C:/Users/jenkins/workspace/Lucene-Solr-master-Windows/solr/core/src/test-files/solr/collection1/lib,
 
/C:/Users/jenkins/workspace/Lucene-Solr-master-Windows/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1481407 INFO  (coreLoadExecutor-4881-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 1481434 INFO  (coreLoadExecutor-4881-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1481603 INFO  (coreLoadExecutor-4881-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1481625 INFO  (coreLoadExecutor-4881-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from configset 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\collection1,
 trusted=true
   [junit4]   2> 1481626 INFO  (coreLoadExecutor-4881-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@453406
   [junit4]   2> 1481626 INFO  (coreLoadExecutor-4881-thread-1) [    
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 1481626 INFO  (coreLoadExecutor-4881-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\collection1],
 
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactStatsCache_122C8868088CF657-001\tempDir-001\shard0\cores\collection1\data\]
   [junit4]   2> 1481632 INFO  (coreLoadExecutor-4881-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=49, maxMergeAtOnceExplicit=10, maxMergedSegmentMB=56.478515625, 
floorSegmentMB=1.4189453125, forceMergeDeletesPctAllowed=26.71068873528499, 
segmentsPerTier=19.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.6774781922784532
   [junit4]   2> 1481869 INFO  (coreLoadExecutor-4881-thread-1) [    
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1481869 INFO  (coreLoadExecutor-4881-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 1481872 INFO  (coreLoadExecutor-4881-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1481872 INFO  (coreLoadExecutor-4881-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1481874 INFO  (coreLoadExecutor-4881-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=10, maxMergeAtOnceExplicit=34, maxMergedSegmentMB=95.525390625, 
floorSegmentMB=2.0712890625, forceMergeDeletesPctAllowed=28.058961882398968, 
segmentsPerTier=39.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.15909547591445056
   [junit4]   2> 1481876 INFO  (coreLoadExecutor-4881-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@181db8a[collection1] 
main]
   [junit4]   2> 1481879 INFO  (coreLoadExecutor-4881-thread-1) [    
x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1481885 INFO  (coreLoadExecutor-4881-thread-1) [    
x:collection1] o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 1481939 INFO  (coreLoadExecutor-4881-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 1481939 INFO  
(searcherExecutor-4882-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1481939 INFO  
(searcherExecutor-4882-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1481941 INFO  
(searcherExecutor-4882-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1481941 INFO  
(searcherExecutor-4882-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 1481941 INFO  
(searcherExecutor-4882-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1481941 INFO  
(searcherExecutor-4882-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1481941 INFO  
(searcherExecutor-4882-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1481942 INFO  
(searcherExecutor-4882-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell i

[...truncated too long message...]

ST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@5adb4e: rootName = null, 
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / 
com.codahale.metrics.MetricRegistry@12dcb5f
   [junit4]   2> 1497062 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 1497062 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@fcf211: rootName = null, 
domain = solr.jetty, service url = null, agent id = null] for registry 
solr.jetty / com.codahale.metrics.MetricRegistry@16f8066
   [junit4]   2> 1497065 INFO  (coreCloseExecutor-4954-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@1d4ee45
   [junit4]   2> 1497065 INFO  (coreCloseExecutor-4954-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=30731845
   [junit4]   2> 1497066 INFO  (coreCloseExecutor-4954-thread-1) [    
x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@967b37: rootName = null, 
domain = solr.core.collection1, service url = null, agent id = null] for 
registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@11056e
   [junit4]   2> 1497093 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@1ecee5d{/tl_lk,null,UNAVAILABLE}
   [junit4]   2> 1497094 INFO  
(TEST-TestExactStatsCache.test-seed#[122C8868088CF657]) [    ] o.e.j.s.session 
Stopped scavenging
   [junit4]   2> 1497106 INFO  
(SUITE-TestExactStatsCache-seed#[122C8868088CF657]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ------------------------------------------------------- 
Done waiting for tracked resources to be released
   [junit4]   2> NOTE: test params are: 
codec=FastDecompressionCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=FAST_DECOMPRESSION,
 chunkSize=5, maxDocsPerChunk=8, blockSize=8), 
termVectorsFormat=CompressingTermVectorsFormat(compressionMode=FAST_DECOMPRESSION,
 chunkSize=5, blockSize=8)), 
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@d435d8),
 locale=vi, timezone=Pacific/Pitcairn
   [junit4]   2> NOTE: Windows 10 10.0 x86/Oracle Corporation 1.8.0_144 
(32-bit)/cpus=3,threads=1,free=269355632,total=518979584
   [junit4]   2> NOTE: All tests run in this JVM: [RegexBoostProcessorTest, 
TestReqParamsAPI, TestJavabinTupleStreamParser, ReplaceNodeTest, 
SortByFunctionTest, TestFieldCacheVsDocValues, TestRawResponseWriter, 
TestStressRecovery, TestSchemaVersionResource, TestSkipOverseerOperations, 
SolrMetricsIntegrationTest, CustomCollectionTest, CurrencyRangeFacetCloudTest, 
TestDocBasedVersionConstraints, ScheduledMaintenanceTriggerTest, 
TestConfigSets, TestSmileRequest, InfixSuggestersTest, 
SolrGraphiteReporterTest, EnumFieldTest, BadCopyFieldTest, 
TestExclusionRuleCollectionAccess, TestPKIAuthenticationPlugin, LargeFieldTest, 
TestLegacyField, TestCodecSupport, TestSubQueryTransformerCrossCore, 
TestTriggerIntegration, OverriddenZkACLAndCredentialsProvidersTest, 
TestQueryWrapperFilter, BlockJoinFacetRandomTest, V2StandaloneTest, 
TestNonDefinedSimilarityFactory, TestScoreJoinQPScore, TestDistribStateManager, 
BasicAuthIntegrationTest, ScriptEngineTest, CollectionStateFormat2Test, 
BadIndexSchemaTest, TestCollectionAPIs, ZkFailoverTest, 
TestExtendedDismaxParser, CloudMLTQParserTest, CdcrBidirectionalTest, 
TestEmbeddedSolrServerSchemaAPI, TestCloudDeleteByQuery, 
HdfsUnloadDistributedZkTest, TestRTGBase, UUIDFieldTest, 
TestZkAclsWithHadoopAuth, TestOrdValues, TestWordDelimiterFilterFactory, 
TestShortCircuitedRequests, TestSimpleTrackingShardHandler, 
MoveReplicaHDFSFailoverTest, TestSolrCoreParser, RegexBytesRefFilterTest, 
TestEmbeddedSolrServerAdminHandler, ClusterStateUpdateTest, 
ConcurrentCreateRoutedAliasTest, TestRandomFaceting, DirectoryFactoryTest, 
BigEndianAscendingWordSerializerTest, TestConfigSetsAPI, 
PrimitiveFieldTypeTest, DistributedIntervalFacetingTest, SearchHandlerTest, 
TestBackupRepositoryFactory, PKIAuthenticationIntegrationTest, GraphQueryTest, 
ResponseLogComponentTest, TestLMDirichletSimilarityFactory, 
TestComplexPhraseLeadingWildcard, TestRandomDVFaceting, 
CloudExitableDirectoryReaderTest, DistributedFacetPivotLongTailTest, 
TestTestInjection, TestRetrieveFieldsOptimizer, TestNestedDocsSort, 
DeleteLastCustomShardedReplicaTest, VersionInfoTest, TestMaxTokenLenTokenizer, 
TestTolerantUpdateProcessorCloud, FieldAnalysisRequestHandlerTest, 
TestSolrConfigHandler, RankQueryTest, PreAnalyzedFieldManagedSchemaCloudTest, 
LoggingHandlerTest, TestSolrDeletionPolicy2, HdfsRestartWhileUpdatingTest, 
TestMissingGroups, OverseerTest, AssignTest, ConnectionReuseTest, 
TestComponentsName, TestBlendedInfixSuggestions, TestStressLiveNodes, 
TestDistributedStatsComponentCardinality, TestRecoveryHdfs, AddBlockUpdateTest, 
TestDistributedSearch, SyncSliceTest, TestFuzzyAnalyzedSuggestions, 
StressHdfsTest, TestLMJelinekMercerSimilarityFactory, 
FullSolrCloudDistribCmdsTest, ZkSolrClientTest, TestDocSet, 
TestMultiValuedNumericRangeQuery, NoCacheHeaderTest, 
TestCloudJSONFacetJoinDomain, RestartWhileUpdatingTest, MinimalSchemaTest, 
DebugComponentTest, TestAddFieldRealTimeGet, TestWriterPerf, 
SpellCheckCollatorWithCollapseTest, TestSolrQueryParser, TestManagedSchemaAPI, 
ClassificationUpdateProcessorFactoryTest, TestSchemaResource, 
LIRRollingUpdatesTest, TestCloudSchemaless, PreAnalyzedFieldTest, 
SolrMetricManagerTest, DistributedTermsComponentTest, 
TestHdfsBackupRestoreCore, TestSlowCompositeReaderWrapper, 
HdfsBasicDistributedZkTest, TestCopyFieldCollectionResource, 
StatsReloadRaceTest, CdcrReplicationDistributedZkTest, 
DisMaxRequestHandlerTest, CSVRequestHandlerTest, TestStressLucene, 
TestFastLRUCache, TestJsonFacetsWithNestedObjects, TestUtilizeNode, 
TestManagedResource, FileBasedSpellCheckerTest, TestRandomFlRTGCloud, 
TestSha256AuthenticationProvider, CollectionTooManyReplicasTest, 
TestNodeAddedTrigger, ChaosMonkeyNothingIsSafeWithPullReplicasTest, 
DistributedFacetExistsSmallTest, TestClassicSimilarityFactory, 
ShardRoutingTest, NodeAddedTriggerTest, SolrJmxReporterTest, TestDistribIDF, 
TestPHPSerializedResponseWriter, CdcrUpdateLogTest, ZkStateReaderTest, 
BasicFunctionalityTest, TestExactStatsCache]
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestExactStatsCache 
-Dtests.seed=122C8868088CF657 -Dtests.slow=true -Dtests.locale=vi 
-Dtests.timezone=Pacific/Pitcairn -Dtests.asserts=true 
-Dtests.file.encoding=ISO-8859-1
   [junit4] ERROR   0.00s J1 | TestExactStatsCache (suite) <<<
   [junit4]    > Throwable #1: java.io.IOException: Could not remove the 
following files (in the order of attempts):
   [junit4]    >    
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactStatsCache_122C8868088CF657-001\tempDir-001\control\collection1:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactStatsCache_122C8868088CF657-001\tempDir-001\control\collection1
   [junit4]    >    
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactStatsCache_122C8868088CF657-001\tempDir-001\control:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactStatsCache_122C8868088CF657-001\tempDir-001\control
   [junit4]    >    
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactStatsCache_122C8868088CF657-001\tempDir-001:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactStatsCache_122C8868088CF657-001\tempDir-001
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([122C8868088CF657]:0)
   [junit4]    >        at org.apache.lucene.util.IOUtils.rm(IOUtils.java:329)
   [junit4]    >        at java.lang.Thread.run(Thread.java:748)
   [junit4] Completed [303/785 (1!)] on J1 in 25.85s, 1 test, 1 error <<< 
FAILURES!

[...truncated 46802 lines...]
[repro] Jenkins log URL: 
https://jenkins.thetaphi.de/job/Lucene-Solr-master-Windows/7215/consoleText

[repro] Revision: 8f1350af20c682df7b7fb9e3af762e03b944fdb9

[repro] Ant options: "-Dargs=-server -XX:+UseConcMarkSweepGC"

[repro] ant clean

[...truncated 6 lines...]
[repro] Test suites by module:
[repro]    solr\core
[repro]       TestExactStatsCache
[repro]    lucene\core
[repro]       TestLongPostings
[repro] ant compile-test

[...truncated 3313 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5 
-Dtests.class="*.TestExactStatsCache" -Dtests.showOutput=onerror 
"-Dargs=-server -XX:+UseConcMarkSweepGC" -Dtests.seed=122C8868088CF657 
-Dtests.slow=true -Dtests.locale=vi -Dtests.timezone=Pacific/Pitcairn 
-Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1

[...truncated 69 lines...]
[repro] ant compile-test

[...truncated 88 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5 
-Dtests.class="*.TestLongPostings" -Dtests.showOutput=onerror "-Dargs=-server 
-XX:+UseConcMarkSweepGC" -Dtests.seed=B6FA22691B178CCE -Dtests.slow=true 
-Dtests.locale=ms-MY -Dtests.timezone=Antarctica/Macquarie -Dtests.asserts=true 
-Dtests.file.encoding=UTF-8

[...truncated 74 lines...]
[repro] Failures:
[repro]   0/5 failed: org.apache.lucene.index.TestLongPostings
[repro]   0/5 failed: org.apache.solr.search.stats.TestExactStatsCache
[repro] Exiting with code 0

[...truncated 75 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org

Reply via email to