Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/19961/
Java: 64bit/jdk1.8.0_131 -XX:-UseCompressedOops -XX:+UseConcMarkSweepGC

4 tests failed.
FAILED:  
org.apache.lucene.index.TestBinaryDocValuesUpdates.testManyReopensAndFields

Error Message:
invalid value for doc=0, field=f4, reader=_28(7.0.0):C936 expected:<12> but 
was:<11>

Stack Trace:
java.lang.AssertionError: invalid value for doc=0, field=f4, 
reader=_28(7.0.0):C936 expected:<12> but was:<11>
        at 
__randomizedtesting.SeedInfo.seed([3A4BC284D906CE1A:CB7A0AB58F3AD06]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.failNotEquals(Assert.java:647)
        at org.junit.Assert.assertEquals(Assert.java:128)
        at org.junit.Assert.assertEquals(Assert.java:472)
        at 
org.apache.lucene.index.TestBinaryDocValuesUpdates.testManyReopensAndFields(TestBinaryDocValuesUpdates.java:844)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.lang.Thread.run(Thread.java:748)


FAILED:  org.apache.solr.search.stats.TestExactSharedStatsCache.test

Error Message:
expected:<2.252763> but was:<1.4054651>

Stack Trace:
java.lang.AssertionError: expected:<2.252763> but was:<1.4054651>
        at 
__randomizedtesting.SeedInfo.seed([3C5E85432D34583E:B40ABA9983C835C6]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.failNotEquals(Assert.java:647)
        at org.junit.Assert.assertEquals(Assert.java:128)
        at org.junit.Assert.assertEquals(Assert.java:147)
        at 
org.apache.solr.search.stats.TestBaseStatsCache.checkResponse(TestBaseStatsCache.java:64)
        at 
org.apache.solr.search.stats.TestDefaultStatsCache.dfQuery(TestDefaultStatsCache.java:109)
        at 
org.apache.solr.search.stats.TestDefaultStatsCache.test(TestDefaultStatsCache.java:76)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsRepeatStatement.callStatement(BaseDistributedSearchTestCase.java:1011)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:960)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.lang.Thread.run(Thread.java:748)


FAILED:  org.apache.solr.search.stats.TestExactStatsCache.test

Error Message:
expected:<2.252763> but was:<1.4054651>

Stack Trace:
java.lang.AssertionError: expected:<2.252763> but was:<1.4054651>
        at 
__randomizedtesting.SeedInfo.seed([3C5E85432D34583E:B40ABA9983C835C6]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.failNotEquals(Assert.java:647)
        at org.junit.Assert.assertEquals(Assert.java:128)
        at org.junit.Assert.assertEquals(Assert.java:147)
        at 
org.apache.solr.search.stats.TestBaseStatsCache.checkResponse(TestBaseStatsCache.java:64)
        at 
org.apache.solr.search.stats.TestDefaultStatsCache.dfQuery(TestDefaultStatsCache.java:109)
        at 
org.apache.solr.search.stats.TestDefaultStatsCache.test(TestDefaultStatsCache.java:76)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsRepeatStatement.callStatement(BaseDistributedSearchTestCase.java:1011)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:960)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.lang.Thread.run(Thread.java:748)


FAILED:  org.apache.solr.search.stats.TestLRUStatsCache.test

Error Message:
expected:<2.252763> but was:<1.4054651>

Stack Trace:
java.lang.AssertionError: expected:<2.252763> but was:<1.4054651>
        at 
__randomizedtesting.SeedInfo.seed([3C5E85432D34583E:B40ABA9983C835C6]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.failNotEquals(Assert.java:647)
        at org.junit.Assert.assertEquals(Assert.java:128)
        at org.junit.Assert.assertEquals(Assert.java:147)
        at 
org.apache.solr.search.stats.TestBaseStatsCache.checkResponse(TestBaseStatsCache.java:64)
        at 
org.apache.solr.search.stats.TestDefaultStatsCache.dfQuery(TestDefaultStatsCache.java:109)
        at 
org.apache.solr.search.stats.TestDefaultStatsCache.test(TestDefaultStatsCache.java:76)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsRepeatStatement.callStatement(BaseDistributedSearchTestCase.java:1011)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:960)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.lang.Thread.run(Thread.java:748)




Build Log:
[...truncated 1378 lines...]
   [junit4] Suite: org.apache.lucene.index.TestBinaryDocValuesUpdates
   [junit4]   1> TEST: isNRT=false reader1=StandardDirectoryReader(segments_1:4 
_0(7.0.0):C2)
   [junit4]   1> TEST: now reopen
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=TestBinaryDocValuesUpdates -Dtests.method=testManyReopensAndFields 
-Dtests.seed=3A4BC284D906CE1A -Dtests.multiplier=3 -Dtests.slow=true 
-Dtests.locale=hr-HR -Dtests.timezone=Pacific/Pitcairn -Dtests.asserts=true 
-Dtests.file.encoding=UTF-8
   [junit4] FAILURE 0.65s J2 | 
TestBinaryDocValuesUpdates.testManyReopensAndFields <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: invalid value for 
doc=0, field=f4, reader=_28(7.0.0):C936 expected:<12> but was:<11>
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([3A4BC284D906CE1A:CB7A0AB58F3AD06]:0)
   [junit4]    >        at 
org.apache.lucene.index.TestBinaryDocValuesUpdates.testManyReopensAndFields(TestBinaryDocValuesUpdates.java:844)
   [junit4]    >        at java.lang.Thread.run(Thread.java:748)
   [junit4] IGNOR/A 0.00s J2 | TestBinaryDocValuesUpdates.testTonsOfUpdates
   [junit4]    > Assumption #1: 'nightly' test group is disabled (@Nightly())
   [junit4]   2> NOTE: test params are: 
codec=HighCompressionCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=HIGH_COMPRESSION,
 chunkSize=12304, maxDocsPerChunk=1, blockSize=26), 
termVectorsFormat=CompressingTermVectorsFormat(compressionMode=HIGH_COMPRESSION,
 chunkSize=12304, blockSize=26)), sim=RandomSimilarity(queryNorm=false): {}, 
locale=hr-HR, timezone=Pacific/Pitcairn
   [junit4]   2> NOTE: Linux 4.10.0-21-generic amd64/Oracle Corporation 
