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 2014/05/10 04:04:35 UTC

[JENKINS] Lucene-Solr-4.x-Linux (32bit/jdk1.8.0_05) - Build # 10158 - Failure!

Build: http://jenkins.thetaphi.de/job/Lucene-Solr-4.x-Linux/10158/
Java: 32bit/jdk1.8.0_05 -server -XX:+UseSerialGC

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

Error Message:
Exception during query

Stack Trace:
java.lang.RuntimeException: Exception during query
	at __randomizedtesting.SeedInfo.seed([2CD6604728AE1B71:1D6DDE728D910BA1]:0)
	at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:704)
	at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:671)
	at org.apache.solr.spelling.SpellCheckCollatorTest.testEstimatedHitCounts(SpellCheckCollatorTest.java:530)
	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:483)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1618)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:827)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:877)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
	at org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:360)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:793)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:453)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:836)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:738)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:772)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:783)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
	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:43)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:360)
	at java.lang.Thread.run(Thread.java:745)
Caused by: java.lang.RuntimeException: REQUEST FAILED: xpath=//lst[@name='spellcheck']/lst[@name='suggestions']/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">4</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 name="collation"><str name="collationQuery">teststop:everyother</str><int name="hits">14</int><lst name="misspellingsAndCorrections"><str name="everother">everyother</str></lst></lst></lst></lst>
</response>

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




