Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/19422/
Java: 64bit/jdk-9-ea+164 -XX:-UseCompressedOops -XX:+UseParallelGC

2 tests failed.
FAILED:  
org.apache.solr.schema.TestUseDocValuesAsStored.testMultipleSearchResults

Error Message:
mismatch: 'myid1'!='myid' @ response/docs/[0]/id

Stack Trace:
java.lang.RuntimeException: mismatch: 'myid1'!='myid' @ response/docs/[0]/id
        at 
__randomizedtesting.SeedInfo.seed([8D4D8B27432142DD:BF678CB9BBDF6604]:0)
        at org.apache.solr.SolrTestCaseJ4.assertJQ(SolrTestCaseJ4.java:984)
        at org.apache.solr.SolrTestCaseJ4.assertJQ(SolrTestCaseJ4.java:931)
        at 
org.apache.solr.schema.TestUseDocValuesAsStored.testMultipleSearchResults(TestUseDocValuesAsStored.java:243)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.base/java.lang.reflect.Method.invoke(Method.java:563)
        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 
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 
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.base/java.lang.Thread.run(Thread.java:844)


FAILED:  org.apache.solr.spelling.SpellCheckCollatorTest.testEstimatedHitCounts

Error Message:
Exception during query

Stack Trace:
java.lang.RuntimeException: Exception during query
        at 
__randomizedtesting.SeedInfo.seed([8D4D8B27432142DD:BCF63512E61E520D]:0)
        at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:896)
        at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:863)
        at 
org.apache.solr.spelling.SpellCheckCollatorTest.testEstimatedHitCounts(SpellCheckCollatorTest.java:569)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.base/java.lang.reflect.Method.invoke(Method.java:563)
        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 
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 
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.base/java.lang.Thread.run(Thread.java:844)
Caused by: java.lang.RuntimeException: REQUEST FAILED: 
xpath=//lst[@name='spellcheck']/lst[@name='collations']/lst[@name='collation']/int[@name='hits'
 and 3 <= . and . <= 13]
        xml response was: <?xml version="1.0" encoding="UTF-8"?>
<response>
<lst name="responseHeader"><int name="status">0</int><int 
name="QTime">2</int></lst><result name="response" numFound="0" 
start="0"></result><lst name="spellcheck"><lst name="suggestions"><lst 
name="everother"><int name="numFound">1</int><int 
name="startOffset">9</int><int name="endOffset">18</int><arr 
name="suggestion"><str>everyother</str></arr></lst></lst><lst 
name="collations"><lst name="collation"><str 
name="collationQuery">teststop:everyother</str><int name="hits">14</int><lst 
name="misspellingsAndCorrections"><str 
name="everother">everyother</str></lst></lst></lst></lst>
</response>

        request 
was:spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:everother&spellcheck.collateMaxCollectDocs=5
        at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:889)
        ... 40 more




Build Log:
[...truncated 10983 lines...]
   [junit4] Suite: org.apache.solr.spelling.SpellCheckCollatorTest
   [junit4]   2> Creating dataDir: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.spelling.SpellCheckCollatorTest_8D4D8B27432142DD-001/init-core-data-001
   [junit4]   2> 134015 WARN  