1.8.0_131 (64-bit)/cpus=8,threads=1,free=302943312,total=518979584
   [junit4]   2> NOTE: All tests run in this JVM: [TestDirectPacked, 
TestFieldCacheRewriteMethod, TestBagOfPostings, TestEarlyTermination, 
TestReaderWrapperDVTypeCheck, TestNeedsScores, TestRoaringDocIdSet, 
TestShardSearching, TestSpansEnum, TestSegmentTermEnum, TestLongPostings, 
TestIndexReaderClose, TestLucene70NormsFormat, TestReqExclBulkScorer, 
TestField, TestSegmentTermDocs, TestSimilarityBase, TestGeoEncodingUtils, 
TestPayloadsOnVectors, TestCharTermAttributeImpl, TestDisjunctionMaxQuery, 
TestTermRangeQuery, TestLongValuesSource, TestCachingTokenFilter, 
TestOfflineSorter, TestTopDocsCollector, TestBufferedIndexInput, 
TestTermScorer, TestPerFieldPostingsFormat2, TestConsistentFieldNumbers, 
TestFieldsReader, TestConjunctions, TestSloppyPhraseQuery2, TestSetOnce, 
TestRollingUpdates, TestIndexWriterLockRelease, TestIndexWriterMergePolicy, 
TestRollingBuffer, TestBinaryDocument, TestSimpleFSLockFactory, 
TestIndexingSequenceNumbers, FiniteStringsIteratorTest, 
TestGraphTokenStreamFiniteStrings, TestSentinelIntSet, TestHugeRamFile, 
TestSortedNumericSortField, TestMultiCollector, TestSpanNotQuery, 
TestAllFilesHaveCodecHeader, TestTrackingDirectoryWrapper, 
TestControlledRealTimeReopenThread, TestDirectoryReader, TestDocValues, 
TestDoubleRangeFieldQueries, TestSpanCollection, TestDemoParallelLeafReader, 
TestSpans, TestTerms, Test2BBinaryDocValues, TestParallelCompositeReader, 
TestArrayUtil, TestPrefixQuery, TestAttributeSource, TestByteBlockPool, 
TestCompiledAutomaton, TestSimpleExplanationsOfNonMatches, 
TestDocValuesScoring, TestExceedMaxTermLength, TestNRTThreads, 
TestLazyProxSkipping, TestSimilarity2, TestSearchWithThreads, TestPolygon2D, 
TestGrowableByteArrayDataOutput, TestIndexCommit, TestBasics, 
TestSearcherManager, TestNorms, TestStandardAnalyzer, TestTopDocsMerge, 
TestMinimize, TestNRTReaderWithThreads, TestIndexWriterForceMerge, 
TestPerFieldPostingsFormat, TestCollectionUtil, TestFastDecompressionMode, 
TestSort, TestMultiDocValues, TestCustomSearcherSort, TestTermsEnum2, 
Test2BDocs, TestMixedCodecs, TestSpanExplanations, TestFastCompressionMode, 
TestStressIndexing2, TestMultiPhraseQuery, TestDeterminism, 
TestMergeSchedulerExternal, TestForceMergeForever, TestSameScoresWithThreads, 
TestMultiFields, TestLiveFieldValues, TestSpanSearchEquivalence, TestPayloads, 
TestDoc, TestFieldMaskingSpanQuery, TestExternalCodecs, TestRegexpQuery, 
TestIntBlockPool, TestComplexExplanationsOfNonMatches, 
TestParallelReaderEmptyIndex, TestDocument, TestFileSwitchDirectory, 
TestDirectory, TestRegexpRandom, TestMultiLevelSkipList, TestCheckIndex, 
TestBooleanQueryVisitSubscorers, TestMatchAllDocsQuery, TestSubScorerFreqs, 
TestIndexWriterConfig, TestPositionIncrement, TestSpanExplanationsOfNonMatches, 
TestFilterLeafReader, TestSameTokenSamePosition, TestAutomatonQueryUnicode, 
TestRamUsageEstimator, TestSpanFirstQuery, TestIsCurrent, TestNoMergePolicy, 
TestNoMergeScheduler, TestNamedSPILoader, TestBytesRef, TestCharFilter, 
TestTwoPhaseCommitTool, TestCloseableThreadLocal, TestVersion, 
TestReaderClosed, TestNGramPhraseQuery, TestIntsRef, Test2BPositions, 
Test2BPostingsBytes, Test2BTerms, TestByteArrayDataInput, Test2BPagedBytes, 
TestCharArraySet, TestDelegatingAnalyzerWrapper, TestStopFilter, 
TestBlockPostingsFormat, TestLucene50TermVectorsFormat, 
Test2BSortedDocValuesOrds, TestAllFilesCheckIndexHeader, 
TestAllFilesHaveChecksumFooter, TestBinaryDocValuesUpdates]
   [junit4] Completed [362/453 (1!)] on J2 in 6.22s, 29 tests, 1 failure, 1 
skipped <<< FAILURES!

[...truncated 9641 lines...]
   [junit4] Suite: org.apache.solr.search.stats.TestExactStatsCache
   [junit4]   2> Creating dataDir: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.search.stats.TestExactStatsCache_3C5E85432D34583E-001/init-core-data-001
   [junit4]   2> 92343 WARN  