Build Log:
[...truncated 11091 lines...]
   [junit4] Suite: org.apache.solr.spelling.SpellCheckCollatorTest
   [junit4]   2> Creating dataDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.spelling.SpellCheckCollatorTest-2CD6604728AE1B71-001/init-core-data-001
   [junit4]   2> 337358 T1304 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl (false) and clientAuth (false)
   [junit4]   2> 337358 T1304 oas.SolrTestCaseJ4.initCore ####initCore
   [junit4]   2> 337358 T1304 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/core/src/test-files/solr/collection1/'
   [junit4]   2> 337359 T1304 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/core/src/test-files/solr/collection1/lib/.svn/' to classloader
   [junit4]   2> 337359 T1304 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
   [junit4]   2> 337359 T1304 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/core/src/test-files/solr/collection1/lib/README' to classloader
   [junit4]   2> 337378 T1304 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_4_9
   [junit4]   2> 337386 T1304 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-spellcheckcomponent.xml
   [junit4]   2> 337387 T1304 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
   [junit4]   2> 337391 T1304 oass.IndexSchema.readSchema [null] Schema name=test
   [junit4]   2> 337482 T1304 oass.ByteField.init WARN ByteField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
   [junit4]   2> 337483 T1304 oass.ShortField.init WARN ShortField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
   [junit4]   2> 337483 T1304 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 337487 T1304 oass.IndexSchema.readSchema default search field in schema is text
   [junit4]   2> 337488 T1304 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 337492 T1304 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 337493 T1304 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 337494 T1304 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 337495 T1304 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
   [junit4]   2> 337495 T1304 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
   [junit4]   2> 337495 T1304 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 337500 T1304 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
   [junit4]   2> 337500 T1304 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
   [junit4]   2> 337500 T1304 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 337501 T1304 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/core/src/test-files/solr
   [junit4]   2> 337501 T1304 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/core/src/test-files/solr/'
   [junit4]   2> 337513 T1304 oasc.CoreContainer.<init> New CoreContainer 27326478
   [junit4]   2> 337514 T1304 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/core/src/test-files/solr/]
   [junit4]   2> 337514 T1304 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
   [junit4]   2> 337514 T1304 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: null
   [junit4]   2> 337514 T1304 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
   [junit4]   2> 337515 T1304 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
   [junit4]   2> 337515 T1304 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
   [junit4]   2> 337515 T1304 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
   [junit4]   2> 337515 T1304 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
   [junit4]   2> 337515 T1304 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
   [junit4]   2> 337516 T1304 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
   [junit4]   2> 337516 T1304 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 337516 T1304 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 337516 T1304 oasc.CoreContainer.load Host Name: 
   [junit4]   2> 337518 T1305 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/core/src/test-files/solr/collection1/'
   [junit4]   2> 337518 T1305 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/core/src/test-files/solr/collection1/lib/.svn/' to classloader
   [junit4]   2> 337518 T1305 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
   [junit4]   2> 337518 T1305 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/core/src/test-files/solr/collection1/lib/README' to classloader
   [junit4]   2> 337533 T1305 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_4_9
   [junit4]   2> 337546 T1305 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-spellcheckcomponent.xml
   [junit4]   2> 337547 T1305 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
   [junit4]   2> 337551 T1305 oass.IndexSchema.readSchema [collection1] Schema name=test
   [junit4]   2> 337645 T1305 oass.ByteField.init WARN ByteField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
   [junit4]   2> 337645 T1305 oass.ShortField.init WARN ShortField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
   [junit4]   2> 337645 T1305 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 337654 T1305 oass.IndexSchema.readSchema default search field in schema is text
   [junit4]   2> 337656 T1305 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 337659 T1305 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 337660 T1305 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 337662 T1305 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 337662 T1305 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
   [junit4]   2> 337662 T1305 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
   [junit4]   2> 337662 T1305 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 337662 T1305 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
   [junit4]   2> 337663 T1305 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
   [junit4]   2> 337663 T1305 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from instancedir /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/core/src/test-files/solr/collection1/
   [junit4]   2> 337663 T1305 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 337663 T1305 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/core/src/test-files/solr/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.spelling.SpellCheckCollatorTest-2CD6604728AE1B71-001/init-core-data-001/
   [junit4]   2> 337663 T1305 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
   [junit4]   2> 337664 T1305 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.spelling.SpellCheckCollatorTest-2CD6604728AE1B71-001/init-core-data-001
   [junit4]   2> 337664 T1305 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.spelling.SpellCheckCollatorTest-2CD6604728AE1B71-001/init-core-data-001/index/
   [junit4]   2> 337664 T1305 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.spelling.SpellCheckCollatorTest-2CD6604728AE1B71-001/init-core-data-001/index' doesn't exist. Creating new index...
   [junit4]   2> 337665 T1305 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.spelling.SpellCheckCollatorTest-2CD6604728AE1B71-001/init-core-data-001/index
   [junit4]   2> 337665 T1305 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=7, maxMergeAtOnceExplicit=8, maxMergedSegmentMB=89.4833984375, floorSegmentMB=1.05078125, forceMergeDeletesPctAllowed=9.277780870039594, segmentsPerTier=37.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 337666 T1305 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@42494c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@165700e),segFN=segments_1,generation=1}
   [junit4]   2> 337666 T1305 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 337666 T1305 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 337667 T1305 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
   [junit4]   2> 337667 T1305 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 337667 T1305 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 337667 T1305 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 337668 T1305 oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 337668 T1305 oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 337668 T1305 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=46, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
   [junit4]   2> 337669 T1305 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@42494c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@165700e),segFN=segments_1,generation=1}
   [junit4]   2> 337669 T1305 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 337669 T1305 oass.SolrIndexSearcher.<init> Opening Searcher@198a92c[collection1] main
   [junit4]   2> 337670 T1305 oasr.ManagedResourceStorage$FileStorageIO.configure File-based storage initialized to use dir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/core/src/test-files/solr/collection1/conf
   [junit4]   2> 337670 T1305 oasr.RestManager.init Initializing RestManager with initArgs: {storageDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/core/src/test-files/solr/collection1/conf/}
   [junit4]   2> 337670 T1305 oasr.ManagedResourceStorage.load Reading _rest_managed.json using file:dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/core/src/test-files/solr/collection1/conf
   [junit4]   2> 337671 T1305 oasr.ManagedResource.reloadFromStorage WARN No stored data found for /rest/managed
   [junit4]   2> 337671 T1305 oasr.ManagedResource.notifyObserversDuringInit WARN No registered observers for /rest/managed
   [junit4]   2> 337671 T1305 oasr.RestManager.init Initializing 0 registered ManagedResources
   [junit4]   2> 337671 T1305 oashc.SpellCheckComponent.inform Initializing spell checkers
   [junit4]   2> 337753 T1305 oashc.SpellCheckComponent.inform Registering newSearcher listener for spellchecker: default
   [junit4]   2> 337756 T1305 oashc.SpellCheckComponent.inform Registering newSearcher listener for spellchecker: default_teststop
   [junit4]   2> 337757 T1305 oass.DirectSolrSpellChecker.init init: {name=direct,classname=solr.DirectSolrSpellChecker,minQueryLength=3,maxQueryFrequency=100.0,field=teststop}
   [junit4]   2> 337757 T1305 oass.DirectSolrSpellChecker.init init: {name=direct_lowerfilt,classname=solr.DirectSolrSpellChecker,minQueryLength=3,maxQueryFrequency=100.0,field=lowerfilt}
   [junit4]   2> 337761 T1305 oashc.SpellCheckComponent.inform Registering newSearcher listener for spellchecker: threshold
   [junit4]   2> 337761 T1305 oass.DirectSolrSpellChecker.init init: {name=threshold_direct,classname=solr.DirectSolrSpellChecker,field=lowerfilt,spellcheckIndexDir=spellcheckerThreshold,buildOnCommit=true,thresholdTokenFrequency=0.29}
   [junit4]   2> 337761 T1305 oashc.SpellCheckComponent.inform Registering newSearcher listener for spellchecker: threshold_direct
   [junit4]   2> 337764 T1305 oashc.SpellCheckComponent.inform Registering newSearcher listener for spellchecker: multipleFields
   [junit4]   2> 337776 T1305 oashc.SpellCheckComponent.inform Registering newSearcher listener for spellchecker: freq
   [junit4]   2> 337778 T1305 oashc.SpellCheckComponent.inform Registering newSearcher listener for spellchecker: fqcn
   [junit4]   2> 337779 T1306 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@198a92c[collection1] main{StandardDirectoryReader(segments_1:1:nrt)}
   [junit4]   2> 337779 T1305 oasc.CoreContainer.registerCore registering core: collection1
   [junit4]   2> 337781 T1304 oas.SolrTestCaseJ4.initCore ####initCore end
   [junit4]   2> ASYNC  NEW_CORE C789 name=collection1 org.apache.solr.core.SolrCore@1874b72
   [junit4]   2> 337782 T1304 C789 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[0]} 0 1
   [junit4]   2> 337786 T1304 C789 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[1]} 0 2
   [junit4]   2> 337787 T1304 C789 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[2]} 0 1
   [junit4]   2> 337789 T1304 C789 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[3]} 0 2
   [junit4]   2> 337790 T1304 C789 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[4]} 0 0
   [junit4]   2> 337792 T1304 C789 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[5]} 0 2
   [junit4]   2> 337793 T1304 C789 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[6]} 0 0
   [junit4]   2> 337795 T1304 C789 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[7]} 0 1
   [junit4]   2> 337796 T1304 C789 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[8]} 0 0
   [junit4]   2> 337798 T1304 C789 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[9]} 0 1
   [junit4]   2> 337799 T1304 C789 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[10]} 0 0
   [junit4]   2> 337801 T1304 C789 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[11]} 0 1
   [junit4]   2> 337802 T1304 C789 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[12]} 0 0
   [junit4]   2> 337804 T1304 C789 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[13]} 0 1
   [junit4]   2> 337805 T1304 C789 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[14]} 0 0
   [junit4]   2> 337807 T1304 C789 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[15]} 0 1
   [junit4]   2> 337808 T1304 C789 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[16]} 0 0
   [junit4]   2> 337809 T1304 C789 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 337818 T1304 C789 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@42494c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@165700e),segFN=segments_1,generation=1}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@42494c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@165700e),segFN=segments_2,generation=2}
   [junit4]   2> 337818 T1304 C789 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
   [junit4]   2> 337820 T1304 C789 oass.SolrIndexSearcher.<init> Opening Searcher@36db44[collection1] main
   [junit4]   2> 337820 T1304 C789 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 337820 T1306 oashc.SpellCheckComponent$SpellCheckerListener.buildSpellIndex Building spell index for spell checker: default
   [junit4]   2> 337856 T1306 oashc.SpellCheckComponent$SpellCheckerListener.buildSpellIndex Building spell index for spell checker: default_teststop
   [junit4]   2> 337907 T1306 oashc.SpellCheckComponent$SpellCheckerListener.buildSpellIndex Building spell index for spell checker: threshold
   [junit4]   2> 337923 T1306 oashc.SpellCheckComponent$SpellCheckerListener.buildSpellIndex Building spell index for spell checker: threshold_direct
   [junit4]   2> 337924 T1306 oashc.SpellCheckComponent$SpellCheckerListener.buildSpellIndex Building spell index for spell checker: multipleFields
   [junit4]   2> 337965 T1306 oashc.SpellCheckComponent$SpellCheckerListener.buildSpellIndex Building spell index for spell checker: freq
   [junit4]   2> 338007 T1306 oashc.SpellCheckComponent$SpellCheckerListener.buildSpellIndex Building spell index for spell checker: fqcn
   [junit4]   2> 338053 T1306 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@36db44[collection1] main{StandardDirectoryReader(segments_2:19:nrt _0(4.9):c2 _1(4.9):c2 _2(4.9):c2 _3(4.9):c2 _4(4.9):c2 _5(4.9):c2 _6(4.9):c2 _7(4.9):c2 _8(4.9):c1)}
   [junit4]   2> 338053 T1304 C789 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 244
   [junit4]   2> 338057 T1304 oas.SolrTestCaseJ4.setUp ###Starting testExtendedCollate
   [junit4]   2> 338146 T1304 oas.SolrTestCaseJ4.tearDown ###Ending testExtendedCollate
   [junit4]   2> 338150 T1304 oas.SolrTestCaseJ4.setUp ###Starting testCollateWithMultipleRequestHandlers
   [junit4]   2> 338208 T1304 oas.SolrTestCaseJ4.tearDown ###Ending testCollateWithMultipleRequestHandlers
   [junit4]   2> 338212 T1304 oas.SolrTestCaseJ4.setUp ###Starting testEstimatedHitCounts
   [junit4]   2> ASYNC  NEW_CORE C790 name=collection1 org.apache.solr.core.SolrCore@1874b72
   [junit4]   2> 338217 T1304 C790 oasc.SolrCore.execute [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%3Ametnoia} hits=0 status=0 QTime=5 
   [junit4]   2> 338223 T1304 C790 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=0} hits=0 status=0 QTime=4 
   [junit4]   2> 338229 T1304 C790 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=30} hits=0 status=0 QTime=5 
   [junit4]   2> 338234 T1304 C790 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=100} hits=0 status=0 QTime=4 
   [junit4]   2> 338239 T1304 C790 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=10000} hits=0 status=0 QTime=4 
   [junit4]   2> 338245 T1304 C790 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=8} hits=0 status=0 QTime=5 
   [junit4]   2> 338251 T1304 C790 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=7} hits=0 status=0 QTime=5 
   [junit4]   2> 338256 T1304 C790 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=13} hits=0 status=0 QTime=4 
   [junit4]   2> 338261 T1304 C790 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=8} hits=0 status=0 QTime=4 
   [junit4]   2> 338266 T1304 C790 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=2} hits=0 status=0 QTime=4 
   [junit4]   2> 338272 T1304 C790 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=12} hits=0 status=0 QTime=5 
   [junit4]   2> 338276 T1304 C790 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=15} hits=0 status=0 QTime=3 
   [junit4]   2> 338281 T1304 C790 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=12} hits=0 status=0 QTime=3 
   [junit4]   2> 338285 T1304 C790 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=17} hits=0 status=0 QTime=3 
   [junit4]   2> 338289 T1304 C790 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=9} hits=0 status=0 QTime=3 
   [junit4]   2> 338293 T1304 C790 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=10} hits=0 status=0 QTime=3 
   [junit4]   2> 338298 T1304 C790 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=4} hits=0 status=0 QTime=4 
   [junit4]   2> ASYNC  NEW_CORE C791 name=collection1 org.apache.solr.core.SolrCore@1874b72
   [junit4]   2> 338311 T1304 C791 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=4} hits=0 status=0 QTime=12 
   [junit4]   2> 338315 T1304 C791 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=9} hits=0 status=0 QTime=3 
   [junit4]   2> 338319 T1304 C791 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=11} hits=0 status=0 QTime=3 
   [junit4]   2> 338323 T1304 C791 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=16} hits=0 status=0 QTime=3 
   [junit4]   2> 338328 T1304 C791 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=1} hits=0 status=0 QTime=4 
   [junit4]   2> 338332 T1304 C791 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=5} hits=0 status=0 QTime=3 
   [junit4]   2> 338336 T1304 C791 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=5} hits=0 status=0 QTime=3 
   [junit4]   2> 338340 T1304 C791 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=3} hits=0 status=0 QTime=3 
   [junit4]   2> 338344 T1304 C791 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=3} hits=0 status=0 QTime=3 
   [junit4]   2> 338348 T1304 C791 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=8} hits=0 status=0 QTime=3 
   [junit4]   2> 338352 T1304 C791 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=6} hits=0 status=0 QTime=3 
   [junit4]   2> 338357 T1304 C791 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=3} hits=0 status=0 QTime=4 
   [junit4]   2> 338361 T1304 C791 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=5} hits=0 status=0 QTime=3 
   [junit4]   2> 338365 T1304 C791 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=17} hits=0 status=0 QTime=3 
   [junit4]   2> 338369 T1304 C791 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=1} hits=0 status=0 QTime=3 
   [junit4]   2> 338373 T1304 C791 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=11} hits=0 status=0 QTime=3 
   [junit4]   2> 338377 T1304 C791 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=5} hits=0 status=0 QTime=3 
   [junit4]   2> 338381 T1304 C791 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=14} hits=0 status=0 QTime=3 
   [junit4]   2> 338385 T1304 C791 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=5} hits=0 status=0 QTime=3 
   [junit4]   2> 338389 T1304 C791 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=17} hits=0 status=0 QTime=3 
   [junit4]   2> 338393 T1304 C791 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=6} hits=0 status=0 QTime=3 
   [junit4]   2> ASYNC  NEW_CORE C792 name=collection1 org.apache.solr.core.SolrCore@1874b72
   [junit4]   2> 338405 T1304 C792 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=7} hits=0 status=0 QTime=11 
   [junit4]   2> 338410 T1304 C792 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=8} hits=0 status=0 QTime=3 
   [junit4]   2> 338414 T1304 C792 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=16} hits=0 status=0 QTime=4 
   [junit4]   2> 338419 T1304 C792 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=5} hits=0 status=0 QTime=4 
   [junit4]   2> 338423 T1304 C792 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=9} hits=0 status=0 QTime=3 
   [junit4]   2> 338427 T1304 C792 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=13} hits=0 status=0 QTime=3 
   [junit4]   2> 338431 T1304 C792 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=14} hits=0 status=0 QTime=3 
   [junit4]   2> 338435 T1304 C792 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=13} hits=0 status=0 QTime=3 
   [junit4]   2> 338440 T1304 C792 oasc.SolrCore.execute [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%3Aeverother&spellcheck.collateMaxCollectDocs=5} hits=0 status=0 QTime=4 
   [junit4]   2> 338441 T1304 oas.SolrTestCaseJ4.assertQ ERROR REQUEST FAILED: xpath=//lst[@name='spellcheck']/lst[@name='suggestions']/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">4</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 name="collation"><str name="collationQuery">teststop:everyother</str><int name="hits">14</int><lst name="misspellingsAndCorrections"><str name="everother">everyother</str></lst></lst></lst></lst>
   [junit4]   2> 	</response>
   [junit4]   2> 	
   [junit4]   2> 		request was:spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop%3Aeverother&spellcheck.collateMaxCollectDocs=5
   [junit4]   2> 338442 T1304 oasc.SolrException.log ERROR 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%3Aeverother&spellcheck.collateMaxCollectDocs=5:java.lang.RuntimeException: REQUEST FAILED: xpath=//lst[@name='spellcheck']/lst[@name='suggestions']/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">4</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 name="collation"><str name="collationQuery">teststop:everyother</str><int name="hits">14</int><lst name="misspellingsAndCorrections"><str name="everother">everyother</str></lst></lst></lst></lst>
   [junit4]   2> 	</response>
   [junit4]   2> 	
   [junit4]   2> 		request was:spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop%3Aeverother&spellcheck.collateMaxCollectDocs=5
   [junit4]   2> 		at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:697)
   [junit4]   2> 		at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:671)
   [junit4]   2> 		at org.apache.solr.spelling.SpellCheckCollatorTest.testEstimatedHitCounts(SpellCheckCollatorTest.java:530)
   [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:483)
   [junit4]   2> 		at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1618)
   [junit4]   2> 		at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:827)
   [junit4]   2> 		at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
   [junit4]   2> 		at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:877)
   [junit4]   2> 		at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
   [junit4]   2> 		at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
   [junit4]   2> 		at org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
   [junit4]   2> 		at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
   [junit4]   2> 		at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
   [junit4]   2> 		at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
   [junit4]   2> 		at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
   [junit4]   2> 		at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
   [junit4]   2> 		at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2> 		at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:360)
   [junit4]   2> 		at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:793)
   [junit4]   2> 		at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:453)
   [junit4]   2> 		at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:836)
   [junit4]   2> 		at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:738)
   [junit4]   2> 		at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:772)
   [junit4]   2> 		at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:783)
   [junit4]   2> 		at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2> 		at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
   [junit4]   2> 		at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
   [junit4]   2> 		at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
   [junit4]   2> 		at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
   [junit4]   2> 		at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
   [junit4]   2> 		at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
   [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:43)
   [junit4]   2> 		at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
   [junit4]   2> 		at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
   [junit4]   2> 		at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
   [junit4]   2> 		at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2> 		at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:360)
   [junit4]   2> 		at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 	
   [junit4]   2> 338443 T1304 oas.SolrTestCaseJ4.tearDown ###Ending testEstimatedHitCounts
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=SpellCheckCollatorTest -Dtests.method=testEstimatedHitCounts -Dtests.seed=2CD6604728AE1B71 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=fr_CH -Dtests.timezone=Pacific/Wake -Dtests.file.encoding=ISO-8859-1
   [junit4] ERROR   0.24s J1 | SpellCheckCollatorTest.testEstimatedHitCounts <<<
   [junit4]    > Throwable #1: java.lang.RuntimeException: Exception during query
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([2CD6604728AE1B71:1D6DDE728D910BA1]:0)
   [junit4]    > 	at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:704)
   [junit4]    > 	at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:671)
   [junit4]    > 	at org.apache.solr.spelling.SpellCheckCollatorTest.testEstimatedHitCounts(SpellCheckCollatorTest.java:530)
   [junit4]    > 	at java.lang.Thread.run(Thread.java:745)
   [junit4]    > Caused by: java.lang.RuntimeException: REQUEST FAILED: xpath=//lst[@name='spellcheck']/lst[@name='suggestions']/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">4</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 name="collation"><str name="collationQuery">teststop:everyother</str><int name="hits">14</int><lst name="misspellingsAndCorrections"><str name="everother">everyother</str></lst></lst></lst></lst>
   [junit4]    > </response>
   [junit4]    > 	request was:spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop%3Aeverother&spellcheck.collateMaxCollectDocs=5
   [junit4]    > 	at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:697)
   [junit4]    > 	... 43 more
   [junit4]   2> 338451 T1304 oas.SolrTestCaseJ4.setUp ###Starting testCollationWithHypens
   [junit4]   2> 338545 T1304 oas.SolrTestCaseJ4.tearDown ###Ending testCollationWithHypens
   [junit4]   2> 338548 T1304 oas.SolrTestCaseJ4.setUp ###Starting testContextSensitiveCollate
   [junit4]   2> 338557 T1304 C792 oasc.SolrCore.execute [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&spellcheck.collate=true} hits=0 status=0 QTime=9 
   [junit4]   2> 338566 T1304 C792 oasc.SolrCore.execute [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&spellcheck.collate=true} hits=1 status=0 QTime=7 
   [junit4]   2> 338569 T1304 C792 oasc.SolrCore.execute [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&spellcheck.collate=true} hits=2 status=0 QTime=1 
   [junit4]   2> 338640 T1304 C792 oasc.SolrCore.execute [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&spellcheck.collate=true} hits=0 status=0 QTime=70 
   [junit4]   2> ASYNC  NEW_CORE C793 name=collection1 org.apache.solr.core.SolrCore@1874b72
   [junit4]   2> 338651 T1304 C793 oasc.SolrCore.execute [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&spellcheck.collate=true} hits=1 status=0 QTime=2 
   [junit4]   2> 338653 T1304 C793 oasc.SolrCore.execute [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&spellcheck.collate=true} hits=2 status=0 QTime=1 
   [junit4]   2> 338654 T1304 oas.SolrTestCaseJ4.tearDown ###Ending testContextSensitiveCollate
   [junit4]   2> 338657 T1304 oas.SolrTestCaseJ4.setUp ###Starting testCollateWithFilter
   [junit4]   2> 338722 T1304 oas.SolrTestCaseJ4.tearDown ###Ending testCollateWithFilter
   [junit4]   2> 338726 T1304 oas.SolrTestCaseJ4.setUp ###Starting testCollateWithOverride
   [junit4]   2> 338748 T1304 C793 oasc.SolrCore.execute [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&spellcheck.collate=true} hits=0 status=0 QTime=21 
   [junit4]   2> 338758 T1304 C793 oasc.SolrCore.execute [collection1] webapp=null path=null params={mm=1&q=partisian+politcal+mashine&defType=edismax&spellcheck.dictionary=direct&qt=spellCheckCompRH&spellcheck.collateParam.mm=100%25&spellcheck=true&qf=teststop&spellcheck.maxCollations=10&spellcheck.count=10&spellcheck.maxCollationTries=10&spellcheck.collate=true} hits=0 status=0 QTime=9 
   [junit4]   2> 338759 T1304 oas.SolrTestCaseJ4.tearDown ###Ending testCollateWithOverride
   [junit4]   2> 338762 T1304 oas.SolrTestCaseJ4.setUp ###Starting testCollateWithGrouping
   [junit4]   2> 338837 T1304 oas.SolrTestCaseJ4.tearDown ###Ending testCollateWithGrouping
   [junit4]   2> 338839 T1304 oas.SolrTestCaseJ4.deleteCore ###deleteCore
   [junit4]   2> 338839 T1304 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=27326478
   [junit4]   2> 338839 T1304 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@1874b72
   [junit4]   2> 338840 T1304 oasu.DirectUpdateHandler2.close 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> 338840 T1304 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
   [junit4]   2> 338840 T1304 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 338841 T1304 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
   [junit4]   2> 338841 T1304 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
   [junit4]   2> 338841 T1304 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 338842 T1304 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.spelling.SpellCheckCollatorTest-2CD6604728AE1B71-001/init-core-data-001/index [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.spelling.SpellCheckCollatorTest-2CD6604728AE1B71-001/init-core-data-001/index;done=false>>]
   [junit4]   2> 338842 T1304 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.spelling.SpellCheckCollatorTest-2CD6604728AE1B71-001/init-core-data-001/index
   [junit4]   2> 338842 T1304 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.spelling.SpellCheckCollatorTest-2CD6604728AE1B71-001/init-core-data-001 [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.spelling.SpellCheckCollatorTest-2CD6604728AE1B71-001/init-core-data-001;done=false>>]
   [junit4]   2> 338843 T1304 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.spelling.SpellCheckCollatorTest-2CD6604728AE1B71-001/init-core-data-001
   [junit4]   2> NOTE: leaving temporary files on disk at: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.spelling.SpellCheckCollatorTest-2CD6604728AE1B71-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene46), sim=DefaultSimilarity, locale=fr_CH, timezone=Pacific/Wake
   [junit4]   2> NOTE: Linux 3.8.0-39-generic i386/Oracle Corporation 1.8.0_05 (32-bit)/cpus=8,threads=1,free=76976128,total=168296448
   [junit4]   2> NOTE: All tests run in this JVM: [DistribDocExpirationUpdateProcessorTest, TestSweetSpotSimilarityFactory, TestIndexingPerformance, TestReload, TestSolr4Spatial, TestDFRSimilarityFactory, ZkSolrClientTest, TestAtomicUpdateErrorCases, DeleteShardTest, TestRandomFaceting, ConvertedLegacyTest, TestBinaryField, NotRequiredUniqueKeyTest, TestLazyCores, TestAnalyzedSuggestions, DocValuesMultiTest, JSONWriterTest, TestMultiCoreConfBootstrap, MinimalSchemaTest, NumericFieldsTest, TestHighFrequencyDictionaryFactory, DeleteReplicaTest, SolrIndexConfigTest, TestReloadAndDeleteDocs, ChaosMonkeyNothingIsSafeTest, TestFuzzyAnalyzedSuggestions, SolrTestCaseJ4Test, HdfsWriteToMultipleCollectionsTest, TestInfoStreamLogging, TestStressReorder, TestCollationKeyRangeQueries, SolrRequestParserTest, TestHashPartitioner, TestOverriddenPrefixQueryForCustomFieldType, DebugComponentTest, TestAnalyzeInfixSuggestions, SpellCheckComponentTest, TestUniqueKeyFieldResource, TestSolrCoreProperties, TestDistributedGrouping, PreAnalyzedFieldTest, NoCacheHeaderTest, TestFastLRUCache, PrimUtilsTest, TestArbitraryIndexDir, TestFoldingMultitermQuery, SpellCheckCollatorTest]
   [junit4] Completed on J1 in 1.50s, 8 tests, 1 error <<< FAILURES!