(SUITE-SpellCheckCollatorTest-seed#[8D4D8B27432142DD]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=1 numCloses=1
   [junit4]   2> 134016 INFO  
(SUITE-SpellCheckCollatorTest-seed#[8D4D8B27432142DD]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields
   [junit4]   2> 134017 INFO  
(SUITE-SpellCheckCollatorTest-seed#[8D4D8B27432142DD]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: 
@org.apache.solr.util.RandomizeSSL(reason="", ssl=0.0/0.0, value=0.0/0.0, 
clientAuth=0.0/0.0)
   [junit4]   2> 134019 INFO  
(SUITE-SpellCheckCollatorTest-seed#[8D4D8B27432142DD]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 134020 INFO  
(SUITE-SpellCheckCollatorTest-seed#[8D4D8B27432142DD]-worker) [    ] 
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> 134078 INFO  
(SUITE-SpellCheckCollatorTest-seed#[8D4D8B27432142DD]-worker) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 134096 INFO  
(SUITE-SpellCheckCollatorTest-seed#[8D4D8B27432142DD]-worker) [    ] 
o.a.s.s.IndexSchema [null] Schema name=test
   [junit4]   2> 134247 WARN  
(SUITE-SpellCheckCollatorTest-seed#[8D4D8B27432142DD]-worker) [    ] 
o.a.s.s.IndexSchema [null] default search field in schema is text. WARNING: 
Deprecated, please use 'df' on request instead.
   [junit4]   2> 134250 INFO  
(SUITE-SpellCheckCollatorTest-seed#[8D4D8B27432142DD]-worker) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 134391 INFO  
(SUITE-SpellCheckCollatorTest-seed#[8D4D8B27432142DD]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@45efa6aa
   [junit4]   2> 134396 INFO  
(SUITE-SpellCheckCollatorTest-seed#[8D4D8B27432142DD]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@45efa6aa
   [junit4]   2> 134396 INFO  
(SUITE-SpellCheckCollatorTest-seed#[8D4D8B27432142DD]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@45efa6aa
   [junit4]   2> 134398 INFO  (coreLoadExecutor-376-thread-1) [    ] 
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> 134449 INFO  (coreLoadExecutor-376-thread-1) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 134462 INFO  (coreLoadExecutor-376-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 134537 WARN  (coreLoadExecutor-376-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] default search field in schema is text. 
WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 134540 INFO  (coreLoadExecutor-376-thread-1) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 134564 INFO  (coreLoadExecutor-376-thread-1) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from 
instancedir 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1,
 trusted=true
   [junit4]   2> 134564 INFO  (coreLoadExecutor-376-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 
'solr.core.collection1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@45efa6aa
   [junit4]   2> 134564 INFO  (coreLoadExecutor-376-thread-1) [    ] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 134564 INFO  (coreLoadExecutor-376-thread-1) [    ] 
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/J1/temp/solr.spelling.SpellCheckCollatorTest_8D4D8B27432142DD-001/init-core-data-001/]
   [junit4]   2> 134566 INFO  (coreLoadExecutor-376-thread-1) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=35, maxMergeAtOnceExplicit=26, maxMergedSegmentMB=11.91015625, 
floorSegmentMB=1.740234375, forceMergeDeletesPctAllowed=7.5766004420047555, 
segmentsPerTier=49.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.6709923748954546
   [junit4]   2> 134682 INFO  (coreLoadExecutor-376-thread-1) [    ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 134683 INFO  (coreLoadExecutor-376-thread-1) [    ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 134684 INFO  (coreLoadExecutor-376-thread-1) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=41, maxMergeAtOnceExplicit=39, maxMergedSegmentMB=92.3515625, 
floorSegmentMB=1.541015625, forceMergeDeletesPctAllowed=25.834896947705197, 
segmentsPerTier=46.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 134684 INFO  (coreLoadExecutor-376-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@7b0badca[collection1] main]
   [junit4]   2> 134685 WARN  (coreLoadExecutor-376-thread-1) [    ] 
o.a.s.r.ManagedResourceStorage Cannot write to config directory 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf;
 switching to use InMemory storage instead.
   [junit4]   2> 134685 INFO  (coreLoadExecutor-376-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 134736 INFO  (coreLoadExecutor-376-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for 
spellchecker: default
   [junit4]   2> 134782 INFO  (coreLoadExecutor-376-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for 
spellchecker: default_teststop
   [junit4]   2> 134792 INFO  (coreLoadExecutor-376-thread-1) [    ] 
o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=solr.DirectSolrSpellChecker,minQueryLength=3,maxQueryFrequency=100.0,field=teststop}
   [junit4]   2> 134792 INFO  (coreLoadExecutor-376-thread-1) [    ] 
o.a.s.s.DirectSolrSpellChecker init: 
{name=direct_lowerfilt,classname=solr.DirectSolrSpellChecker,minQueryLength=3,maxQueryFrequency=100.0,field=lowerfilt}
   [junit4]   2> 134826 INFO  (coreLoadExecutor-376-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for 
spellchecker: threshold
   [junit4]   2> 134826 INFO  (coreLoadExecutor-376-thread-1) [    ] 
o.a.s.s.DirectSolrSpellChecker init: 
{name=threshold_direct,classname=solr.DirectSolrSpellChecker,field=lowerfilt,spellcheckIndexDir=spellcheckerThreshold,buildOnCommit=true,thresholdTokenFrequency=0.29}
   [junit4]   2> 134827 INFO  (coreLoadExecutor-376-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for 
spellchecker: threshold_direct
   [junit4]   2> 134878 INFO  (coreLoadExecutor-376-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for 
spellchecker: multipleFields
   [junit4]   2> 135038 INFO  (coreLoadExecutor-376-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for 
spellchecker: freq
   [junit4]   2> 135091 INFO  (coreLoadExecutor-376-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for 
spellchecker: fqcn
   [junit4]   2> 135092 INFO  (coreLoadExecutor-376-thread-1) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 135093 INFO  (searcherExecutor-377-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 135094 INFO  
(SUITE-SpellCheckCollatorTest-seed#[8D4D8B27432142DD]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 135095 INFO  (searcherExecutor-377-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
default_teststop
   [junit4]   2> 135097 INFO  (searcherExecutor-377-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 135097 INFO  (searcherExecutor-377-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
direct_lowerfilt
   [junit4]   2> 135097 INFO  (searcherExecutor-377-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 135097 INFO  (searcherExecutor-377-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: threshold
   [junit4]   2> 135099 INFO  (searcherExecutor-377-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
threshold_direct
   [junit4]   2> 135099 INFO  (searcherExecutor-377-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 135104 INFO  (searcherExecutor-377-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 135106 INFO  (searcherExecutor-377-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 135107 INFO  
(SUITE-SpellCheckCollatorTest-seed#[8D4D8B27432142DD]-worker) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[0]} 0 12
   [junit4]   2> 135118 INFO  (searcherExecutor-377-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 135118 INFO  
(SUITE-SpellCheckCollatorTest-seed#[8D4D8B27432142DD]-worker) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[1]} 0 8
   [junit4]   2> 135119 INFO  
(SUITE-SpellCheckCollatorTest-seed#[8D4D8B27432142DD]-worker) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[2]} 0 1
   [junit4]   2> 135120 INFO  (searcherExecutor-377-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 135122 INFO  (searcherExecutor-377-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 135123 INFO  
(SUITE-SpellCheckCollatorTest-seed#[8D4D8B27432142DD]-worker) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[3]} 0 2
   [junit4]   2> 135123 INFO  (searcherExecutor-377-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@7b0badca[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 135124 INFO  
(SUITE-SpellCheckCollatorTest-seed#[8D4D8B27432142DD]-worker) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[4]} 0 0
   [junit4]   2> 135126 INFO  
(SUITE-SpellCheckCollatorTest-seed#[8D4D8B27432142DD]-worker) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[5]} 0 2
   [junit4]   2> 135128 INFO  
(SUITE-SpellCheckCollatorTest-seed#[8D4D8B27432142DD]-worker) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[6]} 0 1
   [junit4]   2> 135130 INFO  
(SUITE-SpellCheckCollatorTest-seed#[8D4D8B27432142DD]-worker) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[7]} 0 1
   [junit4]   2> 135131 INFO  
(SUITE-SpellCheckCollatorTest-seed#[8D4D8B27432142DD]-worker) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[8]} 0 0
   [junit4]   2> 135133 INFO  
(SUITE-SpellCheckCollatorTest-seed#[8D4D8B27432142DD]-worker) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[9]} 0 1
   [junit4]   2> 135134 INFO  
(SUITE-SpellCheckCollatorTest-seed#[8D4D8B27432142DD]-worker) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[10]} 0 0
   [junit4]   2> 135136 INFO  
(SUITE-SpellCheckCollatorTest-seed#[8D4D8B27432142DD]-worker) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[11]} 0 2
   [junit4]   2> 135137 INFO  
(SUITE-SpellCheckCollatorTest-seed#[8D4D8B27432142DD]-worker) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[12]} 0 0
   [junit4]   2> 135139 INFO  
(SUITE-SpellCheckCollatorTest-seed#[8D4D8B27432142DD]-worker) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[13]} 0 1
   [junit4]   2> 135141 INFO  
(SUITE-SpellCheckCollatorTest-seed#[8D4D8B27432142DD]-worker) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[14]} 0 0
   [junit4]   2> 135143 INFO  
(SUITE-SpellCheckCollatorTest-seed#[8D4D8B27432142DD]-worker) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[15]} 0 1
   [junit4]   2> 135143 INFO  
(SUITE-SpellCheckCollatorTest-seed#[8D4D8B27432142DD]-worker) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[16]} 0 0
   [junit4]   2> 135144 INFO  
(SUITE-SpellCheckCollatorTest-seed#[8D4D8B27432142DD]-worker) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 135144 INFO  
(SUITE-SpellCheckCollatorTest-seed#[8D4D8B27432142DD]-worker) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@36cd1f5f commitCommandVersion:0
   [junit4]   2> 135167 INFO  
(SUITE-SpellCheckCollatorTest-seed#[8D4D8B27432142DD]-worker) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@43277051[collection1] main]
   [junit4]   2> 135167 INFO  
(SUITE-SpellCheckCollatorTest-seed#[8D4D8B27432142DD]-worker) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 135167 INFO  (searcherExecutor-377-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
   [junit4]   2> 135408 INFO  (searcherExecutor-377-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: 
default_teststop
   [junit4]   2> 135600 INFO  (searcherExecutor-377-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
   [junit4]   2> 135659 INFO  (searcherExecutor-377-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: 
threshold_direct
   [junit4]   2> 135659 INFO  (searcherExecutor-377-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: 
multipleFields
   [junit4]   2> 136610 INFO  (searcherExecutor-377-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
   [junit4]   2> 136910 INFO  (searcherExecutor-377-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
   [junit4]   2> 137206 INFO  (searcherExecutor-377-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@43277051[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):c2)
 Uninverting(_1(7.0.0):c2) Uninverting(_2(7.0.0):c2) Uninverting(_3(7.0.0):c2) 
Uninverting(_4(7.0.0):c2) Uninverting(_5(7.0.0):c2) Uninverting(_6(7.0.0):c2) 
Uninverting(_7(7.0.0):c2) Uninverting(_8(7.0.0):c1)))}
   [junit4]   2> 137206 INFO  
(SUITE-SpellCheckCollatorTest-seed#[8D4D8B27432142DD]-worker) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{commit=} 0 2062
   [junit4]   2> 137208 INFO  
(TEST-SpellCheckCollatorTest.testCollateWithGrouping-seed#[8D4D8B27432142DD]) [ 
   ] o.a.s.SolrTestCaseJ4 ###Starting testCollateWithGrouping
   [junit4]   2> 137550 INFO  
(TEST-SpellCheckCollatorTest.testCollateWithGrouping-seed#[8D4D8B27432142DD]) [ 
   ] o.a.s.SolrTestCaseJ4 ###Ending testCollateWithGrouping
   [junit4]   2> 137552 INFO  
(TEST-SpellCheckCollatorTest.testCollationWithRangeQuery-seed#[8D4D8B27432142DD])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testCollationWithRangeQuery
   [junit4]   1> id:[1 TO 10] AND lowerfilt:love
   [junit4]   2> 137770 INFO  
(TEST-SpellCheckCollatorTest.testCollationWithRangeQuery-seed#[8D4D8B27432142DD])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testCollationWithRangeQuery
   [junit4]   2> 137777 INFO  
(TEST-SpellCheckCollatorTest.testContextSensitiveCollate-seed#[8D4D8B27432142DD])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testContextSensitiveCollate
   [junit4]   2> 137806 INFO  
(TEST-SpellCheckCollatorTest.testContextSensitiveCollate-seed#[8D4D8B27432142DD])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&spellcheck.dictionary=direct&indent=true&spellcheck.maxCollations=1&spellcheck.maxCollationTries=10&spellcheck.alternativeTermCount=5&spellcheck.build=true&spellcheck.extendedResults=true&q=teststop:(flew+AND+form+AND+heathrow)&spellcheck.maxResultsForSuggest=0&spellcheck=true&spellcheck.count=10&wt=xml&spellcheck.collate=true}
 hits=0 status=0 QTime=28
   [junit4]   2> 137819 INFO  
(TEST-SpellCheckCollatorTest.testContextSensitiveCollate-seed#[8D4D8B27432142DD])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&spellcheck.dictionary=direct&indent=true&spellcheck.maxCollations=1&spellcheck.maxCollationTries=10&spellcheck.alternativeTermCount=5&spellcheck.extendedResults=true&q=teststop:(june+AND+customs)&spellcheck.maxResultsForSuggest=1&spellcheck=true&spellcheck.count=10&wt=xml&spellcheck.collate=true}
 hits=1 status=0 QTime=11
   [junit4]   2> 137824 INFO  
(TEST-SpellCheckCollatorTest.testContextSensitiveCollate-seed#[8D4D8B27432142DD])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={mm=2&q=teststop:(june+customs)&qt=spellCheckCompRH&spellcheck.dictionary=direct&indent=true&spellcheck=true&spellcheck.count=10&spellcheck.alternativeTermCount=0&wt=xml&spellcheck.collate=true}
 hits=2 status=0 QTime=2
   [junit4]   2> 138115 INFO  
(TEST-SpellCheckCollatorTest.testContextSensitiveCollate-seed#[8D4D8B27432142DD])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&spellcheck.dictionary=default_teststop&indent=true&spellcheck.maxCollations=1&spellcheck.maxCollationTries=10&spellcheck.alternativeTermCount=5&spellcheck.build=true&spellcheck.extendedResults=true&q=teststop:(flew+AND+form+AND+heathrow)&spellcheck.maxResultsForSuggest=0&spellcheck=true&spellcheck.count=10&wt=xml&spellcheck.collate=true}
 hits=0 status=0 QTime=290
   [junit4]   2> 138121 INFO  
(TEST-SpellCheckCollatorTest.testContextSensitiveCollate-seed#[8D4D8B27432142DD])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&spellcheck.dictionary=default_teststop&indent=true&spellcheck.maxCollations=1&spellcheck.maxCollationTries=10&spellcheck.alternativeTermCount=5&spellcheck.extendedResults=true&q=teststop:(june+AND+customs)&spellcheck.maxResultsForSuggest=1&spellcheck=true&spellcheck.count=10&wt=xml&spellcheck.collate=true}
 hits=1 status=0 QTime=4
   [junit4]   2> 138124 INFO  
(TEST-SpellCheckCollatorTest.testContextSensitiveCollate-seed#[8D4D8B27432142DD])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={mm=2&q=teststop:(june+customs)&qt=spellCheckCompRH&spellcheck.dictionary=default_teststop&indent=true&spellcheck=true&spellcheck.count=10&spellcheck.alternativeTermCount=0&wt=xml&spellcheck.collate=true}
 hits=2 status=0 QTime=1
   [junit4]   2> 138124 INFO  
(TEST-SpellCheckCollatorTest.testContextSensitiveCollate-seed#[8D4D8B27432142DD])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testContextSensitiveCollate
   [junit4]   2> 138126 INFO  
(TEST-SpellCheckCollatorTest.testCollateWithFilter-seed#[8D4D8B27432142DD]) [   
 ] o.a.s.SolrTestCaseJ4 ###Starting testCollateWithFilter
   [junit4]   2> 138362 INFO  
(TEST-SpellCheckCollatorTest.testCollateWithFilter-seed#[8D4D8B27432142DD]) [   
 ] o.a.s.SolrTestCaseJ4 ###Ending testCollateWithFilter
   [junit4]   2> 138364 INFO  
(TEST-SpellCheckCollatorTest.testCollateWithOverride-seed#[8D4D8B27432142DD]) [ 
   ] o.a.s.SolrTestCaseJ4 ###Starting testCollateWithOverride
   [junit4]   2> 138392 INFO  
(TEST-SpellCheckCollatorTest.testCollateWithOverride-seed#[8D4D8B27432142DD]) [ 
   ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={mm=1&q=partisian+politcal+mashine&defType=edismax&spellcheck.dictionary=direct&qt=spellCheckCompRH&spellcheck=true&qf=teststop&spellcheck.maxCollations=10&spellcheck.count=10&spellcheck.maxCollationTries=10&wt=xml&spellcheck.collate=true}
 hits=0 status=0 QTime=27
   [junit4]   2> 138411 INFO  
(TEST-SpellCheckCollatorTest.testCollateWithOverride-seed#[8D4D8B27432142DD]) [ 
   ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={mm=1&spellcheck.dictionary=direct&qt=spellCheckCompRH&spellcheck.maxCollations=10&spellcheck.maxCollationTries=10&q=partisian+politcal+mashine&defType=edismax&spellcheck.collateParam.mm=100%25&spellcheck=true&qf=teststop&spellcheck.count=10&wt=xml&spellcheck.collate=true}
 hits=0 status=0 QTime=18
   [junit4]   2> 138411 INFO  
(TEST-SpellCheckCollatorTest.testCollateWithOverride-seed#[8D4D8B27432142DD]) [ 
   ] o.a.s.SolrTestCaseJ4 ###Ending testCollateWithOverride
   [junit4]   2> 138413 INFO  
(TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[8D4D8B27432142DD]) [  
  ] o.a.s.SolrTestCaseJ4 ###Starting testEstimatedHitCounts
   [junit4]   2> 138420 INFO  
(TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[8D4D8B27432142DD]) [  
  ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia}
 hits=0 status=0 QTime=6
   [junit4]   2> 138425 INFO  
(TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[8D4D8B27432142DD]) [  
  ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=0}
 hits=0 status=0 QTime=4
   [junit4]   2> 138431 INFO  
(TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[8D4D8B27432142DD]) [  
  ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=30}
 hits=0 status=0 QTime=5
   [junit4]   2> 138436 INFO  
(TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[8D4D8B27432142DD]) [  
  ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=100}
 hits=0 status=0 QTime=4
   [junit4]   2> 138442 INFO  
(TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[8D4D8B27432142DD]) [  
  ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=10000}
 hits=0 status=0 QTime=4
   [junit4]   2> 138446 INFO  
(TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[8D4D8B27432142DD]) [  
  ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=4}
 hits=0 status=0 QTime=3
   [junit4]   2> 138452 INFO  
(TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[8D4D8B27432142DD]) [  
  ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=14}
 hits=0 status=0 QTime=4
   [junit4]   2> 138456 INFO  
(TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[8D4D8B27432142DD]) [  
  ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=10}
 hits=0 status=0 QTime=3
   [junit4]   2> 138461 INFO  
(TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[8D4D8B27432142DD]) [  
  ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=13}
 hits=0 status=0 QTime=3
   [junit4]   2> 138466 INFO  
(TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[8D4D8B27432142DD]) [  
  ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=12}
 hits=0 status=0 QTime=3
   [junit4]   2> 138470 INFO  
(TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[8D4D8B27432142DD]) [  
  ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=1}
 hits=0 status=0 QTime=3
   [junit4]   2> 138475 INFO  
(TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[8D4D8B27432142DD]) [  
  ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=6}
 hits=0 status=0 QTime=3
   [junit4]   2> 138480 INFO  
(TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[8D4D8B27432142DD]) [  
  ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=14}
 hits=0 status=0 QTime=4
   [junit4]   2> 138484 INFO  
(TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[8D4D8B27432142DD]) [  
  ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=11}
 hits=0 status=0 QTime=3
   [junit4]   2> 138489 INFO  
(TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[8D4D8B27432142DD]) [  
  ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=1}
 hits=0 status=0 QTime=3
   [junit4]   2> 138493 INFO  
(TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[8D4D8B27432142DD]) [  
  ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=3}
 hits=0 status=0 QTime=3
   [junit4]   2> 138497 INFO  
(TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[8D4D8B27432142DD]) [  
  ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=1}
 hits=0 status=0 QTime=3
   [junit4]   2> 138503 INFO  
(TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[8D4D8B27432142DD]) [  
  ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=6}
 hits=0 status=0 QTime=5
   [junit4]   2> 138508 INFO  
(TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[8D4D8B27432142DD]) [  
  ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=6}
 hits=0 status=0 QTime=3
   [junit4]   2> 138513 INFO  
(TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[8D4D8B27432142DD]) [  
  ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=13}
 hits=0 status=0 QTime=4
   [junit4]   2> 138518 INFO  
(TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[8D4D8B27432142DD]) [  
  ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=13}
 hits=0 status=0 QTime=4
   [junit4]   2> 138523 INFO  
(TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[8D4D8B27432142DD]) [  
  ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=3}
 hits=0 status=0 QTime=3
   [junit4]   2> 138528 INFO  
(TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[8D4D8B27432142DD]) [  
  ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=6}
 hits=0 status=0 QTime=3
   [junit4]   2> 138532 INFO  
(TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[8D4D8B27432142DD]) [  
  ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=14}
 hits=0 status=0 QTime=3
   [junit4]   2> 138537 INFO  
(TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[8D4D8B27432142DD]) [  
  ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=17}
 hits=0 status=0 QTime=4
   [junit4]   2> 138542 INFO  
(TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[8D4D8B27432142DD]) [  
  ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=12}
 hits=0 status=0 QTime=4
   [junit4]   2> 138547 INFO  
(TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[8D4D8B27432142DD]) [  
  ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=17}
 hits=0 status=0 QTime=4
   [junit4]   2> 138552 INFO  
(TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[8D4D8B27432142DD]) [  
  ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=10}
 hits=0 status=0 QTime=3
   [junit4]   2> 138556 INFO  
(TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[8D4D8B27432142DD]) [  
  ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=8}
 hits=0 status=0 QTime=3
   [junit4]   2> 138561 INFO  
(TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[8D4D8B27432142DD]) [  
  ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=5}
 hits=0 status=0 QTime=3
   [junit4]   2> 138566 INFO  
(TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[8D4D8B27432142DD]) [  
  ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=8}
 hits=0 status=0 QTime=4
   [junit4]   2> 138569 INFO  
(TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[8D4D8B27432142DD]) [  
  ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=9}
 hits=0 status=0 QTime=2
   [junit4]   2> 138572 INFO  
(TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[8D4D8B27432142DD]) [  
  ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=3}
 hits=0 status=0 QTime=2
   [junit4]   2> 138575 INFO  
(TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[8D4D8B27432142DD]) [  
  ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=14}
 hits=0 status=0 QTime=2
   [junit4]   2> 138578 INFO  
(TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[8D4D8B27432142DD]) [  
  ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=2}
 hits=0 status=0 QTime=2
   [junit4]   2> 138582 INFO  
(TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[8D4D8B27432142DD]) [  
  ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=4}
 hits=0 status=0 QTime=3
   [junit4]   2> 138586 INFO  
(TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[8D4D8B27432142DD]) [  
  ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=3}
 hits=0 status=0 QTime=3
   [junit4]   2> 138589 INFO  
(TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[8D4D8B27432142DD]) [  
  ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=11}
 hits=0 status=0 QTime=2
   [junit4]   2> 138591 INFO  
(TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[8D4D8B27432142DD]) [  
  ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=6}
 hits=0 status=0 QTime=2
   [junit4]   2> 138594 INFO  
(TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[8D4D8B27432142DD]) [  
  ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=4}
 hits=0 status=0 QTime=2
   [junit4]   2> 138598 INFO  
(TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[8D4D8B27432142DD]) [  
  ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=12}
 hits=0 status=0 QTime=2
   [junit4]   2> 138600 INFO  
(TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[8D4D8B27432142DD]) [  
  ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=15}
 hits=0 status=0 QTime=2
   [junit4]   2> 138603 INFO  
(TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[8D4D8B27432142DD]) [  
  ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=2}
 hits=0 status=0 QTime=2
   [junit4]   2> 138605 INFO  
(TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[8D4D8B27432142DD]) [  
  ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=3}
 hits=0 status=0 QTime=2
   [junit4]   2> 138608 INFO  
(TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[8D4D8B27432142DD]) [  
  ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=3}
 hits=0 status=0 QTime=2
   [junit4]   2> 138611 INFO  
(TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[8D4D8B27432142DD]) [  
  ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=3}
 hits=0 status=0 QTime=1
   [junit4]   2> 138613 INFO  
(TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[8D4D8B27432142DD]) [  
  ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=7}
 hits=0 status=0 QTime=1
   [junit4]   2> 138616 INFO  
(TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[8D4D8B27432142DD]) [  
  ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:everother&spellcheck.collateMaxCollectDocs=5}
 hits=0 status=0 QTime=2
   [junit4]   2> 138617 ERROR 
(TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[8D4D8B27432142DD]) [  
  ] o.a.s.SolrTestCaseJ4 REQUEST FAILED: 
xpath=//lst[@name='spellcheck']/lst[@name='collations']/lst[@name='collation']/int[@name='hits'
 and 3 <= . and . <= 13]
   [junit4]   2>        xml response was: <?xml version="1.0" encoding="UTF-8"?>
   [junit4]   2> <response>
   [junit4]   2> <lst name="responseHeader"><int name="status">0</int><int 
name="QTime">2</int></lst><result name="response" numFound="0" 
start="0"></result><lst name="spellcheck"><lst name="suggestions"><lst 
name="everother"><int name="numFound">1</int><int 
name="startOffset">9</int><int name="endOffset">18</int><arr 
name="suggestion"><str>everyother</str></arr></lst></lst><lst 
name="collations"><lst name="collation"><str 
name="collationQuery">teststop:everyother</str><int name="hits">14</int><lst 
name="misspellingsAndCorrections"><str 
name="everother">everyother</str></lst></lst></lst></lst>
   [junit4]   2> </response>
   [junit4]   2> 
   [junit4]   2>        request 
was:spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:everother&spellcheck.collateMaxCollectDocs=5
   [junit4]   2> 138618 ERROR 
(TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[8D4D8B27432142DD]) [  
  ] o.a.s.SolrTestCaseJ4 REQUEST FAILED: 
spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:everother&spellcheck.collateMaxCollectDocs=5:java.lang.RuntimeException:
 REQUEST FAILED: 
xpath=//lst[@name='spellcheck']/lst[@name='collations']/lst[@name='collation']/int[@name='hits'
 and 3 <= . and . <= 13]
   [junit4]   2>        xml response was: <?xml version="1.0" encoding="UTF-8"?>
   [junit4]   2> <response>
   [junit4]   2> <lst name="responseHeader"><int name="status">0</int><int 
name="QTime">2</int></lst><result name="response" numFound="0" 
start="0"></result><lst name="spellcheck"><lst name="suggestions"><lst 
name="everother"><int name="numFound">1</int><int 
name="startOffset">9</int><int name="endOffset">18</int><arr 
name="suggestion"><str>everyother</str></arr></lst></lst><lst 
name="collations"><lst name="collation"><str 
name="collationQuery">teststop:everyother</str><int name="hits">14</int><lst 
name="misspellingsAndCorrections"><str 
name="everother">everyother</str></lst></lst></lst></lst>
   [junit4]   2> </response>
   [junit4]   2> 
   [junit4]   2>        request 
was:spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:everother&spellcheck.collateMaxCollectDocs=5
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:889)
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:863)
   [junit4]   2>        at 
org.apache.solr.spelling.SpellCheckCollatorTest.testEstimatedHitCounts(SpellCheckCollatorTest.java:569)
   [junit4]   2>        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   [junit4]   2>        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
   [junit4]   2>        at 
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   [junit4]   2>        at 
java.base/java.lang.reflect.Method.invoke(Method.java:563)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
   [junit4]   2>        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
   [junit4]   2>        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
   [junit4]   2>        at java.base/java.lang.Thread.run(Thread.java:844)
   [junit4]   2> 
   [junit4]   2> 138618 INFO  
(TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[8D4D8B27432142DD]) [  
  ] o.a.s.SolrTestCaseJ4 ###Ending testEstimatedHitCounts
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=SpellCheckCollatorTest -Dtests.method=testEstimatedHitCounts 
-Dtests.seed=8D4D8B27432142DD -Dtests.multiplier=3 -Dtests.slow=true 
-Dtests.locale=hr -Dtests.timezone=UTC -Dtests.asserts=true 
-Dtests.file.encoding=ISO-8859-1
   [junit4] ERROR   0.21s J1 | SpellCheckCollatorTest.testEstimatedHitCounts <<<
   [junit4]    > Throwable #1: java.lang.RuntimeException: Exception during 
query
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([8D4D8B27432142DD:BCF63512E61E520D]:0)
   [junit4]    >        at 
org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:896)
   [junit4]    >        at 
org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:863)
   [junit4]    >        at 
org.apache.solr.spelling.SpellCheckCollatorTest.testEstimatedHitCounts(SpellCheckCollatorTest.java:569)
   [junit4]    >        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   [junit4]    >        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
   [junit4]    >        at 
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   [junit4]    >        at 
java.base/java.lang.reflect.Method.invoke(Method.java:563)
   [junit4]    >        at java.base/java.lang.Thread.run(Thread.java:844)
   [junit4]    > Caused by: java.lang.RuntimeException: REQUEST FAILED: 
xpath=//lst[@name='spellcheck']/lst[@name='collations']/lst[@name='collation']/int[@name='hits'
 and 3 <= . and . <= 13]
   [junit4]    >        xml response was: <?xml version="1.0" encoding="UTF-8"?>
   [junit4]    > <response>
   [junit4]    > <lst name="responseHeader"><int name="status">0</int><int 
name="QTime">2</int></lst><result name="response" numFound="0" 
start="0"></result><lst name="spellcheck"><lst name="suggestions"><lst 
name="everother"><int name="numFound">1</int><int 
name="startOffset">9</int><int name="endOffset">18</int><arr 
name="suggestion"><str>everyother</str></arr></lst></lst><lst 
name="collations"><lst name="collation"><str 
name="collationQuery">teststop:everyother</str><int name="hits">14</int><lst 
name="misspellingsAndCorrections"><str 
name="everother">everyother</str></lst></lst></lst></lst>
   [junit4]    > </response>
   [junit4]    >        request 
was:spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:everother&spellcheck.collateMaxCollectDocs=5
   [junit4]    >        at 
org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:889)
   [junit4]    >        ... 40 more
   [junit4]   2> 138621 INFO  
(TEST-SpellCheckCollatorTest.testWithCursorMark-seed#[8D4D8B27432142DD]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testWithCursorMark
   [junit4]   2> 138836 INFO  
(TEST-SpellCheckCollatorTest.testWithCursorMark-seed#[8D4D8B27432142DD]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testWithCursorMark
   [junit4]   2> 138837 INFO  
(TEST-SpellCheckCollatorTest.testExtendedCollate-seed#[8D4D8B27432142DD]) [    
] o.a.s.SolrTestCaseJ4 ###Starting testExtendedCollate
   [junit4]   2> 139023 INFO  
(TEST-SpellCheckCollatorTest.testExtendedCollate-seed#[8D4D8B27432142DD]) [    
] o.a.s.SolrTestCaseJ4 ###Ending testExtendedCollate
   [junit4]   2> 139028 INFO  
(TEST-SpellCheckCollatorTest.testCollationWithHypens-seed#[8D4D8B27432142DD]) [ 
   ] o.a.s.SolrTestCaseJ4 ###Starting testCollationWithHypens
   [junit4]   2> 139387 INFO  
(TEST-SpellCheckCollatorTest.testCollationWithHypens-seed#[8D4D8B27432142DD]) [ 
   ] o.a.s.SolrTestCaseJ4 ###Ending testCollationWithHypens
   [junit4]   2> 139388 INFO  
(TEST-SpellCheckCollatorTest.testZeroTries-seed#[8D4D8B27432142DD]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testZeroTries
   [junit4]   2> 139563 INFO  
(TEST-SpellCheckCollatorTest.testZeroTries-seed#[8D4D8B27432142DD]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testZeroTries
   [junit4]   2> 139564 INFO  
(TEST-SpellCheckCollatorTest.testCollateWithMultipleRequestHandlers-seed#[8D4D8B27432142DD])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testCollateWithMultipleRequestHandlers
   [junit4]   2> 139734 INFO  
(TEST-SpellCheckCollatorTest.testCollateWithMultipleRequestHandlers-seed#[8D4D8B27432142DD])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testCollateWithMultipleRequestHandlers
   [junit4]   2> 139735 INFO  
(SUITE-SpellCheckCollatorTest-seed#[8D4D8B27432142DD]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> 139735 INFO  
(SUITE-SpellCheckCollatorTest-seed#[8D4D8B27432142DD]-worker) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=28530222
   [junit4]   2> 139735 INFO  
(SUITE-SpellCheckCollatorTest-seed#[8D4D8B27432142DD]-worker) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 139737 INFO  
(SUITE-SpellCheckCollatorTest-seed#[8D4D8B27432142DD]-worker) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 139738 INFO  
(SUITE-SpellCheckCollatorTest-seed#[8D4D8B27432142DD]-worker) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 139738 INFO  
(SUITE-SpellCheckCollatorTest-seed#[8D4D8B27432142DD]-worker) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 139739 INFO  (coreCloseExecutor-381-thread-1) [    ] 
o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@b4475a
   [junit4]   2> 139740 INFO  (coreCloseExecutor-381-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=11814746
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.spelling.SpellCheckCollatorTest_8D4D8B27432142DD-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): 
{start1=PostingsFormat(name=MockRandom), 
lowerfilt1=PostingsFormat(name=Memory), 
multiDefault=PostingsFormat(name=Direct), teststop=PostingsFormat(name=Direct), 
lowerfilt1and2=PostingsFormat(name=Direct), end4=PostingsFormat(name=Memory), 
end3=BlockTreeOrds(blocksize=128), end2=PostingsFormat(name=MockRandom), 
end1=PostingsFormat(name=Direct), lowerfilt=PostingsFormat(name=Direct), 
gram1=PostingsFormat(name=Direct), id=PostingsFormat(name=MockRandom), 
gram2=PostingsFormat(name=MockRandom), gram3=BlockTreeOrds(blocksize=128), 
start3=PostingsFormat(name=Memory), gram4=PostingsFormat(name=Memory), 
start2=PostingsFormat(name=Direct), word=PostingsFormat(name=Direct), 
start4=BlockTreeOrds(blocksize=128)}, 
docValues:{range_facet_l_dv=DocValuesFormat(name=Asserting), 
intDefault=DocValuesFormat(name=Lucene70), 
range_facet_i_dv=DocValuesFormat(name=Memory), 
intDvoDefault=DocValuesFormat(name=Asserting), 
range_facet_l=DocValuesFormat(name=Memory), 
timestamp=DocValuesFormat(name=Memory)}, maxPointsInLeafNode=19, 
maxMBSortInHeap=5.833499925044805, sim=RandomSimilarity(queryNorm=true): {}, 
locale=hr, timezone=UTC
   [junit4]   2> NOTE: Linux 4.4.0-72-generic amd64/Oracle Corporation 9-ea 
(64-bit)/cpus=12,threads=1,free=237397856,total=527433728
   [junit4]   2> NOTE: All tests run in this JVM: 
[LeaderFailoverAfterPartitionTest, TestSegmentSorting, TestSimpleQParserPlugin, 
TestSolrCloudSnapshots, JsonValidatorTest, AtomicUpdatesTest, 
TestFieldCacheSortRandom, HttpSolrCallGetCoreTest, SpatialFilterTest, 
TestLRUCache, DocValuesTest, TestElisionMultitermQuery, ZkControllerTest, 
TestSweetSpotSimilarityFactory, SpellCheckCollatorTest]
   [junit4] Completed [56/702 (1!)] on J1 in 5.78s, 11 tests, 1 error <<< 
FAILURES!

[...truncated 1925 lines...]
   [junit4] Suite: org.apache.solr.schema.TestUseDocValuesAsStored
   [junit4]   2> Creating dataDir: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.schema.TestUseDocValuesAsStored_8D4D8B27432142DD-001/init-core-data-001
   [junit4]   2> 1766706 INFO  
(SUITE-TestUseDocValuesAsStored-seed#[8D4D8B27432142DD]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields
   [junit4]   2> 1766709 INFO  
(SUITE-TestUseDocValuesAsStored-seed#[8D4D8B27432142DD]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via: 
@org.apache.solr.util.RandomizeSSL(reason="", ssl=0.0/0.0, value=0.0/0.0, 
clientAuth=0.0/0.0)
   [junit4]   2> 1766711 INFO  
(TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[8D4D8B27432142DD]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testOnEmptyIndex
   [junit4]   2> 1766734 INFO  
(TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[8D4D8B27432142DD]) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 1766745 INFO  
(TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[8D4D8B27432142DD]) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1766762 INFO  
(TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[8D4D8B27432142DD]) [    ] 
o.a.s.s.ManagedIndexSchemaFactory The schema is configured as managed, but 
managed schema resource managed-schema not found - loading non-managed schema 
schema-non-stored-docvalues.xml instead
   [junit4]   2> 1766774 INFO  
(TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[8D4D8B27432142DD]) [    ] 
o.a.s.s.IndexSchema [null] Schema name=test-non-stored-docvalues
   [junit4]   2> 1766785 INFO  
(TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[8D4D8B27432142DD]) [    ] 
o.a.s.s.IndexSchema Loaded schema test-non-stored-docvalues/1.6 with uniqueid 
field id
   [junit4]   2> 1766786 INFO  
(TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[8D4D8B27432142DD]) [    ] 
o.a.s.s.ManagedIndexSchema Upgraded to managed schema at 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.schema.TestUseDocValuesAsStored_8D4D8B27432142DD-001/tempDir-001/collection1/conf/managed-schema
   [junit4]   2> 1766825 INFO  
(TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[8D4D8B27432142DD]) [    ] 
o.a.s.s.ManagedIndexSchemaFactory After upgrading to managed schema, renamed 
the non-managed schema 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.schema.TestUseDocValuesAsStored_8D4D8B27432142DD-001/tempDir-001/collection1/conf/schema-non-stored-docvalues.xml
 to 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.schema.TestUseDocValuesAsStored_8D4D8B27432142DD-001/tempDir-001/collection1/conf/schema-non-stored-docvalues.xml.bak
   [junit4]   2> 1766933 INFO  
(TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[8D4D8B27432142DD]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@45efa6aa
   [junit4]   2> 1766938 INFO  
(TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[8D4D8B27432142DD]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@45efa6aa
   [junit4]   2> 1766938 INFO  
(TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[8D4D8B27432142DD]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@45efa6aa
   [junit4]   2> 1766960 INFO  (coreLoadExecutor-7576-thread-1) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1766968 INFO  (coreLoadExecutor-7576-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test-non-stored-docvalues
   [junit4]   2> 1766993 INFO  (coreLoadExecutor-7576-thread-1) [    ] 
o.a.s.s.IndexSchema Loaded schema test-non-stored-docvalues/1.6 with uniqueid 
field id
   [junit4]   2> 1766993 INFO  (coreLoadExecutor-7576-thread-1) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from 
instancedir 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.schema.TestUseDocValuesAsStored_8D4D8B27432142DD-001/tempDir-001/collection1,
 trusted=true
   [junit4]   2> 1766993 INFO  (coreLoadExecutor-7576-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 
'solr.core.collection1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@45efa6aa
   [junit4]   2> 1766994 INFO  (coreLoadExecutor-7576-thread-1) [    ] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 1766994 INFO  (coreLoadExecutor-7576-thread-1) [    ] 
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.schema.TestUseDocValuesAsStored_8D4D8B27432142DD-001/tempDir-001/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.schema.TestUseDocValuesAsStored_8D4D8B27432142DD-001/init-core-data-001/]
   [junit4]   2> 1766999 INFO  (coreLoadExecutor-7576-thread-1) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=24, maxMergeAtOnceExplicit=31, maxMergedSegmentMB=43.5654296875, 
floorSegmentMB=0.869140625, forceMergeDeletesPctAllowed=19.08952844825402, 
segmentsPerTier=43.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.8165195091343092
   [junit4]   2> 1767057 WARN  (coreLoadExecutor-7576-thread-1) [    ] 
o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = 
requestHandler,name = /dump,class = DumpRequestHandler,attributes = 
{initParams=a, name=/dump, registerPath=/solr,/v2, 
class=DumpRequestHandler},args = {defaults={a=A,b=B}}}
   [junit4]   2> 1767189 INFO  (coreLoadExecutor-7576-thread-1) [    ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1767189 INFO  (coreLoadExecutor-7576-thread-1) [    ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1767190 INFO  (coreLoadExecutor-7576-thread-1) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=28, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.6048623596325519]
   [junit4]   2> 1767193 INFO  (coreLoadExecutor-7576-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@18c38efb[collection1] main]
   [junit4]   2> 1767195 INFO  (coreLoadExecutor-7576-thread-1) [    ] 
o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.schema.TestUseDocValuesAsStored_8D4D8B27432142DD-001/tempDir-001/collection1/conf
   [junit4]   2> 1767197 INFO  (coreLoadExecutor-7576-thread-1) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1767199 INFO  
(TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[8D4D8B27432142DD]) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 1767200 INFO  
(TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[8D4D8B27432142DD]) [    ] 
o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1767200 INFO  
(TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[8D4D8B27432142DD]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}{deleteByQuery=*:*}
 0 1
   [junit4]   2> 1767201 INFO  
(TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[8D4D8B27432142DD]) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1767201 INFO  
(TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[8D4D8B27432142DD]) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@56ab12f8 commitCommandVersion:0
   [junit4]   2> 1767203 INFO  (searcherExecutor-7577-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@18c38efb[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1767245 INFO  
(TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[8D4D8B27432142DD]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@3e32ad20[collection1] main]
   [junit4]   2> 1767245 INFO  
(TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[8D4D8B27432142DD]) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1767249 INFO  (searcherExecutor-7577-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@3e32ad20[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1767249 INFO  
(TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[8D4D8B27432142DD]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{commit=} 0 48
   [junit4]   2> 1767255 INFO  
(TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[8D4D8B27432142DD]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=*:*&wt=xml} 
hits=0 status=0 QTime=1
   [junit4]   2> 1767256 INFO  
(TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[8D4D8B27432142DD]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&fl=*&wt=xml} hits=0 status=0 QTime=0
   [junit4]   2> 1767257 INFO  
(TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[8D4D8B27432142DD]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&fl=test_nonstored_dv_str&wt=xml} hits=0 status=0 QTime=0
   [junit4]   2> 1767257 INFO  
(TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[8D4D8B27432142DD]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&fl=*,test_nonstored_dv_str&wt=xml} hits=0 status=0 QTime=0
   [junit4]   2> 1767258 INFO  
(TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[8D4D8B27432142DD]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[xyz]} 0 1
   [junit4]   2> 1767259 INFO  
(TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[8D4D8B27432142DD]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=*:*&wt=xml} 
hits=0 status=0 QTime=0
   [junit4]   2> 1767260 INFO  
(TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[8D4D8B27432142DD]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&fl=*&wt=xml} hits=0 status=0 QTime=1
   [junit4]   2> 1767261 INFO  
(TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[8D4D8B27432142DD]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&fl=test_nonstored_dv_str&wt=xml} hits=0 status=0 QTime=0
   [junit4]   2> 1767261 INFO  
(TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[8D4D8B27432142DD]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&fl=*,test_nonstored_dv_str&wt=xml} hits=0 status=0 QTime=0
   [junit4]   2> 1767261 INFO  
(TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[8D4D8B27432142DD]) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1767261 INFO  
(TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[8D4D8B27432142DD]) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@56ab12f8 commitCommandVersion:0
   [junit4]   2> 1767429 INFO  
(TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[8D4D8B27432142DD]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@6f1d535b[collection1] main]
   [junit4]   2> 1767430 INFO  
(TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[8D4D8B27432142DD]) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1767430 INFO  (searcherExecutor-7577-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@6f1d535b[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C1)))}
   [junit4]   2> 1767431 INFO  
(TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[8D4D8B27432142DD]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{commit=} 0 169
   [junit4]   2> 1767431 INFO  
(TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[8D4D8B27432142DD]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=*:*&wt=xml} 
hits=1 status=0 QTime=0
   [junit4]   2> 1767432 INFO  
(TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[8D4D8B27432142DD]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&fl=*&wt=xml} hits=1 status=0 QTime=0
   [junit4]   2> 1767432 INFO  
(TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[8D4D8B27432142DD]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&fl=test_nonstored_dv_str&wt=xml} hits=1 status=0 QTime=0
   [junit4]   2> 1767432 INFO  
(TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[8D4D8B27432142DD]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&fl=*,test_nonstored_dv_str&wt=xml} hits=1 status=0 QTime=0
   [junit4]   2> 1767433 INFO  
(TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[8D4D8B27432142DD]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[xyz]} 0 0
   [junit4]   2> 1767433 INFO  
(TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[8D4D8B27432142DD]) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1767433 INFO  
(TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[8D4D8B27432142DD]) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@56ab12f8 commitCommandVersion:0
   [junit4]   2> 1767561 INFO  
(TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[8D4D8B27432142DD]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@55d9491f[collection1] main]
   [junit4]   2> 1767561 INFO  
(TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[8D4D8B27432142DD]) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1767562 INFO  (searcherExecutor-7577-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@55d9491f[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(7.0.0):C1)))}
   [junit4]   2> 1767566 INFO  
(TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[8D4D8B27432142DD]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{commit=} 0 132
   [junit4]   2> 1767567 INFO  
(TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[8D4D8B27432142DD]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=*:*&wt=xml} 
hits=1 status=0 QTime=0
   [junit4]   2> 1767567 INFO  
(TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[8D4D8B27432142DD]) [    ] 
o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1767567 INFO  
(TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[8D4D8B27432142DD]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}{deleteByQuery=*:*}
 0 0
   [junit4]   2> 1767567 INFO  
(TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[8D4D8B27432142DD]) [    ] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> 1767567 INFO  
(TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[8D4D8B27432142DD]) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1119955382
   [junit4]   2> 1767567 INFO  
(TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[8D4D8B27432142DD]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 1767569 INFO  
(TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[8D4D8B27432142DD]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 1767572 INFO  
(TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[8D4D8B27432142DD]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 1767573 INFO  
(TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[8D4D8B27432142DD]) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 1767577 INFO  (coreCloseExecutor-7581-thread-1) [    ] 
o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@38a42429
   [junit4]   2> 1767580 INFO  (coreCloseExecutor-7581-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=950281257
   [junit4]   2> 1767585 INFO  
(TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[8D4D8B27432142DD]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testOnEmptyIndex
   [junit4]   2> 1767588 INFO  
(TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[8D4D8B27432142DD])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testRandomSingleAndMultiValued
   [junit4]   2> 1767612 INFO  
(TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[8D4D8B27432142DD])
 [    ] o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 1767630 INFO  
(TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[8D4D8B27432142DD])
 [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1767641 INFO  
(TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[8D4D8B27432142DD])
 [    ] o.a.s.s.ManagedIndexSchemaFactory The schema is configured as managed, 
but managed schema resource managed-schema not found - loading non-managed 
schema schema-non-stored-docvalues.xml instead
   [junit4]   2> 1767647 INFO  
(TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[8D4D8B27432142DD])
 [    ] o.a.s.s.IndexSchema [null] Schema name=test-non-stored-docvalues
   [junit4]   2> 1767657 INFO  
(TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[8D4D8B27432142DD])
 [    ] o.a.s.s.IndexSchema Loaded schema test-non-stored-docvalues/1.6 with 
uniqueid field id
   [junit4]   2> 1767659 INFO  
(TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[8D4D8B27432142DD])
 [    ] o.a.s.s.ManagedIndexSchema Upgraded to managed schema at 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.schema.TestUseDocValuesAsStored_8D4D8B27432142DD-001/tempDir-002/collection1/conf/managed-schema
   [junit4]   2> 1767674 INFO  
(TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[8D4D8B27432142DD])
 [    ] o.a.s.s.ManagedIndexSchemaFactory After upgrading to managed schema, 
renamed the non-managed schema 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.schema.TestUseDocValuesAsStored_8D4D8B27432142DD-001/tempDir-002/collection1/conf/schema-non-stored-docvalues.xml
 to 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.schema.TestUseDocValuesAsStored_8D4D8B27432142DD-001/tempDir-002/collection1/conf/schema-non-stored-docvalues.xml.bak
   [junit4]   2> 1767795 INFO  
(TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[8D4D8B27432142DD])
 [    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 
'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@45efa6aa
   [junit4]   2> 1767798 INFO  
(TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiVal

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

O  (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[8D4D8B27432142DD]) [  
  ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[myid1]} 0 1
   [junit4]   2> 1830434 INFO  
(TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[8D4D8B27432142DD]) [    
] o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1830434 INFO  
(TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[8D4D8B27432142DD]) [    
] o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@1f7e2f18 commitCommandVersion:0
   [junit4]   2> 1830699 INFO  
(TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[8D4D8B27432142DD]) [    
] o.a.s.s.SolrIndexSearcher Opening [Searcher@aa6b61[collection1] main]
   [junit4]   2> 1830700 INFO  
(TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[8D4D8B27432142DD]) [    
] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1830700 INFO  (searcherExecutor-7637-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@aa6b61[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_7n(7.0.0):C1)))}
   [junit4]   2> 1830702 INFO  
(TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[8D4D8B27432142DD]) [    
] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{commit=} 0 268
   [junit4]   2> 1830704 INFO  
(TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[8D4D8B27432142DD]) [    
] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:myid*&fl=*&wt=xml} hits=1 status=0 QTime=1
   [junit4]   2> 1830704 INFO  
(TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[8D4D8B27432142DD]) [    
] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1830704 INFO  
(TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[8D4D8B27432142DD]) [    
] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}{deleteByQuery=*:*}
 0 0
   [junit4]   2> 1830704 INFO  
(TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[8D4D8B27432142DD]) [    
] o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> 1830704 INFO  
(TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[8D4D8B27432142DD]) [    
] o.a.s.c.CoreContainer Shutting down CoreContainer instance=867309662
   [junit4]   2> 1830704 INFO  
(TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[8D4D8B27432142DD]) [    
] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 1830705 INFO  
(TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[8D4D8B27432142DD]) [    
] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 1830706 INFO  
(TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[8D4D8B27432142DD]) [    
] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 1830706 INFO  
(TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[8D4D8B27432142DD]) [    
] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 
2147483647 transient cores
   [junit4]   2> 1830707 INFO  (coreCloseExecutor-7641-thread-1) [    ] 
o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@7ff3d9ac
   [junit4]   2> 1830708 INFO  (coreCloseExecutor-7641-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=2146687404
   [junit4]   2> 1830710 INFO  
(TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[8D4D8B27432142DD]) [    
] o.a.s.SolrTestCaseJ4 ###Ending testManagedSchema
   [junit4]   2> 1830710 INFO  
(SUITE-TestUseDocValuesAsStored-seed#[8D4D8B27432142DD]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.schema.TestUseDocValuesAsStored_8D4D8B27432142DD-001
   [junit4]   2> NOTE: test params are: 
codec=FastDecompressionCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=FAST_DECOMPRESSION,
 chunkSize=5, maxDocsPerChunk=95, blockSize=1), 
termVectorsFormat=CompressingTermVectorsFormat(compressionMode=FAST_DECOMPRESSION,
 chunkSize=5, blockSize=1)), sim=RandomSimilarity(queryNorm=false): {}, 
locale=ps-AF, timezone=Etc/GMT+7
   [junit4]   2> NOTE: Linux 4.4.0-72-generic amd64/Oracle Corporation 9-ea 
(64-bit)/cpus=12,threads=1,free=111330096,total=534773760
   [junit4]   2> NOTE: All tests run in this JVM: 
[LeaderFailoverAfterPartitionTest, TestSegmentSorting, TestSimpleQParserPlugin, 
TestSolrCloudSnapshots, JsonValidatorTest, AtomicUpdatesTest, 
TestFieldCacheSortRandom, HttpSolrCallGetCoreTest, SpatialFilterTest, 
TestLRUCache, DocValuesTest, TestElisionMultitermQuery, ZkControllerTest, 
TestSweetSpotSimilarityFactory, SpellCheckCollatorTest, SortSpecParsingTest, 
OnlyLeaderIndexesTest, RecoveryAfterSoftCommitTest, ForceLeaderTest, 
CollectionStateFormat2Test, TestSurroundQueryParser, 
IgnoreCommitOptimizeUpdateProcessorFactoryTest, TestSolrIndexConfig, 
TestHashPartitioner, HighlighterMaxOffsetTest, TestSolrConfigHandlerConcurrent, 
ShardRoutingTest, SOLR749Test, AnalyticsMergeStrategyTest, 
DistributedMLTComponentTest, DistributedFacetPivotSmallAdvancedTest, 
TestCollationFieldDocValues, TestCoreContainer, TestRequestForwarding, 
SpellCheckComponentTest, CdcrRequestHandlerTest, TestScoreJoinQPScore, 
SolrMetricManagerTest, DocumentBuilderTest, 
HdfsCollectionsAPIDistributedZkTest, ConnectionManagerTest, 
TestDeleteCollectionOnDownNodes, TestStressRecovery, CSVRequestHandlerTest, 
TestExportWriter, AssignTest, TestPerFieldSimilarity, 
TestDefaultSearchFieldResource, TestConfigSetsAPIExclusivity, JsonLoaderTest, 
SSLMigrationTest, SolrInfoBeanTest, CdcrBootstrapTest, TestBlobHandler, 
SpellCheckCollatorWithCollapseTest, OverseerCollectionConfigSetProcessorTest, 
SecurityConfHandlerTest, TestCoreAdminApis, ChaosMonkeySafeLeaderTest, 
TestSearchPerf, BooleanFieldTest, DistribCursorPagingTest, TestNoOpRegenerator, 
TestManagedResource, TestStressVersions, UpdateRequestProcessorFactoryTest, 
BasicFunctionalityTest, TestFastLRUCache, RuleEngineTest, TestRTGBase, 
TestMacroExpander, TestLegacyFieldCache, TestSchemalessBufferedUpdates, 
TestStressCloudBlindAtomicUpdates, PrimUtilsTest, ConnectionReuseTest, 
MoreLikeThisHandlerTest, SystemInfoHandlerTest, TestCursorMarkWithoutUniqueKey, 
TestCloudPivotFacet, IndexSchemaRuntimeFieldTest, TestBM25SimilarityFactory, 
TriLevelCompositeIdRoutingTest, SuggesterFSTTest, ZkSolrClientTest, 
TestNonDefinedSimilarityFactory, TestFileDictionaryLookup, 
HdfsBasicDistributedZkTest, MoveReplicaTest, TestSolrCLIRunExample, 
TestUninvertingReader, TestSystemIdResolver, 
TestSolrQueryParserDefaultOperatorResource, SuggestComponentTest, 
TestDelegationWithHadoopAuth, TestLockTree, HdfsThreadLeakTest, 
InfoHandlerTest, TestSubQueryTransformer, UpdateLogTest, TestSQLHandler, 
TestTolerantUpdateProcessorCloud, TestExactStatsCache, DeleteReplicaTest, 
SolrCmdDistributorTest, TestSimpleTrackingShardHandler, 
OpenCloseCoreStressTest, ExplicitHLLTest, TestWordDelimiterFilterFactory, 
SortByFunctionTest, TestQueryTypes, SolrSlf4jReporterTest, 
SolrIndexMetricsTest, FileUtilsTest, BigEndianAscendingWordDeserializerTest, 
SolrCoreTest, TestGroupingSearch, BadIndexSchemaTest, TestFunctionQuery, 
TestLazyCores, DirectUpdateHandlerTest, TestIndexSearcher, 
ShowFileRequestHandlerTest, CurrencyFieldOpenExchangeTest, 
DistributedQueryElevationComponentTest, CurrencyFieldXmlFileTest, 
SolrIndexSplitterTest, SimplePostToolTest, AnalysisAfterCoreReloadTest, 
SignatureUpdateProcessorFactoryTest, TestExtendedDismaxParser, 
TestFoldingMultitermQuery, SuggesterTSTTest, TestTrie, NoCacheHeaderTest, 
WordBreakSolrSpellCheckerTest, SchemaVersionSpecificBehaviorTest, TestUpdate, 
QueryEqualityTest, DirectUpdateHandlerOptimizeTest, 
StatelessScriptUpdateProcessorFactoryTest, DocValuesMultiTest, 
DistanceFunctionTest, CacheHeaderTest, LukeRequestHandlerTest, 
TestReversedWildcardFilterFactory, FileBasedSpellCheckerTest, 
TermVectorComponentTest, IndexSchemaTest, TestPHPSerializedResponseWriter, 
AlternateDirectoryTest, CopyFieldTest, ResponseLogComponentTest, 
BadComponentTest, TestSolrDeletionPolicy2, SampleTest, OutputWriterTest, 
TestFuzzyAnalyzedSuggestions, TestSolrCoreProperties, NotRequiredUniqueKeyTest, 
SynonymTokenizerTest, TestLMDirichletSimilarityFactory, ResourceLoaderTest, 
OpenExchangeRatesOrgProviderTest, PreAnalyzedFieldTest, SliceStateTest, 
TestEmbeddedSolrServerSchemaAPI, TestJettySolrRunner, 
AsyncCallRequestStatusResponseTest, CleanupOldIndexTest, 
CollectionsAPIAsyncDistributedZkTest, DeleteInactiveReplicaTest, 
DeleteStatusTest, DistributedQueueTest, DocValuesNotIndexedTest, 
LeaderInitiatedRecoveryOnShardRestartTest, MissingSegmentRecoveryTest, 
MultiThreadedOCPTest, SharedFSAutoReplicaFailoverTest, 
SharedFSAutoReplicaFailoverUtilsTest, SolrCLIZkUtilsTest, SolrCloudExampleTest, 
TestCloudDeleteByQuery, TestCloudRecovery, TestCryptoKeys, 
TestLeaderElectionZkExpiry, TestLocalFSCloudBackupRestore, 
TestMiniSolrCloudClusterSSL, TestOnReconnectListenerSupport, 
TestRebalanceLeaders, TestSolrCloudWithDelegationTokens, 
TestStressInPlaceUpdates, BlobRepositoryCloudTest, TestConfigSetProperties, 
TestConfigSets, TestDynamicLoading, V2ApiIntegrationTest, 
CoreAdminCreateDiscoverTest, CoreAdminRequestStatusTest, MetricsHandlerTest, 
PropertiesRequestHandlerTest, SegmentsInfoRequestHandlerTest, 
StatsReloadRaceTest, DistributedFacetExistsSmallTest, 
DistributedFacetPivotSmallTest, SolrJmxReporterTest, SolrShardReporterTest, 
TestBulkSchemaConcurrent, TestManagedSchemaThreadSafety, 
TestUseDocValuesAsStored]
   [junit4] Completed [650/702 (2!)] on J1 in 64.03s, 6 tests, 1 error <<< 
FAILURES!

[...truncated 36441 lines...]

---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to