(SUITE-TestExactStatsCache-seed#[3C5E85432D34583E]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=27 numCloses=27
   [junit4]   2> 92343 INFO  
(SUITE-TestExactStatsCache-seed#[3C5E85432D34583E]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 92344 INFO  
(SUITE-TestExactStatsCache-seed#[3C5E85432D34583E]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via: 
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
   [junit4]   2> 92345 INFO  
(SUITE-TestExactStatsCache-seed#[3C5E85432D34583E]-worker) [    ] 
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /urpd/y
   [junit4]   2> 92592 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.search.stats.TestExactStatsCache_3C5E85432D34583E-001/tempDir-001/control/cores/collection1
   [junit4]   2> 92594 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] o.e.j.s.Server 
jetty-9.3.14.v20161028
   [junit4]   2> 92656 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@36cd00{/urpd/y,null,AVAILABLE}
   [junit4]   2> 92657 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@72f152d8{SSL,[ssl, 
http/1.1]}{127.0.0.1:39073}
   [junit4]   2> 92657 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] o.e.j.s.Server 
Started @94552ms
   [junit4]   2> 92658 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/urpd/y, 
hostPort=39073, 
coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.search.stats.TestExactStatsCache_3C5E85432D34583E-001/tempDir-001/control/cores}
   [junit4]   2> 92658 ERROR 
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 92658 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.0.0
   [junit4]   2> 92658 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 92658 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 92658 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-06-25T01:56:02.175Z
   [junit4]   2> 92658 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.search.stats.TestExactStatsCache_3C5E85432D34583E-001/tempDir-001/control/solr.xml
   [junit4]   2> 92665 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@3be8eef7, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 92739 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3be8eef7
   [junit4]   2> 92763 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3be8eef7
   [junit4]   2> 92763 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3be8eef7
   [junit4]   2> 92765 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.search.stats.TestExactStatsCache_3C5E85432D34583E-001/tempDir-001/control/cores
   [junit4]   2> 92765 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 92808 INFO  (coreLoadExecutor-455-thread-1) [    
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, 
from paths: 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib,
 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 92995 INFO  (coreLoadExecutor-455-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 93016 INFO  (coreLoadExecutor-455-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 93246 INFO  (coreLoadExecutor-455-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 93324 INFO  (coreLoadExecutor-455-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from configset 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1,
 trusted=true
   [junit4]   2> 93324 INFO  (coreLoadExecutor-455-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@3be8eef7
   [junit4]   2> 93324 INFO  (coreLoadExecutor-455-thread-1) [    
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 93324 INFO  (coreLoadExecutor-455-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.search.stats.TestExactStatsCache_3C5E85432D34583E-001/tempDir-001/control/cores/collection1/data/]
   [junit4]   2> 93327 INFO  (coreLoadExecutor-455-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=36, maxMergeAtOnceExplicit=42, maxMergedSegmentMB=1.3466796875, 
floorSegmentMB=0.9736328125, forceMergeDeletesPctAllowed=17.674920063055986, 
segmentsPerTier=18.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 93468 INFO  (coreLoadExecutor-455-thread-1) [    
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 93468 INFO  (coreLoadExecutor-455-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 93469 INFO  (coreLoadExecutor-455-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 93469 INFO  (coreLoadExecutor-455-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 93470 INFO  (coreLoadExecutor-455-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=35, maxMergeAtOnceExplicit=24, maxMergedSegmentMB=36.2685546875, 
floorSegmentMB=1.6083984375, forceMergeDeletesPctAllowed=3.6184016728110837, 
segmentsPerTier=47.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 93470 INFO  (coreLoadExecutor-455-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@30eeb535[collection1] main]
   [junit4]   2> 93471 INFO  (coreLoadExecutor-455-thread-1) [    
x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 93491 INFO  (coreLoadExecutor-455-thread-1) [    
x:collection1] o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 93561 INFO  (coreLoadExecutor-455-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 93561 INFO  (coreLoadExecutor-455-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1571139892625276928
   [junit4]   2> 93563 INFO  
(searcherExecutor-456-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 93563 INFO  
(searcherExecutor-456-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 93563 INFO  
(searcherExecutor-456-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 93564 INFO  
(searcherExecutor-456-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 93564 INFO  
(searcherExecutor-456-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 93565 INFO  
(searcherExecutor-456-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 93566 INFO  
(searcherExecutor-456-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 93566 INFO  
(searcherExecutor-456-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 93567 INFO  
(searcherExecutor-456-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 93573 INFO  
(searcherExecutor-456-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@30eeb535[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 93912 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.search.stats.TestExactStatsCache_3C5E85432D34583E-001/tempDir-001/shard0/cores/collection1
   [junit4]   2> 93916 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] o.e.j.s.Server 
jetty-9.3.14.v20161028
   [junit4]   2> 93921 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@6072bbf4{/urpd/y,null,AVAILABLE}
   [junit4]   2> 93922 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@3c6618df{SSL,[ssl, 
http/1.1]}{127.0.0.1:42293}
   [junit4]   2> 93922 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] o.e.j.s.Server 
Started @95816ms
   [junit4]   2> 93922 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/urpd/y, 
hostPort=42293, 
coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.search.stats.TestExactStatsCache_3C5E85432D34583E-001/tempDir-001/shard0/cores}
   [junit4]   2> 93922 ERROR 
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 93923 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.0.0
   [junit4]   2> 93923 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 93923 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 93923 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-06-25T01:56:03.440Z
   [junit4]   2> 93923 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.search.stats.TestExactStatsCache_3C5E85432D34583E-001/tempDir-001/shard0/solr.xml
   [junit4]   2> 93926 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@3be8eef7, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 93954 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3be8eef7
   [junit4]   2> 93959 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3be8eef7
   [junit4]   2> 93960 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3be8eef7
   [junit4]   2> 93962 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.search.stats.TestExactStatsCache_3C5E85432D34583E-001/tempDir-001/shard0/cores
   [junit4]   2> 93962 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 93977 INFO  (coreLoadExecutor-466-thread-1) [    
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, 
from paths: 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib,
 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 94015 INFO  (coreLoadExecutor-466-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 94037 INFO  (coreLoadExecutor-466-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 94249 INFO  (coreLoadExecutor-466-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 94266 INFO  (coreLoadExecutor-466-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from configset 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1,
 trusted=true
   [junit4]   2> 94266 INFO  (coreLoadExecutor-466-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@3be8eef7
   [junit4]   2> 94267 INFO  (coreLoadExecutor-466-thread-1) [    
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 94267 INFO  (coreLoadExecutor-466-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.search.stats.TestExactStatsCache_3C5E85432D34583E-001/tempDir-001/shard0/cores/collection1/data/]
   [junit4]   2> 94269 INFO  (coreLoadExecutor-466-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=36, maxMergeAtOnceExplicit=42, maxMergedSegmentMB=1.3466796875, 
floorSegmentMB=0.9736328125, forceMergeDeletesPctAllowed=17.674920063055986, 
segmentsPerTier=18.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 94321 INFO  (coreLoadExecutor-466-thread-1) [    
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 94321 INFO  (coreLoadExecutor-466-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 94322 INFO  (coreLoadExecutor-466-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 94322 INFO  (coreLoadExecutor-466-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 94324 INFO  (coreLoadExecutor-466-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=35, maxMergeAtOnceExplicit=24, maxMergedSegmentMB=36.2685546875, 
floorSegmentMB=1.6083984375, forceMergeDeletesPctAllowed=3.6184016728110837, 
segmentsPerTier=47.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 94324 INFO  (coreLoadExecutor-466-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@2a489312[collection1] main]
   [junit4]   2> 94334 INFO  (coreLoadExecutor-466-thread-1) [    
x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 94353 INFO  (coreLoadExecutor-466-thread-1) [    
x:collection1] o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 94426 INFO  (coreLoadExecutor-466-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 94427 INFO  (coreLoadExecutor-466-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1571139893533343744
   [junit4]   2> 94428 INFO  
(searcherExecutor-467-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 94428 INFO  
(searcherExecutor-467-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 94428 INFO  
(searcherExecutor-467-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 94428 INFO  
(searcherExecutor-467-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 94428 INFO  
(searcherExecutor-467-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 94429 INFO  
(searcherExecutor-467-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 94429 INFO  
(searcherExecutor-467-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 94429 INFO  
(searcherExecutor-467-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 94429 INFO  
(searcherExecutor-467-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 94431 INFO  
(searcherExecutor-467-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@2a489312[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 94500 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting test
   [junit4]   2> 94578 INFO  (qtp1274752974-1016) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/urpd/y path=/update 
params={wt=javabin&version=2}{deleteByQuery=*:* (-1571139893684338688)} 0 7
   [junit4]   2> 94640 INFO  (qtp430334475-1033) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/urpd/y path=/update 
params={wt=javabin&version=2}{deleteByQuery=*:* (-1571139893749350400)} 0 7
   [junit4]   2> 94653 INFO  (qtp1274752974-1011) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/urpd/y path=/update 
params={wt=javabin&version=2}{add=[0 (1571139893758787584)]} 0 10
   [junit4]   2> 94656 INFO  (qtp430334475-1034) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/urpd/y path=/update 
params={wt=javabin&version=2}{add=[0 (1571139893772419072)]} 0 1
   [junit4]   2> 94658 INFO  (qtp1274752974-1015) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1571139893775564800,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 94658 INFO  (qtp1274752974-1015) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@4862184a 
commitCommandVersion:1571139893775564800
   [junit4]   2> 94675 INFO  (qtp1274752974-1015) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@65e1a522[collection1] main]
   [junit4]   2> 94675 INFO  (qtp1274752974-1015) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 94677 INFO  
(searcherExecutor-456-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@65e1a522[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C1)))}
   [junit4]   2> 94677 INFO  (qtp1274752974-1015) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/urpd/y path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 19
   [junit4]   2> 94678 INFO  (qtp430334475-1027) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1571139893796536320,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 94678 INFO  (qtp430334475-1027) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@243efa7d 
commitCommandVersion:1571139893796536320
   [junit4]   2> 94682 INFO  (qtp430334475-1027) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@14d9f049[collection1] main]
   [junit4]   2> 94683 INFO  (qtp430334475-1027) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 94685 INFO  
(searcherExecutor-467-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@14d9f049[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C1)))}
   [junit4]   2> 94685 INFO  (qtp430334475-1027) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/urpd/y path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 6
   [junit4]   2> 94688 INFO  (qtp1274752974-1017) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/urpd/y path=/select 
params={q=a_t:one&fl=*,score&wt=javabin&version=2&debugQuery=true} hits=1 
status=0 QTime=2
   [junit4]   2> 94699 INFO  (qtp430334475-1027) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/urpd/y path=/select 
params={df=text&distrib=false&debug=false&debug=timing&debug=track&fl=*,score&shards.purpose=32768&shard.url=https://127.0.0.1:42293/urpd/y/collection1&rid=127.0.0.1-collection1-1498355764208-10&version=2&q=a_t:one&requestPurpose=GET_TERM_STATS&NOW=1498355764207&isShard=true&wt=javabin&debugQuery=false}
 status=0 QTime=3
   [junit4]   2> 94720 INFO  (qtp430334475-1028) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/urpd/y 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=https://127.0.0.1:42293/urpd/y/collection1&rid=127.0.0.1-collection1-1498355764208-10&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=1498355764207&isShard=true&org.apache.solr.stats.terms=a_t:on&wt=javabin&debugQuery=false}
 hits=1 status=0 QTime=0
   [junit4]   2> 94738 INFO  (qtp430334475-1034) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/urpd/y path=/select 
params={df=text&distrib=false&debug=timing&debug=track&fl=*,score&shards.purpose=320&shard.url=https://127.0.0.1:42293/urpd/y/collection1&rid=127.0.0.1-collection1-1498355764208-10&version=2&q=a_t:one&requestPurpose=GET_FIELDS,GET_DEBUG&NOW=1498355764207&ids=0&isShard=true&wt=javabin&debugQuery=true}
 status=0 QTime=0
   [junit4]   2> 94739 INFO  (qtp430334475-1032) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/urpd/y path=/select 
params={q=a_t:one&shards=https://127.0.0.1:42293/urpd/y/collection1&fl=*,score&wt=javabin&version=2&debugQuery=true}
 rid=127.0.0.1-collection1-1498355764208-10 hits=1 status=0 QTime=49
   [junit4]   1> ======================= Control Response 
=======================
   [junit4]   1> 
{responseHeader={status=0,QTime=2},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 Jun 25 03:56:04 EET 2017, _version_=1571139893758787584, 
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 = fieldWeight in 0, product of:
   [junit4]   1>     1.0 = tf(freq=1.0), with freq of:
   [junit4]   1>       1.0 = termFreq=1.0
   [junit4]   1>     1.0 = idf, computed as log((docCount+1)/(docFreq+1)) + 1 
from:
   [junit4]   1>       1.0 = docFreq
   [junit4]   1>       1.0 = docCount
   [junit4]   1>     0.57735026 = fieldNorm(doc=0)
   [junit4]   1> 
},QParser=LuceneQParser,timing={time=2.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=49},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 Jun 25 03:56:04 EET 2017, _version_=1571139893772419072, 
intDvoDefault=42, 
score=0.57735026}]},debug={track={rid=127.0.0.1-collection1-1498355764208-10,PARSE_QUERY={https://127.0.0.1:42293/urpd/y/collection1={QTime=3,ElapsedTime=10,RequestPurpose=GET_TERM_STATS,Response={responseHeader={status=0,QTime=3},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=3.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=3.0,query={time=3.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={https://127.0.0.1:42293/urpd/y/collection1={QTime=0,ElapsedTime=24,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={https://127.0.0.1:42293/urpd/y/collection1={QTime=0,ElapsedTime=5,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 Jun 25 03:56:04 EET 2017, _version_=1571139893772419072, 
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 = fieldWeight in 0, product of:
   [junit4]   1>     1.0 = tf(freq=1.0), with freq of:
   [junit4]   1>       1.0 = termFreq=1.0
   [junit4]   1>     1.0 = idf, computed as log((docCount+1)/(docFreq+1)) + 1 
from:
   [junit4]   1>       1.0 = docFreq
   [junit4]   1>       1.0 = docCount
   [junit4]   1>     0.57735026 = fieldNorm(doc=0)
   [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=3.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=3.0,query={time=3.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 = fieldWeight in 0, product of:
   [junit4]   1>     1.0 = tf(freq=1.0), with freq of:
   [junit4]   1>       1.0 = termFreq=1.0
   [junit4]   1>     1.0 = idf, computed as log((docCount+1)/(docFreq+1)) + 1 
from:
   [junit4]   1>       1.0 = docFreq
   [junit4]   1>       1.0 = docCount
   [junit4]   1>     0.57735026 = fieldNorm(doc=0)
   [junit4]   1> }}}
   [junit4]   2> 94745 INFO  (qtp1274752974-1016) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/urpd/y path=/update 
params={wt=javabin&version=2}{add=[1 (1571139893863645184)]} 0 3
   [junit4]   2> 94750 INFO  (qtp430334475-1033) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/urpd/y path=/update 
params={wt=javabin&version=2}{add=[1 (1571139893868888064)]} 0 2
   [junit4]   2> 94752 INFO  (qtp1274752974-1011) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1571139893874130944,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 94753 INFO  (qtp1274752974-1011) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@4862184a 
commitCommandVersion:1571139893874130944
   [junit4]   2> 94759 INFO  (qtp1274752974-1011) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@6ac04791[collection1] main]
   [junit4]   2> 94766 INFO  
(searcherExecutor-456-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@6ac04791[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C1)
 Uninverting(_1(7.0.0):C1)))}
   [junit4]   2> 94767 INFO  (qtp1274752974-1011) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 94767 INFO  (qtp1274752974-1011) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/urpd/y path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 15
   [junit4]   2> 94769 INFO  (qtp430334475-1028) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1571139893891956736,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 94769 INFO  (qtp430334475-1028) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@243efa7d 
commitCommandVersion:1571139893891956736
   [junit4]   2> 94800 INFO  (qtp430334475-1028) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@3fa11a83[collection1] main]
   [junit4]   2> 94803 INFO  
(searcherExecutor-467-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@3fa11a83[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C1)
 Uninverting(_1(7.0.0):C1)))}
   [junit4]   2> 94803 INFO  (qtp430334475-1028) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 94803 INFO  (qtp430334475-1028) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/urpd/y path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 34
   [junit4]   2> 94809 INFO  (qtp1274752974-1015) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/urpd/y path=/select 
params={q=a_t:one+a_t:four&fl=*,score&wt=javabin&version=2&debugQuery=true} 
hits=2 status=0 QTime=4
   [junit4]   2> 94813 INFO  (qtp430334475-1034) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/urpd/y path=/select 
params={df=text&distrib=false&debug=false&debug=timing&debug=track&fl=*,score&shards.purpose=32768&shard.url=https://127.0.0.1:42293/urpd/y/collection1&rid=127.0.0.1-collection1-1498355764329-11&version=2&q=a_t:one+a_t:four&requestPurpose=GET_TERM_STATS&NOW=1498355764328&isShard=true&wt=javabin&debugQuery=false}
 status=0 QTime=0
   [junit4]   2> 94816 INFO  (qtp430334475-1034) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/urpd/y 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=https://127.0.0.1:42293/urpd/y/collection1&rid=127.0.0.1-collection1-1498355764329-11&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=1498355764328&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=1
   [junit4]   2> 94819 INFO  (qtp430334475-1028) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/urpd/y path=/select 
params={df=text&distrib=false&debug=timing&debug=track&fl=*,score&shards.purpose=320&shard.url=https://127.0.0.1:42293/urpd/y/collection1&rid=127.0.0.1-collection1-1498355764329-11&version=2&q=a_t:one+a_t:four&requestPurpose=GET_FIELDS,GET_DEBUG&NOW=1498355764328&ids=0,1&isShard=true&wt=javabin&debugQuery=true}
 status=0 QTime=1
   [junit4]   2> 94821 INFO  (qtp430334475-1027) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/urpd/y path=/select 
params={q=a_t:one+a_t:four&shards=https://127.0.0.1:42293/urpd/y/collection1&fl=*,score&wt=javabin&version=2&debugQuery=true}
 rid=127.0.0.1-collection1-1498355764329-11 hits=2 status=0 QTime=10
   [junit4]   1> ======================= Control Response 
=======================
   [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 Jun 25 03:56:04 EET 2017, 
_version_=1571139893863645184, 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 Jun 25 03:56:04 EET 
2017, _version_=1571139893758787584, 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 = fieldWeight in 0, product of:
   [junit4]   1>       1.0 = tf(freq=1.0), with freq of:
   [junit4]   1>         1.0 = termFreq=1.0
   [junit4]   1>       1.0 = idf, computed as log((docCount+1)/(docFreq+1)) + 1 
from:
   [junit4]   1>         2.0 = docFreq
   [junit4]   1>         2.0 = docCount
   [junit4]   1>       0.4472136 = fieldNorm(doc=0)
   [junit4]   1>   0.6285431 = weight(a_t:four in 0) 
[MockConfigurableSimilarity], result of:
   [junit4]   1>     0.6285431 = fieldWeight in 0, product of:
   [junit4]   1>       1.0 = tf(freq=1.0), with freq of:
   [junit4]   1>         1.0 = termFreq=1.0
   [junit4]   1>       1.4054651 = idf, computed as 
log((docCount+1)/(docFreq+1)) + 1 from:
   [junit4]   1>         1.0 = docFreq
   [junit4]   1>         2.0 = docCount
   [junit4]   1>       0.4472136 = fieldNorm(doc=0)
   [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 = fieldWeight in 0, product of:
   [junit4]   1>       1.0 = tf(freq=1.0), with freq of:
   [junit4]   1>         1.0 = termFreq=1.0
   [junit4]   1>       1.0 = idf, computed as log((docCount+1)/(docFreq+1)) + 1 
from:
   [junit4]   1>         2.0 = docFreq
   [junit4]   1>         2.0 = docCount
   [junit4]   1>       0.57735026 = fieldNorm(doc=0)
   [junit4]   1> 
},QParser=LuceneQParser,timing={time=4.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=3.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=3.0}}}}}
   [junit4]   1> 
   [junit4]   1> 
   [junit4]   1> ======================= Shard Response =======================
   [junit4]   1> 
   [junit4]   1> 
{responseHeader={status=0,QTime=10},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 Jun 25 03:56:04 EET 2017, 
_version_=1571139893868888064, 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 Jun 25 03:56:04 EET 
2017, _version_=1571139893772419072, intDvoDefault=42, 
score=0.57735026}]},debug={track={rid=127.0.0.1-collection1-1498355764329-11,PARSE_QUERY={https://127.0.0.1:42293/urpd/y/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.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={https://127.0.0.1:42293/urpd/y/collection1={QTime=1,ElapsedTime=2,RequestPurpose=GET_TOP_IDS,SET_TERM_STATS,NumFound=2,Response={responseHeader={status=0,QTime=1},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=1.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={https://127.0.0.1:42293/urpd/y/collection1={QTime=1,ElapsedTime=3,RequestPurpose=GET_FIELDS,GET_DEBUG,NumFound=2,Response={responseHeader={status=0,QTime=1},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 Jun 25 03:56:04 EET 2017, _version_=1571139893772419072, 
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 
Jun 25 03:56:04 EET 2017, _version_=1571139893868888064, 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 = fieldWeight in 0, product of:
   [junit4]   1>       1.0 = tf(freq=1.0), with freq of:
   [junit4]   1>         1.0 = termFreq=1.0
   [junit4]   1>       1.0 = idf, computed as log((docCount+1)/(docFreq+1)) + 1 
from:
   [junit4]   1>         2.0 = docFreq
   [junit4]   1>         2.0 = docCount
   [junit4]   1>       0.57735026 = fieldNorm(doc=0)
   [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 = fieldWeight in 0, product of:
   [junit4]   1>       1.0 = tf(freq=1.0), with freq of:
   [junit4]   1>         1.0 = termFreq=1.0
   [junit4]   1>       1.0 = idf, computed as log((docCount+1)/(docFreq+1)) + 1 
from:
   [junit4]   1>         2.0 = docFreq
   [junit4]   1>         2.0 = docCount
   [junit4]   1>       0.4472136 = fieldNorm(doc=0)
   [junit4]   1>   0.6285431 = weight(a_t:four in 0) 
[MockConfigurableSimilarity], result of:
   [junit4]   1>     0.6285431 = fieldWeight in 0, product of:
   [junit4]   1>       1.0 = tf(freq=1.0), with freq of:
   [junit4]   1>         1.0 = termFreq=1.0
   [junit4]   1>       1.4054651 = idf, computed as 
log((docCount+1)/(docFreq+1)) + 1 from:
   [junit4]   1>         1.0 = docFreq
   [junit4]   1>         2.0 = docCount
   [junit4]   1>       0.4472136 = fieldNorm(doc=0)
   [junit4]   1> 
},QParser=LuceneQParser,timing={time=1.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=2.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 = fieldWeight in 0, product of:
   [junit4]   1>       1.0 = tf(freq=1.0), with freq of:
   [junit4]   1>         1.0 = termFreq=1.0
   [junit4]   1>       1.0 = idf, computed as log((docCount+1)/(docFreq+1)) + 1 
from:
   [junit4]   1>         2.0 = docFreq
   [junit4]   1>         2.0 = docCount
   [junit4]   1>       0.4472136 = fieldNorm(doc=0)
   [junit4]   1>   0.6285431 = weight(a_t:four in 0) 
[MockConfigurableSimilarity], result of:
   [junit4]   1>     0.6285431 = fieldWeight in 0, product of:
   [junit4]   1>       1.0 = tf(freq=1.0), with freq of:
   [junit4]   1>         1.0 = termFreq=1.0
   [junit4]   1>       1.4054651 = idf, computed as 
log((docCount+1)/(docFreq+1)) + 1 from:
   [junit4]   1>         1.0 = docFreq
   [junit4]   1>         2.0 = docCount
   [junit4]   1>       0.4472136 = fieldNorm(doc=0)
   [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 = fieldWeight in 0, product of:
   [junit4]   1>       1.0 = tf(freq=1.0), with freq of:
   [junit4]   1>         1.0 = termFreq=1.0
   [junit4]   1>       1.0 = idf, computed as log((docCount+1)/(docFreq+1)) + 1 
from:
   [junit4]   1>         2.0 = docFreq
   [junit4]   1>         2.0 = docCount
   [junit4]   1>       0.57735026 = fieldNorm(doc=0)
   [junit4]   1> }}}
   [junit4]   2> 94823 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending test
   [junit4]   2> 94824 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.e.j.s.AbstractConnector Stopped ServerConnector@72f152d8{SSL,[ssl, 
http/1.1]}{127.0.0.1:0}
   [junit4]   2> 94824 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=32015612
   [junit4]   2> 94824 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 94826 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 94828 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 94828 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 94828 INFO  (coreCloseExecutor-472-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@7dc1a854
   [junit4]   2> 94838 INFO  (coreCloseExecutor-472-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=2109843540
   [junit4]   2> 94842 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@36cd00{/urpd/y,null,UNAVAILABLE}
   [junit4]   2> 94847 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.e.j.s.AbstractConnector Stopped ServerConnector@3c6618df{SSL,[ssl, 
http/1.1]}{127.0.0.1:0}
   [junit4]   2> 94847 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1528023578
   [junit4]   2> 94847 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 94847 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 94847 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 94847 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 94848 INFO  (coreCloseExecutor-474-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@286d0090
   [junit4]   2> 94850 INFO  (coreCloseExecutor-474-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=678232208
   [junit4]   2> 94859 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@6072bbf4{/urpd/y,null,UNAVAILABLE}
   [junit4]   2> 94921 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] o.e.j.s.Server 
jetty-9.3.14.v20161028
   [junit4]   2> 94922 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@50620e28{/urpd/y,null,AVAILABLE}
   [junit4]   2> 94922 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@75a80409{SSL,[ssl, 
http/1.1]}{127.0.0.1:34465}
   [junit4]   2> 94923 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] o.e.j.s.Server 
Started @96817ms
   [junit4]   2> 94923 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/urpd/y, 
hostPort=34465, 
coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.search.stats.TestExactStatsCache_3C5E85432D34583E-001/tempDir-001/control/cores}
   [junit4]   2> 94923 ERROR 
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 94923 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.0.0
   [junit4]   2> 94923 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 94923 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 94923 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-06-25T01:56:04.440Z
   [junit4]   2> 94923 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.search.stats.TestExactStatsCache_3C5E85432D34583E-001/tempDir-001/control/solr.xml
   [junit4]   2> 94928 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@3be8eef7, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 94956 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3be8eef7
   [junit4]   2> 94960 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3be8eef7
   [junit4]   2> 94960 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3be8eef7
   [junit4]   2> 94963 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.search.stats.TestExactStatsCache_3C5E85432D34583E-001/tempDir-001/control/cores
   [junit4]   2> 94963 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 94965 INFO  (coreLoadExecutor-481-thread-1) [    
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, 
from paths: 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib,
 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 94996 INFO  (coreLoadExecutor-481-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 95019 INFO  (coreLoadExecutor-481-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 95170 INFO  (coreLoadExecutor-481-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 95179 INFO  (coreLoadExecutor-481-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from configset 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1,
 trusted=true
   [junit4]   2> 95179 INFO  (coreLoadExecutor-481-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@3be8eef7
   [junit4]   2> 95179 INFO  (coreLoadExecutor-481-thread-1) [    
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 95180 INFO  (coreLoadExecutor-481-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.search.stats.TestExactStatsCache_3C5E85432D34583E-001/tempDir-001/control/cores/collection1/data/]
   [junit4]   2> 95182 INFO  (coreLoadExecutor-481-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=36, maxMergeAtOnceExplicit=42, maxMergedSegmentMB=1.3466796875, 
floorSegmentMB=0.9736328125, forceMergeDeletesPctAllowed=17.674920063055986, 
segmentsPerTier=18.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 95235 INFO  (coreLoadExecutor-481-thread-1) [    
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 95235 INFO  (coreLoadExecutor-481-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 95236 INFO  (coreLoadExecutor-481-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 95236 INFO  (coreLoadExecutor-481-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 95236 INFO  (coreLoadExecutor-481-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=35, maxMergeAtOnceExplicit=24, maxMergedSegmentMB=36.2685546875, 
floorSegmentMB=1.6083984375, forceMergeDeletesPctAllowed=3.6184016728110837, 
segmentsPerTier=47.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 95237 INFO  (coreLoadExecutor-481-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@13716e90[collection1] main]
   [junit4]   2> 95238 INFO  (coreLoadExecutor-481-thread-1) [    
x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 95238 INFO  (coreLoadExecutor-481-thread-1) [    
x:collection1] o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 95241 INFO  (coreLoadExecutor-481-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 95242 INFO  
(searcherExecutor-482-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 95242 INFO  (coreLoadExecutor-481-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1571139894387933184
   [junit4]   2> 95242 INFO  
(searcherExecutor-482-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 95242 INFO  
(searcherExecutor-482-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 95242 INFO  
(searcherExecutor-482-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 95242 INFO  
(searcherExecutor-482-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 95242 INFO  
(searcherExecutor-482-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 95242 INFO  
(searcherExecutor-482-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 95242 INFO  
(searcherExecutor-482-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 95243 INFO  
(searcherExecutor-482-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 95244 INFO  
(searcherExecutor-482-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@13716e90[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 95552 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] o.e.j.s.Server 
jetty-9.3.14.v20161028
   [junit4]   2> 95556 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@556b9d3f{/urpd/y,null,AVAILABLE}
   [junit4]   2> 95557 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@7b3310a4{SSL,[ssl, 
http/1.1]}{127.0.0.1:34595}
   [junit4]   2> 95557 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] o.e.j.s.Server 
Started @97451ms
   [junit4]   2> 95557 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/urpd/y, 
hostPort=34595, 
coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.search.stats.TestExactStatsCache_3C5E85432D34583E-001/tempDir-001/shard0/cores}
   [junit4]   2> 95557 ERROR 
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 95557 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.0.0
   [junit4]   2> 95558 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 95558 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 95558 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-06-25T01:56:05.075Z
   [junit4]   2> 95558 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.search.stats.TestExactStatsCache_3C5E85432D34583E-001/tempDir-001/shard0/solr.xml
   [junit4]   2> 95563 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@3be8eef7, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 95583 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3be8eef7
   [junit4]   2> 95586 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3be8eef7
   [junit4]   2> 95586 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3be8eef7
   [junit4]   2> 95588 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.search.stats.TestExactStatsCache_3C5E85432D34583E-001/tempDir-001/shard0/cores
   [junit4]   2> 95588 INFO  
(TEST-TestExactStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 95592 INFO  (coreLoadExecutor-492-thread-1) [    
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, 
from paths: 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib,
 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 95642 INFO  (coreLoadExecutor-492-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 95661 INFO  (coreLoadExecutor-492-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 95839 INFO  (coreLoadExecutor-492-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 95847 INFO  (coreLoadExecutor-492-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from configset 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1,
 trusted=true
   [junit4]   2> 95848 INFO  (coreLoadExecutor-492-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@3be8eef7
   [junit4]   2> 95848 INFO  (coreLoadExecutor-492-thread-1) [    
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 95848 INFO  (coreLoadExecutor-492-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace

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

ocFreq
   [junit4]   1>       2.0 = docCount
   [junit4]   1>     1.0 = fieldNorm(doc=0)
   [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=id:2,querystring=id:2,parsedquery=id:2,parsedquery_toString=id:2,QParser=LuceneQParser,explain={2=
   [junit4]   1> 1.4054651 = weight(id:2 in 0) [MockConfigurableSimilarity], 
result of:
   [junit4]   1>   1.4054651 = fieldWeight in 0, product of:
   [junit4]   1>     1.0 = tf(freq=1.0), with freq of:
   [junit4]   1>       1.0 = termFreq=1.0
   [junit4]   1>     1.4054651 = idf, computed as log((docCount+1)/(docFreq+1)) 
+ 1 from:
   [junit4]   1>       1.0 = docFreq
   [junit4]   1>       2.0 = docCount
   [junit4]   1>     1.0 = fieldNorm(doc=0)
   [junit4]   1> }}}
   [junit4]   2> 439163 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending test
   [junit4]   2> 439164 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.e.j.s.AbstractConnector Stopped 
ServerConnector@525483de{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 439164 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=2123405860
   [junit4]   2> 439164 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 439165 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 439166 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 439166 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 439166 INFO  (coreCloseExecutor-2447-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@67a3bf36
   [junit4]   2> 439167 INFO  (coreCloseExecutor-2447-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=1738784566
   [junit4]   2> 439169 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@40e2f228{/j,null,UNAVAILABLE}
   [junit4]   2> 439170 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.e.j.s.AbstractConnector Stopped 
ServerConnector@21622818{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 439170 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=227399027
   [junit4]   2> 439170 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 439170 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 439170 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 439170 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 439170 INFO  (coreCloseExecutor-2449-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@4c8d61ce
   [junit4]   2> 439171 INFO  (coreCloseExecutor-2449-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=1284334030
   [junit4]   2> 439171 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@41abd9e6{/j,null,UNAVAILABLE}
   [junit4]   2> 439172 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.e.j.s.AbstractConnector Stopped 
ServerConnector@460863d8{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 439172 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1000468745
   [junit4]   2> 439172 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 439172 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 439172 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 439172 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 439172 INFO  (coreCloseExecutor-2451-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@5b8a0fe8
   [junit4]   2> 439173 INFO  (coreCloseExecutor-2451-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=1535774696
   [junit4]   2> 439173 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[3C5E85432D34583E]) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@6afac21f{/j,null,UNAVAILABLE}
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=TestExactSharedStatsCache -Dtests.method=test 
-Dtests.seed=3C5E85432D34583E -Dtests.multiplier=3 -Dtests.slow=true 
-Dtests.locale=da -Dtests.timezone=America/Godthab -Dtests.asserts=true 
-Dtests.file.encoding=UTF-8
   [junit4] FAILURE 3.28s J1 | TestExactSharedStatsCache.test <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: expected:<2.252763> 
but was:<1.4054651>
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([3C5E85432D34583E:B40ABA9983C835C6]:0)
   [junit4]    >        at 
org.apache.solr.search.stats.TestBaseStatsCache.checkResponse(TestBaseStatsCache.java:64)
   [junit4]    >        at 
org.apache.solr.search.stats.TestDefaultStatsCache.dfQuery(TestDefaultStatsCache.java:109)
   [junit4]    >        at 
org.apache.solr.search.stats.TestDefaultStatsCache.test(TestDefaultStatsCache.java:76)
   [junit4]    >        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsRepeatStatement.callStatement(BaseDistributedSearchTestCase.java:1011)
   [junit4]    >        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:960)
   [junit4]    >        at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.search.stats.TestExactSharedStatsCache_3C5E85432D34583E-001
   [junit4]   2> NOTE: test params are: 
codec=FastDecompressionCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=FAST_DECOMPRESSION,
 chunkSize=3, maxDocsPerChunk=5, blockSize=7), 
termVectorsFormat=CompressingTermVectorsFormat(compressionMode=FAST_DECOMPRESSION,
 chunkSize=3, blockSize=7)), sim=RandomSimilarity(queryNorm=true): {}, 
locale=da, timezone=America/Godthab
   [junit4]   2> NOTE: Linux 4.10.0-21-generic amd64/Oracle Corporation 
1.8.0_131 (64-bit)/cpus=8,threads=1,free=211845640,total=518979584
   [junit4]   2> NOTE: All tests run in this JVM: 
[AddSchemaFieldsUpdateProcessorFactoryTest, TestSmileRequest, 
SortSpecParsingTest, TestDFISimilarityFactory, 
UpdateRequestProcessorFactoryTest, TestRestoreCore, TestFieldCacheWithThreads, 
TestValueSourceCache, TestComplexPhraseLeadingWildcard, TestConfigSets, 
HdfsRecoveryZkTest, TestSolrDeletionPolicy2, TestRandomRequestDistribution, 
TestDistributedGrouping, TestSchemaVersionResource, CSVRequestHandlerTest, 
TestCollectionAPIs, CopyFieldTest, EchoParamsTest, 
BigEndianAscendingWordDeserializerTest, TestCoreContainer, BadCopyFieldTest, 
TestSegmentSorting, CdcrReplicationDistributedZkTest, LoggingHandlerTest, 
HdfsThreadLeakTest, DocValuesTest, CloudMLTQParserTest, TestTlogReplica, 
TlogReplayBufferedWhileIndexingTest, TestAuthorizationFramework, 
V2ApiIntegrationTest, DistribJoinFromCollectionTest, ZkSolrClientTest, 
TestReloadDeadlock, TestHighFrequencyDictionaryFactory, TestManagedResource, 
TestPullReplica, SolrSlf4jReporterTest, ParsingFieldUpdateProcessorsTest, 
UninvertDocValuesMergePolicyTest, TestLegacyTerms, AnalysisAfterCoreReloadTest, 
CollectionReloadTest, ZkStateReaderTest, SpatialHeatmapFacetsTest, 
SharedFSAutoReplicaFailoverTest, SolrCLIZkUtilsTest, ZkNodePropsTest, 
RecoveryAfterSoftCommitTest, HdfsBasicDistributedZkTest, UUIDFieldTest, 
TestExactSharedStatsCache]
   [junit4] Completed [168/723 (3!)] on J1 in 3.29s, 1 test, 1 failure <<< 
FAILURES!

[...truncated 45072 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to