[...truncated 907 lines...]
BUILD FAILED
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:467: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:447: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:45: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/extra-targets.xml:37: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build.xml:189: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/common-build.xml:496: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/common-build.xml:1297: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/common-build.xml:921: There were test failures: 390 suites, 1635 tests, 1 error, 38 ignored (17 assumptions)

Total time: 58 minutes 53 seconds
Build step 'Invoke Ant' marked build as failure
Description set: Java: 32bit/jdk1.8.0_05 -server -XX:+UseSerialGC
Archiving artifacts
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure



[JENKINS] Lucene-Solr-4.x-Linux (64bit/jdk1.7.0_55) - Build # 10159 - Still Failing!

Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-4.x-Linux/10159/
Java: 64bit/jdk1.7.0_55 -XX:-UseCompressedOops -XX:+UseConcMarkSweepGC

1 tests failed.
FAILED:  org.apache.solr.morphlines.cell.SolrCellMorphlineTest.testSolrCellDocumentTypes

Error Message:
key:ignored__attachment_mimetype expected:<[message/rfc822]> but was:<[text/plain]>

Stack Trace:
java.lang.AssertionError: key:ignored__attachment_mimetype expected:<[message/rfc822]> but was:<[text/plain]>
	at __randomizedtesting.SeedInfo.seed([7CE576EB875CD620:E626D575E28788F5]: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.apache.solr.morphlines.solr.AbstractSolrMorphlineTestBase.testDocumentTypesInternal(AbstractSolrMorphlineTestBase.java:170)
	at org.apache.solr.morphlines.cell.SolrCellMorphlineTest.testSolrCellDocumentTypes(SolrCellMorphlineTest.java:193)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1618)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:827)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:877)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
	at org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:360)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:793)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:453)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:836)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:738)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:772)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:783)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
	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:43)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:360)
	at java.lang.Thread.run(Thread.java:745)




