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/10/31 07:48:25 UTC
[JENKINS-EA] Lucene-Solr-master-Linux (32bit/jdk-9-ea+140) - Build
# 18183 - Still Unstable!
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/18183/
Java: 32bit/jdk-9-ea+140 -client -XX:+UseSerialGC
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([4B1CF67E50479C63:C1BB798FDFACA518]: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 11050 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_4B1CF67E50479C63-001/init-core-data-001
[junit4] 2> 455984 INFO (SUITE-SpellCheckComponentTest-seed#[4B1CF67E50479C63]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason="", ssl=0.0/0.0, value=0.0/0.0, clientAuth=0.0/0.0)
[junit4] 2> 455984 INFO (SUITE-SpellCheckComponentTest-seed#[4B1CF67E50479C63]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 455986 INFO (SUITE-SpellCheckComponentTest-seed#[4B1CF67E50479C63]-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> 456070 WARN (SUITE-SpellCheckComponentTest-seed#[4B1CF67E50479C63]-worker) [ ] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 456075 INFO (SUITE-SpellCheckComponentTest-seed#[4B1CF67E50479C63]-worker) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 456085 INFO (SUITE-SpellCheckComponentTest-seed#[4B1CF67E50479C63]-worker) [ ] o.a.s.s.IndexSchema [null] Schema name=test
[junit4] 2> 456148 WARN (SUITE-SpellCheckComponentTest-seed#[4B1CF67E50479C63]-worker) [ ] o.a.s.s.IndexSchema [null] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead.
[junit4] 2> 456150 INFO (SUITE-SpellCheckComponentTest-seed#[4B1CF67E50479C63]-worker) [ ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 456180 INFO (coreLoadExecutor-1801-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> 456260 WARN (coreLoadExecutor-1801-thread-1) [ ] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 456261 INFO (coreLoadExecutor-1801-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 456276 INFO (coreLoadExecutor-1801-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 456338 WARN (coreLoadExecutor-1801-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> 456340 INFO (coreLoadExecutor-1801-thread-1) [ ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 456362 INFO (coreLoadExecutor-1801-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> 456362 INFO (coreLoadExecutor-1801-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_4B1CF67E50479C63-001/init-core-data-001/]
[junit4] 2> 456363 INFO (coreLoadExecutor-1801-thread-1) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=21, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 456367 INFO (coreLoadExecutor-1801-thread-1) [ ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 456367 INFO (coreLoadExecutor-1801-thread-1) [ ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 456367 INFO (coreLoadExecutor-1801-thread-1) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=43, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 456367 INFO (coreLoadExecutor-1801-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@106bc82[collection1] main]
[junit4] 2> 456368 WARN (coreLoadExecutor-1801-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> 456368 INFO (coreLoadExecutor-1801-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 456416 INFO (coreLoadExecutor-1801-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: default
[junit4] 2> 456462 INFO (coreLoadExecutor-1801-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: default_teststop
[junit4] 2> 456462 INFO (coreLoadExecutor-1801-thread-1) [ ] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=solr.DirectSolrSpellChecker,minQueryLength=3,maxQueryFrequency=100.0,field=teststop}
[junit4] 2> 456463 INFO (coreLoadExecutor-1801-thread-1) [ ] o.a.s.s.DirectSolrSpellChecker init: {name=direct_lowerfilt,classname=solr.DirectSolrSpellChecker,minQueryLength=3,maxQueryFrequency=100.0,field=lowerfilt}
[junit4] 2> 456510 INFO (coreLoadExecutor-1801-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: threshold
[junit4] 2> 456510 INFO (coreLoadExecutor-1801-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> 456510 INFO (coreLoadExecutor-1801-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: threshold_direct
[junit4] 2> 456553 INFO (coreLoadExecutor-1801-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: multipleFields
[junit4] 2> 456679 INFO (coreLoadExecutor-1801-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: freq
[junit4] 2> 456712 INFO (coreLoadExecutor-1801-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: fqcn
[junit4] 2> 456712 INFO (coreLoadExecutor-1801-thread-1) [ ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 456712 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 456713 INFO (SUITE-SpellCheckComponentTest-seed#[4B1CF67E50479C63]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 456714 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default_teststop
[junit4] 2> 456715 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[4B1CF67E50479C63]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testThresholdTokenFrequency
[junit4] 2> 456716 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 456716 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct_lowerfilt
[junit4] 2> 456716 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 456716 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: threshold
[junit4] 2> 456716 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[0]} 0 1
[junit4] 2> 456717 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: threshold_direct
[junit4] 2> 456717 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
[junit4] 2> 456717 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 456718 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 456718 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 456718 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 456718 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[4]} 0 0
[junit4] 2> 456718 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[5]} 0 0
[junit4] 2> 456719 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[6]} 0 0
[junit4] 2> 456719 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[7]} 0 0
[junit4] 2> 456719 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 456719 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[8]} 0 0
[junit4] 2> 456720 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[9]} 0 0
[junit4] 2> 456726 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 456726 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@159a2ff
[junit4] 2> 456727 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 456728 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 456729 WARN (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[4B1CF67E50479C63]) [ ] o.a.s.c.SolrCore [collection1] PERFORMANCE WARNING: Overlapping onDeckSearchers=2
[junit4] 2> 456730 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[4B1CF67E50479C63]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@574889[collection1] main]
[junit4] 2> 456730 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 456731 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 456731 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@106bc82[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 456731 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 456733 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default_teststop
[junit4] 2> 456735 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 456735 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct_lowerfilt
[junit4] 2> 456735 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 456736 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: threshold
[junit4] 2> 456738 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: threshold_direct
[junit4] 2> 456738 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
[junit4] 2> 456740 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 456741 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 456743 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 456744 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 456745 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 456745 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@574889[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C10)))}
[junit4] 2> 456745 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 19
[junit4] 2> 456746 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[4B1CF67E50479C63]) [ ] 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> 456747 ERROR (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[4B1CF67E50479C63]) [ ] 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> 456747 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[4B1CF67E50479C63]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testThresholdTokenFrequency
[junit4] 2> 456747 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 456748 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{deleteByQuery=*:*} 0 0
[junit4] 2> 456748 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 456748 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@159a2ff
[junit4] 2> 456748 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[4B1CF67E50479C63]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@71e0e0[collection1] main]
[junit4] 2> 456748 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 456748 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 456816 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 456883 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 456930 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 456930 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 456995 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 457044 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 457113 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@71e0e0[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 457113 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 365
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=SpellCheckComponentTest -Dtests.method=testThresholdTokenFrequency -Dtests.seed=4B1CF67E50479C63 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=mer-KE -Dtests.timezone=America/Guyana -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] ERROR 0.40s J1 | SpellCheckComponentTest.testThresholdTokenFrequency <<<
[junit4] > Throwable #1: java.lang.RuntimeException: Path not found: /spellcheck/suggestions/[1]/suggestion
[junit4] > at __randomizedtesting.SeedInfo.seed([4B1CF67E50479C63:C1BB798FDFACA518]: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> 457116 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[4B1CF67E50479C63]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testPerDictionary
[junit4] 2> 457116 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[0]} 0 0
[junit4] 2> 457116 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 457117 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 457117 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 457117 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[4]} 0 0
[junit4] 2> 457117 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[5]} 0 0
[junit4] 2> 457118 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[6]} 0 0
[junit4] 2> 457118 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[7]} 0 0
[junit4] 2> 457118 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[8]} 0 0
[junit4] 2> 457118 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[9]} 0 0
[junit4] 2> 457118 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 457118 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@159a2ff
[junit4] 2> 457121 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[4B1CF67E50479C63]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@26fa08[collection1] main]
[junit4] 2> 457121 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 457121 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 457276 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 457316 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 457418 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 457418 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 457542 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 457726 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 457913 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@26fa08[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(7.0.0):C10)))}
[junit4] 2> 457914 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 795
[junit4] 2> 457914 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[4B1CF67E50479C63]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=documemt&qt=spellCheckCompRH&spellcheck.dictionary=perDict&json.nl=map&spellcheck..perDict.foo=bar&spellcheck=true&spellcheck..perDict.bar=foo&wt=xml&spellcheck.build=true} hits=0 status=0 QTime=0
[junit4] 2> 457915 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[4B1CF67E50479C63]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testPerDictionary
[junit4] 2> 457915 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 457915 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{deleteByQuery=*:*} 0 0
[junit4] 2> 457915 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 457915 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@159a2ff
[junit4] 2> 457915 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[4B1CF67E50479C63]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1d8d99d[collection1] main]
[junit4] 2> 457916 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 457916 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 457958 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 458023 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 458080 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 458080 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 458134 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 458189 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 458251 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1d8d99d[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 458252 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 336
[junit4] 2> 458253 INFO (TEST-SpellCheckComponentTest.test-seed#[4B1CF67E50479C63]) [ ] o.a.s.SolrTestCaseJ4 ###Starting test
[junit4] 2> 458254 INFO (TEST-SpellCheckComponentTest.test-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[0]} 0 0
[junit4] 2> 458255 INFO (TEST-SpellCheckComponentTest.test-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 458255 INFO (TEST-SpellCheckComponentTest.test-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 458255 INFO (TEST-SpellCheckComponentTest.test-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 458256 INFO (TEST-SpellCheckComponentTest.test-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[4]} 0 0
[junit4] 2> 458256 INFO (TEST-SpellCheckComponentTest.test-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[5]} 0 0
[junit4] 2> 458256 INFO (TEST-SpellCheckComponentTest.test-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[6]} 0 0
[junit4] 2> 458257 INFO (TEST-SpellCheckComponentTest.test-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[7]} 0 0
[junit4] 2> 458257 INFO (TEST-SpellCheckComponentTest.test-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[8]} 0 0
[junit4] 2> 458257 INFO (TEST-SpellCheckComponentTest.test-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[9]} 0 0
[junit4] 2> 458258 INFO (TEST-SpellCheckComponentTest.test-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 458258 INFO (TEST-SpellCheckComponentTest.test-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@159a2ff
[junit4] 2> 458261 INFO (TEST-SpellCheckComponentTest.test-seed#[4B1CF67E50479C63]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@220172[collection1] main]
[junit4] 2> 458261 INFO (TEST-SpellCheckComponentTest.test-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 458261 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 458368 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 458407 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 458549 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 458549 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 458677 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 458804 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 458906 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@220172[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(7.0.0):C10)))}
[junit4] 2> 458906 INFO (TEST-SpellCheckComponentTest.test-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 648
[junit4] 2> 458908 INFO (TEST-SpellCheckComponentTest.test-seed#[4B1CF67E50479C63]) [ ] 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> 458908 INFO (TEST-SpellCheckComponentTest.test-seed#[4B1CF67E50479C63]) [ ] o.a.s.SolrTestCaseJ4 ###Ending test
[junit4] 2> 458908 INFO (TEST-SpellCheckComponentTest.test-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 458909 INFO (TEST-SpellCheckComponentTest.test-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{deleteByQuery=*:*} 0 0
[junit4] 2> 458909 INFO (TEST-SpellCheckComponentTest.test-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 458909 INFO (TEST-SpellCheckComponentTest.test-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@159a2ff
[junit4] 2> 458909 INFO (TEST-SpellCheckComponentTest.test-seed#[4B1CF67E50479C63]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@18b5173[collection1] main]
[junit4] 2> 458909 INFO (TEST-SpellCheckComponentTest.test-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 458909 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 458968 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 459007 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 459056 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 459056 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 459125 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 459172 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 459221 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@18b5173[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 459221 INFO (TEST-SpellCheckComponentTest.test-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 312
[junit4] 2> 459223 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4B1CF67E50479C63]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testRebuildOnCommit
[junit4] 2> 459223 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[0]} 0 0
[junit4] 2> 459224 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 459224 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 459224 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 459224 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[4]} 0 0
[junit4] 2> 459225 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[5]} 0 0
[junit4] 2> 459225 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[6]} 0 0
[junit4] 2> 459225 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[7]} 0 0
[junit4] 2> 459225 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[8]} 0 0
[junit4] 2> 459226 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[9]} 0 0
[junit4] 2> 459226 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 459226 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@159a2ff
[junit4] 2> 459230 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4B1CF67E50479C63]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@8fbccd[collection1] main]
[junit4] 2> 459230 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 459230 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 459368 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 459428 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 459581 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 459581 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 459679 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 459830 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 459934 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@8fbccd[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_3(7.0.0):C10)))}
[junit4] 2> 459935 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 708
[junit4] 2> 459937 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4B1CF67E50479C63]) [ ] 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=1
[junit4] 2> 459937 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[11231]} 0 0
[junit4] 2> 459938 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 459938 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@159a2ff
[junit4] 2> 459941 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4B1CF67E50479C63]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1300014[collection1] main]
[junit4] 2> 459941 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 459941 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 460045 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 460118 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 460300 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 460300 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 460461 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 460561 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 460703 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1300014[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_3(7.0.0):C10) Uninverting(_4(7.0.0):C1)))}
[junit4] 2> 460703 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 765
[junit4] 2> 460705 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4B1CF67E50479C63]) [ ] 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=770
[junit4] 2> 460706 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4B1CF67E50479C63]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testRebuildOnCommit
[junit4] 2> 460706 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 460706 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{deleteByQuery=*:*} 0 0
[junit4] 2> 460706 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 460706 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@159a2ff
[junit4] 2> 460707 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4B1CF67E50479C63]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@13610bf[collection1] main]
[junit4] 2> 460707 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 460707 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 460770 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 460839 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 460900 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 460900 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 460949 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 461027 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 461090 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@13610bf[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 461090 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 384
[junit4] 2> 461092 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4B1CF67E50479C63]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testMaximumResultsForSuggest
[junit4] 2> 461093 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[0]} 0 0
[junit4] 2> 461094 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 461094 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 461094 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 461095 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[4]} 0 0
[junit4] 2> 461095 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[5]} 0 0
[junit4] 2> 461095 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[6]} 0 0
[junit4] 2> 461096 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[7]} 0 0
[junit4] 2> 461096 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[8]} 0 0
[junit4] 2> 461096 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[9]} 0 0
[junit4] 2> 461096 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 461097 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@159a2ff
[junit4] 2> 461100 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4B1CF67E50479C63]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@18d940c[collection1] main]
[junit4] 2> 461100 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 461100 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 461236 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 461303 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 461494 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 461494 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 461644 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 461842 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 462005 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@18d940c[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_5(7.0.0):C10)))}
[junit4] 2> 462005 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 909
[junit4] 2> 462137 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4B1CF67E50479C63]) [ ] 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=131
[junit4] 2> 462273 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4B1CF67E50479C63]) [ ] 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=135
[junit4] 2> 462274 ERROR (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4B1CF67E50479C63]) [ ] 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":135},
[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-10-31T07:13:54.408Z"},
[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-10-31T07:13:54.409Z"},
[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-10-31T07:13:54.409Z"},
[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-10-31T07:13:54.409Z"},
[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-10-31T07:13:54.410Z"},
[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-10-31T07:13:54.407Z"},
[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-10-31T07:13:54.408Z"}]
[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> 462445 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4B1CF67E50479C63]) [ ] 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=170
[junit4] 2> 462582 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4B1CF67E50479C63]) [ ] 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=137
[junit4] 2> 462583 ERROR (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4B1CF67E50479C63]) [ ] 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":137},
[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-10-31T07:13:54.408Z"},
[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-10-31T07:13:54.409Z"},
[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-10-31T07:13:54.409Z"},
[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-10-31T07:13:54.409Z"},
[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-10-31T07:13:54.410Z"},
[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-10-31T07:13:54.407Z"},
[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-10-31T07:13:54.408Z"}]
[junit4] 2> },
[junit4] 2> "spellcheck":{
[junit4] 2> "suggestions":[]}}
[junit4] 2>
[junit4] 2> request = 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
[junit4] 2> 462721 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4B1CF67E50479C63]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=lowerfilt:(this+OR+brwn)&spellcheck.maxResultsForSuggest=.70&qt=spellCheckCompRH&spellcheck=true&fq=id:[0+TO+9]&spellcheck.count=5&wt=xml&spellcheck.build=true&spellcheck.maxResultsForSuggest.fq=id:[0+TO+9]&spellcheck.extendedResults=false} hits=7 status=0 QTime=137
[junit4] 2> 462860 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4B1CF67E50479C63]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=lowerfilt:(this+OR+brwn)&spellcheck.maxResultsForSuggest=.64&qt=spellCheckCompRH&spellcheck=true&fq=id:[0+TO+9]&spellcheck.count=5&wt=xml&spellcheck.build=true&spellcheck.maxResultsForSuggest.fq=lowerfilt:th*&spellcheck.extendedResults=false} hits=7 status=0 QTime=137
[junit4] 2> 462860 ERROR (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4B1CF67E50479C63]) [ ] 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":137},
[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-10-31T07:13:54.408Z"},
[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-10-31T07:13:54.409Z"},
[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-10-31T07:13:54.409Z"},
[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-10-31T07:13:54.409Z"},
[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-10-31T07:13:54.410Z"},
[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-10-31T07:13:54.407Z"},
[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-10-31T07:13:54.408Z"}]
[junit4] 2> },
[junit4] 2> "spellcheck":{
[junit4] 2> "suggestions":[]}}
[junit4] 2>
[junit4] 2> request = q=lowerfilt:(this+OR+brwn)&spellcheck.maxResultsForSuggest=.64&qt=spellCheckCompRH&spellcheck=true&fq=id:[0+TO+9]&spellcheck.count=5&wt=xml&spellcheck.build=true&spellcheck.maxResultsForSuggest.fq=lowerfilt:th*&spellcheck.extendedResults=false
[junit4] 2> 462860 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4B1CF67E50479C63]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testMaximumResultsForSuggest
[junit4] 2> 462860 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 462861 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{deleteByQuery=*:*} 0 0
[junit4] 2> 462861 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 462861 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@159a2ff
[junit4] 2> 462861 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4B1CF67E50479C63]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@4e80f[collection1] main]
[junit4] 2> 462861 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 462861 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 462918 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 462958 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 463029 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 463029 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 463101 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 463157 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 463221 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@4e80f[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 463221 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 360
[junit4] 2> 463223 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[4B1CF67E50479C63]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testNumericQuery
[junit4] 2> 463223 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[0]} 0 0
[junit4] 2> 463224 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 463224 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 463224 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 463224 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[4]} 0 0
[junit4] 2> 463224 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[5]} 0 0
[junit4] 2> 463225 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[6]} 0 0
[junit4] 2> 463225 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[7]} 0 0
[junit4] 2> 463225 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[8]} 0 0
[junit4] 2> 463225 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[9]} 0 0
[junit4] 2> 463225 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 463225 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@159a2ff
[junit4] 2> 463229 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[4B1CF67E50479C63]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1958564[collection1] main]
[junit4] 2> 463229 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 463229 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 463416 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 463470 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 463613 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 463613 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 463716 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 463859 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 464050 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1958564[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_6(7.0.0):C10)))}
[junit4] 2> 464050 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 824
[junit4] 2> 464051 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[4B1CF67E50479C63]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=12346&qt=spellCheckCompRH&spellcheck=true&wt=xml} hits=0 status=0 QTime=0
[junit4] 2> 464051 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[4B1CF67E50479C63]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testNumericQuery
[junit4] 2> 464052 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 464052 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{deleteByQuery=*:*} 0 0
[junit4] 2> 464052 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 464052 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@159a2ff
[junit4] 2> 464052 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[4B1CF67E50479C63]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@8a31a1[collection1] main]
[junit4] 2> 464052 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 464052 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 464108 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 464170 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 464226 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 464226 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 464267 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 464312 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 464370 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@8a31a1[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 464371 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 318
[junit4] 2> 464372 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[4B1CF67E50479C63]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testCollate
[junit4] 2> 464373 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[0]} 0 0
[junit4] 2> 464373 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 464373 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 464374 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 464374 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[4]} 0 0
[junit4] 2> 464374 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[5]} 0 0
[junit4] 2> 464374 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[6]} 0 0
[junit4] 2> 464374 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[7]} 0 0
[junit4] 2> 464375 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[8]} 0 0
[junit4] 2> 464375 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[9]} 0 0
[junit4] 2> 464375 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 464375 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@159a2ff
[junit4] 2> 464377 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[4B1CF67E50479C63]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1787620[collection1] main]
[junit4] 2> 464377 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 464377 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 464526 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 464587 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 464790 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 464790 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 464934 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 465062 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 465206 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1787620[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_7(7.0.0):C10)))}
[junit4] 2> 465206 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 830
[junit4] 2> 465400 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[4B1CF67E50479C63]) [ ] 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=194
[junit4] 2> 465402 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[4B1CF67E50479C63]) [ ] 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=1
[junit4] 2> 465404 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[4B1CF67E50479C63]) [ ] 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=1
[junit4] 2> 465405 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[4B1CF67E50479C63]) [ ] 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> 465405 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[4B1CF67E50479C63]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testCollate
[junit4] 2> 465405 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 465405 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{deleteByQuery=*:*} 0 0
[junit4] 2> 465406 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 465406 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@159a2ff
[junit4] 2> 465406 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[4B1CF67E50479C63]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@14ce3df[collection1] main]
[junit4] 2> 465406 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 465406 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 465459 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 465530 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 465598 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 465598 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 465664 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 465716 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 465805 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@14ce3df[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 465805 INFO (TEST-SpellCheckComponentTest.test
[...truncated too long message...]
d#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 470376 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 470376 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[4]} 0 0
[junit4] 2> 470377 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[5]} 0 0
[junit4] 2> 470377 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[6]} 0 0
[junit4] 2> 470377 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[7]} 0 0
[junit4] 2> 470377 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[8]} 0 0
[junit4] 2> 470377 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[9]} 0 0
[junit4] 2> 470378 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 470378 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@159a2ff
[junit4] 2> 470380 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[4B1CF67E50479C63]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@de7844[collection1] main]
[junit4] 2> 470380 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 470380 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 470529 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 470568 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 470715 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 470715 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 470899 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 471093 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 471281 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@de7844[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_c(7.0.0):C10)))}
[junit4] 2> 471282 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 904
[junit4] 2> 471283 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[4B1CF67E50479C63]) [ ] 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> 471284 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[4B1CF67E50479C63]) [ ] 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> 471285 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[4B1CF67E50479C63]) [ ] 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=1
[junit4] 2> 471285 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[4B1CF67E50479C63]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testCorrectSpelling
[junit4] 2> 471285 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 471285 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{deleteByQuery=*:*} 0 0
[junit4] 2> 471286 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 471286 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@159a2ff
[junit4] 2> 471286 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[4B1CF67E50479C63]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@243885[collection1] main]
[junit4] 2> 471286 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 471286 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 471371 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 471449 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 471513 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 471513 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 471576 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 471633 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 471689 INFO (searcherExecutor-1802-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@243885[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 471689 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[4B1CF67E50479C63]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 403
[junit4] 2> 471690 INFO (SUITE-SpellCheckComponentTest-seed#[4B1CF67E50479C63]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> 471690 INFO (SUITE-SpellCheckComponentTest-seed#[4B1CF67E50479C63]-worker) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=10727064
[junit4] 2> 471690 INFO (coreCloseExecutor-1806-thread-1) [ ] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@a907ee
[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_4B1CF67E50479C63-001
[junit4] 2> NOTE: test params are: codec=Lucene70, sim=ClassicSimilarity, locale=mer-KE, timezone=America/Guyana
[junit4] 2> NOTE: Linux 4.4.0-42-generic i386/Oracle Corporation 9-ea (32-bit)/cpus=12,threads=1,free=104012064,total=211226624
[junit4] 2> NOTE: All tests run in this JVM: [DistributedSuggestComponentTest, DistanceFunctionTest, JavabinLoaderTest, AlternateDirectoryTest, HdfsDirectoryTest, QueryParsingTest, TestXIncludeConfig, TestImplicitCoreProperties, WrapperMergePolicyFactoryTest, SoftAutoCommitTest, FileUtilsTest, SpellCheckCollatorTest, TestStressRecovery, HdfsBasicDistributedZkTest, TestSolrConfigHandlerConcurrent, SharedFSAutoReplicaFailoverUtilsTest, ChaosMonkeySafeLeaderTest, ForceLeaderTest, SimplePostToolTest, TestFieldCacheWithThreads, IndexBasedSpellCheckerTest, TestCoreContainer, TestCustomSort, BlockCacheTest, AnalyticsQueryTest, SolrInfoMBeanTest, GraphQueryTest, SparseHLLTest, SuggestComponentContextFilterQueryTest, TestOnReconnectListenerSupport, TestBulkSchemaConcurrent, TestOrdValues, TestFieldCollectionResource, BlockJoinFacetDistribTest, TestBulkSchemaAPI, TestPerFieldSimilarityWithDefaultOverride, DirectSolrConnectionTest, TestPerFieldSimilarity, TestUpdate, DOMUtilTest, TestMiniSolrCloudCluster, TestRuleBasedAuthorizationPlugin, TestCloudPseudoReturnFields, DistributedFacetPivotLongTailTest, DistributedFacetPivotWhiteBoxTest, SpellCheckComponentTest]
[junit4] Completed [133/647 (1!)] on J1 in 15.72s, 11 tests, 1 error <<< FAILURES!
[...truncated 51571 lines...]
[JENKINS] Lucene-Solr-master-Linux (64bit/jdk1.8.0_102) - Build #
18185 - Still Unstable!
Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/18185/
Java: 64bit/jdk1.8.0_102 -XX:-UseCompressedOops -XX:+UseG1GC
1 tests failed.
FAILED: org.apache.solr.cloud.TestSolrCloudWithDelegationTokens.testDelegationTokenCancelFail
Error Message:
expected:<200> but was:<404>
Stack Trace:
java.lang.AssertionError: expected:<200> but was:<404>
at __randomizedtesting.SeedInfo.seed([73D32783679D0714:1B6C12A9B70715F8]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.failNotEquals(Assert.java:647)
at org.junit.Assert.assertEquals(Assert.java:128)
at org.junit.Assert.assertEquals(Assert.java:472)
at org.junit.Assert.assertEquals(Assert.java:456)
at org.apache.solr.cloud.TestSolrCloudWithDelegationTokens.cancelDelegationToken(TestSolrCloudWithDelegationTokens.java:140)
at org.apache.solr.cloud.TestSolrCloudWithDelegationTokens.testDelegationTokenCancelFail(TestSolrCloudWithDelegationTokens.java:294)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
at 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(Thread.java:745)
Build Log:
[...truncated 10839 lines...]
[junit4] Suite: org.apache.solr.cloud.TestSolrCloudWithDelegationTokens
[junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestSolrCloudWithDelegationTokens_73D32783679D0714-001/init-core-data-001
[junit4] 2> 153065 INFO (SUITE-TestSolrCloudWithDelegationTokens-seed#[73D32783679D0714]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
[junit4] 2> 153067 INFO (SUITE-TestSolrCloudWithDelegationTokens-seed#[73D32783679D0714]-worker) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestSolrCloudWithDelegationTokens_73D32783679D0714-001/tempDir-001
[junit4] 2> 153067 INFO (SUITE-TestSolrCloudWithDelegationTokens-seed#[73D32783679D0714]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 153067 INFO (Thread-355) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 153067 INFO (Thread-355) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 153167 INFO (SUITE-TestSolrCloudWithDelegationTokens-seed#[73D32783679D0714]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port:32889
[junit4] 2> 153176 INFO (jetty-launcher-225-thread-2) [ ] o.e.j.s.Server jetty-9.3.8.v20160314
[junit4] 2> 153177 INFO (jetty-launcher-225-thread-1) [ ] o.e.j.s.Server jetty-9.3.8.v20160314
[junit4] 2> 153177 INFO (jetty-launcher-225-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@14cb8d23{/solr,null,AVAILABLE}
[junit4] 2> 153179 INFO (jetty-launcher-225-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@32fa9995{/solr,null,AVAILABLE}
[junit4] 2> 153179 INFO (jetty-launcher-225-thread-2) [ ] o.e.j.s.ServerConnector Started ServerConnector@3d4d6386{HTTP/1.1,[http/1.1]}{127.0.0.1:44229}
[junit4] 2> 153179 INFO (jetty-launcher-225-thread-2) [ ] o.e.j.s.Server Started @154898ms
[junit4] 2> 153179 INFO (jetty-launcher-225-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=44229}
[junit4] 2> 153179 INFO (jetty-launcher-225-thread-1) [ ] o.e.j.s.ServerConnector Started ServerConnector@600a960{HTTP/1.1,[http/1.1]}{127.0.0.1:35828}
[junit4] 2> 153179 INFO (jetty-launcher-225-thread-1) [ ] o.e.j.s.Server Started @154898ms
[junit4] 2> 153179 INFO (jetty-launcher-225-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=35828}
[junit4] 2> 153179 ERROR (jetty-launcher-225-thread-2) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 153180 INFO (jetty-launcher-225-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.0.0
[junit4] 2> 153180 INFO (jetty-launcher-225-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 153180 INFO (jetty-launcher-225-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 153180 INFO (jetty-launcher-225-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2016-10-31T12:56:32.420Z
[junit4] 2> 153180 ERROR (jetty-launcher-225-thread-1) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 153180 INFO (jetty-launcher-225-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.0.0
[junit4] 2> 153180 INFO (jetty-launcher-225-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 153180 INFO (jetty-launcher-225-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 153180 INFO (jetty-launcher-225-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2016-10-31T12:56:32.420Z
[junit4] 2> 153183 INFO (jetty-launcher-225-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 153183 INFO (jetty-launcher-225-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 153188 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x1581ad00d340002, likely client has closed socket
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 153190 INFO (jetty-launcher-225-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:32889/solr
[junit4] 2> 153190 INFO (jetty-launcher-225-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:32889/solr
[junit4] 2> 153192 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x1581ad00d340003, likely client has closed socket
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 153208 INFO (jetty-launcher-225-thread-2) [n:127.0.0.1:44229_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:44229_solr
[junit4] 2> 153209 INFO (jetty-launcher-225-thread-2) [n:127.0.0.1:44229_solr ] o.a.s.c.Overseer Overseer (id=96856872865497093-127.0.0.1:44229_solr-n_0000000000) starting
[junit4] 2> 153214 INFO (jetty-launcher-225-thread-2) [n:127.0.0.1:44229_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:44229_solr
[junit4] 2> 153216 INFO (zkCallback-235-thread-1-processing-n:127.0.0.1:44229_solr) [n:127.0.0.1:44229_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 153216 INFO (zkCallback-236-thread-1-processing-n:127.0.0.1:35828_solr) [n:127.0.0.1:35828_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 153220 INFO (jetty-launcher-225-thread-1) [n:127.0.0.1:35828_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:35828_solr
[junit4] 2> 153222 INFO (zkCallback-236-thread-1-processing-n:127.0.0.1:35828_solr) [n:127.0.0.1:35828_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 153222 INFO (zkCallback-235-thread-1-processing-n:127.0.0.1:44229_solr) [n:127.0.0.1:44229_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 153228 INFO (jetty-launcher-225-thread-2) [n:127.0.0.1:44229_solr ] o.a.s.c.CoreContainer Initializing authentication plugin: org.apache.solr.security.HttpParamDelegationTokenPlugin
[junit4] 2> 153233 INFO (jetty-launcher-225-thread-1) [n:127.0.0.1:35828_solr ] o.a.s.c.CoreContainer Initializing authentication plugin: org.apache.solr.security.HttpParamDelegationTokenPlugin
[junit4] 2> 153249 INFO (jetty-launcher-225-thread-2) [n:127.0.0.1:44229_solr ] o.a.s.s.KerberosPlugin Params: {token.valid=30, delegation-token.token-kind=solr-dt, cookie.domain=127.0.0.1, cookie.path=/, zk-dt-secret-manager.znodeWorkingPath=solr/security/zkdtsm, token.validity=36000, signer.secret.provider.zookeeper.path=/token, type=kerberos, zk-dt-secret-manager.enable=true, kerberos.name.rules=DEFAULT, signer.secret.provider=zookeeper}
[junit4] 2> 153249 INFO (jetty-launcher-225-thread-1) [n:127.0.0.1:35828_solr ] o.a.s.s.KerberosPlugin Params: {token.valid=30, delegation-token.token-kind=solr-dt, cookie.domain=127.0.0.1, cookie.path=/, zk-dt-secret-manager.znodeWorkingPath=solr/security/zkdtsm, token.validity=36000, signer.secret.provider.zookeeper.path=/token, type=kerberos, zk-dt-secret-manager.enable=true, kerberos.name.rules=DEFAULT, signer.secret.provider=zookeeper}
[junit4] 2> 153348 INFO (jetty-launcher-225-thread-2) [n:127.0.0.1:44229_solr ] o.a.c.f.i.CuratorFrameworkImpl Starting
[junit4] 2> 153348 INFO (jetty-launcher-225-thread-1) [n:127.0.0.1:35828_solr ] o.a.c.f.i.CuratorFrameworkImpl Starting
[junit4] 2> 153378 INFO (jetty-launcher-225-thread-1-EventThread) [n:127.0.0.1:35828_solr ] o.a.c.f.s.ConnectionStateManager State change: CONNECTED
[junit4] 2> 153378 INFO (jetty-launcher-225-thread-2-EventThread) [n:127.0.0.1:44229_solr ] o.a.c.f.s.ConnectionStateManager State change: CONNECTED
[junit4] 2> 153583 INFO (jetty-launcher-225-thread-1) [n:127.0.0.1:35828_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestSolrCloudWithDelegationTokens_73D32783679D0714-001/tempDir-001/node1/.
[junit4] 2> 153583 INFO (jetty-launcher-225-thread-2) [n:127.0.0.1:44229_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestSolrCloudWithDelegationTokens_73D32783679D0714-001/tempDir-001/node2/.
[junit4] 2> 153602 INFO (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenCancelFail-seed#[73D32783679D0714]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testDelegationTokenCancelFail
[junit4] 2> 154093 INFO (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenCancelFail-seed#[73D32783679D0714]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testDelegationTokenCancelFail
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestSolrCloudWithDelegationTokens -Dtests.method=testDelegationTokenCancelFail -Dtests.seed=73D32783679D0714 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=ar-MA -Dtests.timezone=Africa/Mogadishu -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] FAILURE 0.51s J2 | TestSolrCloudWithDelegationTokens.testDelegationTokenCancelFail <<<
[junit4] > Throwable #1: java.lang.AssertionError: expected:<200> but was:<404>
[junit4] > at __randomizedtesting.SeedInfo.seed([73D32783679D0714:1B6C12A9B70715F8]:0)
[junit4] > at org.apache.solr.cloud.TestSolrCloudWithDelegationTokens.cancelDelegationToken(TestSolrCloudWithDelegationTokens.java:140)
[junit4] > at org.apache.solr.cloud.TestSolrCloudWithDelegationTokens.testDelegationTokenCancelFail(TestSolrCloudWithDelegationTokens.java:294)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 154107 INFO (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[73D32783679D0714]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testDelegationTokenRenew
[junit4] 2> 154160 INFO (qtp1108933276-1425) [n:127.0.0.1:35828_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params action=LIST&delegation=GgADYmFyA2JhcgCKAVga0BFEigFYPtyVRAIEFLYdyWx9Oz0BWDmOYJ0y1ybhCFI9B3NvbHItZHQA&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 154161 INFO (qtp1108933276-1425) [n:127.0.0.1:35828_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=LIST&delegation=GgADYmFyA2JhcgCKAVga0BFEigFYPtyVRAIEFLYdyWx9Oz0BWDmOYJ0y1ybhCFI9B3NvbHItZHQA&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 154175 WARN (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[73D32783679D0714]) [ ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: hadoop.auth=; Path=/; Domain=127.0.0.1; Expires= , 01- -1970 00:00:00 GMT; HttpOnly". Invalid 'expires' attribute: , 01- -1970 00:00:00 GMT
[junit4] 2> 154180 INFO (qtp1060310775-1410) [n:127.0.0.1:44229_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params action=LIST&delegation=GgADYmFyA2JhcgCKAVga0BFEigFYPtyVRAIEFLYdyWx9Oz0BWDmOYJ0y1ybhCFI9B3NvbHItZHQA&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 154180 INFO (qtp1060310775-1410) [n:127.0.0.1:44229_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=LIST&delegation=GgADYmFyA2JhcgCKAVga0BFEigFYPtyVRAIEFLYdyWx9Oz0BWDmOYJ0y1ybhCFI9B3NvbHItZHQA&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 154183 WARN (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[73D32783679D0714]) [ ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: hadoop.auth=; Path=/; Domain=127.0.0.1; Expires= , 01- -1970 00:00:00 GMT; HttpOnly". Invalid 'expires' attribute: , 01- -1970 00:00:00 GMT
[junit4] 2> 154201 INFO (qtp1108933276-1421) [n:127.0.0.1:35828_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params action=LIST&delegation=GgADYmFyA2JhcgCKAVga0BGQigFYPtyVkAMEFKX-CTDgdjLtXsxzhlFlgeBkqHoEB3NvbHItZHQA&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 154202 INFO (qtp1108933276-1421) [n:127.0.0.1:35828_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=LIST&delegation=GgADYmFyA2JhcgCKAVga0BGQigFYPtyVkAMEFKX-CTDgdjLtXsxzhlFlgeBkqHoEB3NvbHItZHQA&wt=javabin&version=2} status=0 QTime=1
[junit4] 2> 154206 WARN (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[73D32783679D0714]) [ ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: hadoop.auth=; Path=/; Domain=127.0.0.1; Expires= , 01- -1970 00:00:00 GMT; HttpOnly". Invalid 'expires' attribute: , 01- -1970 00:00:00 GMT
[junit4] 2> 154210 INFO (qtp1060310775-1411) [n:127.0.0.1:44229_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params action=LIST&delegation=GgADYmFyA2JhcgCKAVga0BGQigFYPtyVkAMEFKX-CTDgdjLtXsxzhlFlgeBkqHoEB3NvbHItZHQA&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 154210 INFO (qtp1060310775-1411) [n:127.0.0.1:44229_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=LIST&delegation=GgADYmFyA2JhcgCKAVga0BGQigFYPtyVkAMEFKX-CTDgdjLtXsxzhlFlgeBkqHoEB3NvbHItZHQA&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 154216 INFO (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[73D32783679D0714]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 154219 WARN (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[73D32783679D0714]) [ ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: hadoop.auth=; Path=/; Domain=127.0.0.1; Expires= , 01- -1970 00:00:00 GMT; HttpOnly". Invalid 'expires' attribute: , 01- -1970 00:00:00 GMT
[junit4] 2> 154236 INFO (qtp1108933276-1418) [n:127.0.0.1:35828_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params action=LIST&delegation=GgADYmFyA2JhcgCKAVga0BG1igFYPtyVtQQEFBuwRXFdCv3RED_wt1huzpwDKsYEB3NvbHItZHQA&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 154236 INFO (qtp1108933276-1418) [n:127.0.0.1:35828_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=LIST&delegation=GgADYmFyA2JhcgCKAVga0BG1igFYPtyVtQQEFBuwRXFdCv3RED_wt1huzpwDKsYEB3NvbHItZHQA&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 154242 INFO (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[73D32783679D0714]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 154246 WARN (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[73D32783679D0714]) [ ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: hadoop.auth=; Path=/; Domain=127.0.0.1; Expires= , 01- -1970 00:00:00 GMT; HttpOnly". Invalid 'expires' attribute: , 01- -1970 00:00:00 GMT
[junit4] 2> 154251 INFO (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[73D32783679D0714]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 154253 INFO (qtp1060310775-1411) [n:127.0.0.1:44229_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params action=LIST&delegation=GgADYmFyA2JhcgCKAVga0BG1igFYPtyVtQQEFBuwRXFdCv3RED_wt1huzpwDKsYEB3NvbHItZHQA&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 154254 INFO (qtp1060310775-1411) [n:127.0.0.1:44229_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=LIST&delegation=GgADYmFyA2JhcgCKAVga0BG1igFYPtyVtQQEFBuwRXFdCv3RED_wt1huzpwDKsYEB3NvbHItZHQA&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 154260 INFO (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[73D32783679D0714]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 154263 WARN (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[73D32783679D0714]) [ ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: hadoop.auth=; Path=/; Domain=127.0.0.1; Expires= , 01- -1970 00:00:00 GMT; HttpOnly". Invalid 'expires' attribute: , 01- -1970 00:00:00 GMT
[junit4] 2> 154278 INFO (qtp1108933276-1423) [n:127.0.0.1:35828_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params action=LIST&delegation=GgADYmFyA2JhcgCKAVga0BHhigFYPtyV4QUEFJo_yEgwos524ZrOhtwOiNGzPxI4B3NvbHItZHQA&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 154278 INFO (qtp1108933276-1423) [n:127.0.0.1:35828_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=LIST&delegation=GgADYmFyA2JhcgCKAVga0BHhigFYPtyV4QUEFJo_yEgwos524ZrOhtwOiNGzPxI4B3NvbHItZHQA&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 154281 WARN (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[73D32783679D0714]) [ ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: hadoop.auth=; Path=/; Domain=127.0.0.1; Expires= , 01- -1970 00:00:00 GMT; HttpOnly". Invalid 'expires' attribute: , 01- -1970 00:00:00 GMT
[junit4] 2> 154284 INFO (qtp1060310775-1414) [n:127.0.0.1:44229_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params action=LIST&delegation=GgADYmFyA2JhcgCKAVga0BHhigFYPtyV4QUEFJo_yEgwos524ZrOhtwOiNGzPxI4B3NvbHItZHQA&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 154284 INFO (qtp1060310775-1414) [n:127.0.0.1:44229_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=LIST&delegation=GgADYmFyA2JhcgCKAVga0BHhigFYPtyV4QUEFJo_yEgwos524ZrOhtwOiNGzPxI4B3NvbHItZHQA&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 154289 INFO (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[73D32783679D0714]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 154291 WARN (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[73D32783679D0714]) [ ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: hadoop.auth=; Path=/; Domain=127.0.0.1; Expires= , 01- -1970 00:00:00 GMT; HttpOnly". Invalid 'expires' attribute: , 01- -1970 00:00:00 GMT
[junit4] 2> 154292 INFO (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[73D32783679D0714]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testDelegationTokenRenew
[junit4] 2> 154312 INFO (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenVerify-seed#[73D32783679D0714]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testDelegationTokenVerify
[junit4] 2> 154321 INFO (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenVerify-seed#[73D32783679D0714]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 154325 INFO (qtp1060310775-1414) [n:127.0.0.1:44229_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params action=LIST&delegation=GgADYmFyA2JhcgCKAVga0BIRigFYPtyWEQYEFEB7ooyCCpAy337MdxmPAb05boosB3NvbHItZHQA&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 154325 INFO (qtp1060310775-1414) [n:127.0.0.1:44229_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=LIST&delegation=GgADYmFyA2JhcgCKAVga0BIRigFYPtyWEQYEFEB7ooyCCpAy337MdxmPAb05boosB3NvbHItZHQA&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 154332 INFO (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenVerify-seed#[73D32783679D0714]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 154336 WARN (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenVerify-seed#[73D32783679D0714]) [ ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: hadoop.auth=; Path=/; Domain=127.0.0.1; Expires= , 01- -1970 00:00:00 GMT; HttpOnly". Invalid 'expires' attribute: , 01- -1970 00:00:00 GMT
[junit4] 2> 154348 INFO (qtp1060310775-1414) [n:127.0.0.1:44229_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params action=LIST&delegation=GgADYmFyA2JhcgCKAVga0BIRigFYPtyWEQYEFEB7ooyCCpAy337MdxmPAb05boosB3NvbHItZHQA&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 154348 INFO (qtp1060310775-1414) [n:127.0.0.1:44229_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=LIST&delegation=GgADYmFyA2JhcgCKAVga0BIRigFYPtyWEQYEFEB7ooyCCpAy337MdxmPAb05boosB3NvbHItZHQA&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 154352 INFO (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenVerify-seed#[73D32783679D0714]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 154359 WARN (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenVerify-seed#[73D32783679D0714]) [ ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: hadoop.auth=; Path=/; Domain=127.0.0.1; Expires= , 01- -1970 00:00:00 GMT; HttpOnly". Invalid 'expires' attribute: , 01- -1970 00:00:00 GMT
[junit4] 2> 154360 INFO (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenVerify-seed#[73D32783679D0714]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testDelegationTokenVerify
[junit4] 2> 154378 INFO (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenCancel-seed#[73D32783679D0714]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testDelegationTokenCancel
[junit4] 2> 154390 INFO (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenCancel-seed#[73D32783679D0714]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 154394 ERROR (qtp1060310775-1415) [ ] o.a.h.s.t.d.ZKDelegationTokenSecretManager No node in path [/ZKDTSMTokensRoot/DT_7]
[junit4] 2> 154412 WARN (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenCancel-seed#[73D32783679D0714]) [ ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: hadoop.auth=; Path=/; Domain=127.0.0.1; Expires= , 01- -1970 00:00:00 GMT; HttpOnly". Invalid 'expires' attribute: , 01- -1970 00:00:00 GMT
[junit4] 2> 154415 WARN (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenCancel-seed#[73D32783679D0714]) [ ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: hadoop.auth=; Path=/; Domain=127.0.0.1; Expires= , 01- -1970 00:00:00 GMT; HttpOnly". Invalid 'expires' attribute: , 01- -1970 00:00:00 GMT
[junit4] 2> 154434 ERROR (qtp1060310775-1415) [ ] o.a.h.s.t.d.ZKDelegationTokenSecretManager No node in path [/ZKDTSMTokensRoot/DT_8]
[junit4] 2> 154440 WARN (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenCancel-seed#[73D32783679D0714]) [ ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: hadoop.auth=; Path=/; Domain=127.0.0.1; Expires= , 01- -1970 00:00:00 GMT; HttpOnly". Invalid 'expires' attribute: , 01- -1970 00:00:00 GMT
[junit4] 2> 154445 INFO (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenCancel-seed#[73D32783679D0714]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 154448 WARN (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenCancel-seed#[73D32783679D0714]) [ ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: hadoop.auth=; Path=/; Domain=127.0.0.1; Expires= , 01- -1970 00:00:00 GMT; HttpOnly". Invalid 'expires' attribute: , 01- -1970 00:00:00 GMT
[junit4] 2> 154448 INFO (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenCancel-seed#[73D32783679D0714]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testDelegationTokenCancel
[junit4] 2> 154460 INFO (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenewFail-seed#[73D32783679D0714]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testDelegationTokenRenewFail
[junit4] 2> 154466 WARN (qtp1108933276-1423) [n:127.0.0.1:35828_solr ] o.a.h.s.a.s.AuthenticationFilter Authentication exception: org.apache.hadoop.security.AccessControlException: foo tries to renew a token with renewer bar
[junit4] 2> 154466 WARN (qtp1108933276-1423) [n:127.0.0.1:35828_solr ] o.a.s.s.KerberosPlugin Could not find org.apache.solr.security.kerberosplugin.requestcontinues
[junit4] 2> 154467 WARN (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenewFail-seed#[73D32783679D0714]) [ ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: hadoop.auth=; Path=/; Domain=127.0.0.1; Expires= , 01- -1970 00:00:00 GMT; HttpOnly". Invalid 'expires' attribute: , 01- -1970 00:00:00 GMT
[junit4] 2> 154468 WARN (qtp1060310775-1416) [ ] o.a.h.s.a.s.AuthenticationFilter Authentication exception: org.apache.hadoop.security.AccessControlException: foo tries to renew a token with renewer bar
[junit4] 2> 154469 WARN (qtp1060310775-1416) [ ] o.a.s.s.KerberosPlugin Could not find org.apache.solr.security.kerberosplugin.requestcontinues
[junit4] 2> 154469 WARN (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenewFail-seed#[73D32783679D0714]) [ ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: hadoop.auth=; Path=/; Domain=127.0.0.1; Expires= , 01- -1970 00:00:00 GMT; HttpOnly". Invalid 'expires' attribute: , 01- -1970 00:00:00 GMT
[junit4] 2> 154474 WARN (qtp1108933276-1419) [ ] o.a.h.s.a.s.AuthenticationFilter Authentication exception: org.apache.hadoop.security.AccessControlException: notRenewUser tries to renew a token with renewer renewUser
[junit4] 2> 154475 WARN (qtp1108933276-1419) [ ] o.a.s.s.KerberosPlugin Could not find org.apache.solr.security.kerberosplugin.requestcontinues
[junit4] 2> 154475 WARN (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenewFail-seed#[73D32783679D0714]) [ ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: hadoop.auth=; Path=/; Domain=127.0.0.1; Expires= , 01- -1970 00:00:00 GMT; HttpOnly". Invalid 'expires' attribute: , 01- -1970 00:00:00 GMT
[junit4] 2> 154476 WARN (qtp1060310775-1410) [n:127.0.0.1:44229_solr ] o.a.h.s.a.s.AuthenticationFilter Authentication exception: org.apache.hadoop.security.AccessControlException: notRenewUser tries to renew a token with renewer renewUser
[junit4] 2> 154477 WARN (qtp1060310775-1410) [n:127.0.0.1:44229_solr ] o.a.s.s.KerberosPlugin Could not find org.apache.solr.security.kerberosplugin.requestcontinues
[junit4] 2> 154477 WARN (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenewFail-seed#[73D32783679D0714]) [ ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: hadoop.auth=; Path=/; Domain=127.0.0.1; Expires= , 01- -1970 00:00:00 GMT; HttpOnly". Invalid 'expires' attribute: , 01- -1970 00:00:00 GMT
[junit4] 2> 154478 INFO (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenewFail-seed#[73D32783679D0714]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testDelegationTokenRenewFail
[junit4] 2> 154491 INFO (TEST-TestSolrCloudWithDelegationTokens.testDelegationOtherOp-seed#[73D32783679D0714]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testDelegationOtherOp
[junit4] 2> 154493 INFO (qtp1108933276-1423) [n:127.0.0.1:35828_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params op=someSolrOperation&action=LIST&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 154494 INFO (qtp1108933276-1423) [n:127.0.0.1:35828_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={op=someSolrOperation&action=LIST&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 154494 WARN (TEST-TestSolrCloudWithDelegationTokens.testDelegationOtherOp-seed#[73D32783679D0714]) [ ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: hadoop.auth="u=bar&p=bar&t=test&e=1477954593733&s=CzhSP494LgsA4hgPzx2w6x7n5LE="; Path=/; Domain=127.0.0.1; Expires= , 31- -2016 22:56:33 GMT; HttpOnly". Invalid 'expires' attribute: , 31- -2016 22:56:33 GMT
[junit4] 2> 154494 INFO (TEST-TestSolrCloudWithDelegationTokens.testDelegationOtherOp-seed#[73D32783679D0714]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testDelegationOtherOp
[junit4] 2> 154515 INFO (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenSolrClient-seed#[73D32783679D0714]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testDelegationTokenSolrClient
[junit4] 2> 154522 WARN (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenSolrClient-seed#[73D32783679D0714]) [ ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: hadoop.auth=; Path=/; Domain=127.0.0.1; Expires= , 01- -1970 00:00:00 GMT; HttpOnly". Invalid 'expires' attribute: , 01- -1970 00:00:00 GMT
[junit4] 2> 154527 INFO (qtp1108933276-1421) [n:127.0.0.1:35828_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params action=LIST&delegation=GgADYmFyA2JhcgCKAVga0BLcigFYPtyW3AsEFAOxZjSAmydUUs1VNSssTUOicx3VB3NvbHItZHQA&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 154527 INFO (qtp1108933276-1421) [n:127.0.0.1:35828_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=LIST&delegation=GgADYmFyA2JhcgCKAVga0BLcigFYPtyW3AsEFAOxZjSAmydUUs1VNSssTUOicx3VB3NvbHItZHQA&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 154528 INFO (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenSolrClient-seed#[73D32783679D0714]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testDelegationTokenSolrClient
[junit4] 2> 154540 INFO (TEST-TestSolrCloudWithDelegationTokens.testZNodePaths-seed#[73D32783679D0714]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testZNodePaths
[junit4] 2> 154547 INFO (TEST-TestSolrCloudWithDelegationTokens.testZNodePaths-seed#[73D32783679D0714]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testZNodePaths
[junit4] 2> 154548 INFO (jetty-launcher-225-thread-1) [ ] o.e.j.s.ServerConnector Stopped ServerConnector@600a960{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 154548 INFO (jetty-launcher-225-thread-1) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1037347470
[junit4] 2> 154548 INFO (jetty-launcher-225-thread-2) [ ] o.e.j.s.ServerConnector Stopped ServerConnector@3d4d6386{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 154548 INFO (jetty-launcher-225-thread-2) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1478028875
[junit4] 2> 154551 WARN (zkCallback-236-thread-1-processing-n:127.0.0.1:35828_solr) [n:127.0.0.1:35828_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 154551 ERROR (Thread[Thread-373,5,TGRP-TestSolrCloudWithDelegationTokens]) [n:127.0.0.1:35828_solr ] o.a.h.s.t.d.AbstractDelegationTokenSecretManager ExpiredTokenRemover received java.lang.InterruptedException: sleep interrupted
[junit4] 2> 154552 INFO (jetty-launcher-225-thread-2) [ ] o.a.s.c.Overseer Overseer (id=96856872865497093-127.0.0.1:44229_solr-n_0000000000) closing
[junit4] 2> 154552 INFO (OverseerStateUpdate-96856872865497093-127.0.0.1:44229_solr-n_0000000000) [n:127.0.0.1:44229_solr ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:44229_solr
[junit4] 2> 154560 INFO (jetty-launcher-225-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@32fa9995{/solr,null,UNAVAILABLE}
[junit4] 2> 156052 WARN (zkCallback-235-thread-1-processing-n:127.0.0.1:44229_solr) [n:127.0.0.1:44229_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 156052 ERROR (Thread[Thread-374,5,TGRP-TestSolrCloudWithDelegationTokens]) [n:127.0.0.1:44229_solr ] o.a.h.s.t.d.AbstractDelegationTokenSecretManager ExpiredTokenRemover received java.lang.InterruptedException: sleep interrupted
[junit4] 2> 156054 INFO (jetty-launcher-225-thread-2) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@14cb8d23{/solr,null,UNAVAILABLE}
[junit4] 2> 156054 INFO (SUITE-TestSolrCloudWithDelegationTokens-seed#[73D32783679D0714]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:32889 32889
[junit4] 2> 156118 INFO (Thread-355) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:32889 32889
[junit4] 2> 156118 WARN (Thread-355) [ ] o.a.s.c.ZkTestServer Watch limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 12 /solr/aliases.json
[junit4] 2> 12 /solr/clusterprops.json
[junit4] 2> 2 /solr/security.json
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 12 /solr/clusterstate.json
[junit4] 2> 4 /solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMKeyIdRoot
[junit4] 2> 2 /solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_7
[junit4] 2> 2 /solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_6
[junit4] 2> 2 /solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_9
[junit4] 2> 2 /solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_8
[junit4] 2> 2 /solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMMasterKeyRoot/DK_1
[junit4] 2> 2 /solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_1
[junit4] 2> 2 /solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMMasterKeyRoot/DK_3
[junit4] 2> 2 /solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_3
[junit4] 2> 2 /solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMMasterKeyRoot/DK_2
[junit4] 2> 2 /solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_2
[junit4] 2> 2 /solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_5
[junit4] 2> 2 /solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMMasterKeyRoot/DK_4
[junit4] 2> 2 /solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_4
[junit4] 2> 2 /solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_12
[junit4] 2> 2 /solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMSeqNumRoot
[junit4] 2> 2 /solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_11
[junit4] 2> 2 /solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_10
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 12 /solr/live_nodes
[junit4] 2> 12 /solr/collections
[junit4] 2> 2 /solr/overseer/queue
[junit4] 2> 2 /solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMMasterKeyRoot
[junit4] 2> 2 /solr/overseer/queue-work
[junit4] 2> 2 /solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot
[junit4] 2>
[junit4] 2> 156119 INFO (SUITE-TestSolrCloudWithDelegationTokens-seed#[73D32783679D0714]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestSolrCloudWithDelegationTokens_73D32783679D0714-001
[junit4] 2> Oct 31, 2016 12:56:35 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 2 leaked thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {}, docValues:{}, maxPointsInLeafNode=310, maxMBSortInHeap=6.431054123297628, sim=ClassicSimilarity, locale=ar-MA, timezone=Africa/Mogadishu
[junit4] 2> NOTE: Linux 4.4.0-42-generic amd64/Oracle Corporation 1.8.0_102 (32-bit)/cpus=12,threads=1,free=134169136,total=526385152
[junit4] 2> NOTE: All tests run in this JVM: [CursorMarkTest, TestXmlQParser, TestCSVResponseWriter, UnloadDistributedZkTest, CdcrRequestHandlerTest, TestRecovery, TestExtendedDismaxParser, CollectionStateFormat2Test, TestSchemaNameResource, TestConfigReload, DirectUpdateHandlerOptimizeTest, TestZkChroot, TestExactSharedStatsCache, DistributedFacetExistsSmallTest, TestPhraseSuggestions, TestSolrQueryParserResource, TestPHPSerializedResponseWriter, TestSolrCloudWithDelegationTokens]
[junit4] Completed [66/647 (1!)] on J2 in 3.83s, 8 tests, 1 failure <<< FAILURES!
[...truncated 62250 lines...]
[JENKINS-EA] Lucene-Solr-master-Linux (32bit/jdk-9-ea+140) - Build
# 18184 - Still Unstable!
Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/18184/
Java: 32bit/jdk-9-ea+140 -server -XX:+UseConcMarkSweepGC
1 tests failed.
FAILED: org.apache.solr.handler.component.SpellCheckComponentTest.test
Error Message:
List size mismatch @ spellcheck/suggestions
Stack Trace:
java.lang.RuntimeException: List size mismatch @ spellcheck/suggestions
at __randomizedtesting.SeedInfo.seed([D5AEBE2285FEAD5F:5DFA81F82B02C0A7]: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.test(SpellCheckComponentTest.java:147)
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 11704 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/J0/temp/solr.handler.component.SpellCheckComponentTest_D5AEBE2285FEAD5F-001/init-core-data-001
[junit4] 2> 1398911 INFO (SUITE-SpellCheckComponentTest-seed#[D5AEBE2285FEAD5F]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) 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> 1398912 INFO (SUITE-SpellCheckComponentTest-seed#[D5AEBE2285FEAD5F]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 1398913 INFO (SUITE-SpellCheckComponentTest-seed#[D5AEBE2285FEAD5F]-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> 1399015 WARN (SUITE-SpellCheckComponentTest-seed#[D5AEBE2285FEAD5F]-worker) [ ] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 1399016 INFO (SUITE-SpellCheckComponentTest-seed#[D5AEBE2285FEAD5F]-worker) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 1399032 INFO (SUITE-SpellCheckComponentTest-seed#[D5AEBE2285FEAD5F]-worker) [ ] o.a.s.s.IndexSchema [null] Schema name=test
[junit4] 2> 1399129 WARN (SUITE-SpellCheckComponentTest-seed#[D5AEBE2285FEAD5F]-worker) [ ] o.a.s.s.IndexSchema [null] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead.
[junit4] 2> 1399132 INFO (SUITE-SpellCheckComponentTest-seed#[D5AEBE2285FEAD5F]-worker) [ ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1399166 INFO (coreLoadExecutor-5438-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> 1399257 WARN (coreLoadExecutor-5438-thread-1) [ ] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 1399257 INFO (coreLoadExecutor-5438-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 1399275 INFO (coreLoadExecutor-5438-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1399344 WARN (coreLoadExecutor-5438-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> 1399346 INFO (coreLoadExecutor-5438-thread-1) [ ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1399369 INFO (coreLoadExecutor-5438-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> 1399369 INFO (coreLoadExecutor-5438-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/J0/temp/solr.handler.component.SpellCheckComponentTest_D5AEBE2285FEAD5F-001/init-core-data-001/]
[junit4] 2> 1399370 INFO (coreLoadExecutor-5438-thread-1) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=43, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.4565990077306411]
[junit4] 2> 1399374 INFO (coreLoadExecutor-5438-thread-1) [ ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1399375 INFO (coreLoadExecutor-5438-thread-1) [ ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1399375 INFO (coreLoadExecutor-5438-thread-1) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=9, maxMergeAtOnceExplicit=5, maxMergedSegmentMB=12.53515625, floorSegmentMB=0.484375, forceMergeDeletesPctAllowed=8.886235216678415, segmentsPerTier=36.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.6609858261083998
[junit4] 2> 1399375 INFO (coreLoadExecutor-5438-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1065f1c[collection1] main]
[junit4] 2> 1399376 WARN (coreLoadExecutor-5438-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> 1399376 INFO (coreLoadExecutor-5438-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 1399432 INFO (coreLoadExecutor-5438-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: default
[junit4] 2> 1399469 INFO (coreLoadExecutor-5438-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: default_teststop
[junit4] 2> 1399469 INFO (coreLoadExecutor-5438-thread-1) [ ] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=solr.DirectSolrSpellChecker,minQueryLength=3,maxQueryFrequency=100.0,field=teststop}
[junit4] 2> 1399470 INFO (coreLoadExecutor-5438-thread-1) [ ] o.a.s.s.DirectSolrSpellChecker init: {name=direct_lowerfilt,classname=solr.DirectSolrSpellChecker,minQueryLength=3,maxQueryFrequency=100.0,field=lowerfilt}
[junit4] 2> 1399513 INFO (coreLoadExecutor-5438-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: threshold
[junit4] 2> 1399513 INFO (coreLoadExecutor-5438-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> 1399513 INFO (coreLoadExecutor-5438-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: threshold_direct
[junit4] 2> 1399560 INFO (coreLoadExecutor-5438-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: multipleFields
[junit4] 2> 1399790 INFO (coreLoadExecutor-5438-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: freq
[junit4] 2> 1399873 INFO (coreLoadExecutor-5438-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: fqcn
[junit4] 2> 1399873 INFO (coreLoadExecutor-5438-thread-1) [ ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1399873 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 1399875 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default_teststop
[junit4] 2> 1399875 INFO (SUITE-SpellCheckComponentTest-seed#[D5AEBE2285FEAD5F]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 1399876 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 1399876 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct_lowerfilt
[junit4] 2> 1399877 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 1399877 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: threshold
[junit4] 2> 1399877 INFO (TEST-SpellCheckComponentTest.test-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.SolrTestCaseJ4 ###Starting test
[junit4] 2> 1399878 INFO (TEST-SpellCheckComponentTest.test-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[0]} 0 0
[junit4] 2> 1399879 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: threshold_direct
[junit4] 2> 1399879 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
[junit4] 2> 1399879 INFO (TEST-SpellCheckComponentTest.test-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 1399880 INFO (TEST-SpellCheckComponentTest.test-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 1399880 INFO (TEST-SpellCheckComponentTest.test-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 1399880 INFO (TEST-SpellCheckComponentTest.test-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[4]} 0 0
[junit4] 2> 1399880 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 1399880 INFO (TEST-SpellCheckComponentTest.test-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[5]} 0 0
[junit4] 2> 1399881 INFO (TEST-SpellCheckComponentTest.test-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[6]} 0 0
[junit4] 2> 1399881 INFO (TEST-SpellCheckComponentTest.test-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[7]} 0 0
[junit4] 2> 1399881 INFO (TEST-SpellCheckComponentTest.test-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[8]} 0 0
[junit4] 2> 1399882 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 1399884 INFO (TEST-SpellCheckComponentTest.test-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[9]} 0 2
[junit4] 2> 1399884 INFO (TEST-SpellCheckComponentTest.test-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1399884 INFO (TEST-SpellCheckComponentTest.test-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@159b251
[junit4] 2> 1399884 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 1399885 WARN (TEST-SpellCheckComponentTest.test-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.c.SolrCore [collection1] PERFORMANCE WARNING: Overlapping onDeckSearchers=2
[junit4] 2> 1399888 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 1399889 INFO (TEST-SpellCheckComponentTest.test-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@19d8ae9[collection1] main]
[junit4] 2> 1399889 INFO (TEST-SpellCheckComponentTest.test-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1399890 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 1399890 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1065f1c[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1399890 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 1399891 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default_teststop
[junit4] 2> 1399893 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 1399893 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct_lowerfilt
[junit4] 2> 1399893 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 1399893 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: threshold
[junit4] 2> 1399895 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: threshold_direct
[junit4] 2> 1399895 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
[junit4] 2> 1399897 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 1399898 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 1399900 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 1399901 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 1399903 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 1399903 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@19d8ae9[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C10)))}
[junit4] 2> 1399903 INFO (TEST-SpellCheckComponentTest.test-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 18
[junit4] 2> 1399904 INFO (TEST-SpellCheckComponentTest.test-seed#[D5AEBE2285FEAD5F]) [ ] 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=0
[junit4] 2> 1399905 ERROR (TEST-SpellCheckComponentTest.test-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.SolrTestCaseJ4 query failed JSON validation. error=List size mismatch @ spellcheck/suggestions
[junit4] 2> expected =/spellcheck=={'suggestions':['documemt',{'numFound':1,'startOffset':0,'endOffset':8,'suggestion':['document']}]}
[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>
[junit4] 2> request = q=documemt&qt=spellCheckCompRH&spellcheck=true&wt=xml
[junit4] 2> 1399905 INFO (TEST-SpellCheckComponentTest.test-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.SolrTestCaseJ4 ###Ending test
[junit4] 2> 1399905 INFO (TEST-SpellCheckComponentTest.test-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 1399905 INFO (TEST-SpellCheckComponentTest.test-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{deleteByQuery=*:*} 0 0
[junit4] 2> 1399905 INFO (TEST-SpellCheckComponentTest.test-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1399905 INFO (TEST-SpellCheckComponentTest.test-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@159b251
[junit4] 2> 1399906 INFO (TEST-SpellCheckComponentTest.test-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@e2b29[collection1] main]
[junit4] 2> 1399906 INFO (TEST-SpellCheckComponentTest.test-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1399906 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 1400004 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 1400074 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 1400122 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 1400122 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 1400186 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 1400242 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 1400329 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@e2b29[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1400330 INFO (TEST-SpellCheckComponentTest.test-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 424
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=SpellCheckComponentTest -Dtests.method=test -Dtests.seed=D5AEBE2285FEAD5F -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=he-IL -Dtests.timezone=America/Guyana -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
[junit4] ERROR 0.46s J0 | SpellCheckComponentTest.test <<<
[junit4] > Throwable #1: java.lang.RuntimeException: List size mismatch @ spellcheck/suggestions
[junit4] > at __randomizedtesting.SeedInfo.seed([D5AEBE2285FEAD5F:5DFA81F82B02C0A7]: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.test(SpellCheckComponentTest.java:147)
[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> 1400335 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testPerDictionary
[junit4] 2> 1400335 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[0]} 0 0
[junit4] 2> 1400335 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 1400336 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 1400336 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 1400336 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[4]} 0 0
[junit4] 2> 1400336 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[5]} 0 0
[junit4] 2> 1400337 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[6]} 0 0
[junit4] 2> 1400337 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[7]} 0 0
[junit4] 2> 1400337 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[8]} 0 0
[junit4] 2> 1400339 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[9]} 0 2
[junit4] 2> 1400340 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1400340 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@159b251
[junit4] 2> 1400341 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@83c86d[collection1] main]
[junit4] 2> 1400341 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1400342 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 1400503 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 1400574 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 1400737 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 1400737 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 1400901 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 1401483 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 1401654 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@83c86d[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(7.0.0):C10)))}
[junit4] 2> 1401654 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 1314
[junit4] 2> 1401655 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=documemt&qt=spellCheckCompRH&spellcheck.dictionary=perDict&json.nl=map&spellcheck..perDict.foo=bar&spellcheck=true&spellcheck..perDict.bar=foo&wt=xml&spellcheck.build=true} hits=0 status=0 QTime=0
[junit4] 2> 1401656 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testPerDictionary
[junit4] 2> 1401656 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 1401656 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{deleteByQuery=*:*} 0 0
[junit4] 2> 1401656 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1401656 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@159b251
[junit4] 2> 1401656 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@15a61eb[collection1] main]
[junit4] 2> 1401656 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1401656 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 1401705 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 1401750 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 1401845 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 1401845 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 1401905 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 1401988 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 1402079 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@15a61eb[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1402079 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 423
[junit4] 2> 1402081 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testReloadOnStart
[junit4] 2> 1402082 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[0]} 0 0
[junit4] 2> 1402082 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 1402082 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 1402082 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 1402083 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[4]} 0 0
[junit4] 2> 1402083 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[5]} 0 0
[junit4] 2> 1402083 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[6]} 0 0
[junit4] 2> 1402083 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[7]} 0 0
[junit4] 2> 1402083 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[8]} 0 0
[junit4] 2> 1402085 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[9]} 0 1
[junit4] 2> 1402085 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1402085 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@159b251
[junit4] 2> 1402085 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1012d3[collection1] main]
[junit4] 2> 1402086 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1402086 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 1402257 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 1402315 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 1402480 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 1402480 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 1402662 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 1402863 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 1403031 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1012d3[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(7.0.0):C10)))}
[junit4] 2> 1403031 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 946
[junit4] 2> 1403031 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[0]} 0 0
[junit4] 2> 1403032 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1403032 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@159b251
[junit4] 2> 1403034 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1fa7321[collection1] main]
[junit4] 2> 1403034 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1403034 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 1403187 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 1403239 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 1403419 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 1403419 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 1403592 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 1403729 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 1403882 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1fa7321[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(7.0.0):C10/1:delGen=1) Uninverting(_3(7.0.0):C1)))}
[junit4] 2> 1403883 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 851
[junit4] 2> 1404068 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[D5AEBE2285FEAD5F]) [ ] 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> 1404069 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 1404076 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testReloadOnStart
[junit4] 2> 1404076 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 1404076 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{deleteByQuery=*:*} 0 0
[junit4] 2> 1404076 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1404076 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@159b251
[junit4] 2> 1404077 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@39357c[collection1] main]
[junit4] 2> 1404077 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1404077 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 1404137 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 1404216 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 1404272 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 1404272 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 1404340 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 1404404 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 1404486 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@39357c[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1404487 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 410
[junit4] 2> 1404491 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testRelativeIndexDirLocation
[junit4] 2> 1404492 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[0]} 0 0
[junit4] 2> 1404492 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 1404493 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 1404493 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 1404493 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[4]} 0 0
[junit4] 2> 1404493 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[5]} 0 0
[junit4] 2> 1404494 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[6]} 0 0
[junit4] 2> 1404494 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[7]} 0 0
[junit4] 2> 1404494 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[8]} 0 0
[junit4] 2> 1404496 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[9]} 0 1
[junit4] 2> 1404496 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1404496 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@159b251
[junit4] 2> 1404497 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1ef8ab5[collection1] main]
[junit4] 2> 1404497 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1404497 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 1404665 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 1404729 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 1404915 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 1404915 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 1405023 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 1405197 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 1405386 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1ef8ab5[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(7.0.0):C10)))}
[junit4] 2> 1405386 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 890
[junit4] 2> 1405387 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testRelativeIndexDirLocation
[junit4] 2> 1405388 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 1405388 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{deleteByQuery=*:*} 0 0
[junit4] 2> 1405388 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1405388 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@159b251
[junit4] 2> 1405388 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@6cb1fd[collection1] main]
[junit4] 2> 1405388 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1405388 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 1405449 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 1405517 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 1405598 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 1405598 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 1405665 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 1405719 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 1405794 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@6cb1fd[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1405794 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 406
[junit4] 2> 1405796 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testRebuildOnCommit
[junit4] 2> 1405797 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[0]} 0 0
[junit4] 2> 1405797 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 1405798 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 1405798 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 1405799 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[4]} 0 0
[junit4] 2> 1405799 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[5]} 0 0
[junit4] 2> 1405800 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[6]} 0 0
[junit4] 2> 1405800 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[7]} 0 0
[junit4] 2> 1405800 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[8]} 0 0
[junit4] 2> 1405802 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[9]} 0 1
[junit4] 2> 1405802 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1405802 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@159b251
[junit4] 2> 1405803 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@e2f222[collection1] main]
[junit4] 2> 1405803 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 1405803 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1405981 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 1406034 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 1406204 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 1406204 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 1406398 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 1406582 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 1406749 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@e2f222[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_5(7.0.0):C10)))}
[junit4] 2> 1406749 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 947
[junit4] 2> 1406750 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D5AEBE2285FEAD5F]) [ ] 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> 1406751 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[11231]} 0 0
[junit4] 2> 1406751 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1406751 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@159b251
[junit4] 2> 1406756 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@16a2dba[collection1] main]
[junit4] 2> 1406756 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1406756 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 1406911 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 1406952 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 1407108 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 1407108 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 1407304 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 1407504 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 1407687 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@16a2dba[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_5(7.0.0):C10) Uninverting(_6(7.0.0):C1)))}
[junit4] 2> 1407687 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 936
[junit4] 2> 1407689 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D5AEBE2285FEAD5F]) [ ] 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=939
[junit4] 2> 1407689 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testRebuildOnCommit
[junit4] 2> 1407689 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 1407689 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{deleteByQuery=*:*} 0 0
[junit4] 2> 1407689 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1407690 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@159b251
[junit4] 2> 1407690 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@f368f3[collection1] main]
[junit4] 2> 1407690 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 1407690 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1407750 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 1407793 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 1407859 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 1407859 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 1407914 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 1407984 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 1408065 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@f368f3[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1408065 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 375
[junit4] 2> 1408068 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testNumericQuery
[junit4] 2> 1408068 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[0]} 0 0
[junit4] 2> 1408068 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 1408069 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 1408069 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 1408069 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[4]} 0 0
[junit4] 2> 1408069 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[5]} 0 0
[junit4] 2> 1408070 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[6]} 0 0
[junit4] 2> 1408071 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[7]} 0 0
[junit4] 2> 1408071 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[8]} 0 0
[junit4] 2> 1408073 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[9]} 0 1
[junit4] 2> 1408073 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1408073 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@159b251
[junit4] 2> 1408074 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@d94dc7[collection1] main]
[junit4] 2> 1408075 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 1408075 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1408205 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 1408278 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 1408445 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 1408445 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 1408627 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 1408778 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 1408939 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@d94dc7[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_7(7.0.0):C10)))}
[junit4] 2> 1408939 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 865
[junit4] 2> 1408940 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=12346&qt=spellCheckCompRH&spellcheck=true&wt=xml} hits=0 status=0 QTime=0
[junit4] 2> 1408940 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testNumericQuery
[junit4] 2> 1408940 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 1408940 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{deleteByQuery=*:*} 0 0
[junit4] 2> 1408941 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1408941 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@159b251
[junit4] 2> 1408941 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1c55fe7[collection1] main]
[junit4] 2> 1408941 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 1408941 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1409009 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 1409066 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 1409126 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 1409127 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 1409173 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 1409218 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 1409283 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1c55fe7[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1409283 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 342
[junit4] 2> 1409285 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testMaximumResultsForSuggest
[junit4] 2> 1409286 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[0]} 0 0
[junit4] 2> 1409286 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 1409286 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 1409287 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 1409287 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[4]} 0 0
[junit4] 2> 1409287 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[5]} 0 0
[junit4] 2> 1409287 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[6]} 0 0
[junit4] 2> 1409288 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[7]} 0 0
[junit4] 2> 1409288 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[8]} 0 0
[junit4] 2> 1409291 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[9]} 0 2
[junit4] 2> 1409291 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1409291 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@159b251
[junit4] 2> 1409292 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@20e9ae[collection1] main]
[junit4] 2> 1409292 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 1409294 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1409482 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 1409573 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 1409715 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 1409715 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 1409854 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 1410019 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 1410187 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@20e9ae[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_8(7.0.0):C10)))}
[junit4] 2> 1410187 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 896
[junit4] 2> 1410396 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[D5AEBE2285FEAD5F]) [ ] 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=208
[junit4] 2> 1410608 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[D5AEBE2285FEAD5F]) [ ] 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=211
[junit4] 2> 1410608 ERROR (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[D5AEBE2285FEAD5F]) [ ] 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":211},
[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-10-31T10:26:16.686Z"},
[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-10-31T10:26:16.686Z"},
[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-10-31T10:26:16.686Z"},
[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-10-31T10:26:16.686Z"},
[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-10-31T10:26:16.687Z"},
[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-10-31T10:26:16.684Z"},
[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-10-31T10:26:16.685Z"}]
[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> 1410794 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[D5AEBE2285FEAD5F]) [ ] 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=185
[junit4] 2> 1411020 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[D5AEBE2285FEAD5F]) [ ] 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=225
[junit4] 2> 1411020 ERROR (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[D5AEBE2285FEAD5F]) [ ] 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":225},
[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-10-31T10:26:16.686Z"},
[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-10-31T10:26:16.686Z"},
[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-10-31T10:26:16.686Z"},
[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-10-31T10:26:16.686Z"},
[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-10-31T10:26:16.687Z"},
[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-10-31T10:26:16.684Z"},
[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-10-31T10:26:16.685Z"}]
[junit4] 2> },
[junit4] 2> "spellcheck":{
[junit4] 2> "suggestions":[]}}
[junit4] 2>
[junit4] 2> request = 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
[junit4] 2> 1411298 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=lowerfilt:(this+OR+brwn)&spellcheck.maxResultsForSuggest=.70&qt=spellCheckCompRH&spellcheck=true&fq=id:[0+TO+9]&spellcheck.count=5&wt=xml&spellcheck.build=true&spellcheck.maxResultsForSuggest.fq=id:[0+TO+9]&spellcheck.extendedResults=false} hits=7 status=0 QTime=277
[junit4] 2> 1411467 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=lowerfilt:(this+OR+brwn)&spellcheck.maxResultsForSuggest=.64&qt=spellCheckCompRH&spellcheck=true&fq=id:[0+TO+9]&spellcheck.count=5&wt=xml&spellcheck.build=true&spellcheck.maxResultsForSuggest.fq=lowerfilt:th*&spellcheck.extendedResults=false} hits=7 status=0 QTime=168
[junit4] 2> 1411467 ERROR (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[D5AEBE2285FEAD5F]) [ ] 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-10-31T10:26:16.686Z"},
[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-10-31T10:26:16.686Z"},
[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-10-31T10:26:16.686Z"},
[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-10-31T10:26:16.686Z"},
[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-10-31T10:26:16.687Z"},
[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-10-31T10:26:16.684Z"},
[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-10-31T10:26:16.685Z"}]
[junit4] 2> },
[junit4] 2> "spellcheck":{
[junit4] 2> "suggestions":[]}}
[junit4] 2>
[junit4] 2> request = q=lowerfilt:(this+OR+brwn)&spellcheck.maxResultsForSuggest=.64&qt=spellCheckCompRH&spellcheck=true&fq=id:[0+TO+9]&spellcheck.count=5&wt=xml&spellcheck.build=true&spellcheck.maxResultsForSuggest.fq=lowerfilt:th*&spellcheck.extendedResults=false
[junit4] 2> 1411468 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testMaximumResultsForSuggest
[junit4] 2> 1411468 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 1411468 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{deleteByQuery=*:*} 0 0
[junit4] 2> 1411468 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1411468 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[D5AEBE2285FEAD5F])
[...truncated too long message...]
erExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 1417182 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 1417369 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1c71e86[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_c(7.0.0):C10)))}
[junit4] 2> 1417370 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 1437
[junit4] 2> 1417525 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[D5AEBE2285FEAD5F]) [ ] 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=155
[junit4] 2> 1417526 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[D5AEBE2285FEAD5F]) [ ] 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> 1417527 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[D5AEBE2285FEAD5F]) [ ] 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> 1417527 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[D5AEBE2285FEAD5F]) [ ] 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> 1417527 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testCollate
[junit4] 2> 1417528 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 1417528 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{deleteByQuery=*:*} 0 0
[junit4] 2> 1417528 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1417528 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@159b251
[junit4] 2> 1417528 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@54ae1c[collection1] main]
[junit4] 2> 1417528 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 1417528 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1417589 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 1417662 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 1417735 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 1417735 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 1417810 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 1417879 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 1417951 INFO (searcherExecutor-5439-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@54ae1c[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1417951 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[D5AEBE2285FEAD5F]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 423
[junit4] 2> 1417952 INFO (SUITE-SpellCheckComponentTest-seed#[D5AEBE2285FEAD5F]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> 1417952 INFO (SUITE-SpellCheckComponentTest-seed#[D5AEBE2285FEAD5F]-worker) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=96060
[junit4] 2> 1417952 INFO (coreCloseExecutor-5443-thread-1) [ ] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@1fa77e1
[junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.component.SpellCheckComponentTest_D5AEBE2285FEAD5F-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {start1=PostingsFormat(name=LuceneVarGapDocFreqInterval), range_facet_l_dv=PostingsFormat(name=MockRandom), multiDefault=PostingsFormat(name=Memory doPackFST= false), intDefault=BlockTreeOrds(blocksize=128), range_facet_l=BlockTreeOrds(blocksize=128), lowerfilt1and2=PostingsFormat(name=Memory doPackFST= false), end4=PostingsFormat(name=LuceneVarGapDocFreqInterval), end3=PostingsFormat(name=Memory doPackFST= false), end2=PostingsFormat(name=MockRandom), end1=BlockTreeOrds(blocksize=128), lowerfilt=PostingsFormat(name=Memory doPackFST= false), gram1=BlockTreeOrds(blocksize=128), id=PostingsFormat(name=MockRandom), range_facet_i_dv=BlockTreeOrds(blocksize=128), gram2=PostingsFormat(name=MockRandom), gram3=PostingsFormat(name=Memory doPackFST= false), start3=PostingsFormat(name=MockRandom), gram4=PostingsFormat(name=LuceneVarGapDocFreqInterval), start2=PostingsFormat(name=Memory doPackFST= false), word=BlockTreeOrds(blocksize=128), timestamp=BlockTreeOrds(blocksize=128), start4=BlockTreeOrds(blocksize=128)}, docValues:{range_facet_l_dv=DocValuesFormat(name=Asserting), range_facet_i_dv=DocValuesFormat(name=Direct), timestamp=DocValuesFormat(name=Direct)}, maxPointsInLeafNode=1087, maxMBSortInHeap=7.611696244013812, sim=ClassicSimilarity, locale=he-IL, timezone=America/Guyana
[junit4] 2> NOTE: Linux 4.4.0-42-generic i386/Oracle Corporation 9-ea (32-bit)/cpus=12,threads=1,free=114533584,total=378691584
[junit4] 2> NOTE: All tests run in this JVM: [QueryElevationComponentTest, CursorPagingTest, MultiThreadedOCPTest, TestInitQParser, TestAuthenticationFramework, XsltUpdateRequestHandlerTest, HdfsSyncSliceTest, TestDistributedSearch, BadCopyFieldTest, LeaderInitiatedRecoveryOnCommitTest, AddSchemaFieldsUpdateProcessorFactoryTest, PeerSyncTest, TestSuggestSpellingConverter, MinimalSchemaTest, TestFoldingMultitermQuery, DeleteLastCustomShardedReplicaTest, TestPseudoReturnFields, TestLRUCache, TestRestoreCore, TestStressUserVersions, TestLeaderElectionZkExpiry, TestReplicationHandler, CollectionTooManyReplicasTest, TestXmlQParserPlugin, BasicAuthStandaloneTest, TestMacroExpander, TestCSVLoader, TestSolrCLIRunExample, TestRequestForwarding, TestChildDocTransformer, SecurityConfHandlerTest, TestExceedMaxTermLength, TestFieldCacheVsDocValues, ConcurrentDeleteAndCreateCollectionTest, HdfsUnloadDistributedZkTest, CacheHeaderTest, RecoveryAfterSoftCommitTest, CurrencyFieldOpenExchangeTest, DistributedVersionInfoTest, TestRandomDVFaceting, TestConfigSets, SolrCoreTest, TestFieldCacheSanityChecker, ExplicitHLLTest, ResponseHeaderTest, AsyncCallRequestStatusResponseTest, TestConfigSetsAPIExclusivity, SpellPossibilityIteratorTest, TestExclusionRuleCollectionAccess, ZkNodePropsTest, DistribDocExpirationUpdateProcessorTest, TestCopyFieldCollectionResource, LeaderElectionContextKeyTest, BJQParserTest, TestComplexPhraseQParserPlugin, TestLockTree, ParsingFieldUpdateProcessorsTest, TestSolr4Spatial, DateMathParserTest, TestSolrXml, TestSerializedLuceneMatchVersion, HLLUtilTest, TestMissingGroups, DeleteShardTest, BigEndianAscendingWordDeserializerTest, TestDistributedStatsComponentCardinality, SmileWriterTest, BlockJoinFacetSimpleTest, TestNumericTerms32, CdcrVersionReplicationTest, TestRemoteStreaming, ClusterStateTest, TestJoin, TestEmbeddedSolrServerConstructors, PingRequestHandlerTest, TestFieldTypeCollectionResource, ResponseLogComponentTest, RegexBoostProcessorTest, SpatialHeatmapFacetsTest, TestHdfsBackupRestoreCore, DataDrivenBlockJoinTest, LeaderElectionIntegrationTest, TestBlendedInfixSuggestions, TestReRankQParserPlugin, DistributedDebugComponentTest, TestMinMaxOnMultiValuedField, HdfsChaosMonkeySafeLeaderTest, DefaultValueUpdateProcessorTest, TestNamedUpdateProcessors, TestInitParams, TestQueryWrapperFilter, SimpleMLTQParserTest, SSLMigrationTest, UUIDFieldTest, AnalyticsMergeStrategyTest, TestAtomicUpdateErrorCases, TestSolrDeletionPolicy2, DateRangeFieldTest, TestJmxMonitoredMap, NotRequiredUniqueKeyTest, TestStressLucene, DistributedFacetPivotLargeTest, BasicDistributedZkTest, ChaosMonkeySafeLeaderTest, SyncSliceTest, OpenCloseCoreStressTest, ShardRoutingTest, BasicZkTest, RecoveryZkTest, FullSolrCloudDistribCmdsTest, ClusterStateUpdateTest, TestRandomFaceting, LeaderElectionTest, TestDistributedGrouping, DistributedSpellCheckComponentTest, TestStressVersions, DistributedTermsComponentTest, TestCoreContainer, SimpleFacetsTest, StatsComponentTest, SpellCheckComponentTest]
[junit4] Completed [347/647 (1!)] on J0 in 19.06s, 11 tests, 1 error <<< FAILURES!
[...truncated 50936 lines...]