You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2016/11/21 19:47:49 UTC

[JENKINS-EA] Lucene-Solr-master-Linux (32bit/jdk-9-ea+140) - Build # 18340 - Still Unstable!

Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/18340/
Java: 32bit/jdk-9-ea+140 -client -XX:+UseParallelGC

1 tests failed.
FAILED:  org.apache.solr.handler.component.SpellCheckComponentTest.testThresholdTokenFrequency

Error Message:
Path not found: /spellcheck/suggestions/[1]/suggestion

Stack Trace:
java.lang.RuntimeException: Path not found: /spellcheck/suggestions/[1]/suggestion
	at __randomizedtesting.SeedInfo.seed([8B58D135477A65A:821202E2DB9C9F21]:0)
	at org.apache.solr.SolrTestCaseJ4.assertJQ(SolrTestCaseJ4.java:900)
	at org.apache.solr.SolrTestCaseJ4.assertJQ(SolrTestCaseJ4.java:847)
	at org.apache.solr.handler.component.SpellCheckComponentTest.testThresholdTokenFrequency(SpellCheckComponentTest.java:277)
	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native Method)
	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
	at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(java.base@9-ea/Method.java:535)
	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:367)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:811)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:462)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at java.lang.Thread.run(java.base@9-ea/Thread.java:843)




Build Log:
[...truncated 11579 lines...]
   [junit4] Suite: org.apache.solr.handler.component.SpellCheckComponentTest
   [junit4]   2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.handler.component.SpellCheckComponentTest_8B58D135477A65A-001/init-core-data-001
   [junit4]   2> 1136924 INFO  (SUITE-SpellCheckComponentTest-seed#[8B58D135477A65A]-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> 1136925 INFO  (SUITE-SpellCheckComponentTest-seed#[8B58D135477A65A]-worker) [    ] o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 1136926 INFO  (SUITE-SpellCheckComponentTest-seed#[8B58D135477A65A]-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> 1137016 WARN  (SUITE-SpellCheckComponentTest-seed#[8B58D135477A65A]-worker) [    ] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
   [junit4]   2> 1137016 INFO  (SUITE-SpellCheckComponentTest-seed#[8B58D135477A65A]-worker) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1137028 INFO  (SUITE-SpellCheckComponentTest-seed#[8B58D135477A65A]-worker) [    ] o.a.s.s.IndexSchema [null] Schema name=test
   [junit4]   2> 1137102 WARN  (SUITE-SpellCheckComponentTest-seed#[8B58D135477A65A]-worker) [    ] o.a.s.s.IndexSchema [null] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 1137103 INFO  (SUITE-SpellCheckComponentTest-seed#[8B58D135477A65A]-worker) [    ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1137135 INFO  (coreLoadExecutor-4049-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> 1137214 WARN  (coreLoadExecutor-4049-thread-1) [    ] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
   [junit4]   2> 1137215 INFO  (coreLoadExecutor-4049-thread-1) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1137231 INFO  (coreLoadExecutor-4049-thread-1) [    ] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1137298 WARN  (coreLoadExecutor-4049-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> 1137299 INFO  (coreLoadExecutor-4049-thread-1) [    ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1137322 INFO  (coreLoadExecutor-4049-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
   [junit4]   2> 1137323 INFO  (coreLoadExecutor-4049-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.handler.component.SpellCheckComponentTest_8B58D135477A65A-001/init-core-data-001/]
   [junit4]   2> 1137323 INFO  (coreLoadExecutor-4049-thread-1) [    ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=15, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.702608438448745]
   [junit4]   2> 1137328 INFO  (coreLoadExecutor-4049-thread-1) [    ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1137328 INFO  (coreLoadExecutor-4049-thread-1) [    ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1137328 INFO  (coreLoadExecutor-4049-thread-1) [    ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=27, maxMergeAtOnceExplicit=47, maxMergedSegmentMB=34.5361328125, floorSegmentMB=0.5771484375, forceMergeDeletesPctAllowed=0.694916593013406, segmentsPerTier=39.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.6824311867608911
   [junit4]   2> 1137328 INFO  (coreLoadExecutor-4049-thread-1) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@9f881f[collection1] main]
   [junit4]   2> 1137328 WARN  (coreLoadExecutor-4049-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> 1137329 INFO  (coreLoadExecutor-4049-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1137388 INFO  (coreLoadExecutor-4049-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: default
   [junit4]   2> 1137438 INFO  (coreLoadExecutor-4049-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: default_teststop
   [junit4]   2> 1137438 INFO  (coreLoadExecutor-4049-thread-1) [    ] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=solr.DirectSolrSpellChecker,minQueryLength=3,maxQueryFrequency=100.0,field=teststop}
   [junit4]   2> 1137438 INFO  (coreLoadExecutor-4049-thread-1) [    ] o.a.s.s.DirectSolrSpellChecker init: {name=direct_lowerfilt,classname=solr.DirectSolrSpellChecker,minQueryLength=3,maxQueryFrequency=100.0,field=lowerfilt}
   [junit4]   2> 1137508 INFO  (coreLoadExecutor-4049-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: threshold
   [junit4]   2> 1137508 INFO  (coreLoadExecutor-4049-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> 1137508 INFO  (coreLoadExecutor-4049-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: threshold_direct
   [junit4]   2> 1137554 INFO  (coreLoadExecutor-4049-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: multipleFields
   [junit4]   2> 1137754 INFO  (coreLoadExecutor-4049-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: freq
   [junit4]   2> 1137825 INFO  (coreLoadExecutor-4049-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: fqcn
   [junit4]   2> 1137826 INFO  (coreLoadExecutor-4049-thread-1) [    ] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1137826 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1137827 INFO  (SUITE-SpellCheckComponentTest-seed#[8B58D135477A65A]-worker) [    ] o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 1137827 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default_teststop
   [junit4]   2> 1137829 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[8B58D135477A65A]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testThresholdTokenFrequency
   [junit4]   2> 1137829 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1137829 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct_lowerfilt
   [junit4]   2> 1137829 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1137829 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: threshold
   [junit4]   2> 1137829 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[0]} 0 0
   [junit4]   2> 1137830 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[1]} 0 0
   [junit4]   2> 1137830 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: threshold_direct
   [junit4]   2> 1137830 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
   [junit4]   2> 1137830 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[2]} 0 0
   [junit4]   2> 1137830 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[3]} 0 0
   [junit4]   2> 1137831 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[4]} 0 0
   [junit4]   2> 1137831 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[5]} 0 0
   [junit4]   2> 1137831 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[6]} 0 0
   [junit4]   2> 1137831 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[7]} 0 0
   [junit4]   2> 1137831 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[8]} 0 0
   [junit4]   2> 1137831 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1137831 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[9]} 0 0
   [junit4]   2> 1137832 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[8B58D135477A65A]) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1137832 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[8B58D135477A65A]) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@aed989
   [junit4]   2> 1137833 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1137834 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1137834 WARN  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[8B58D135477A65A]) [    ] o.a.s.c.SolrCore [collection1] PERFORMANCE WARNING: Overlapping onDeckSearchers=2
   [junit4]   2> 1137835 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[8B58D135477A65A]) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1626713[collection1] main]
   [junit4]   2> 1137835 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[8B58D135477A65A]) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1137835 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 1137836 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 1137836 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@9f881f[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1137836 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1137839 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default_teststop
   [junit4]   2> 1137841 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1137841 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct_lowerfilt
   [junit4]   2> 1137841 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1137841 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: threshold
   [junit4]   2> 1137842 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: threshold_direct
   [junit4]   2> 1137842 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
   [junit4]   2> 1137843 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1137844 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1137846 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1137847 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 1137848 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 1137848 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1626713[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):c10)))}
   [junit4]   2> 1137848 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 16
   [junit4]   2> 1137850 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[8B58D135477A65A]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=documenq&qt=spellCheckCompRH&spellcheck.dictionary=threshold&spellcheck=true&spellcheck.count=5&wt=xml&spellcheck.extendedResults=true} hits=0 status=0 QTime=0
   [junit4]   2> 1137850 ERROR (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[8B58D135477A65A]) [    ] o.a.s.SolrTestCaseJ4 query failed JSON validation. error=Path not found: /spellcheck/suggestions/[1]/suggestion
   [junit4]   2>  expected =/spellcheck/suggestions/[1]/suggestion==[{'word':'document','freq':2}]
   [junit4]   2>  response = {
   [junit4]   2>   "responseHeader":{
   [junit4]   2>     "status":0,
   [junit4]   2>     "QTime":0},
   [junit4]   2>   "response":{"numFound":0,"start":0,"docs":[]
   [junit4]   2>   },
   [junit4]   2>   "spellcheck":{
   [junit4]   2>     "suggestions":[],
   [junit4]   2>     "correctlySpelled":false}}
   [junit4]   2> 
   [junit4]   2>  request = q=documenq&qt=spellCheckCompRH&spellcheck.dictionary=threshold&spellcheck=true&spellcheck.count=5&wt=xml&spellcheck.extendedResults=true
   [junit4]   2> 1137850 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[8B58D135477A65A]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testThresholdTokenFrequency
   [junit4]   2> 1137850 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[8B58D135477A65A]) [    ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1137850 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{deleteByQuery=*:*} 0 0
   [junit4]   2> 1137850 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[8B58D135477A65A]) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1137850 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[8B58D135477A65A]) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@aed989
   [junit4]   2> 1137851 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[8B58D135477A65A]) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@17a872d[collection1] main]
   [junit4]   2> 1137851 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[8B58D135477A65A]) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1137851 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
   [junit4]   2> 1137913 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
   [junit4]   2> 1137987 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
   [junit4]   2> 1138066 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
   [junit4]   2> 1138066 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
   [junit4]   2> 1138169 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
   [junit4]   2> 1138287 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
   [junit4]   2> 1138356 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@17a872d[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1138356 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 506
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=SpellCheckComponentTest -Dtests.method=testThresholdTokenFrequency -Dtests.seed=8B58D135477A65A -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=rn -Dtests.timezone=Africa/Bujumbura -Dtests.asserts=true -Dtests.file.encoding=UTF-8
   [junit4] ERROR   0.53s J1 | SpellCheckComponentTest.testThresholdTokenFrequency <<<
   [junit4]    > Throwable #1: java.lang.RuntimeException: Path not found: /spellcheck/suggestions/[1]/suggestion
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([8B58D135477A65A:821202E2DB9C9F21]:0)
   [junit4]    > 	at org.apache.solr.SolrTestCaseJ4.assertJQ(SolrTestCaseJ4.java:900)
   [junit4]    > 	at org.apache.solr.SolrTestCaseJ4.assertJQ(SolrTestCaseJ4.java:847)
   [junit4]    > 	at org.apache.solr.handler.component.SpellCheckComponentTest.testThresholdTokenFrequency(SpellCheckComponentTest.java:277)
   [junit4]    > 	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native Method)
   [junit4]    > 	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
   [junit4]    > 	at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
   [junit4]    > 	at java.lang.Thread.run(java.base@9-ea/Thread.java:843)
   [junit4]   2> 1138361 INFO  (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[8B58D135477A65A]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testRelativeIndexDirLocation
   [junit4]   2> 1138361 INFO  (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[0]} 0 0
   [junit4]   2> 1138362 INFO  (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[1]} 0 0
   [junit4]   2> 1138362 INFO  (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[2]} 0 0
   [junit4]   2> 1138362 INFO  (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[3]} 0 0
   [junit4]   2> 1138362 INFO  (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[4]} 0 0
   [junit4]   2> 1138363 INFO  (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[5]} 0 0
   [junit4]   2> 1138363 INFO  (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[6]} 0 0
   [junit4]   2> 1138363 INFO  (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[7]} 0 0
   [junit4]   2> 1138363 INFO  (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[8]} 0 0
   [junit4]   2> 1138363 INFO  (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[9]} 0 0
   [junit4]   2> 1138364 INFO  (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[8B58D135477A65A]) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1138364 INFO  (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[8B58D135477A65A]) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@aed989
   [junit4]   2> 1138368 INFO  (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[8B58D135477A65A]) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@640009[collection1] main]
   [junit4]   2> 1138368 INFO  (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[8B58D135477A65A]) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1138368 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
   [junit4]   2> 1138599 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
   [junit4]   2> 1138694 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
   [junit4]   2> 1138825 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
   [junit4]   2> 1138825 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
   [junit4]   2> 1138958 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
   [junit4]   2> 1139077 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
   [junit4]   2> 1139239 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@640009[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(7.0.0):c10)))}
   [junit4]   2> 1139239 INFO  (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 875
   [junit4]   2> 1139240 INFO  (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[8B58D135477A65A]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testRelativeIndexDirLocation
   [junit4]   2> 1139240 INFO  (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[8B58D135477A65A]) [    ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1139241 INFO  (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{deleteByQuery=*:*} 0 0
   [junit4]   2> 1139241 INFO  (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[8B58D135477A65A]) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1139241 INFO  (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[8B58D135477A65A]) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@aed989
   [junit4]   2> 1139241 INFO  (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[8B58D135477A65A]) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@11bd777[collection1] main]
   [junit4]   2> 1139241 INFO  (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[8B58D135477A65A]) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1139241 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
   [junit4]   2> 1139315 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
   [junit4]   2> 1139389 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
   [junit4]   2> 1139464 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
   [junit4]   2> 1139464 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
   [junit4]   2> 1139540 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
   [junit4]   2> 1139592 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
   [junit4]   2> 1139642 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@11bd777[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1139642 INFO  (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 401
   [junit4]   2> 1139644 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[8B58D135477A65A]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testRebuildOnCommit
   [junit4]   2> 1139644 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[0]} 0 0
   [junit4]   2> 1139644 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[1]} 0 0
   [junit4]   2> 1139644 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[2]} 0 0
   [junit4]   2> 1139645 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[3]} 0 0
   [junit4]   2> 1139645 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[4]} 0 0
   [junit4]   2> 1139645 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[5]} 0 0
   [junit4]   2> 1139645 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[6]} 0 0
   [junit4]   2> 1139645 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[7]} 0 0
   [junit4]   2> 1139645 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[8]} 0 0
   [junit4]   2> 1139646 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[9]} 0 0
   [junit4]   2> 1139646 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[8B58D135477A65A]) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1139646 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[8B58D135477A65A]) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@aed989
   [junit4]   2> 1139649 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[8B58D135477A65A]) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1c227a[collection1] main]
   [junit4]   2> 1139649 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[8B58D135477A65A]) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1139649 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
   [junit4]   2> 1139805 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
   [junit4]   2> 1139871 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
   [junit4]   2> 1140018 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
   [junit4]   2> 1140018 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
   [junit4]   2> 1140203 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
   [junit4]   2> 1140336 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
   [junit4]   2> 1140469 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1c227a[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(7.0.0):c10)))}
   [junit4]   2> 1140469 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 823
   [junit4]   2> 1140470 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[8B58D135477A65A]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=lowerfilt:lucenejavt&qt=spellCheckCompRH&spellcheck=true&wt=xml} hits=0 status=0 QTime=0
   [junit4]   2> 1140471 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[11231]} 0 0
   [junit4]   2> 1140471 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[8B58D135477A65A]) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1140471 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[8B58D135477A65A]) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@aed989
   [junit4]   2> 1140474 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[8B58D135477A65A]) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1713581[collection1] main]
   [junit4]   2> 1140474 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[8B58D135477A65A]) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1140474 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
   [junit4]   2> 1140622 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
   [junit4]   2> 1140666 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
   [junit4]   2> 1140902 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
   [junit4]   2> 1140902 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
   [junit4]   2> 1141054 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
   [junit4]   2> 1141188 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
   [junit4]   2> 1141327 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1713581[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(7.0.0):c10) Uninverting(_3(7.0.0):c1)))}
   [junit4]   2> 1141327 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 855
   [junit4]   2> 1141328 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[8B58D135477A65A]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=lowerfilt:lucenejavt&qt=spellCheckCompRH&spellcheck=true&wt=xml} hits=0 status=0 QTime=858
   [junit4]   2> 1141328 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[8B58D135477A65A]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testRebuildOnCommit
   [junit4]   2> 1141328 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[8B58D135477A65A]) [    ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1141329 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{deleteByQuery=*:*} 0 0
   [junit4]   2> 1141329 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[8B58D135477A65A]) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1141329 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[8B58D135477A65A]) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@aed989
   [junit4]   2> 1141329 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[8B58D135477A65A]) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@f01635[collection1] main]
   [junit4]   2> 1141329 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[8B58D135477A65A]) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1141329 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
   [junit4]   2> 1141396 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
   [junit4]   2> 1141486 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
   [junit4]   2> 1141539 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
   [junit4]   2> 1141539 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
   [junit4]   2> 1141606 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
   [junit4]   2> 1141705 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
   [junit4]   2> 1141799 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@f01635[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1141799 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 470
   [junit4]   2> 1141801 INFO  (TEST-SpellCheckComponentTest.testCollate-seed#[8B58D135477A65A]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testCollate
   [junit4]   2> 1141801 INFO  (TEST-SpellCheckComponentTest.testCollate-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[0]} 0 0
   [junit4]   2> 1141802 INFO  (TEST-SpellCheckComponentTest.testCollate-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[1]} 0 0
   [junit4]   2> 1141802 INFO  (TEST-SpellCheckComponentTest.testCollate-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[2]} 0 0
   [junit4]   2> 1141802 INFO  (TEST-SpellCheckComponentTest.testCollate-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[3]} 0 0
   [junit4]   2> 1141802 INFO  (TEST-SpellCheckComponentTest.testCollate-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[4]} 0 0
   [junit4]   2> 1141802 INFO  (TEST-SpellCheckComponentTest.testCollate-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[5]} 0 0
   [junit4]   2> 1141802 INFO  (TEST-SpellCheckComponentTest.testCollate-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[6]} 0 0
   [junit4]   2> 1141803 INFO  (TEST-SpellCheckComponentTest.testCollate-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[7]} 0 0
   [junit4]   2> 1141803 INFO  (TEST-SpellCheckComponentTest.testCollate-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[8]} 0 0
   [junit4]   2> 1141803 INFO  (TEST-SpellCheckComponentTest.testCollate-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[9]} 0 0
   [junit4]   2> 1141803 INFO  (TEST-SpellCheckComponentTest.testCollate-seed#[8B58D135477A65A]) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1141803 INFO  (TEST-SpellCheckComponentTest.testCollate-seed#[8B58D135477A65A]) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@aed989
   [junit4]   2> 1141806 INFO  (TEST-SpellCheckComponentTest.testCollate-seed#[8B58D135477A65A]) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@18755e3[collection1] main]
   [junit4]   2> 1141806 INFO  (TEST-SpellCheckComponentTest.testCollate-seed#[8B58D135477A65A]) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1141806 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
   [junit4]   2> 1142077 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
   [junit4]   2> 1142145 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
   [junit4]   2> 1142273 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
   [junit4]   2> 1142274 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
   [junit4]   2> 1142425 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
   [junit4]   2> 1142601 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
   [junit4]   2> 1142763 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@18755e3[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(7.0.0):c10)))}
   [junit4]   2> 1142763 INFO  (TEST-SpellCheckComponentTest.testCollate-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 959
   [junit4]   2> 1142931 INFO  (TEST-SpellCheckComponentTest.testCollate-seed#[8B58D135477A65A]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=documemt&qt=spellCheckCompRH&json.nl=map&spellcheck=true&wt=xml&spellcheck.build=true&spellcheck.collate=true} hits=0 status=0 QTime=168
   [junit4]   2> 1142932 INFO  (TEST-SpellCheckComponentTest.testCollate-seed#[8B58D135477A65A]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=documemt+lowerfilt:broen^4&qt=spellCheckCompRH&json.nl=map&spellcheck=true&wt=xml&spellcheck.collate=true} hits=0 status=0 QTime=0
   [junit4]   2> 1142933 INFO  (TEST-SpellCheckComponentTest.testCollate-seed#[8B58D135477A65A]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=documemtsss+broens&qt=spellCheckCompRH&json.nl=map&spellcheck=true&wt=xml&spellcheck.collate=true} hits=0 status=0 QTime=0
   [junit4]   2> 1142934 INFO  (TEST-SpellCheckComponentTest.testCollate-seed#[8B58D135477A65A]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=pixma&qt=spellCheckCompRH&json.nl=map&spellcheck=true&wt=xml&spellcheck.collate=true} hits=0 status=0 QTime=0
   [junit4]   2> 1142934 INFO  (TEST-SpellCheckComponentTest.testCollate-seed#[8B58D135477A65A]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testCollate
   [junit4]   2> 1142934 INFO  (TEST-SpellCheckComponentTest.testCollate-seed#[8B58D135477A65A]) [    ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1142934 INFO  (TEST-SpellCheckComponentTest.testCollate-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{deleteByQuery=*:*} 0 0
   [junit4]   2> 1142934 INFO  (TEST-SpellCheckComponentTest.testCollate-seed#[8B58D135477A65A]) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1142935 INFO  (TEST-SpellCheckComponentTest.testCollate-seed#[8B58D135477A65A]) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@aed989
   [junit4]   2> 1142935 INFO  (TEST-SpellCheckComponentTest.testCollate-seed#[8B58D135477A65A]) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@12061bb[collection1] main]
   [junit4]   2> 1142935 INFO  (TEST-SpellCheckComponentTest.testCollate-seed#[8B58D135477A65A]) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1142935 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
   [junit4]   2> 1142995 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
   [junit4]   2> 1143061 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
   [junit4]   2> 1143126 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
   [junit4]   2> 1143126 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
   [junit4]   2> 1143188 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
   [junit4]   2> 1143248 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
   [junit4]   2> 1143300 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@12061bb[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1143300 INFO  (TEST-SpellCheckComponentTest.testCollate-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 365
   [junit4]   2> 1143302 INFO  (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[8B58D135477A65A]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testExtendedResultsCount
   [junit4]   2> 1143302 INFO  (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[0]} 0 0
   [junit4]   2> 1143302 INFO  (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[1]} 0 0
   [junit4]   2> 1143302 INFO  (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[2]} 0 0
   [junit4]   2> 1143303 INFO  (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[3]} 0 0
   [junit4]   2> 1143303 INFO  (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[4]} 0 0
   [junit4]   2> 1143303 INFO  (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[5]} 0 0
   [junit4]   2> 1143303 INFO  (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[6]} 0 0
   [junit4]   2> 1143303 INFO  (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[7]} 0 0
   [junit4]   2> 1143303 INFO  (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[8]} 0 0
   [junit4]   2> 1143304 INFO  (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[9]} 0 0
   [junit4]   2> 1143304 INFO  (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[8B58D135477A65A]) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1143304 INFO  (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[8B58D135477A65A]) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@aed989
   [junit4]   2> 1143306 INFO  (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[8B58D135477A65A]) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@430fc8[collection1] main]
   [junit4]   2> 1143307 INFO  (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[8B58D135477A65A]) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1143307 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
   [junit4]   2> 1143490 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
   [junit4]   2> 1143541 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
   [junit4]   2> 1143685 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
   [junit4]   2> 1143685 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
   [junit4]   2> 1143894 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
   [junit4]   2> 1144065 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
   [junit4]   2> 1144198 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@430fc8[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_5(7.0.0):c10)))}
   [junit4]   2> 1144198 INFO  (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 894
   [junit4]   2> 1144382 INFO  (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[8B58D135477A65A]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=bluo&qt=spellCheckCompRH&spellcheck=true&spellcheck.count=5&wt=xml&spellcheck.build=true&spellcheck.extendedResults=false} hits=0 status=0 QTime=183
   [junit4]   2> 1144383 INFO  (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[8B58D135477A65A]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=bluo&qt=spellCheckCompRH&spellcheck=true&spellcheck.count=3&wt=xml&spellcheck.extendedResults=true} hits=0 status=0 QTime=0
   [junit4]   2> 1144383 INFO  (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[8B58D135477A65A]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testExtendedResultsCount
   [junit4]   2> 1144383 INFO  (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[8B58D135477A65A]) [    ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1144383 INFO  (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{deleteByQuery=*:*} 0 0
   [junit4]   2> 1144383 INFO  (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[8B58D135477A65A]) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1144383 INFO  (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[8B58D135477A65A]) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@aed989
   [junit4]   2> 1144383 INFO  (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[8B58D135477A65A]) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1074fcb[collection1] main]
   [junit4]   2> 1144384 INFO  (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[8B58D135477A65A]) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1144384 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
   [junit4]   2> 1144460 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
   [junit4]   2> 1144529 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
   [junit4]   2> 1144614 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
   [junit4]   2> 1144614 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
   [junit4]   2> 1144699 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
   [junit4]   2> 1144756 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
   [junit4]   2> 1144824 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1074fcb[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1144824 INFO  (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 440
   [junit4]   2> 1144825 INFO  (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[8B58D135477A65A]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testReloadOnStart
   [junit4]   2> 1144826 INFO  (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[0]} 0 0
   [junit4]   2> 1144826 INFO  (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[1]} 0 0
   [junit4]   2> 1144826 INFO  (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[2]} 0 0
   [junit4]   2> 1144826 INFO  (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[3]} 0 0
   [junit4]   2> 1144826 INFO  (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[4]} 0 0
   [junit4]   2> 1144827 INFO  (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[5]} 0 0
   [junit4]   2> 1144827 INFO  (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[6]} 0 0
   [junit4]   2> 1144827 INFO  (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[7]} 0 0
   [junit4]   2> 1144827 INFO  (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[8]} 0 0
   [junit4]   2> 1144827 INFO  (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[9]} 0 0
   [junit4]   2> 1144827 INFO  (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[8B58D135477A65A]) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1144827 INFO  (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[8B58D135477A65A]) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@aed989
   [junit4]   2> 1144830 INFO  (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[8B58D135477A65A]) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@112fd04[collection1] main]
   [junit4]   2> 1144830 INFO  (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[8B58D135477A65A]) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1144830 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
   [junit4]   2> 1145049 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
   [junit4]   2> 1145121 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
   [junit4]   2> 1145272 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
   [junit4]   2> 1145272 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
   [junit4]   2> 1145428 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
   [junit4]   2> 1145574 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
   [junit4]   2> 1145693 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@112fd04[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_6(7.0.0):c10)))}
   [junit4]   2> 1145693 INFO  (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 865
   [junit4]   2> 1145693 INFO  (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[0]} 0 0
   [junit4]   2> 1145694 INFO  (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[8B58D135477A65A]) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1145694 INFO  (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[8B58D135477A65A]) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@aed989
   [junit4]   2> 1145696 INFO  (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[8B58D135477A65A]) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@f98053[collection1] main]
   [junit4]   2> 1145696 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
   [junit4]   2> 1145696 INFO  (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[8B58D135477A65A]) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1145859 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
   [junit4]   2> 1145933 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
   [junit4]   2> 1146080 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
   [junit4]   2> 1146080 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
   [junit4]   2> 1146250 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
   [junit4]   2> 1146398 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
   [junit4]   2> 1146594 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@f98053[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_6(7.0.0):c10/1:delGen=1) Uninverting(_7(7.0.0):c1)))}
   [junit4]   2> 1146594 INFO  (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 900
   [junit4]   2> 1146780 INFO  (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[8B58D135477A65A]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=*:*&spellcheck.q=ttle&qt=spellCheckCompRH&spellcheck.dictionary=default&spellcheck=true&wt=xml&spellcheck.build=true} hits=10 status=0 QTime=185
   [junit4]   2> 1146781 INFO  (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[8B58D135477A65A]) [    ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1146788 INFO  (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[8B58D135477A65A]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testReloadOnStart
   [junit4]   2> 1146788 INFO  (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[8B58D135477A65A]) [    ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1146788 INFO  (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{deleteByQuery=*:*} 0 0
   [junit4]   2> 1146789 INFO  (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[8B58D135477A65A]) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1146789 INFO  (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[8B58D135477A65A]) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@aed989
   [junit4]   2> 1146789 INFO  (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[8B58D135477A65A]) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@19d40de[collection1] main]
   [junit4]   2> 1146789 INFO  (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[8B58D135477A65A]) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1146789 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
   [junit4]   2> 1146855 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
   [junit4]   2> 1146903 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
   [junit4]   2> 1146949 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
   [junit4]   2> 1146949 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
   [junit4]   2> 1147006 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
   [junit4]   2> 1147193 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
   [junit4]   2> 1147243 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@19d40de[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1147243 INFO  (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 454
   [junit4]   2> 1147245 INFO  (TEST-SpellCheckComponentTest.test-seed#[8B58D135477A65A]) [    ] o.a.s.SolrTestCaseJ4 ###Starting test
   [junit4]   2> 1147246 INFO  (TEST-SpellCheckComponentTest.test-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[0]} 0 0
   [junit4]   2> 1147246 INFO  (TEST-SpellCheckComponentTest.test-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[1]} 0 0
   [junit4]   2> 1147246 INFO  (TEST-SpellCheckComponentTest.test-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[2]} 0 0
   [junit4]   2> 1147247 INFO  (TEST-SpellCheckComponentTest.test-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[3]} 0 0
   [junit4]   2> 1147247 INFO  (TEST-SpellCheckComponentTest.test-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[4]} 0 0
   [junit4]   2> 1147247 INFO  (TEST-SpellCheckComponentTest.test-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[5]} 0 0
   [junit4]   2> 1147247 INFO  (TEST-SpellCheckComponentTest.test-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[6]} 0 0
   [junit4]   2> 1147247 INFO  (TEST-SpellCheckComponentTest.test-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[7]} 0 0
   [junit4]   2> 1147247 INFO  (TEST-SpellCheckComponentTest.test-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[8]} 0 0
   [junit4]   2> 1147248 INFO  (TEST-SpellCheckComponentTest.test-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[9]} 0 0
   [junit4]   2> 1147248 INFO  (TEST-SpellCheckComponentTest.test-seed#[8B58D135477A65A]) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1147248 INFO  (TEST-SpellCheckComponentTest.test-seed#[8B58D135477A65A]) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@aed989
   [junit4]   2> 1147250 INFO  (TEST-SpellCheckComponentTest.test-seed#[8B58D135477A65A]) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1c4e1a6[collection1] main]
   [junit4]   2> 1147250 INFO  (TEST-SpellCheckComponentTest.test-seed#[8B58D135477A65A]) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1147251 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
   [junit4]   2> 1147385 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
   [junit4]   2> 1147444 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
   [junit4]   2> 1147583 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
   [junit4]   2> 1147583 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
   [junit4]   2> 1147720 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
   [junit4]   2> 1147876 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
   [junit4]   2> 1148000 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1c4e1a6[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_8(7.0.0):c10)))}
   [junit4]   2> 1148000 INFO  (TEST-SpellCheckComponentTest.test-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 752
   [junit4]   2> 1148002 INFO  (TEST-SpellCheckComponentTest.test-seed#[8B58D135477A65A]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=documemt&qt=spellCheckCompRH&spellcheck=true&wt=xml} hits=0 status=0 QTime=1
   [junit4]   2> 1148002 INFO  (TEST-SpellCheckComponentTest.test-seed#[8B58D135477A65A]) [    ] o.a.s.SolrTestCaseJ4 ###Ending test
   [junit4]   2> 1148002 INFO  (TEST-SpellCheckComponentTest.test-seed#[8B58D135477A65A]) [    ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1148002 INFO  (TEST-SpellCheckComponentTest.test-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{deleteByQuery=*:*} 0 0
   [junit4]   2> 1148002 INFO  (TEST-SpellCheckComponentTest.test-seed#[8B58D135477A65A]) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1148002 INFO  (TEST-SpellCheckComponentTest.test-seed#[8B58D135477A65A]) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@aed989
   [junit4]   2> 1148002 INFO  (TEST-SpellCheckComponentTest.test-seed#[8B58D135477A65A]) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1e6f296[collection1] main]
   [junit4]   2> 1148002 INFO  (TEST-SpellCheckComponentTest.test-seed#[8B58D135477A65A]) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1148002 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
   [junit4]   2> 1148088 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
   [junit4]   2> 1148149 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
   [junit4]   2> 1148208 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
   [junit4]   2> 1148208 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
   [junit4]   2> 1148266 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
   [junit4]   2> 1148344 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
   [junit4]   2> 1148428 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1e6f296[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1148428 INFO  (TEST-SpellCheckComponentTest.test-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 426
   [junit4]   2> 1148430 INFO  (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[8B58D135477A65A]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testMaximumResultsForSuggest
   [junit4]   2> 1148430 INFO  (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[0]} 0 0
   [junit4]   2> 1148431 INFO  (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[1]} 0 0
   [junit4]   2> 1148431 INFO  (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[2]} 0 0
   [junit4]   2> 1148431 INFO  (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[3]} 0 0
   [junit4]   2> 1148431 INFO  (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[4]} 0 0
   [junit4]   2> 1148431 INFO  (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[5]} 0 0
   [junit4]   2> 1148431 INFO  (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[6]} 0 0
   [junit4]   2> 1148432 INFO  (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[7]} 0 0
   [junit4]   2> 1148432 INFO  (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[8]} 0 0
   [junit4]   2> 1148432 INFO  (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[9]} 0 0
   [junit4]   2> 1148436 INFO  (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[8B58D135477A65A]) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1148436 INFO  (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[8B58D135477A65A]) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@aed989
   [junit4]   2> 1148439 INFO  (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[8B58D135477A65A]) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@107d9dd[collection1] main]
   [junit4]   2> 1148439 INFO  (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[8B58D135477A65A]) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1148439 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
   [junit4]   2> 1148589 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
   [junit4]   2> 1148665 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
   [junit4]   2> 1148888 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
   [junit4]   2> 1148888 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
   [junit4]   2> 1149070 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
   [junit4]   2> 1149250 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
   [junit4]   2> 1149359 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@107d9dd[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_9(7.0.0):c10)))}
   [junit4]   2> 1149359 INFO  (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 922
   [junit4]   2> 1149575 INFO  (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[8B58D135477A65A]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=lowerfilt:(this+OR+brwn)&spellcheck.maxResultsForSuggest=7&qt=spellCheckCompRH&spellcheck=true&spellcheck.count=5&wt=xml&spellcheck.build=true&spellcheck.extendedResults=false} hits=7 status=0 QTime=215
   [junit4]   2> 1149770 INFO  (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[8B58D135477A65A]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=lowerfilt:(this+OR+brwn)&spellcheck.maxResultsForSuggest=6&qt=spellCheckCompRH&spellcheck=true&spellcheck.count=5&wt=xml&spellcheck.build=true&spellcheck.extendedResults=false} hits=7 status=0 QTime=194
   [junit4]   2> 1149770 ERROR (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[8B58D135477A65A]) [    ] o.a.s.SolrTestCaseJ4 query failed JSON validation. error=Path not found: /spellcheck/suggestions/[1]/numFound
   [junit4]   2>  expected =/spellcheck/suggestions/[1]/numFound==1
   [junit4]   2>  response = {
   [junit4]   2>   "responseHeader":{
   [junit4]   2>     "status":0,
   [junit4]   2>     "QTime":194},
   [junit4]   2>   "command":"build",
   [junit4]   2>   "response":{"numFound":7,"start":0,"docs":[
   [junit4]   2>       {
   [junit4]   2>         "id":4,
   [junit4]   2>         "range_facet_l":[4],
   [junit4]   2>         "range_facet_l_dv":[4],
   [junit4]   2>         "range_facet_i_dv":[4],
   [junit4]   2>         "lowerfilt":["this blue"],
   [junit4]   2>         "lowerfilt1and2":["this blue"],
   [junit4]   2>         "multiDefault":["muLti-Default"],
   [junit4]   2>         "intDefault":42,
   [junit4]   2>         "timestamp":"2016-11-21T19:21:05.391Z"},
   [junit4]   2>       {
   [junit4]   2>         "id":5,
   [junit4]   2>         "range_facet_l":[5],
   [junit4]   2>         "range_facet_l_dv":[5],
   [junit4]   2>         "range_facet_i_dv":[5],
   [junit4]   2>         "lowerfilt":["this blud"],
   [junit4]   2>         "lowerfilt1and2":["this blud"],
   [junit4]   2>         "multiDefault":["muLti-Default"],
   [junit4]   2>         "intDefault":42,
   [junit4]   2>         "timestamp":"2016-11-21T19:21:05.391Z"},
   [junit4]   2>       {
   [junit4]   2>         "id":6,
   [junit4]   2>         "range_facet_l":[6],
   [junit4]   2>         "range_facet_l_dv":[6],
   [junit4]   2>         "range_facet_i_dv":[6],
   [junit4]   2>         "lowerfilt":["this boue"],
   [junit4]   2>         "lowerfilt1and2":["this boue"],
   [junit4]   2>         "multiDefault":["muLti-Default"],
   [junit4]   2>         "intDefault":42,
   [junit4]   2>         "timestamp":"2016-11-21T19:21:05.391Z"},
   [junit4]   2>       {
   [junit4]   2>         "id":7,
   [junit4]   2>         "range_facet_l":[7],
   [junit4]   2>         "range_facet_l_dv":[7],
   [junit4]   2>         "range_facet_i_dv":[7],
   [junit4]   2>         "lowerfilt":["this glue"],
   [junit4]   2>         "lowerfilt1and2":["this glue"],
   [junit4]   2>         "multiDefault":["muLti-Default"],
   [junit4]   2>         "intDefault":42,
   [junit4]   2>         "timestamp":"2016-11-21T19:21:05.392Z"},
   [junit4]   2>       {
   [junit4]   2>         "id":8,
   [junit4]   2>         "range_facet_l":[8],
   [junit4]   2>         "range_facet_l_dv":[8],
   [junit4]   2>         "range_facet_i_dv":[8],
   [junit4]   2>         "lowerfilt":["this blee"],
   [junit4]   2>         "lowerfilt1and2":["this blee"],
   [junit4]   2>         "multiDefault":["muLti-Default"],
   [junit4]   2>         "intDefault":42,
   [junit4]   2>         "timestamp":"2016-11-21T19:21:05.392Z"},
   [junit4]   2>       {
   [junit4]   2>         "id":0,
   [junit4]   2>         "range_facet_l":[0],
   [junit4]   2>         "range_facet_l_dv":[0],
   [junit4]   2>         "range_facet_i_dv":[0],
   [junit4]   2>         "lowerfilt":["This is a title"],
   [junit4]   2>         "lowerfilt1and2":["This is a title"],
   [junit4]   2>         "multiDefault":["muLti-Default"],
   [junit4]   2>         "intDefault":42,
   [junit4]   2>         "timestamp":"2016-11-21T19:21:05.390Z"},
   [junit4]   2>       {
   [junit4]   2>         "id":2,
   [junit4]   2>         "range_facet_l":[2],
   [junit4]   2>         "range_facet_l_dv":[2],
   [junit4]   2>         "range_facet_i_dv":[2],
   [junit4]   2>         "lowerfilt":["This is a document"],
   [junit4]   2>         "lowerfilt1and2":["This is a document"],
   [junit4]   2>         "multiDefault":["muLti-Default"],
   [junit4]   2>         "intDefault":42,
   [junit4]   2>         "timestamp":"2016-11-21T19:21:05.391Z"}]
   [junit4]   2>   },
   [junit4]   2>   "spellcheck":{
   [junit4]   2>     "suggestions":[]}}
   [junit4]   2> 
   [junit4]   2>  request = q=lowerfilt:(this+OR+brwn)&spellcheck.maxResultsForSuggest=6&qt=spellCheckCompRH&spellcheck=true&spellcheck.count=5&wt=xml&spellcheck.build=true&spellcheck.extendedResults=false
   [junit4]   2> 1149966 INFO  (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[8B58D135477A65A]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=lowerfilt:(this+OR+brwn)&spellcheck.maxResultsForSuggest=.90&qt=spellCheckCompRH&spellcheck=true&fq=id:[0+TO+9]&fq=lowerfilt:th*&spellcheck.count=5&wt=xml&spellcheck.build=true&spellcheck.extendedResults=false} hits=7 status=0 QTime=194
   [junit4]   2> 1150135 INFO  (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[8B58D135477A65A]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=lowerfilt:(this+OR+brwn)&spellcheck.maxResultsForSuggest=.80&qt=spellCheckCompRH&spellcheck=true&fq=id:[0+TO+9]&fq=lowerfilt:th*&spellcheck.count=5&wt=xml&spellcheck.build=true&spellcheck.extendedResults=false} hits=7 status=0 QTime=168
   [junit4]   2> 1150135 ERROR (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[8B58D135477A65A]) [    ] o.a.s.SolrTestCaseJ4 query failed JSON validation. error=Path not found: /spellcheck/suggestions/[1]/numFound
   [junit4]   2>  expected =/spellcheck/suggestions/[1]/numFound==1
   [junit4]   2>  response = {
   [junit4]   2>   "responseHeader":{
   [junit4]   2>     "status":0,
   [junit4]   2>     "QTime":168},
   [junit4]   2>   "command":"build",
   [junit4]   2>   "response":{"numFound":7,"start":0,"docs":[
   [junit4]   2>       {
   [junit4]   2>         "id":4,
   [junit4]   2>         "range_facet_l":[4],
   [junit4]   2>         "range_facet_l_dv":[4],
   [junit4]   2>         "range_facet_i_dv":[4],
   [junit4]   2>         "lowerfilt":["this blue"],
   [junit4]   2>         "lowerfilt1and2":["this blue"],
   [junit4]   2>         "multiDefault":["muLti-Default"],
   [junit4]   2>         "intDefault":42,
   [junit4]   2>         "timestamp":"2016-11-21T19:21:05.391Z"},
   [junit4]   2>       {
   [junit4]   2>         "id":5,
   [junit4]   2>         "range_facet_l":[5],
   [junit4]   2>        

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

utor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
   [junit4]   2> 1154440 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
   [junit4]   2> 1154635 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
   [junit4]   2> 1154820 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@167b7ed[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_c(7.0.0):c10)))}
   [junit4]   2> 1154820 INFO  (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 974
   [junit4]   2> 1154820 INFO  (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[8B58D135477A65A]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=lowerfilt:lazy+lowerfilt:brown&qt=spellCheckCompRH&json.nl=map&spellcheck=true&wt=xml&spellcheck.extendedResults=true} hits=1 status=0 QTime=0
   [junit4]   2> 1154821 INFO  (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[8B58D135477A65A]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=lowerfilt:lazy+lowerfilt:brown&qt=spellCheckCompRH&spellcheck.dictionary=direct_lowerfilt&json.nl=map&spellcheck=true&wt=xml&spellcheck.extendedResults=true} hits=1 status=0 QTime=0
   [junit4]   2> 1154827 INFO  (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[8B58D135477A65A]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=lakkle&qt=spellCheckCompRH&spellcheck.dictionary=direct_lowerfilt&json.nl=map&spellcheck=true&wt=xml&spellcheck.extendedResults=true} hits=0 status=0 QTime=5
   [junit4]   2> 1154827 INFO  (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[8B58D135477A65A]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testCorrectSpelling
   [junit4]   2> 1154827 INFO  (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[8B58D135477A65A]) [    ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1154827 INFO  (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{deleteByQuery=*:*} 0 0
   [junit4]   2> 1154827 INFO  (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[8B58D135477A65A]) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1154827 INFO  (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[8B58D135477A65A]) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@aed989
   [junit4]   2> 1154828 INFO  (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[8B58D135477A65A]) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@dd18c[collection1] main]
   [junit4]   2> 1154828 INFO  (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[8B58D135477A65A]) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1154828 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
   [junit4]   2> 1154903 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
   [junit4]   2> 1154965 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
   [junit4]   2> 1155043 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
   [junit4]   2> 1155043 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
   [junit4]   2> 1155108 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
   [junit4]   2> 1155182 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
   [junit4]   2> 1155257 INFO  (searcherExecutor-4050-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@dd18c[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1155257 INFO  (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[8B58D135477A65A]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 429
   [junit4]   2> 1155258 INFO  (SUITE-SpellCheckComponentTest-seed#[8B58D135477A65A]-worker) [    ] o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> 1155258 INFO  (SUITE-SpellCheckComponentTest-seed#[8B58D135477A65A]-worker) [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=13099583
   [junit4]   2> 1155258 INFO  (coreCloseExecutor-4054-thread-1) [    ] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@e13266
   [junit4]   2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.handler.component.SpellCheckComponentTest_8B58D135477A65A-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): {start1=PostingsFormat(name=Memory), range_facet_l_dv=Lucene50(blocksize=128), multiDefault=FSTOrd50, intDefault=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), range_facet_l=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), lowerfilt1and2=FSTOrd50, end4=PostingsFormat(name=Memory), end3=FSTOrd50, end2=Lucene50(blocksize=128), end1=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), lowerfilt=FSTOrd50, gram1=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), id=Lucene50(blocksize=128), range_facet_i_dv=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), gram2=Lucene50(blocksize=128), gram3=FSTOrd50, start3=Lucene50(blocksize=128), gram4=PostingsFormat(name=Memory), start2=FSTOrd50, word=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), timestamp=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), start4=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128)))}, docValues:{range_facet_l_dv=DocValuesFormat(name=Lucene70), range_facet_i_dv=DocValuesFormat(name=Memory), timestamp=DocValuesFormat(name=Memory)}, maxPointsInLeafNode=816, maxMBSortInHeap=5.951077510252567, sim=RandomSimilarity(queryNorm=false): {}, locale=rn, timezone=Africa/Bujumbura
   [junit4]   2> NOTE: Linux 4.4.0-47-generic i386/Oracle Corporation 9-ea (32-bit)/cpus=12,threads=1,free=42144160,total=370409472
   [junit4]   2> NOTE: All tests run in this JVM: [TestFastLRUCache, TestAddFieldRealTimeGet, FileUtilsTest, UtilsToolTest, TestSchemaManager, TestFiltering, TestScoreJoinQPScore, TestSolrQueryParserDefaultOperatorResource, SchemaVersionSpecificBehaviorTest, TestCloudPseudoReturnFields, DirectSolrConnectionTest, TestElisionMultitermQuery, TestManagedStopFilterFactory, AnalyticsMergeStrategyTest, SolrIndexSplitterTest, DirectoryFactoryTest, SuggestComponentTest, TestNRTOpen, TestOnReconnectListenerSupport, BlockDirectoryTest, TestReRankQParserPlugin, CollectionReloadTest, OpenExchangeRatesOrgProviderTest, SpatialFilterTest, LeaderFailoverAfterPartitionTest, IndexBasedSpellCheckerTest, ShufflingReplicaListTransformerTest, ClassificationUpdateProcessorFactoryTest, TermsComponentTest, DistributedFacetPivotLongTailTest, CollectionsAPIDistributedZkTest, ZkStateReaderTest, DistributedFacetPivotWhiteBoxTest, TestSimpleTrackingShardHandler, IgnoreCommitOptimizeUpdateProcessorFactoryTest, RestartWhileUpdatingTest, TestAnalyzeInfixSuggestions, CdcrReplicationHandlerTest, TestMiniSolrCloudCluster, MoreLikeThisHandlerTest, TestBM25SimilarityFactory, OverseerModifyCollectionTest, HttpSolrCallGetCoreTest, ChaosMonkeyNothingIsSafeTest, TestSurroundQueryParser, TestPKIAuthenticationPlugin, TestReplicationHandlerBackup, TestSearcherReuse, TestJettySolrRunner, TestDistributedGrouping, TestXIncludeConfig, TestStressRecovery, TestSystemIdResolver, SampleTest, HdfsBasicDistributedZkTest, TestStressVersions, JSONWriterTest, TestLegacyFieldCache, BJQParserTest, TestRequestStatusCollectionAPI, TestSubQueryTransformer, DOMUtilTest, TestConfigSetsAPIZkFailure, TestCharFilters, SolrCloudExampleTest, BlockJoinFacetSimpleTest, TestDistribDocBasedVersion, SortByFunctionTest, TestExactStatsCache, QueryParsingTest, SolrInfoMBeanTest, TestFilteredDocIdSet, ForceLeaderTest, DocValuesMissingTest, TestDocumentBuilder, HighlighterMaxOffsetTest, RuleEngineTest, TestQueryWrapperFilter, ZkControllerTest, CoreMergeIndexesAdminHandlerTest, CustomCollectionTest, TestUpdate, HdfsCollectionsAPIDistributedZkTest, TestConfigSetImmutable, TestRTimerTree, TestCoreContainer, TestSolrCloudWithSecureImpersonation, TestSearchPerf, SharedFSAutoReplicaFailoverUtilsTest, AliasIntegrationTest, ConfigSetsAPITest, TestRawTransformer, DeleteNodeTest, TestQueryTypes, TestPostingsSolrHighlighter, DocValuesTest, TestBlobHandler, TestSweetSpotSimilarityFactory, TestSolrConfigHandlerConcurrent, TestFuzzyAnalyzedSuggestions, ClusterStateUpdateTest, TestWordDelimiterFilterFactory, TestDefaultSearchFieldResource, TestNonDefinedSimilarityFactory, SimplePostToolTest, FullSolrCloudDistribCmdsTest, TestRandomDVFaceting, ShardRoutingCustomTest, TestHashPartitioner, TestJoin, HardAutoCommitTest, StatsComponentTest, SpellCheckComponentTest]
   [junit4] Completed [281/652 (1!)] on J1 in 18.35s, 11 tests, 1 error <<< FAILURES!

[...truncated 52581 lines...]