Build Log:
[...truncated 18996 lines...]
   [junit4] Suite: org.apache.solr.morphlines.cell.SolrCellMorphlineTest
   [junit4]   2> log4j:WARN No such property [conversionPattern] in org.apache.solr.util.SolrLogLayout.
   [junit4]   2> Creating dataDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/contrib/solr-morphlines-cell/test/J0/./solr.morphlines.cell.SolrCellMorphlineTest-7CE576EB875CD620-001/init-core-data-001
   [junit4]   2> 816 T11 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl (true) and clientAuth (false)
   [junit4]   2> 847 T11 oas.SolrTestCaseJ4.initCore ####initCore
   [junit4]   2> 886 T11 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/'
   [junit4]   2> 1494 T11 oasc.SolrConfig.initLibs Adding specified lib dirs to ClassLoader
   [junit4]   2> 1496 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/extraction/lib (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/extraction/lib).
   [junit4]   2> 1497 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
   [junit4]   2> 1498 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/clustering/lib/ (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/clustering/lib).
   [junit4]   2> 1499 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
   [junit4]   2> 1500 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/langid/lib/ (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/langid/lib).
   [junit4]   2> 1501 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
   [junit4]   2> 1502 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/velocity/lib (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/velocity/lib).
   [junit4]   2> 1503 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
   [junit4]   2> 1504 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: /non/existent/dir/yields/warning (resolved as: /non/existent/dir/yields/warning).
   [junit4]   2> 1665 T11 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_4_9
   [junit4]   2> 1921 T11 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 1929 T11 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
   [junit4]   2> 2033 T11 oass.IndexSchema.readSchema [null] Schema name=example
   [junit4]   2> 2228 T11 oasc.SolrResourceLoader.findClass WARN Solr loaded a deprecated plugin/analysis class [solr.IntField]. Please consult documentation how to replace it accordingly.
   [junit4]   2> 2250 T11 oasc.SolrResourceLoader.findClass WARN Solr loaded a deprecated plugin/analysis class [solr.LongField]. Please consult documentation how to replace it accordingly.
   [junit4]   2> 2263 T11 oasc.SolrResourceLoader.findClass WARN Solr loaded a deprecated plugin/analysis class [solr.FloatField]. Please consult documentation how to replace it accordingly.
   [junit4]   2> 2278 T11 oasc.SolrResourceLoader.findClass WARN Solr loaded a deprecated plugin/analysis class [solr.DoubleField]. Please consult documentation how to replace it accordingly.
   [junit4]   2> 2288 T11 oasc.SolrResourceLoader.findClass WARN Solr loaded a deprecated plugin/analysis class [solr.DateField]. Please consult documentation how to replace it accordingly.
   [junit4]   2> 2941 T11 oasc.SolrResourceLoader.findClass WARN Solr loaded a deprecated plugin/analysis class [solr.ThaiWordFilterFactory]. Please consult documentation how to replace it accordingly.
   [junit4]   2> 2986 T11 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 3155 T11 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 3167 T11 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 3347 T11 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 3347 T11 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr
   [junit4]   2> 3348 T11 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/'
   [junit4]   2> 3470 T11 oasc.CoreContainer.<init> New CoreContainer 1384313712
   [junit4]   2> 3471 T11 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/]
   [junit4]   2> 3489 T11 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
   [junit4]   2> 3490 T11 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: null
   [junit4]   2> 3496 T11 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
   [junit4]   2> 3497 T11 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
   [junit4]   2> 3498 T11 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
   [junit4]   2> 3499 T11 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
   [junit4]   2> 3499 T11 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
   [junit4]   2> 3500 T11 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
   [junit4]   2> 3501 T11 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
   [junit4]   2> 3738 T11 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 3740 T11 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 3747 T11 oasc.CoreContainer.load Host Name: 
   [junit4]   2> 3846 T12 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/'
   [junit4]   2> 3926 T12 oasc.SolrConfig.initLibs Adding specified lib dirs to ClassLoader
   [junit4]   2> 3928 T12 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/extraction/lib (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/extraction/lib).
   [junit4]   2> 3930 T12 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
   [junit4]   2> 3932 T12 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/clustering/lib/ (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/clustering/lib).
   [junit4]   2> 3933 T12 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
   [junit4]   2> 3935 T12 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/langid/lib/ (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/langid/lib).
   [junit4]   2> 3935 T12 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
   [junit4]   2> 3936 T12 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/velocity/lib (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/velocity/lib).
   [junit4]   2> 3937 T12 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
   [junit4]   2> 3938 T12 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: /non/existent/dir/yields/warning (resolved as: /non/existent/dir/yields/warning).
   [junit4]   2> 4028 T12 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_4_9
   [junit4]   2> 4115 T12 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 4116 T12 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
   [junit4]   2> 4187 T12 oass.IndexSchema.readSchema [collection1] Schema name=example
   [junit4]   2> 4769 T12 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 4811 T12 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 4819 T12 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 4886 T12 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from instancedir /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/
   [junit4]   2> 4914 T12 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 4923 T12 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/contrib/solr-morphlines-cell/test/J0/./solr.morphlines.cell.SolrCellMorphlineTest-7CE576EB875CD620-001/init-core-data-001/
   [junit4]   2> 4925 T12 oasc.JmxMonitoredMap.<init> No JMX servers found, not exposing Solr information with JMX.
   [junit4]   2> 4937 T12 oasc.SolrCore.initListeners [collection1] Added SolrEventListener for newSearcher: org.apache.solr.core.QuerySenderListener{queries=[]}
   [junit4]   2> 4938 T12 oasc.SolrCore.initListeners [collection1] Added SolrEventListener for firstSearcher: org.apache.solr.core.QuerySenderListener{queries=[{q=static firstSearcher warming in solrconfig.xml}]}
   [junit4]   2> 4963 T12 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/contrib/solr-morphlines-cell/test/J0/./solr.morphlines.cell.SolrCellMorphlineTest-7CE576EB875CD620-001/init-core-data-001
   [junit4]   2> 4963 T12 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/contrib/solr-morphlines-cell/test/J0/./solr.morphlines.cell.SolrCellMorphlineTest-7CE576EB875CD620-001/init-core-data-001/index/
   [junit4]   2> 4964 T12 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/contrib/solr-morphlines-cell/test/J0/./solr.morphlines.cell.SolrCellMorphlineTest-7CE576EB875CD620-001/init-core-data-001/index' doesn't exist. Creating new index...
   [junit4]   2> 4978 T12 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/contrib/solr-morphlines-cell/test/J0/./solr.morphlines.cell.SolrCellMorphlineTest-7CE576EB875CD620-001/init-core-data-001/index
   [junit4]   2> 5021 T12 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@cfa9dbf lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/contrib/solr-morphlines-cell/test/J0/./solr.morphlines.cell.SolrCellMorphlineTest-7CE576EB875CD620-001/init-core-data-001/index),segFN=segments_1,generation=1}
   [junit4]   2> 5022 T12 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 5032 T12 oasc.SolrCore.initWriters created json: solr.JSONResponseWriter
   [junit4]   2> 5032 T12 oasc.SolrCore.initWriters adding lazy queryResponseWriter: solr.VelocityResponseWriter
   [junit4]   2> 5034 T12 oasc.SolrCore.initWriters created velocity: solr.VelocityResponseWriter
   [junit4]   2> 5043 T12 oasc.SolrCore.initWriters created xslt: solr.XSLTResponseWriter
   [junit4]   2> 5044 T12 oasr.XSLTResponseWriter.init xsltCacheLifetimeSeconds=5
   [junit4]   2> 5274 T12 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 5296 T12 oasc.RequestHandlers.initHandlersFromConfig created /select: solr.SearchHandler
   [junit4]   2> 5297 T12 oasc.RequestHandlers.initHandlersFromConfig created /query: solr.SearchHandler
   [junit4]   2> 5301 T12 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
   [junit4]   2> 5302 T12 oasc.RequestHandlers.initHandlersFromConfig created /browse: solr.SearchHandler
   [junit4]   2> 5309 T12 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
   [junit4]   2> 5314 T12 oasc.SolrResourceLoader.findClass WARN Solr loaded a deprecated plugin/analysis class [solr.JsonUpdateRequestHandler]. Please consult documentation how to replace it accordingly.
   [junit4]   2> 5314 T12 oasc.RequestHandlers.initHandlersFromConfig created /update/json: solr.JsonUpdateRequestHandler
   [junit4]   2> 5319 T12 oasc.SolrResourceLoader.findClass WARN Solr loaded a deprecated plugin/analysis class [solr.CSVRequestHandler]. Please consult documentation how to replace it accordingly.
   [junit4]   2> 5320 T12 oasc.RequestHandlers.initHandlersFromConfig created /update/csv: solr.CSVRequestHandler
   [junit4]   2> 5320 T12 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.FieldAnalysisRequestHandler
   [junit4]   2> 5321 T12 oasc.RequestHandlers.initHandlersFromConfig created /analysis/field: solr.FieldAnalysisRequestHandler
   [junit4]   2> 5322 T12 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.DocumentAnalysisRequestHandler
   [junit4]   2> 5322 T12 oasc.RequestHandlers.initHandlersFromConfig created /analysis/document: solr.DocumentAnalysisRequestHandler
   [junit4]   2> 5328 T12 oasc.RequestHandlers.initHandlersFromConfig created /admin/: solr.admin.AdminHandlers
   [junit4]   2> 5333 T12 oasc.RequestHandlers.initHandlersFromConfig created /admin/ping: solr.PingRequestHandler
   [junit4]   2> 5338 T12 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
   [junit4]   2> 5351 T12 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
   [junit4]   2> 5352 T12 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.SearchHandler
   [junit4]   2> 5352 T12 oasc.RequestHandlers.initHandlersFromConfig created /spell: solr.SearchHandler
   [junit4]   2> 5352 T12 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.SearchHandler
   [junit4]   2> 5353 T12 oasc.RequestHandlers.initHandlersFromConfig created /tvrh: solr.SearchHandler
   [junit4]   2> 5353 T12 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.SearchHandler
   [junit4]   2> 5354 T12 oasc.RequestHandlers.initHandlersFromConfig created /terms: solr.SearchHandler
   [junit4]   2> 5354 T12 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.SearchHandler
   [junit4]   2> 5354 T12 oasc.RequestHandlers.initHandlersFromConfig created /elevate: solr.SearchHandler
   [junit4]   2> 5386 T12 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 5390 T12 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 5391 T12 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 5416 T12 oasu.CommitTracker.<init> Hard AutoCommit: if uncommited for 60000ms; 
   [junit4]   2> 5417 T12 oasu.CommitTracker.<init> Soft AutoCommit: if uncommited for 1000ms; 
   [junit4]   2> 5419 T12 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@cfa9dbf lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/contrib/solr-morphlines-cell/test/J0/./solr.morphlines.cell.SolrCellMorphlineTest-7CE576EB875CD620-001/init-core-data-001/index),segFN=segments_1,generation=1}
   [junit4]   2> 5420 T12 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 5432 T12 oass.SolrIndexSearcher.<init> Opening Searcher@188ef927[collection1] main
   [junit4]   2> 5446 T12 oasr.ManagedResourceStorage$FileStorageIO.configure File-based storage initialized to use dir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/conf
   [junit4]   2> 5447 T12 oasr.RestManager.init Initializing RestManager with initArgs: {storageDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/conf/}
   [junit4]   2> 5466 T12 oasr.ManagedResourceStorage.load Reading _rest_managed.json using file:dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/conf
   [junit4]   2> 5467 T12 oasr.ManagedResource.reloadFromStorage WARN No stored data found for /rest/managed
   [junit4]   2> 5467 T12 oasr.ManagedResource.notifyObserversDuringInit WARN No registered observers for /rest/managed
   [junit4]   2> 5468 T12 oasr.RestManager.init Initializing 0 registered ManagedResources
   [junit4]   2> 5468 T12 oashc.SpellCheckComponent.inform Initializing spell checkers
   [junit4]   2> 5499 T12 oass.DirectSolrSpellChecker.init init: {name=default,field=name,classname=solr.DirectSolrSpellChecker,distanceMeasure=internal,accuracy=0.5,maxEdits=2,minPrefix=1,maxInspections=5,minQueryLength=4,maxQueryFrequency=0.01}
   [junit4]   2> 5517 T12 oashc.SpellCheckComponent.inform No queryConverter defined, using default converter
   [junit4]   2> 5522 T12 oashc.QueryElevationComponent.inform Loading QueryElevation from: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/conf/elevate.xml
   [junit4]   2> 5590 T12 oash.ReplicationHandler.inform Commits will be reserved for  10000
   [junit4]   2> 5591 T13 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@188ef927[collection1] main{StandardDirectoryReader(segments_1:1:nrt)}
   [junit4]   2> 5592 T12 oasc.CoreContainer.registerCore registering core: collection1
   [junit4]   2> 5600 T11 oas.SolrTestCaseJ4.initCore ####initCore end
   [junit4]   2> 5630 T11 oas.SolrTestCaseJ4.setUp ###Starting testSolrCellDocumentTypes2
   [junit4]   2> ASYNC  NEW_CORE C0 name=collection1 org.apache.solr.core.SolrCore@7de8b042
   [junit4]   2> 5677 T13 C0 oasc.SolrCore.execute [collection1] webapp=null path=null params={distrib=false&q=static+firstSearcher+warming+in+solrconfig.xml&event=firstSearcher} hits=0 status=0 QTime=81 
   [junit4]   2> 5679 T13 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
   [junit4]   2> 5680 T13 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: default
   [junit4]   2> 5680 T13 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: wordbreak
   [junit4]   2> 5681 T13 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@188ef927[collection1] main{StandardDirectoryReader(segments_1:1:nrt)}
   [junit4]   2> 5792 T11 C0 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {deleteByQuery=*:* (-1467690010578780160)} 0 148
   [junit4]   2> 5796 T11 C0 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 5796 T11 C0 oasu.DirectUpdateHandler2.commit No uncommitted changes. Skipping IW.commit.
   [junit4]   2> 5798 T11 C0 oasc.SolrCore.openNewSearcher SolrIndexSearcher has not changed - not re-opening: org.apache.solr.search.SolrIndexSearcher
   [junit4]   2> 5799 T11 C0 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 5800 T11 C0 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=false&waitSearcher=true} {commit=} 0 5
   [junit4]   2> 6044 T11 okma.MorphlineContext.importCommandBuilders Importing commands
   [junit4]   2> 7442 T11 okma.MorphlineContext.importCommandBuilders Done importing commands
   [junit4]   2> 9435 T11 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/'
   [junit4]   2> 9487 T11 oasc.SolrConfig.initLibs Adding specified lib dirs to ClassLoader
   [junit4]   2> 9488 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/extraction/lib (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/extraction/lib).
   [junit4]   2> 9490 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
   [junit4]   2> 9492 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/clustering/lib/ (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/clustering/lib).
   [junit4]   2> 9493 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
   [junit4]   2> 9495 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/langid/lib/ (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/langid/lib).
   [junit4]   2> 9496 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
   [junit4]   2> 9497 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/velocity/lib (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/velocity/lib).
   [junit4]   2> 9499 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
   [junit4]   2> 9501 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: /non/existent/dir/yields/warning (resolved as: /non/existent/dir/yields/warning).
   [junit4]   2> 9562 T11 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_4_9
   [junit4]   2> 9660 T11 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 9661 T11 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
   [junit4]   2> 9707 T11 oass.IndexSchema.readSchema [null] Schema name=example
   [junit4]   2> 10277 T11 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 10304 T11 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 10311 T11 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 10359 T11 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/'
   [junit4]   2> 10411 T11 oasc.SolrConfig.initLibs Adding specified lib dirs to ClassLoader
   [junit4]   2> 10411 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/extraction/lib (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/extraction/lib).
   [junit4]   2> 10412 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
   [junit4]   2> 10413 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/clustering/lib/ (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/clustering/lib).
   [junit4]   2> 10414 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
   [junit4]   2> 10415 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/langid/lib/ (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/langid/lib).
   [junit4]   2> 10416 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
   [junit4]   2> 10417 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/velocity/lib (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/velocity/lib).
   [junit4]   2> 10418 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
   [junit4]   2> 10419 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: /non/existent/dir/yields/warning (resolved as: /non/existent/dir/yields/warning).
   [junit4]   2> 10459 T11 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_4_9
   [junit4]   2> 10540 T11 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 10541 T11 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
   [junit4]   2> 10585 T11 oass.IndexSchema.readSchema [null] Schema name=example
   [junit4]   2> 11174 T11 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 11200 T11 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 11207 T11 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 11709 T11 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/'
   [junit4]   2> 11748 T11 oasc.SolrConfig.initLibs Adding specified lib dirs to ClassLoader
   [junit4]   2> 11748 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/extraction/lib (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/extraction/lib).
   [junit4]   2> 11749 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
   [junit4]   2> 11750 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/clustering/lib/ (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/clustering/lib).
   [junit4]   2> 11750 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
   [junit4]   2> 11751 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/langid/lib/ (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/langid/lib).
   [junit4]   2> 11751 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
   [junit4]   2> 11752 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/velocity/lib (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/velocity/lib).
   [junit4]   2> 11752 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
   [junit4]   2> 11753 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: /non/existent/dir/yields/warning (resolved as: /non/existent/dir/yields/warning).
   [junit4]   2> 11799 T11 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_4_9
   [junit4]   2> 11874 T11 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 11875 T11 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
   [junit4]   2> 11903 T11 oass.IndexSchema.readSchema [null] Schema name=example
   [junit4]   2> 12422 T11 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 12447 T11 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 12454 T11 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 12490 T11 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/'
   [junit4]   2> 12529 T11 oasc.SolrConfig.initLibs Adding specified lib dirs to ClassLoader
   [junit4]   2> 12530 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/extraction/lib (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/extraction/lib).
   [junit4]   2> 12530 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
   [junit4]   2> 12531 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/clustering/lib/ (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/clustering/lib).
   [junit4]   2> 12532 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
   [junit4]   2> 12532 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/langid/lib/ (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/langid/lib).
   [junit4]   2> 12533 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
   [junit4]   2> 12533 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/velocity/lib (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/velocity/lib).
   [junit4]   2> 12534 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
   [junit4]   2> 12535 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: /non/existent/dir/yields/warning (resolved as: /non/existent/dir/yields/warning).
   [junit4]   2> 12578 T11 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_4_9
   [junit4]   2> 12659 T11 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 12660 T11 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
   [junit4]   2> 12686 T11 oass.IndexSchema.readSchema [null] Schema name=example
   [junit4]   2> 13210 T11 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 13234 T11 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 13239 T11 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 13441 T11 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/'
   [junit4]   2> 13487 T11 oasc.SolrConfig.initLibs Adding specified lib dirs to ClassLoader
   [junit4]   2> 13487 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/extraction/lib (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/extraction/lib).
   [junit4]   2> 13488 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
   [junit4]   2> 13489 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/clustering/lib/ (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/clustering/lib).
   [junit4]   2> 13489 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
   [junit4]   2> 13490 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/langid/lib/ (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/langid/lib).
   [junit4]   2> 13490 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
   [junit4]   2> 13491 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/velocity/lib (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/velocity/lib).
   [junit4]   2> 13491 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
   [junit4]   2> 13492 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: /non/existent/dir/yields/warning (resolved as: /non/existent/dir/yields/warning).
   [junit4]   2> 13539 T11 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_4_9
   [junit4]   2> 13618 T11 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 13619 T11 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
   [junit4]   2> 13638 T11 oass.IndexSchema.readSchema [null] Schema name=example
   [junit4]   2> 14152 T11 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 14173 T11 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 14178 T11 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> ASYNC  NEW_CORE C1 name=collection1 org.apache.solr.core.SolrCore@7de8b042
   [junit4]   2> 14206 T11 C1 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {deleteByQuery=*:* (-1467690019476996096)} 0 1
   [junit4]   2> 14207 T11 C1 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 14207 T11 C1 oasu.DirectUpdateHandler2.commit No uncommitted changes. Skipping IW.commit.
   [junit4]   2> 14208 T11 C1 oasc.SolrCore.openNewSearcher SolrIndexSearcher has not changed - not re-opening: org.apache.solr.search.SolrIndexSearcher
   [junit4]   2> 14208 T11 C1 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 14209 T11 C1 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=false&waitSearcher=true} {commit=} 0 2
   [junit4]   2> ASYNC  NEW_CORE C2 name=collection1 org.apache.solr.core.SolrCore@7de8b042
   [junit4]   2> 14833 T11 C2 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[testPPT_various.ppt#0 (1467690020043227136)]} 0 90
   [junit4]   2> 14837 T11 C2 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 14917 T11 C2 oass.SolrIndexSearcher.<init> Opening Searcher@e4b5ba2[collection1] main
   [junit4]   2> 14920 T11 C2 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 14920 T13 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@e4b5ba2[collection1] main{StandardDirectoryReader(segments_1:3:nrt _0(4.9):C1)}
   [junit4]   2> 14921 T13 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
   [junit4]   2> 14922 T13 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@e4b5ba2[collection1] main{StandardDirectoryReader(segments_1:3:nrt _0(4.9):C1)}
   [junit4]   2> 14924 T11 C2 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 87
   [junit4]   2> 14934 T11 C2 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=1 status=0 QTime=8 
   [junit4]   2> ASYNC  NEW_CORE C3 name=collection1 org.apache.solr.core.SolrCore@7de8b042
   [junit4]   2> 16536 T11 C3 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[testPPT_various.pptx#0 (1467690021912838144)]} 0 10
   [junit4]   2> 16537 T11 C3 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 16569 T11 C3 oass.SolrIndexSearcher.<init> Opening Searcher@1118af1b[collection1] main
   [junit4]   2> 16570 T11 C3 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 16570 T13 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@1118af1b[collection1] main{StandardDirectoryReader(segments_1:5:nrt _0(4.9):C1 _1(4.9):C1)}
   [junit4]   2> 16571 T13 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
   [junit4]   2> 16572 T13 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1118af1b[collection1] main{StandardDirectoryReader(segments_1:5:nrt _0(4.9):C1 _1(4.9):C1)}
   [junit4]   2> 16573 T11 C3 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 36
   [junit4]   2> 16574 T11 C3 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=2 status=0 QTime=1 
   [junit4]   2> ASYNC  NEW_CORE C4 name=collection1 org.apache.solr.core.SolrCore@7de8b042
   [junit4]   2> 16789 T11 C4 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[testEXCEL.xlsx#0 (1467690022181273600)]} 0 6
   [junit4]   2> 16790 T11 C4 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 16804 T11 C4 oass.SolrIndexSearcher.<init> Opening Searcher@2cd7ef39[collection1] main
   [junit4]   2> 16804 T11 C4 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 16805 T13 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@2cd7ef39[collection1] main{StandardDirectoryReader(segments_1:7:nrt _0(4.9):C1 _1(4.9):C1 _2(4.9):C1)}
   [junit4]   2> 16805 T13 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
   [junit4]   2> 16806 T13 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@2cd7ef39[collection1] main{StandardDirectoryReader(segments_1:7:nrt _0(4.9):C1 _1(4.9):C1 _2(4.9):C1)}
   [junit4]   2> 16807 T11 C4 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 17
   [junit4]   2> 16808 T11 C4 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=3 status=0 QTime=1 
   [junit4]   2> ASYNC  NEW_CORE C5 name=collection1 org.apache.solr.core.SolrCore@7de8b042
   [junit4]   2> 17100 T11 C5 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[testEXCEL.xls#0 (1467690022507380736)]} 0 6
   [junit4]   2> 17101 T11 C5 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 17113 T11 C5 oass.SolrIndexSearcher.<init> Opening Searcher@11d70523[collection1] main
   [junit4]   2> 17114 T11 C5 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 17115 T13 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@11d70523[collection1] main{StandardDirectoryReader(segments_1:9:nrt _0(4.9):C1 _1(4.9):C1 _2(4.9):C1 _3(4.9):C1)}
   [junit4]   2> 17115 T13 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
   [junit4]   2> 17116 T13 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@11d70523[collection1] main{StandardDirectoryReader(segments_1:9:nrt _0(4.9):C1 _1(4.9):C1 _2(4.9):C1 _3(4.9):C1)}
   [junit4]   2> 17117 T11 C5 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 16
   [junit4]   2> 17118 T11 C5 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=4 status=0 QTime=1 
   [junit4]   2> 17291 T11 C5 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[testPages.pages#0 (1467690022699270144)]} 0 15
   [junit4]   2> 17293 T11 C5 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 17317 T11 C5 oass.SolrIndexSearcher.<init> Opening Searcher@32102bc1[collection1] main
   [junit4]   2> 17318 T11 C5 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 17318 T13 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@32102bc1[collection1] main{StandardDirectoryReader(segments_1:11:nrt _0(4.9):C1 _1(4.9):C1 _2(4.9):C1 _3(4.9):C1 _4(4.9):C1)}
   [junit4]   2> 17319 T13 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
   [junit4]   2> 17320 T13 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@32102bc1[collection1] main{StandardDirectoryReader(segments_1:11:nrt _0(4.9):C1 _1(4.9):C1 _2(4.9):C1 _3(4.9):C1 _4(4.9):C1)}
   [junit4]   2> 17321 T11 C5 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 29
   [junit4]   2> 17322 T11 C5 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=5 status=0 QTime=1 
   [junit4]   2> 17583 T11 C5 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[testRTFVarious.rtf#0 (1467690023014891520)]} 0 5
   [junit4]   2> 17585 T11 C5 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 17595 T11 C5 oass.SolrIndexSearcher.<init> Opening Searcher@ae35e0d[collection1] main
   [junit4]   2> 17596 T11 C5 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 17596 T13 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@ae35e0d[collection1] main{StandardDirectoryReader(segments_1:13:nrt _0(4.9):C1 _1(4.9):C1 _2(4.9):C1 _3(4.9):C1 _4(4.9):C1 _5(4.9):C1)}
   [junit4]   2> 17597 T13 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
   [junit4]   2> 17597 T13 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@ae35e0d[collection1] main{StandardDirectoryReader(segments_1:13:nrt _0(4.9):C1 _1(4.9):C1 _2(4.9):C1 _3(4.9):C1 _4(4.9):C1 _5(4.9):C1)}
   [junit4]   2> 17598 T11 C5 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 14
   [junit4]   2> 17599 T11 C5 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=6 status=0 QTime=0 
   [junit4]   2> 17636 T11 C5 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[complex.mbox#0 (1467690023057883136)]} 0 18
   [junit4]   2> 17637 T11 C5 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 17658 T11 C5 oass.SolrIndexSearcher.<init> Opening Searcher@55ad011c[collection1] main
   [junit4]   2> 17659 T11 C5 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 17659 T13 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@55ad011c[collection1] main{StandardDirectoryReader(segments_1:15:nrt _0(4.9):C1 _1(4.9):C1 _2(4.9):C1 _3(4.9):C1 _4(4.9):C1 _5(4.9):C1 _6(4.9):C1)}
   [junit4]   2> 17660 T13 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
   [junit4]   2> 17661 T13 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@55ad011c[collection1] main{StandardDirectoryReader(segments_1:15:nrt _0(4.9):C1 _1(4.9):C1 _2(4.9):C1 _3(4.9):C1 _4(4.9):C1 _5(4.9):C1 _6(4.9):C1)}
   [junit4]   2> 17662 T11 C5 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 25
   [junit4]   2> 17663 T11 C5 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=7 status=0 QTime=1 
   [junit4]   2> 17760 T11 C5 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[test-outlook.msg#0 (1467690023195246592)]} 0 10
   [junit4]   2> 17761 T11 C5 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 17773 T11 C5 oass.SolrIndexSearcher.<init> Opening Searcher@3794941c[collection1] main
   [junit4]   2> 17774 T11 C5 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 17774 T13 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@3794941c[collection1] main{StandardDirectoryReader(segments_1:17:nrt _0(4.9):C1 _1(4.9):C1 _2(4.9):C1 _3(4.9):C1 _4(4.9):C1 _5(4.9):C1 _6(4.9):C1 _7(4.9):C1)}
   [junit4]   2> 17776 T13 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
   [junit4]   2> 17776 T13 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@3794941c[collection1] main{StandardDirectoryReader(segments_1:17:nrt _0(4.9):C1 _1(4.9):C1 _2(4.9):C1 _3(4.9):C1 _4(4.9):C1 _5(4.9):C1 _6(4.9):C1 _7(4.9):C1)}
   [junit4]   2> 17778 T11 C5 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 17
   [junit4]   2> 17779 T11 C5 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=8 status=0 QTime=0 
   [junit4]   2> ASYNC  NEW_CORE C6 name=collection1 org.apache.solr.core.SolrCore@7de8b042
   [junit4]   2> 17835 T11 C6 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[testEMLX.emlx#0 (1467690023271792640)]} 0 12
   [junit4]   2> 17837 T11 C6 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 17854 T11 C6 oass.SolrIndexSearcher.<init> Opening Searcher@12211dcc[collection1] main
   [junit4]   2> 17855 T11 C6 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 17855 T13 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@12211dcc[collection1] main{StandardDirectoryReader(segments_1:19:nrt _0(4.9):C1 _1(4.9):C1 _2(4.9):C1 _3(4.9):C1 _4(4.9):C1 _5(4.9):C1 _6(4.9):C1 _7(4.9):C1 _8(4.9):C1)}
   [junit4]   2> 17856 T13 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
   [junit4]   2> 17857 T13 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@12211dcc[collection1] main{StandardDirectoryReader(segments_1:19:nrt _0(4.9):C1 _1(4.9):C1 _2(4.9):C1 _3(4.9):C1 _4(4.9):C1 _5(4.9):C1 _6(4.9):C1 _7(4.9):C1 _8(4.9):C1)}
   [junit4]   2> 17858 T11 C6 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 21
   [junit4]   2> 17859 T11 C6 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=9 status=0 QTime=1 
   [junit4]   2> 18072 T11 C6 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[testRFC822#0 (1467690023526596608)]} 0 6
   [junit4]   2> 18073 T11 C6 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 18089 T11 C6 oass.SolrIndexSearcher.<init> Opening Searcher@1abb25ce[collection1] main
   [junit4]   2> 18090 T11 C6 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 18090 T13 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@1abb25ce[collection1] main{StandardDirectoryReader(segments_1:21:nrt _0(4.9):C1 _1(4.9):C1 _2(4.9):C1 _3(4.9):C1 _4(4.9):C1 _5(4.9):C1 _6(4.9):C1 _7(4.9):C1 _8(4.9):C1 _9(4.9):C1)}
   [junit4]   2> 18091 T13 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
   [junit4]   2> 18092 T13 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1abb25ce[collection1] main{StandardDirectoryReader(segments_1:21:nrt _0(4.9):C1 _1(4.9):C1 _2(4.9):C1 _3(4.9):C1 _4(4.9):C1 _5(4.9):C1 _6(4.9):C1 _7(4.9):C1 _8(4.9):C1 _9(4.9):C1)}
   [junit4]   2> 18094 T11 C6 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 21
   [junit4]   2> 18095 T11 C6 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=10 status=0 QTime=0 
   [junit4]   2> ASYNC  NEW_CORE C7 name=collection1 org.apache.solr.core.SolrCore@7de8b042
   [junit4]   2> 18302 T11 C7 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[rsstest.rss#0 (1467690023770914816)]} 0 3
   [junit4]   2> 18303 T11 C7 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 18309 T11 C7 oass.SolrIndexSearcher.<init> Opening Searcher@73a6811f[collection1] main
   [junit4]   2> 18310 T11 C7 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 18311 T13 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@73a6811f[collection1] main{StandardDirectoryReader(segments_1:25:nrt _a(4.9):C10 _b(4.9):C1)}
   [junit4]   2> 18311 T13 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
   [junit4]   2> 18312 T13 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@73a6811f[collection1] main{StandardDirectoryReader(segments_1:25:nrt _a(4.9):C10 _b(4.9):C1)}
   [junit4]   2> 18318 T11 C7 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 15
   [junit4]   2> 18319 T11 C7 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=11 status=0 QTime=1 
   [junit4]   2> 18359 T11 C7 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[testMP3i18n.mp3#0 (1467690023829635072)]} 0 4
   [junit4]   2> 18360 T11 C7 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 18365 T11 C7 oass.SolrIndexSearcher.<init> Opening Searcher@5392025d[collection1] main
   [junit4]   2> 18365 T11 C7 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 18366 T13 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@5392025d[collection1] main{StandardDirectoryReader(segments_1:27:nrt _a(4.9):C10 _b(4.9):C1 _c(4.9):C1)}
   [junit4]   2> 18366 T13 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
   [junit4]   2> 18367 T13 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@5392025d[collection1] main{StandardDirectoryReader(segments_1:27:nrt _a(4.9):C10 _b(4.9):C1 _c(4.9):C1)}
   [junit4]   2> 18368 T11 C7 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 8
   [junit4]   2> 18369 T11 C7 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=12 status=0 QTime=1 
   [junit4]   2> 18406 T11 C7 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[testAIFF.aif#0 (1467690023879966720)]} 0 3
   [junit4]   2> 18408 T11 C7 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 18415 T11 C7 oass.SolrIndexSearcher.<init> Opening Searcher@3a3fcd96[collection1] main
   [junit4]   2> 18416 T11 C7 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 18416 T13 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@3a3fcd96[collection1] main{StandardDirectoryReader(segments_1:29:nrt _a(4.9):C10 _b(4.9):C1 _c(4.9):C1 _d(4.9):C1)}
   [junit4]   2> 18417 T13 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
   [junit4]   2> 18417 T13 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@3a3fcd96[collection1] main{StandardDirectoryReader(segments_1:29:nrt _a(4.9):C10 _b(4.9):C1 _c(4.9):C1 _d(4.9):C1)}
   [junit4]   2> 18418 T11 C7 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 10
   [junit4]   2> 18419 T11 C7 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=13 status=0 QTime=0 
   [junit4]   2> 18448 T11 C7 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[testFLAC.flac#0 (1467690023924006912)]} 0 3
   [junit4]   2> 18449 T11 C7 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 18454 T11 C7 oass.SolrIndexSearcher.<init> Opening Searcher@d311888[collection1] main
   [junit4]   2> 18455 T11 C7 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 18455 T13 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@d311888[collection1] main{StandardDirectoryReader(segments_1:31:nrt _a(4.9):C10 _b(4.9):C1 _c(4.9):C1 _d(4.9):C1 _e(4.9):C1)}
   [junit4]   2> 18455 T13 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
   [junit4]   2> 18456 T13 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@d311888[collection1] main{StandardDirectoryReader(segments_1:31:nrt _a(4.9):C10 _b(4.9):C1 _c(4.9):C1 _d(4.9):C1 _e(4.9):C1)}
   [junit4]   2> 18457 T11 C7 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 8
   [junit4]   2> 18458 T11 C7 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=14 status=0 QTime=1 
   [junit4]   2> 18619 T11 C7 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[testMP4.m4a#0 (1467690024101216256)]} 0 5
   [junit4]   2> 18620 T11 C7 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 18626 T11 C7 oass.SolrIndexSearcher.<init> Opening Searcher@53befe3f[collection1] main
   [junit4]   2> 18627 T11 C7 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 18627 T13 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@53befe3f[collection1] main{StandardDirectoryReader(segments_1:33:nrt _a(4.9):C10 _b(4.9):C1 _c(4.9):C1 _d(4.9):C1 _e(4.9):C1 _f(4.9):C1)}
   [junit4]   2> 18627 T13 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
   [junit4]   2> 18628 T13 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@53befe3f[collection1] main{StandardDirectoryReader(segments_1:33:nrt _a(4.9):C10 _b(4.9):C1 _c(4.9):C1 _d(4.9):C1 _e(4.9):C1 _f(4.9):C1)}
   [junit4]   2> 18629 T11 C7 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 9
   [junit4]   2> 18630 T11 C7 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=15 status=0 QTime=1 
   [junit4]   2> 18651 T11 C7 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[testWAV.wav#0 (1467690024136867840)]} 0 3
   [junit4]   2> 18652 T11 C7 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 18659 T11 C7 oass.SolrIndexSearcher.<init> Opening Searcher@504f4807[collection1] main
   [junit4]   2> 18660 T11 C7 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 18660 T13 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@504f4807[collection1] main{StandardDirectoryReader(segments_1:35:nrt _a(4.9):C10 _b(4.9):C1 _c(4.9):C1 _d(4.9):C1 _e(4.9):C1 _f(4.9):C1 _g(4.9):C1)}
   [junit4]   2> 18661 T13 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
   [junit4]   2> 18661 T13 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@504f4807[collection1] main{StandardDirectoryReader(segments_1:35:nrt _a(4.9):C10 _b(4.9):C1 _c(4.9):C1 _d(4.9):C1 _e(4.9):C1 _f(4.9):C1 _g(4.9):C1)}
   [junit4]   2> 18662 T11 C7 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 10
   [junit4]   2> 18663 T11 C7 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=16 status=0 QTime=0 
   [junit4]   2> 18694 T11 C7 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[testFLV.flv#0 (1467690024180908032)]} 0 4
   [junit4]   2> 18695 T11 C7 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 18702 T11 C7 oass.SolrIndexSearcher.<init> Opening Searcher@46345d55[collection1] main
   [junit4]   2> 18703 T11 C7 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 18704 T13 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@46345d55[collection1] main{StandardDirectoryReader(segments_1:37:nrt _a(4.9):C10 _b(4.9):C1 _c(4.9):C1 _d(4.9):C1 _e(4.9):C1 _f(4.9):C1 _g(4.9):C1 _h(4.9):C1)}
   [junit4]   2> 18711 T13 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
   [junit4]   2> 18712 T13 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@46345d55[collection1] main{StandardDirectoryReader(segments_1:37:nrt _a(4.9):C10 _b(4.9):C1 _c(4.9):C1 _d(4.9):C1 _e(4.9):C1 _f(4.9):C1 _g(4.9):C1 _h(4.9):C1)}
   [junit4]   2> ASYNC  NEW_CORE C8 name=collection1 org.apache.solr.core.SolrCore@7de8b042
   [junit4]   2> 18713 T11 C8 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 18
   [junit4]   2> 18714 T11 C8 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=17 status=0 QTime=0 
   [junit4]   2> 18724 T11 C8 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[testBMP.bmp#0 (1467690024214462464)]} 0 2
   [junit4]   2> 18725 T11 C8 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 18731 T11 C8 oass.SolrIndexSearcher.<init> Opening Searcher@5c7439c6[collection1] main
   [junit4]   2> 18731 T11 C8 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 18732 T13 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@5c7439c6[collection1] main{StandardDirectoryReader(segments_1:39:nrt _a(4.9):C10 _b(4.9):C1 _c(4.9):C1 _d(4.9):C1 _e(4.9):C1 _f(4.9):C1 _g(4.9):C1 _h(4.9):C1 _i(4.9):C1)}
   [junit4]   2> 18732 T13 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
   [junit4]   2> 18733 T13 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@5c7439c6[collection1] main{StandardDirectoryReader(segments_1:39:nrt _a(4.9):C10 _b(4.9):C1 _c(4.9):C1 _d(4.9):C1 _e(4.9):C1 _f(4.9):C1 _g(4.9):C1 _h(4.9):C1 _i(4.9):C1)}
   [junit4]   2> 18734 T11 C8 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 9
   [junit4]   2> 18735 T11 C8 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=18 status=0 QTime=1 
   [junit4]   2> 18742 T11 C8 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[testPNG.png#0 (1467690024233336832)]} 0 1
   [junit4]   2> 18743 T11 C8 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 18751 T11 C8 oass.SolrIndexSearcher.<init> Opening Searcher@c9b2a7[collection1] main
   [junit4]   2> 18754 T11 C8 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 18755 T13 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@c9b2a7[collection1] main{StandardDirectoryReader(segments_1:41:nrt _a(4.9):C10 _b(4.9):C1 _c(4.9):C1 _d(4.9):C1 _e(4.9):C1 _f(4.9):C1 _g(4.9):C1 _h(4.9):C1 _i(4.9):C1 _j(4.9):C1)}
   [junit4]   2> 18756 T13 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
   [junit4]   2> 18756 T13 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@c9b2a7[collection1] main{StandardDirectoryReader(segments_1:41:nrt _a(4.9):C10 _b(4.9):C1 _c(4.9):C1 _d(4.9):C1 _e(4.9):C1 _f(4.9):C1 _g(4.9):C1 _h(4.9):C1 _i(4.9):C1 _j(4.9):C1)}
   [junit4]   2> 18757 T11 C8 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 14
   [junit4]   2> 18759 T11 C8 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=19 status=0 QTime=1 
   [junit4]   2> 18776 T11 C8 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[testPSD.psd#0 (1467690024268988416)]} 0 1
   [junit4]   2> 18777 T11 C8 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 18785 T11 C8 oass.SolrIndexSearcher.<init> Opening Searcher@5fca52d1[collection1] main
   [junit4]   2> 18786 T11 C8 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 18786 T13 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@5fca52d1[collection1] main{StandardDirectoryReader(segments_1:44:nrt _a(4.9):C10 _b(4.9):C1 _c(4.9):C1 _d(4.9):C1 _e(4.9):C1 _f(4.9):C1 _g(4.9):C1 _h(4.9):C1 _i(4.9):C1 _j(4.9):C1 _l(4.9):C1)}
   [junit4]   2> 18787 T13 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
   [junit4]   2> 18787 T13 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@5fca52d1[collection1] main{StandardDirectoryReader(segments_1:44:nrt _a(4.9):C10 _b(4.9):C1 _c(4.9):C1 _d(4.9):C1 _e(4.9):C1 _f(4.9):C1 _g(4.9):C1 _h(4.9):C1 _i(4.9):C1 _j(4.9):C1 _l(4.9):C1)}
   [junit4]   2> 18788 T11 C8 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 11
   [junit4]   2> 18790 T11 C8 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=20 status=0 QTime=1 
   [junit4]   2> 18844 T11 C8 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[testSVG.svg#0 (1467690024339243008)]} 0 2
   [junit4]   2> 18845 T11 C8 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 18853 T11 C8 oass.SolrIndexSearcher.<init> Opening Searcher@16bb5ba6[collection1] main
   [junit4]   2> 18853 T11 C8 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 18854 T13 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@16bb5ba6[collection1] main{StandardDirectoryReader(segments_1:47:nrt _k(4.9):C19 _l(4.9):C1 _m(4.9):C1)}
   [junit4]   2> 18854 T13 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
   [junit4]   2> 18855 T13 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@16bb5ba6[collection1] main{StandardDirectoryReader(segments_1:47:nrt _k(4.9):C19 _l(4.9):C1 _m(4.9):C1)}
   [junit4]   2> 18858 T11 C8 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 13
   [junit4]   2> 18859 T11 C8 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=21 status=0 QTime=0 
   [junit4]   2> 18974 T11 C8 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[testTIFF.tif#0 (1467690024448294912)]} 0 29
   [junit4]   2> 18975 T11 C8 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 19040 T11 C8 oass.SolrIndexSearcher.<init> Opening Searcher@7c4ecdd5[collection1] main
   [junit4]   2> 19040 T11 C8 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 19040 T13 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@7c4ecdd5[collection1] main{StandardDirectoryReader(segments_1:49:nrt _k(4.9):C19 _l(4.9):C1 _m(4.9):C1 _n(4.9):C1)}
   [junit4]   2> 19041 T13 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
   [junit4]   2> 19042 T13 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@7c4ecdd5[collection1] main{StandardDirectoryReader(segments_1:49:nrt _k(4.9):C19 _l(4.9):C1 _m(4.9):C1 _n(4.9):C1)}
   [junit4]   2> 19043 T11 C8 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 68
   [junit4]   2> 19044 T11 C8 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=22 status=0 QTime=1 
   [junit4]   2> 19126 T11 C8 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[testVISIO.vsd#0 (1467690024633892864)]} 0 4
   [junit4]   2> 19127 T11 C8 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 19132 T11 C8 oass.SolrIndexSearcher.<init> Opening Searcher@25611afb[collection1] main
   [junit4]   2> 19133 T11 C8 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 19133 T13 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@25611afb[collection1] main{StandardDirectoryReader(segments_1:51:nrt _k(4.9):C19 _l(4.9):C1 _m(4.9):C1 _n(4.9):C1 _o(4.9):C1)}
   [junit4]   2> 19134 T13 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
   [junit4]   2> 19135 T13 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@25611afb[collection1] main{StandardDirectoryReader(segments_1:51:nrt _k(4.9):C19 _l(4.9):C1 _m(4.9):C1 _n(4.9):C1 _o(4.9):C1)}
   [junit4]   2> 19136 T11 C8 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 9
   [junit4]   2> 19137 T11 C8 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=23 status=0 QTime=1 
   [junit4]   2> 19145 T11 C8 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 19146 T11 C8 oasc.SolrCore.openNewSearcher SolrIndexSearcher has not changed - not re-opening: org.apache.solr.search.SolrIndexSearcher
   [junit4]   2> 19146 T11 C8 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 19147 T11 C8 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 2
   [junit4]   2> 19147 T11 C8 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=23 status=0 QTime=0 
   [junit4]   2> 19150 T11 oas.SolrTestCaseJ4.tearDown ###Ending testSolrCellDocumentTypes2
   [junit4]   2> 19174 T11 oas.SolrTestCaseJ4.setUp ###Starting testSolrCellDocumentTypes
   [junit4]   2> ASYNC  NEW_CORE C9 name=collection1 org.apache.solr.core.SolrCore@7de8b042
   [junit4]   2> 19209 T11 C9 oass.SolrIndexSearcher.<init> Opening Searcher@59067cdc[collection1] realtime
   [junit4]   2> 19210 T11 C9 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {deleteByQuery=*:* (-1467690024688418816)} 0 35
   [junit4]   2> 19211 T11 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 19212 T11 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@cfa9dbf lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/contrib/solr-morphlines-cell/test/J0/./solr.morphlines.cell.SolrCellMorphlineTest-7CE576EB875CD620-001/init-core-data-001/index),segFN=segments_1,generation=1}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@cfa9dbf lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/contrib/solr-morphlines-cell/test/J0/./solr.morphlines.cell.SolrCellMorphlineTest-7CE576EB875CD620-001/init-core-data-001/index),segFN=segments_2,generation=2}
   [junit4]   2> 19213 T11 C9 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
   [junit4]   2> 19213 T11 C9 oass.SolrIndexSearcher.<init> Opening Searcher@5e16b22a[collection1] main
   [junit4]   2> 19214 T11 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 19214 T13 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@5e16b22a[collection1] main{StandardDirectoryReader(segments_1:53:nrt)}
   [junit4]   2> 19215 T13 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
   [junit4]   2> 19215 T13 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@5e16b22a[collection1] main{StandardDirectoryReader(segments_1:53:nrt)}
   [junit4]   2> 19217 T11 C9 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=false&waitSearcher=true} {commit=} 0 6
   [junit4]   2> 19247 T11 okma.MorphlineContext.importCommandBuilders Importing commands
   [junit4]   2> 19735 T11 okma.MorphlineContext.importCommandBuilders Done importing commands
   [junit4]   2> 20190 T11 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/'
   [junit4]   2> 20247 T11 oasc.SolrConfig.initLibs Adding specified lib dirs to ClassLoader
   [junit4]   2> 20248 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/extraction/lib (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/extraction/lib).
   [junit4]   2> 20249 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
   [junit4]   2> 20249 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/clustering/lib/ (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/clustering/lib).
   [junit4]   2> 20250 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
   [junit4]   2> 20250 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/langid/lib/ (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/langid/lib).
   [junit4]   2> 20251 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
   [junit4]   2> 20251 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/velocity/lib (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/velocity/lib).
   [junit4]   2> 20252 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
   [junit4]   2> 20252 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: /non/existent/dir/yields/warning (resolved as: /non/existent/dir/yields/warning).
   [junit4]   2> 20294 T11 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_4_9
   [junit4]   2> 20377 T11 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 20377 T11 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
   [junit4]   2> 20401 T11 oass.IndexSchema.readSchema [null] Schema name=example
   [junit4]   2> 20911 T11 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 20933 T11 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 20938 T11 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 20972 T11 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/'
   [junit4]   2> 21012 T11 oasc.SolrConfig.initLibs Adding specified lib dirs to ClassLoader
   [junit4]   2> 21013 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/extraction/lib (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/extraction/lib).
   [junit4]   2> 21013 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
   [junit4]   2> 21014 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/clustering/lib/ (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/clustering/lib).
   [junit4]   2> 21014 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
   [junit4]   2> 21015 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/langid/lib/ (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/langid/lib).
   [junit4]   2> 21015 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
   [junit4]   2> 21016 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/velocity/lib (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/velocity/lib).
   [junit4]   2> 21016 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
   [junit4]   2> 21017 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: /non/existent/dir/yields/warning (resolved as: /non/existent/dir/yields/warning).
   [junit4]   2> 21056 T11 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_4_9
   [junit4]   2> 21131 T11 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 21132 T11 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
   [junit4]   2> 21147 T11 oass.IndexSchema.readSchema [null] Schema name=example
   [junit4]   2> 21651 T11 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 21670 T11 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 21675 T11 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 21697 T11 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory

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

r=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 31300 T11 C17 oasu.DirectUpdateHandler2.commit No uncommitted changes. Skipping IW.commit.
   [junit4]   2> 31300 T11 C17 oasc.SolrCore.openNewSearcher SolrIndexSearcher has not changed - not re-opening: org.apache.solr.search.SolrIndexSearcher
   [junit4]   2> 31300 T11 C17 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 31301 T11 C17 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=false&waitSearcher=true} {commit=} 0 2
   [junit4]   2> 31305 T11 C17 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[testXML2.xml#0 (1467690037406597120)]} 0 1
   [junit4]   2> 31305 T11 C17 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 31308 T11 C17 oass.SolrIndexSearcher.<init> Opening Searcher@554d905f[collection1] main
   [junit4]   2> 31309 T11 C17 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 31309 T13 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@554d905f[collection1] main{StandardDirectoryReader(segments_4:101:nrt _1a(4.9):C1)}
   [junit4]   2> 31309 T13 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
   [junit4]   2> 31310 T13 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@554d905f[collection1] main{StandardDirectoryReader(segments_4:101:nrt _1a(4.9):C1)}
   [junit4]   2> 31310 T11 C17 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 5
   [junit4]   2> 31311 T11 C17 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=1 status=0 QTime=0 
   [junit4]   2> 31312 T11 C17 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 31312 T11 C17 oasc.SolrCore.openNewSearcher SolrIndexSearcher has not changed - not re-opening: org.apache.solr.search.SolrIndexSearcher
   [junit4]   2> 31313 T11 C17 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 31313 T11 C17 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 1
   [junit4]   2> 31314 T11 C17 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=1 status=0 QTime=1 
   [junit4]   2> 31314 T11 oas.SolrTestCaseJ4.tearDown ###Ending testSolrCellXML
   [junit4]   2> 31325 T11 oas.SolrTestCaseJ4.setUp ###Starting testTransformValue
   [junit4]   2> 31326 T11 C17 oass.SolrIndexSearcher.<init> Opening Searcher@25ec55af[collection1] realtime
   [junit4]   2> 31327 T11 C17 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {deleteByQuery=*:* (-1467690037428617216)} 0 2
   [junit4]   2> 31327 T11 C17 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 31328 T11 C17 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@cfa9dbf lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/contrib/solr-morphlines-cell/test/J0/./solr.morphlines.cell.SolrCellMorphlineTest-7CE576EB875CD620-001/init-core-data-001/index),segFN=segments_4,generation=4}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@cfa9dbf lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/contrib/solr-morphlines-cell/test/J0/./solr.morphlines.cell.SolrCellMorphlineTest-7CE576EB875CD620-001/init-core-data-001/index),segFN=segments_5,generation=5}
   [junit4]   2> 31328 T11 C17 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 5
   [junit4]   2> 31329 T11 C17 oass.SolrIndexSearcher.<init> Opening Searcher@18e9fd55[collection1] main
   [junit4]   2> 31329 T11 C17 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 31329 T13 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@18e9fd55[collection1] main{StandardDirectoryReader(segments_4:103:nrt)}
   [junit4]   2> 31330 T13 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
   [junit4]   2> 31331 T13 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@18e9fd55[collection1] main{StandardDirectoryReader(segments_4:103:nrt)}
   [junit4]   2> 31332 T11 C17 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=false&waitSearcher=true} {commit=} 0 5
   [junit4]   2> 31336 T11 oas.SolrTestCaseJ4.tearDown ###Ending testTransformValue
   [junit4]   2> 31339 T11 oas.SolrTestCaseJ4.deleteCore ###deleteCore
   [junit4]   2> 31339 T11 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1384313712
   [junit4]   2> 31340 T11 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@7de8b042
   [junit4]   2> 31341 T11 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=56,autocommit maxTime=60000ms,autocommits=0,soft autocommit maxTime=1000ms,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=61,cumulative_deletesById=0,cumulative_deletesByQuery=9,cumulative_errors=0,transaction_logs_total_size=125807,transaction_logs_total_number=9}
   [junit4]   2> 31342 T11 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
   [junit4]   2> 31342 T11 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 31342 T11 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
   [junit4]   2> 31344 T11 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
   [junit4]   2> 31345 T11 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 31345 T11 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/contrib/solr-morphlines-cell/test/J0/./solr.morphlines.cell.SolrCellMorphlineTest-7CE576EB875CD620-001/init-core-data-001 [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/contrib/solr-morphlines-cell/test/J0/./solr.morphlines.cell.SolrCellMorphlineTest-7CE576EB875CD620-001/init-core-data-001;done=false>>]
   [junit4]   2> 31346 T11 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/contrib/solr-morphlines-cell/test/J0/./solr.morphlines.cell.SolrCellMorphlineTest-7CE576EB875CD620-001/init-core-data-001
   [junit4]   2> 31346 T11 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/contrib/solr-morphlines-cell/test/J0/./solr.morphlines.cell.SolrCellMorphlineTest-7CE576EB875CD620-001/init-core-data-001/index [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/contrib/solr-morphlines-cell/test/J0/./solr.morphlines.cell.SolrCellMorphlineTest-7CE576EB875CD620-001/init-core-data-001/index;done=false>>]
   [junit4]   2> 31347 T11 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/contrib/solr-morphlines-cell/test/J0/./solr.morphlines.cell.SolrCellMorphlineTest-7CE576EB875CD620-001/init-core-data-001/index
   [junit4]   2> NOTE: leaving temporary files on disk at: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/contrib/solr-morphlines-cell/test/J0/./solr.morphlines.cell.SolrCellMorphlineTest-7CE576EB875CD620-001
   [junit4]   2> NOTE: test params are: codec=CheapBastard, sim=RandomSimilarityProvider(queryNorm=false,coord=crazy): {}, locale=tr_TR, timezone=Canada/East-Saskatchewan
   [junit4]   2> NOTE: Linux 3.8.0-39-generic amd64/Oracle Corporation 1.7.0_55 (64-bit)/cpus=8,threads=1,free=65271984,total=191901696
   [junit4]   2> NOTE: All tests run in this JVM: [SolrCellMorphlineTest]
   [junit4] Completed in 31.53s, 5 tests, 1 failure <<< FAILURES!

[...truncated 9 lines...]
BUILD FAILED
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:467: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:447: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:45: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/extra-targets.xml:37: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build.xml:209: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/common-build.xml:440: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/common-build.xml:496: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/common-build.xml:1297: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/common-build.xml:921: There were test failures: 1 suite, 5 tests, 1 failure

Total time: 59 minutes 52 seconds
Build step 'Invoke Ant' marked build as failure
Description set: Java: 64bit/jdk1.7.0_55 -XX:-UseCompressedOops -XX:+UseConcMarkSweepGC
Archiving artifacts
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure