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/07/03 15:07:46 UTC

[JENKINS] Lucene-Solr-master-MacOSX (64bit/jdk1.8.0) - Build # 3383 - Failure!

Build: http://jenkins.thetaphi.de/job/Lucene-Solr-master-MacOSX/3383/
Java: 64bit/jdk1.8.0 -XX:+UseCompressedOops -XX:+UseSerialGC

1 tests failed.
FAILED:  org.apache.solr.spelling.SpellCheckCollatorTest.testEstimatedHitCounts

Error Message:
Exception during query

Stack Trace:
java.lang.RuntimeException: Exception during query
	at __randomizedtesting.SeedInfo.seed([C8E4ED69726CEF32:F95F535CD753FFE2]:0)
	at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:780)
	at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:747)
	at org.apache.solr.spelling.SpellCheckCollatorTest.testEstimatedHitCounts(SpellCheckCollatorTest.java:562)
	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:1764)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
	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:809)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
	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)
Caused by: java.lang.RuntimeException: REQUEST FAILED: xpath=//lst[@name='spellcheck']/lst[@name='collations']/lst[@name='collation']/int[@name='hits' and 6 <= . and . <= 10]
	xml response was: <?xml version="1.0" encoding="UTF-8"?>
<response>
<lst name="responseHeader"><int name="status">0</int><int name="QTime">2</int></lst><result name="response" numFound="0" start="0"></result><lst name="spellcheck"><lst name="suggestions"><lst name="everother"><int name="numFound">1</int><int name="startOffset">9</int><int name="endOffset">18</int><arr name="suggestion"><str>everyother</str></arr></lst></lst><lst name="collations"><lst name="collation"><str name="collationQuery">teststop:everyother</str><int name="hits">12</int><lst name="misspellingsAndCorrections"><str name="everother">everyother</str></lst></lst></lst></lst>
</response>

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




Build Log:
[...truncated 11263 lines...]
   [junit4] Suite: org.apache.solr.spelling.SpellCheckCollatorTest
   [junit4]   2> Creating dataDir: /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.spelling.SpellCheckCollatorTest_C8E4ED69726CEF32-001/init-core-data-001
   [junit4]   2> 1192316 INFO  (SUITE-SpellCheckCollatorTest-seed#[C8E4ED69726CEF32]-worker) [    ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN) w/ MAC_OS_X supressed clientAuth
   [junit4]   2> 1192316 INFO  (SUITE-SpellCheckCollatorTest-seed#[C8E4ED69726CEF32]-worker) [    ] o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 1192316 INFO  (SUITE-SpellCheckCollatorTest-seed#[C8E4ED69726CEF32]-worker) [    ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/core/src/test-files/solr/collection1'
   [junit4]   2> 1192316 INFO  (SUITE-SpellCheckCollatorTest-seed#[C8E4ED69726CEF32]-worker) [    ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1192316 INFO  (SUITE-SpellCheckCollatorTest-seed#[C8E4ED69726CEF32]-worker) [    ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/core/src/test-files/solr
   [junit4]   2> 1192317 INFO  (SUITE-SpellCheckCollatorTest-seed#[C8E4ED69726CEF32]-worker) [    ] o.a.s.c.SolrResourceLoader Adding 'file:/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
   [junit4]   2> 1192317 INFO  (SUITE-SpellCheckCollatorTest-seed#[C8E4ED69726CEF32]-worker) [    ] o.a.s.c.SolrResourceLoader Adding 'file:/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/core/src/test-files/solr/collection1/lib/README' to classloader
   [junit4]   2> 1192365 INFO  (SUITE-SpellCheckCollatorTest-seed#[C8E4ED69726CEF32]-worker) [    ] o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 1192372 INFO  (SUITE-SpellCheckCollatorTest-seed#[C8E4ED69726CEF32]-worker) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1192382 INFO  (SUITE-SpellCheckCollatorTest-seed#[C8E4ED69726CEF32]-worker) [    ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig-spellcheckcomponent.xml
   [junit4]   2> 1192388 INFO  (SUITE-SpellCheckCollatorTest-seed#[C8E4ED69726CEF32]-worker) [    ] o.a.s.s.IndexSchema [null] Schema name=test
   [junit4]   2> 1192505 INFO  (SUITE-SpellCheckCollatorTest-seed#[C8E4ED69726CEF32]-worker) [    ] o.a.s.s.OpenExchangeRatesOrgProvider Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 1192513 INFO  (SUITE-SpellCheckCollatorTest-seed#[C8E4ED69726CEF32]-worker) [    ] o.a.s.s.IndexSchema default search field in schema is text
   [junit4]   2> 1192514 INFO  (SUITE-SpellCheckCollatorTest-seed#[C8E4ED69726CEF32]-worker) [    ] o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 1192518 INFO  (SUITE-SpellCheckCollatorTest-seed#[C8E4ED69726CEF32]-worker) [    ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 1192519 INFO  (SUITE-SpellCheckCollatorTest-seed#[C8E4ED69726CEF32]-worker) [    ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 1192520 INFO  (SUITE-SpellCheckCollatorTest-seed#[C8E4ED69726CEF32]-worker) [    ] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 1192520 INFO  (SUITE-SpellCheckCollatorTest-seed#[C8E4ED69726CEF32]-worker) [    ] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 1192521 INFO  (SUITE-SpellCheckCollatorTest-seed#[C8E4ED69726CEF32]-worker) [    ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1192521 INFO  (SUITE-SpellCheckCollatorTest-seed#[C8E4ED69726CEF32]-worker) [    ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/core/src/test-files/solr
   [junit4]   2> 1192521 INFO  (SUITE-SpellCheckCollatorTest-seed#[C8E4ED69726CEF32]-worker) [    ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/core/src/test-files/solr'
   [junit4]   2> 1192521 INFO  (SUITE-SpellCheckCollatorTest-seed#[C8E4ED69726CEF32]-worker) [    ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1192521 INFO  (SUITE-SpellCheckCollatorTest-seed#[C8E4ED69726CEF32]-worker) [    ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/core/src/test-files/solr
   [junit4]   2> 1192521 INFO  (SUITE-SpellCheckCollatorTest-seed#[C8E4ED69726CEF32]-worker) [    ] o.a.s.c.CoreContainer New CoreContainer 1581683292
   [junit4]   2> 1192521 INFO  (SUITE-SpellCheckCollatorTest-seed#[C8E4ED69726CEF32]-worker) [    ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/core/src/test-files/solr]
   [junit4]   2> 1192521 WARN  (SUITE-SpellCheckCollatorTest-seed#[C8E4ED69726CEF32]-worker) [    ] o.a.s.c.CoreContainer Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/core/src/test-files/solr/lib to classpath: /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/core/src/test-files/solr/lib
   [junit4]   2> 1192522 INFO  (SUITE-SpellCheckCollatorTest-seed#[C8E4ED69726CEF32]-worker) [    ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 600000,connTimeout : 60000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,
   [junit4]   2> 1192528 INFO  (SUITE-SpellCheckCollatorTest-seed#[C8E4ED69726CEF32]-worker) [    ] o.a.s.u.UpdateShardHandler Created UpdateShardHandler HTTP client with params: socketTimeout=30000&connTimeout=30000&maxConnections=100000&maxConnectionsPerHost=100000
   [junit4]   2> 1192528 INFO  (SUITE-SpellCheckCollatorTest-seed#[C8E4ED69726CEF32]-worker) [    ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 1192528 INFO  (SUITE-SpellCheckCollatorTest-seed#[C8E4ED69726CEF32]-worker) [    ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 1192528 INFO  (SUITE-SpellCheckCollatorTest-seed#[C8E4ED69726CEF32]-worker) [    ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module.
   [junit4]   2> 1192529 INFO  (SUITE-SpellCheckCollatorTest-seed#[C8E4ED69726CEF32]-worker) [    ] o.a.s.c.CoreContainer No authentication plugin used.
   [junit4]   2> 1192530 INFO  (SUITE-SpellCheckCollatorTest-seed#[C8E4ED69726CEF32]-worker) [    ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection1, config=solrconfig-spellcheckcomponent.xml, transient=false, schema=schema.xml, loadOnStartup=true, configSetProperties=configsetprops.json, collection=collection1, dataDir=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.spelling.SpellCheckCollatorTest_C8E4ED69726CEF32-001/init-core-data-001, shard=shard1}
   [junit4]   2> 1192530 INFO  (coreLoadExecutor-3045-thread-1) [    ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/core/src/test-files/solr/collection1'
   [junit4]   2> 1192531 INFO  (coreLoadExecutor-3045-thread-1) [    ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1192531 INFO  (coreLoadExecutor-3045-thread-1) [    ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/core/src/test-files/solr
   [junit4]   2> 1192531 INFO  (coreLoadExecutor-3045-thread-1) [    ] o.a.s.c.SolrResourceLoader Adding 'file:/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
   [junit4]   2> 1192531 INFO  (coreLoadExecutor-3045-thread-1) [    ] o.a.s.c.SolrResourceLoader Adding 'file:/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/core/src/test-files/solr/collection1/lib/README' to classloader
   [junit4]   2> 1192554 INFO  (coreLoadExecutor-3045-thread-1) [    ] o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 1192557 INFO  (coreLoadExecutor-3045-thread-1) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1192580 INFO  (coreLoadExecutor-3045-thread-1) [    ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig-spellcheckcomponent.xml
   [junit4]   2> 1192586 INFO  (coreLoadExecutor-3045-thread-1) [    ] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1192683 INFO  (coreLoadExecutor-3045-thread-1) [    ] o.a.s.s.OpenExchangeRatesOrgProvider Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 1192689 INFO  (coreLoadExecutor-3045-thread-1) [    ] o.a.s.s.IndexSchema default search field in schema is text
   [junit4]   2> 1192691 INFO  (coreLoadExecutor-3045-thread-1) [    ] o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 1192695 INFO  (coreLoadExecutor-3045-thread-1) [    ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 1192697 INFO  (coreLoadExecutor-3045-thread-1) [    ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 1192699 INFO  (coreLoadExecutor-3045-thread-1) [    ] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 1192699 INFO  (coreLoadExecutor-3045-thread-1) [    ] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 1192705 INFO  (coreLoadExecutor-3045-thread-1) [    ] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or '/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/core/src/test-files/solr/collection1'
   [junit4]   2> 1192705 INFO  (coreLoadExecutor-3045-thread-1) [    ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/core/src/test-files/solr/collection1
   [junit4]   2> 1192705 INFO  (coreLoadExecutor-3045-thread-1) [    x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 1192705 INFO  (coreLoadExecutor-3045-thread-1) [    x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/core/src/test-files/solr/collection1], dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.spelling.SpellCheckCollatorTest_C8E4ED69726CEF32-001/init-core-data-001/]
   [junit4]   2> 1192705 INFO  (coreLoadExecutor-3045-thread-1) [    x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core: collection1
   [junit4]   2> 1192706 INFO  (coreLoadExecutor-3045-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.spelling.SpellCheckCollatorTest_C8E4ED69726CEF32-001/init-core-data-001
   [junit4]   2> 1192706 INFO  (coreLoadExecutor-3045-thread-1) [    x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.spelling.SpellCheckCollatorTest_C8E4ED69726CEF32-001/init-core-data-001/index/
   [junit4]   2> 1192706 WARN  (coreLoadExecutor-3045-thread-1) [    x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory '/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.spelling.SpellCheckCollatorTest_C8E4ED69726CEF32-001/init-core-data-001/index' doesn't exist. Creating new index...
   [junit4]   2> 1192706 INFO  (coreLoadExecutor-3045-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.spelling.SpellCheckCollatorTest_C8E4ED69726CEF32-001/init-core-data-001/index
   [junit4]   2> 1192706 INFO  (coreLoadExecutor-3045-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=38, maxMergeAtOnceExplicit=10, maxMergedSegmentMB=73.80859375, floorSegmentMB=1.3271484375, forceMergeDeletesPctAllowed=23.633383694604532, segmentsPerTier=43.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.25810896813405926
   [junit4]   2> 1192707 INFO  (coreLoadExecutor-3045-thread-1) [    x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(RAMDirectory@465f8fd5 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4060a017),segFN=segments_1,generation=1}
   [junit4]   2> 1192707 INFO  (coreLoadExecutor-3045-thread-1) [    x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 1192707 INFO  (OldIndexDirectoryCleanupThreadForCore-collection1) [    x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.spelling.SpellCheckCollatorTest_C8E4ED69726CEF32-001/init-core-data-001/
   [junit4]   2> 1192709 INFO  (coreLoadExecutor-3045-thread-1) [    x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 1192712 INFO  (coreLoadExecutor-3045-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1192713 INFO  (coreLoadExecutor-3045-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1192714 INFO  (coreLoadExecutor-3045-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1192715 INFO  (coreLoadExecutor-3045-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1192716 INFO  (coreLoadExecutor-3045-thread-1) [    x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,spellCheckCompRH,/update/json/docs,/admin/luke,/export,/get,/admin/properties,/update/json,/admin/threads,/update/csv,/sql,/graph,/admin/segments,spellCheckCompRH1,/admin/system,/replication,/config,/stream,/schema,/admin/plugins,/admin/logging,spellCheckWithWordbreak,/admin/ping,/update,/admin/file
   [junit4]   2> 1192716 INFO  (coreLoadExecutor-3045-thread-1) [    x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 1192717 INFO  (coreLoadExecutor-3045-thread-1) [    x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1192717 INFO  (coreLoadExecutor-3045-thread-1) [    x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1192717 INFO  (coreLoadExecutor-3045-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=34, maxMergeAtOnceExplicit=25, maxMergedSegmentMB=64.8564453125, floorSegmentMB=0.8984375, forceMergeDeletesPctAllowed=6.83151220436407, segmentsPerTier=19.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 1192717 INFO  (coreLoadExecutor-3045-thread-1) [    x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(RAMDirectory@465f8fd5 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4060a017),segFN=segments_1,generation=1}
   [junit4]   2> 1192717 INFO  (coreLoadExecutor-3045-thread-1) [    x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 1192717 INFO  (coreLoadExecutor-3045-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1bcbdef1[collection1] main]
   [junit4]   2> 1192717 WARN  (coreLoadExecutor-3045-thread-1) [    x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
   [junit4]   2> 1192718 INFO  (coreLoadExecutor-3045-thread-1) [    x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {}
   [junit4]   2> 1192718 INFO  (coreLoadExecutor-3045-thread-1) [    x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using InMemoryStorage
   [junit4]   2> 1192718 INFO  (coreLoadExecutor-3045-thread-1) [    x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
   [junit4]   2> 1192718 INFO  (coreLoadExecutor-3045-thread-1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1192723 INFO  (coreLoadExecutor-3045-thread-1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: default
   [junit4]   2> 1192728 INFO  (coreLoadExecutor-3045-thread-1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: default_teststop
   [junit4]   2> 1192728 INFO  (coreLoadExecutor-3045-thread-1) [    x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=solr.DirectSolrSpellChecker,minQueryLength=3,maxQueryFrequency=100.0,field=teststop}
   [junit4]   2> 1192728 INFO  (coreLoadExecutor-3045-thread-1) [    x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct_lowerfilt,classname=solr.DirectSolrSpellChecker,minQueryLength=3,maxQueryFrequency=100.0,field=lowerfilt}
   [junit4]   2> 1192747 INFO  (coreLoadExecutor-3045-thread-1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: threshold
   [junit4]   2> 1192747 INFO  (coreLoadExecutor-3045-thread-1) [    x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=threshold_direct,classname=solr.DirectSolrSpellChecker,field=lowerfilt,spellcheckIndexDir=spellcheckerThreshold,buildOnCommit=true,thresholdTokenFrequency=0.29}
   [junit4]   2> 1192747 INFO  (coreLoadExecutor-3045-thread-1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: threshold_direct
   [junit4]   2> 1192763 INFO  (coreLoadExecutor-3045-thread-1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: multipleFields
   [junit4]   2> 1192782 INFO  (coreLoadExecutor-3045-thread-1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: freq
   [junit4]   2> 1192788 INFO  (coreLoadExecutor-3045-thread-1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: fqcn
   [junit4]   2> 1192788 INFO  (coreLoadExecutor-3045-thread-1) [    x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1192788 INFO  (searcherExecutor-3046-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1192789 INFO  (coreLoadExecutor-3045-thread-1) [    x:collection1] o.a.s.c.CoreContainer registering core: collection1
   [junit4]   2> 1192789 INFO  (searcherExecutor-3046-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default_teststop
   [junit4]   2> 1192789 INFO  (searcherExecutor-3046-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1192789 INFO  (searcherExecutor-3046-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct_lowerfilt
   [junit4]   2> 1192789 INFO  (searcherExecutor-3046-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1192789 INFO  (searcherExecutor-3046-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: threshold
   [junit4]   2> 1192790 INFO  (SUITE-SpellCheckCollatorTest-seed#[C8E4ED69726CEF32]-worker) [    ] o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 1192790 INFO  (searcherExecutor-3046-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: threshold_direct
   [junit4]   2> 1192790 INFO  (searcherExecutor-3046-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
   [junit4]   2> 1192790 INFO  (searcherExecutor-3046-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1192792 INFO  (searcherExecutor-3046-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1192792 INFO  (SUITE-SpellCheckCollatorTest-seed#[C8E4ED69726CEF32]-worker) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[0]} 0 1
   [junit4]   2> 1192792 INFO  (searcherExecutor-3046-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1192792 INFO  (searcherExecutor-3046-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 1192793 INFO  (searcherExecutor-3046-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 1192793 INFO  (searcherExecutor-3046-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1bcbdef1[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1192793 INFO  (SUITE-SpellCheckCollatorTest-seed#[C8E4ED69726CEF32]-worker) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[1]} 0 0
   [junit4]   2> 1192797 INFO  (SUITE-SpellCheckCollatorTest-seed#[C8E4ED69726CEF32]-worker) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[2]} 0 3
   [junit4]   2> 1192797 INFO  (SUITE-SpellCheckCollatorTest-seed#[C8E4ED69726CEF32]-worker) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[3]} 0 0
   [junit4]   2> 1192798 INFO  (SUITE-SpellCheckCollatorTest-seed#[C8E4ED69726CEF32]-worker) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[4]} 0 0
   [junit4]   2> 1192801 INFO  (SUITE-SpellCheckCollatorTest-seed#[C8E4ED69726CEF32]-worker) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[5]} 0 2
   [junit4]   2> 1192801 INFO  (SUITE-SpellCheckCollatorTest-seed#[C8E4ED69726CEF32]-worker) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[6]} 0 0
   [junit4]   2> 1192801 INFO  (SUITE-SpellCheckCollatorTest-seed#[C8E4ED69726CEF32]-worker) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[7]} 0 0
   [junit4]   2> 1192803 INFO  (SUITE-SpellCheckCollatorTest-seed#[C8E4ED69726CEF32]-worker) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[8]} 0 1
   [junit4]   2> 1192804 INFO  (SUITE-SpellCheckCollatorTest-seed#[C8E4ED69726CEF32]-worker) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[9]} 0 0
   [junit4]   2> 1192804 INFO  (SUITE-SpellCheckCollatorTest-seed#[C8E4ED69726CEF32]-worker) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[10]} 0 0
   [junit4]   2> 1192806 INFO  (SUITE-SpellCheckCollatorTest-seed#[C8E4ED69726CEF32]-worker) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[11]} 0 1
   [junit4]   2> 1192806 INFO  (SUITE-SpellCheckCollatorTest-seed#[C8E4ED69726CEF32]-worker) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[12]} 0 0
   [junit4]   2> 1192806 INFO  (SUITE-SpellCheckCollatorTest-seed#[C8E4ED69726CEF32]-worker) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[13]} 0 0
   [junit4]   2> 1192808 INFO  (SUITE-SpellCheckCollatorTest-seed#[C8E4ED69726CEF32]-worker) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[14]} 0 1
   [junit4]   2> 1192816 INFO  (SUITE-SpellCheckCollatorTest-seed#[C8E4ED69726CEF32]-worker) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[15]} 0 0
   [junit4]   2> 1192817 INFO  (SUITE-SpellCheckCollatorTest-seed#[C8E4ED69726CEF32]-worker) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[16]} 0 0
   [junit4]   2> 1192817 INFO  (SUITE-SpellCheckCollatorTest-seed#[C8E4ED69726CEF32]-worker) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1192826 INFO  (SUITE-SpellCheckCollatorTest-seed#[C8E4ED69726CEF32]-worker) [    ] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(RAMDirectory@465f8fd5 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4060a017),segFN=segments_1,generation=1}
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(RAMDirectory@465f8fd5 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4060a017),segFN=segments_2,generation=2}
   [junit4]   2> 1192826 INFO  (SUITE-SpellCheckCollatorTest-seed#[C8E4ED69726CEF32]-worker) [    ] o.a.s.c.SolrDeletionPolicy newest commit generation = 2
   [junit4]   2> 1192827 INFO  (SUITE-SpellCheckCollatorTest-seed#[C8E4ED69726CEF32]-worker) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@42d5cc1d[collection1] main]
   [junit4]   2> 1192827 INFO  (SUITE-SpellCheckCollatorTest-seed#[C8E4ED69726CEF32]-worker) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1192827 INFO  (searcherExecutor-3046-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
   [junit4]   2> 1192879 INFO  (searcherExecutor-3046-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
   [junit4]   2> 1192951 INFO  (searcherExecutor-3046-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
   [junit4]   2> 1192958 INFO  (searcherExecutor-3046-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
   [junit4]   2> 1192958 INFO  (searcherExecutor-3046-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
   [junit4]   2> 1192983 INFO  (searcherExecutor-3046-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
   [junit4]   2> 1193016 INFO  (searcherExecutor-3046-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
   [junit4]   2> 1193047 INFO  (searcherExecutor-3046-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@42d5cc1d[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C3) Uninverting(_1(7.0.0):C3) Uninverting(_2(7.0.0):C3) Uninverting(_3(7.0.0):C3) Uninverting(_4(7.0.0):C3) Uninverting(_5(7.0.0):C2)))}
   [junit4]   2> 1193047 INFO  (SUITE-SpellCheckCollatorTest-seed#[C8E4ED69726CEF32]-worker) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 230
   [junit4]   2> 1193049 INFO  (TEST-SpellCheckCollatorTest.testExtendedCollate-seed#[C8E4ED69726CEF32]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testExtendedCollate
   [junit4]   2> 1193124 INFO  (TEST-SpellCheckCollatorTest.testExtendedCollate-seed#[C8E4ED69726CEF32]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testExtendedCollate
   [junit4]   2> 1193127 INFO  (TEST-SpellCheckCollatorTest.testCollateWithGrouping-seed#[C8E4ED69726CEF32]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testCollateWithGrouping
   [junit4]   2> 1193196 INFO  (TEST-SpellCheckCollatorTest.testCollateWithGrouping-seed#[C8E4ED69726CEF32]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testCollateWithGrouping
   [junit4]   2> 1193198 INFO  (TEST-SpellCheckCollatorTest.testCollateWithOverride-seed#[C8E4ED69726CEF32]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testCollateWithOverride
   [junit4]   2> 1193252 INFO  (TEST-SpellCheckCollatorTest.testCollateWithOverride-seed#[C8E4ED69726CEF32]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={mm=1&q=partisian+politcal+mashine&defType=edismax&spellcheck.dictionary=direct&qt=spellCheckCompRH&spellcheck=true&qf=teststop&spellcheck.maxCollations=10&spellcheck.count=10&spellcheck.maxCollationTries=10&wt=xml&spellcheck.collate=true} hits=0 status=0 QTime=53
   [junit4]   2> 1193268 INFO  (TEST-SpellCheckCollatorTest.testCollateWithOverride-seed#[C8E4ED69726CEF32]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={mm=1&spellcheck.dictionary=direct&qt=spellCheckCompRH&spellcheck.maxCollations=10&spellcheck.maxCollationTries=10&q=partisian+politcal+mashine&defType=edismax&spellcheck.collateParam.mm=100%25&spellcheck=true&qf=teststop&spellcheck.count=10&wt=xml&spellcheck.collate=true} hits=0 status=0 QTime=15
   [junit4]   2> 1193268 INFO  (TEST-SpellCheckCollatorTest.testCollateWithOverride-seed#[C8E4ED69726CEF32]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testCollateWithOverride
   [junit4]   2> 1193271 INFO  (TEST-SpellCheckCollatorTest.testZeroTries-seed#[C8E4ED69726CEF32]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testZeroTries
   [junit4]   2> 1193341 INFO  (TEST-SpellCheckCollatorTest.testZeroTries-seed#[C8E4ED69726CEF32]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testZeroTries
   [junit4]   2> 1193343 INFO  (TEST-SpellCheckCollatorTest.testCollateWithFilter-seed#[C8E4ED69726CEF32]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testCollateWithFilter
   [junit4]   2> 1193382 INFO  (TEST-SpellCheckCollatorTest.testCollateWithFilter-seed#[C8E4ED69726CEF32]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testCollateWithFilter
   [junit4]   2> 1193386 INFO  (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[C8E4ED69726CEF32]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testEstimatedHitCounts
   [junit4]   2> 1193389 INFO  (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[C8E4ED69726CEF32]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia} hits=0 status=0 QTime=3
   [junit4]   2> 1193392 INFO  (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[C8E4ED69726CEF32]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=0} hits=0 status=0 QTime=2
   [junit4]   2> 1193395 INFO  (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[C8E4ED69726CEF32]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=30} hits=0 status=0 QTime=2
   [junit4]   2> 1193398 INFO  (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[C8E4ED69726CEF32]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=100} hits=0 status=0 QTime=2
   [junit4]   2> 1193401 INFO  (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[C8E4ED69726CEF32]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=10000} hits=0 status=0 QTime=3
   [junit4]   2> 1193404 INFO  (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[C8E4ED69726CEF32]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=12} hits=0 status=0 QTime=2
   [junit4]   2> 1193411 INFO  (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[C8E4ED69726CEF32]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=17} hits=0 status=0 QTime=2
   [junit4]   2> 1193415 INFO  (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[C8E4ED69726CEF32]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=9} hits=0 status=0 QTime=3
   [junit4]   2> 1193419 INFO  (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[C8E4ED69726CEF32]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=8} hits=0 status=0 QTime=4
   [junit4]   2> 1193422 INFO  (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[C8E4ED69726CEF32]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=14} hits=0 status=0 QTime=1
   [junit4]   2> 1193424 INFO  (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[C8E4ED69726CEF32]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=16} hits=0 status=0 QTime=2
   [junit4]   2> 1193427 INFO  (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[C8E4ED69726CEF32]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=8} hits=0 status=0 QTime=1
   [junit4]   2> 1193429 INFO  (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[C8E4ED69726CEF32]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=10} hits=0 status=0 QTime=1
   [junit4]   2> 1193431 INFO  (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[C8E4ED69726CEF32]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=12} hits=0 status=0 QTime=1
   [junit4]   2> 1193433 INFO  (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[C8E4ED69726CEF32]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=3} hits=0 status=0 QTime=1
   [junit4]   2> 1193436 INFO  (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[C8E4ED69726CEF32]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=5} hits=0 status=0 QTime=2
   [junit4]   2> 1193438 INFO  (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[C8E4ED69726CEF32]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=17} hits=0 status=0 QTime=1
   [junit4]   2> 1193441 INFO  (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[C8E4ED69726CEF32]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:everother&spellcheck.collateMaxCollectDocs=5} hits=0 status=0 QTime=2
   [junit4]   2> 1193441 ERROR (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[C8E4ED69726CEF32]) [    ] o.a.s.SolrTestCaseJ4 REQUEST FAILED: xpath=//lst[@name='spellcheck']/lst[@name='collations']/lst[@name='collation']/int[@name='hits' and 6 <= . and . <= 10]
   [junit4]   2> 	xml response was: <?xml version="1.0" encoding="UTF-8"?>
   [junit4]   2> <response>
   [junit4]   2> <lst name="responseHeader"><int name="status">0</int><int name="QTime">2</int></lst><result name="response" numFound="0" start="0"></result><lst name="spellcheck"><lst name="suggestions"><lst name="everother"><int name="numFound">1</int><int name="startOffset">9</int><int name="endOffset">18</int><arr name="suggestion"><str>everyother</str></arr></lst></lst><lst name="collations"><lst name="collation"><str name="collationQuery">teststop:everyother</str><int name="hits">12</int><lst name="misspellingsAndCorrections"><str name="everother">everyother</str></lst></lst></lst></lst>
   [junit4]   2> </response>
   [junit4]   2> 
   [junit4]   2> 	request was:spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:everother&spellcheck.collateMaxCollectDocs=5
   [junit4]   2> 1193442 ERROR (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[C8E4ED69726CEF32]) [    ] o.a.s.SolrTestCaseJ4 REQUEST FAILED: spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:everother&spellcheck.collateMaxCollectDocs=5:java.lang.RuntimeException: REQUEST FAILED: xpath=//lst[@name='spellcheck']/lst[@name='collations']/lst[@name='collation']/int[@name='hits' and 6 <= . and . <= 10]
   [junit4]   2> 	xml response was: <?xml version="1.0" encoding="UTF-8"?>
   [junit4]   2> <response>
   [junit4]   2> <lst name="responseHeader"><int name="status">0</int><int name="QTime">2</int></lst><result name="response" numFound="0" start="0"></result><lst name="spellcheck"><lst name="suggestions"><lst name="everother"><int name="numFound">1</int><int name="startOffset">9</int><int name="endOffset">18</int><arr name="suggestion"><str>everyother</str></arr></lst></lst><lst name="collations"><lst name="collation"><str name="collationQuery">teststop:everyother</str><int name="hits">12</int><lst name="misspellingsAndCorrections"><str name="everother">everyother</str></lst></lst></lst></lst>
   [junit4]   2> </response>
   [junit4]   2> 
   [junit4]   2> 	request was:spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:everother&spellcheck.collateMaxCollectDocs=5
   [junit4]   2> 	at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:773)
   [junit4]   2> 	at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:747)
   [junit4]   2> 	at org.apache.solr.spelling.SpellCheckCollatorTest.testEstimatedHitCounts(SpellCheckCollatorTest.java:562)
   [junit4]   2> 	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   [junit4]   2> 	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
   [junit4]   2> 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   [junit4]   2> 	at java.lang.reflect.Method.invoke(Method.java:498)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
   [junit4]   2> 	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
   [junit4]   2> 	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
   [junit4]   2> 	at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 
   [junit4]   2> 1193442 INFO  (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[C8E4ED69726CEF32]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testEstimatedHitCounts
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=SpellCheckCollatorTest -Dtests.method=testEstimatedHitCounts -Dtests.seed=C8E4ED69726CEF32 -Dtests.slow=true -Dtests.locale=uk-UA -Dtests.timezone=Mexico/BajaSur -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
   [junit4] ERROR   0.06s J1 | SpellCheckCollatorTest.testEstimatedHitCounts <<<
   [junit4]    > Throwable #1: java.lang.RuntimeException: Exception during query
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([C8E4ED69726CEF32:F95F535CD753FFE2]:0)
   [junit4]    > 	at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:780)
   [junit4]    > 	at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:747)
   [junit4]    > 	at org.apache.solr.spelling.SpellCheckCollatorTest.testEstimatedHitCounts(SpellCheckCollatorTest.java:562)
   [junit4]    > 	at java.lang.Thread.run(Thread.java:745)
   [junit4]    > Caused by: java.lang.RuntimeException: REQUEST FAILED: xpath=//lst[@name='spellcheck']/lst[@name='collations']/lst[@name='collation']/int[@name='hits' and 6 <= . and . <= 10]
   [junit4]    > 	xml response was: <?xml version="1.0" encoding="UTF-8"?>
   [junit4]    > <response>
   [junit4]    > <lst name="responseHeader"><int name="status">0</int><int name="QTime">2</int></lst><result name="response" numFound="0" start="0"></result><lst name="spellcheck"><lst name="suggestions"><lst name="everother"><int name="numFound">1</int><int name="startOffset">9</int><int name="endOffset">18</int><arr name="suggestion"><str>everyother</str></arr></lst></lst><lst name="collations"><lst name="collation"><str name="collationQuery">teststop:everyother</str><int name="hits">12</int><lst name="misspellingsAndCorrections"><str name="everother">everyother</str></lst></lst></lst></lst>
   [junit4]    > </response>
   [junit4]    > 	request was:spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop:everother&spellcheck.collateMaxCollectDocs=5
   [junit4]    > 	at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:773)
   [junit4]    > 	... 41 more
   [junit4]   2> 1193449 INFO  (TEST-SpellCheckCollatorTest.testContextSensitiveCollate-seed#[C8E4ED69726CEF32]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testContextSensitiveCollate
   [junit4]   2> 1193453 INFO  (TEST-SpellCheckCollatorTest.testContextSensitiveCollate-seed#[C8E4ED69726CEF32]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&spellcheck.dictionary=direct&indent=true&spellcheck.maxCollations=1&spellcheck.maxCollationTries=10&spellcheck.alternativeTermCount=5&spellcheck.build=true&spellcheck.extendedResults=true&q=teststop:(flew+AND+form+AND+heathrow)&spellcheck.maxResultsForSuggest=0&spellcheck=true&spellcheck.count=10&wt=xml&spellcheck.collate=true} hits=0 status=0 QTime=4
   [junit4]   2> 1193457 INFO  (TEST-SpellCheckCollatorTest.testContextSensitiveCollate-seed#[C8E4ED69726CEF32]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&spellcheck.dictionary=direct&indent=true&spellcheck.maxCollations=1&spellcheck.maxCollationTries=10&spellcheck.alternativeTermCount=5&spellcheck.extendedResults=true&q=teststop:(june+AND+customs)&spellcheck.maxResultsForSuggest=1&spellcheck=true&spellcheck.count=10&wt=xml&spellcheck.collate=true} hits=1 status=0 QTime=3
   [junit4]   2> 1193458 INFO  (TEST-SpellCheckCollatorTest.testContextSensitiveCollate-seed#[C8E4ED69726CEF32]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={mm=2&q=teststop:(june+customs)&qt=spellCheckCompRH&spellcheck.dictionary=direct&indent=true&spellcheck=true&spellcheck.count=10&spellcheck.alternativeTermCount=0&wt=xml&spellcheck.collate=true} hits=2 status=0 QTime=0
   [junit4]   2> 1193513 INFO  (TEST-SpellCheckCollatorTest.testContextSensitiveCollate-seed#[C8E4ED69726CEF32]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&spellcheck.dictionary=default_teststop&indent=true&spellcheck.maxCollations=1&spellcheck.maxCollationTries=10&spellcheck.alternativeTermCount=5&spellcheck.build=true&spellcheck.extendedResults=true&q=teststop:(flew+AND+form+AND+heathrow)&spellcheck.maxResultsForSuggest=0&spellcheck=true&spellcheck.count=10&wt=xml&spellcheck.collate=true} hits=0 status=0 QTime=53
   [junit4]   2> 1193514 INFO  (TEST-SpellCheckCollatorTest.testContextSensitiveCollate-seed#[C8E4ED69726CEF32]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&spellcheck.dictionary=default_teststop&indent=true&spellcheck.maxCollations=1&spellcheck.maxCollationTries=10&spellcheck.alternativeTermCount=5&spellcheck.extendedResults=true&q=teststop:(june+AND+customs)&spellcheck.maxResultsForSuggest=1&spellcheck=true&spellcheck.count=10&wt=xml&spellcheck.collate=true} hits=1 status=0 QTime=1
   [junit4]   2> 1193516 INFO  (TEST-SpellCheckCollatorTest.testContextSensitiveCollate-seed#[C8E4ED69726CEF32]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={mm=2&q=teststop:(june+customs)&qt=spellCheckCompRH&spellcheck.dictionary=default_teststop&indent=true&spellcheck=true&spellcheck.count=10&spellcheck.alternativeTermCount=0&wt=xml&spellcheck.collate=true} hits=2 status=0 QTime=0
   [junit4]   2> 1193516 INFO  (TEST-SpellCheckCollatorTest.testContextSensitiveCollate-seed#[C8E4ED69726CEF32]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testContextSensitiveCollate
   [junit4]   2> 1193519 INFO  (TEST-SpellCheckCollatorTest.testCollationWithHypens-seed#[C8E4ED69726CEF32]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testCollationWithHypens
   [junit4]   2> 1193629 INFO  (TEST-SpellCheckCollatorTest.testCollationWithHypens-seed#[C8E4ED69726CEF32]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testCollationWithHypens
   [junit4]   2> 1193632 INFO  (TEST-SpellCheckCollatorTest.testCollateWithMultipleRequestHandlers-seed#[C8E4ED69726CEF32]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testCollateWithMultipleRequestHandlers
   [junit4]   2> 1193696 INFO  (TEST-SpellCheckCollatorTest.testCollateWithMultipleRequestHandlers-seed#[C8E4ED69726CEF32]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testCollateWithMultipleRequestHandlers
   [junit4]   2> 1193699 INFO  (TEST-SpellCheckCollatorTest.testCollationWithRangeQuery-seed#[C8E4ED69726CEF32]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testCollationWithRangeQuery
   [junit4]   1> id:[1 TO 10] AND lowerfilt:love
   [junit4]   2> 1193755 INFO  (TEST-SpellCheckCollatorTest.testCollationWithRangeQuery-seed#[C8E4ED69726CEF32]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testCollationWithRangeQuery
   [junit4]   2> 1193758 INFO  (TEST-SpellCheckCollatorTest.testWithCursorMark-seed#[C8E4ED69726CEF32]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testWithCursorMark
   [junit4]   2> 1193813 INFO  (TEST-SpellCheckCollatorTest.testWithCursorMark-seed#[C8E4ED69726CEF32]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testWithCursorMark
   [junit4]   2> 1193813 INFO  (SUITE-SpellCheckCollatorTest-seed#[C8E4ED69726CEF32]-worker) [    ] o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> 1193813 INFO  (SUITE-SpellCheckCollatorTest-seed#[C8E4ED69726CEF32]-worker) [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1581683292
   [junit4]   2> 1193814 INFO  (coreCloseExecutor-3050-thread-1) [    x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@2fdc2be3
   [junit4]   2> 1193814 INFO  (coreCloseExecutor-3050-thread-1) [    x:collection1] o.a.s.u.DirectUpdateHandler2 closing DirectUpdateHandler2{commits=1,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=17,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
   [junit4]   2> 1193815 INFO  (coreCloseExecutor-3050-thread-1) [    x:collection1] o.a.s.u.SolrCoreState Closing SolrCoreState
   [junit4]   2> 1193815 INFO  (coreCloseExecutor-3050-thread-1) [    x:collection1] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 1193815 INFO  (coreCloseExecutor-3050-thread-1) [    x:collection1] o.a.s.u.DefaultSolrCoreState closing IndexWriter with IndexWriterCloser
   [junit4]   2> 1193816 INFO  (coreCloseExecutor-3050-thread-1) [    x:collection1] o.a.s.c.SolrCore [collection1] Closing main searcher on request.
   [junit4]   2> 1193816 INFO  (coreCloseExecutor-3050-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory Closing MockDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 1193816 INFO  (coreCloseExecutor-3050-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory looking to close /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.spelling.SpellCheckCollatorTest_C8E4ED69726CEF32-001/init-core-data-001/index [CachedDir<<refCount=0;path=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.spelling.SpellCheckCollatorTest_C8E4ED69726CEF32-001/init-core-data-001/index;done=false>>]
   [junit4]   2> 1193816 INFO  (coreCloseExecutor-3050-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory, CoreContainer#isShutdown=true
   [junit4]   2> 1193816 INFO  (coreCloseExecutor-3050-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.spelling.SpellCheckCollatorTest_C8E4ED69726CEF32-001/init-core-data-001/index
   [junit4]   2> 1193816 INFO  (coreCloseExecutor-3050-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory looking to close /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.spelling.SpellCheckCollatorTest_C8E4ED69726CEF32-001/init-core-data-001 [CachedDir<<refCount=0;path=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.spelling.SpellCheckCollatorTest_C8E4ED69726CEF32-001/init-core-data-001;done=false>>]
   [junit4]   2> 1193816 INFO  (coreCloseExecutor-3050-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory, CoreContainer#isShutdown=true
   [junit4]   2> 1193816 INFO  (coreCloseExecutor-3050-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.spelling.SpellCheckCollatorTest_C8E4ED69726CEF32-001/init-core-data-001
   [junit4]   2> NOTE: leaving temporary files on disk at: /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.spelling.SpellCheckCollatorTest_C8E4ED69726CEF32-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene62): {start1=PostingsFormat(name=LuceneFixedGap), range_facet_l_dv=PostingsFormat(name=LuceneFixedGap), lowerfilt1=FST50, multiDefault=Lucene50(blocksize=128), teststop=Lucene50(blocksize=128), intDefault=BlockTreeOrds(blocksize=128), range_facet_l=Lucene50(blocksize=128), lowerfilt1and2=Lucene50(blocksize=128), end4=FST50, end3=BlockTreeOrds(blocksize=128), end2=PostingsFormat(name=LuceneFixedGap), end1=Lucene50(blocksize=128), lowerfilt=Lucene50(blocksize=128), gram1=Lucene50(blocksize=128), id=PostingsFormat(name=LuceneFixedGap), range_facet_i_dv=Lucene50(blocksize=128), gram2=PostingsFormat(name=LuceneFixedGap), gram3=BlockTreeOrds(blocksize=128), start3=FST50, gram4=FST50, start2=Lucene50(blocksize=128), word=Lucene50(blocksize=128), timestamp=Lucene50(blocksize=128), start4=BlockTreeOrds(blocksize=128)}, docValues:{range_facet_l_dv=DocValuesFormat(name=Direct), range_facet_i_dv=DocValuesFormat(name=Lucene54), timestamp=DocValuesFormat(name=Lucene54)}, maxPointsInLeafNode=337, maxMBSortInHeap=5.753760132406442, sim=ClassicSimilarity, locale=uk-UA, timezone=Mexico/BajaSur
   [junit4]   2> NOTE: Mac OS X 10.11.5 x86_64/Oracle Corporation 1.8.0_92 (64-bit)/cpus=3,threads=1,free=153898936,total=292798464
   [junit4]   2> NOTE: All tests run in this JVM: [TestCopyFieldCollectionResource, TestFieldCollectionResource, TestNumericTerms64, TestBinaryField, SolrCoreCheckLockOnStartupTest, TestSimpleQParserPlugin, TestSystemIdResolver, BigEndianAscendingWordDeserializerTest, ResponseLogComponentTest, BlobRepositoryCloudTest, TestFastWriter, AddSchemaFieldsUpdateProcessorFactoryTest, FileBasedSpellCheckerTest, TestRealTimeGet, TestStressRecovery, SpellPossibilityIteratorTest, BinaryUpdateRequestHandlerTest, ResponseHeaderTest, SortByFunctionTest, SecurityConfHandlerTest, TestQueryTypes, TestSolrDeletionPolicy2, CoreAdminCreateDiscoverTest, SharedFSAutoReplicaFailoverTest, TestBulkSchemaAPI, BaseCdcrDistributedZkTest, BadIndexSchemaTest, RecoveryAfterSoftCommitTest, TestFieldCacheReopen, HdfsTlogReplayBufferedWhileIndexingTest, OutputWriterTest, TestReloadDeadlock, RuleEngineTest, TestManagedStopFilterFactory, CoreAdminHandlerTest, PluginInfoTest, DeleteInactiveReplicaTest, TestFoldingMultitermQuery, TestLMJelinekMercerSimilarityFactory, MinimalSchemaTest, FieldAnalysisRequestHandlerTest, SolrCloudExampleTest, HdfsNNFailoverTest, TestSolrQueryParser, EchoParamsTest, TestFuzzyAnalyzedSuggestions, TestExclusionRuleCollectionAccess, TestTolerantUpdateProcessorCloud, FacetPivotSmallTest, TestRuleBasedAuthorizationPlugin, HdfsBasicDistributedZkTest, TestConfigOverlay, ZkStateWriterTest, StatsComponentTest, TestAuthorizationFramework, DistributedFacetPivotSmallAdvancedTest, TestSuggestSpellingConverter, TestOnReconnectListenerSupport, HdfsSyncSliceTest, BlockDirectoryTest, TestSchemaManager, ChangedSchemaMergeTest, TestDocTermOrds, TestReload, UniqFieldsUpdateProcessorFactoryTest, TestSolrDynamicMBean, TestRTGBase, TestDynamicFieldCollectionResource, OpenExchangeRatesOrgProviderTest, TestZkChroot, TestSizeLimitedDistributedMap, TestValueSourceCache, TestCloudManagedSchema, ResourceLoaderTest, HighlighterConfigTest, DirectSolrConnectionTest, DocValuesMissingTest, SuggesterWFSTTest, ZkNodePropsTest, SolrCmdDistributorTest, TestAtomicUpdateErrorCases, AsyncCallRequestStatusResponseTest, ConvertedLegacyTest, VMParamsZkACLAndCredentialsProvidersTest, DeleteStatusTest, LeaderElectionIntegrationTest, TestExactStatsCache, SortSpecParsingTest, NotRequiredUniqueKeyTest, TestMiniSolrCloudCluster, TestFileDictionaryLookup, TestRandomFaceting, TestOmitPositions, SpatialRPTFieldTypeTest, TestSchemaNameResource, TestDistributedStatsComponentCardinality, DistributedFacetPivotLargeTest, TestWriterPerf, TestSchemaSimilarityResource, ForceLeaderTest, JavabinLoaderTest, TestConfigReload, TestNRTOpen, LoggingHandlerTest, NumericFieldsTest, SpellCheckCollatorTest]
   [junit4] Completed [245/618 (1!)] on J1 in 1.52s, 11 tests, 1 error <<< FAILURES!

[...truncated 1216 lines...]
BUILD FAILED
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/build.xml:740: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/build.xml:684: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/build.xml:59: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build.xml:233: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/common-build.xml:530: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/lucene/common-build.xml:1427: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/lucene/common-build.xml:984: There were test failures: 618 suites (10 ignored), 2590 tests, 1 error, 124 ignored (73 assumptions) [seed: C8E4ED69726CEF32]

Total time: 80 minutes 56 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
[WARNINGS] Skipping publisher since build result is FAILURE
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any