Build: https://builds.apache.org/job/Lucene-Solr-Tests-5.x-Java7/2384/

1 tests failed.
REGRESSION:  
org.apache.solr.update.SoftAutoCommitTest.testSoftAndHardCommitMaxTimeRapidAdds

Error Message:
1: soft wasn't fast enough

Stack Trace:
java.lang.AssertionError: 1: soft wasn't fast enough
        at 
__randomizedtesting.SeedInfo.seed([35CF872C8BE86DF0:69DA2915606A2C88]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.assertTrue(Assert.java:43)
        at org.junit.Assert.assertNotNull(Assert.java:526)
        at 
org.apache.solr.update.SoftAutoCommitTest.testSoftAndHardCommitMaxTimeRapidAdds(SoftAutoCommitTest.java:316)
        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.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:365)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458)
        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:54)
        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:365)
        at java.lang.Thread.run(Thread.java:745)




Build Log:
[...truncated 8886 lines...]
   [junit4] Suite: org.apache.solr.update.SoftAutoCommitTest
   [junit4]   2> Creating dataDir: 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.update.SoftAutoCommitTest-35CF872C8BE86DF0-001/init-core-data-001
   [junit4]   2> 16051 T16 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl 
(false) and clientAuth (false)
   [junit4]   2> 16053 T16 oas.SolrTestCaseJ4.initCore ####initCore
   [junit4]   2> 16054 T16 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/'
   [junit4]   2> 16055 T16 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/lib/classes/'
 to classloader
   [junit4]   2> 16056 T16 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/lib/README'
 to classloader
   [junit4]   2> 16057 T16 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/lib/.svn/'
 to classloader
   [junit4]   2> 16330 T16 oasc.SolrConfig.<init> Using Lucene MatchVersion: 
5.0.0
   [junit4]   2> 16479 T16 oasc.SolrConfig.<init> Loaded SolrConfig: 
solrconfig.xml
   [junit4]   2> 16481 T16 oass.IndexSchema.readSchema Reading Solr Schema from 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/conf/schema.xml
   [junit4]   2> 16577 T16 oass.IndexSchema.readSchema [null] Schema name=test
   [junit4]   2> 19021 T16 oass.OpenExchangeRatesOrgProvider.init Initialized 
with rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 19079 T16 oass.IndexSchema.readSchema default search field in 
schema is text
   [junit4]   2> 19082 T16 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 20259 T16 oass.FileExchangeRateProvider.reload Reloading 
exchange rates from file currency.xml
   [junit4]   2> 20295 T16 oass.FileExchangeRateProvider.reload Reloading 
exchange rates from file currency.xml
   [junit4]   2> 20301 T16 oass.OpenExchangeRatesOrgProvider.reload Reloading 
exchange rates from open-exchange-rates.json
   [junit4]   2> 20309 T16 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 20310 T16 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 20310 T16 oass.OpenExchangeRatesOrgProvider.reload Reloading 
exchange rates from open-exchange-rates.json
   [junit4]   2> 20311 T16 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 20312 T16 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 20313 T16 oasc.SolrResourceLoader.locateSolrHome JNDI not 
configured for solr (NoInitialContextEx)
   [junit4]   2> 20313 T16 oasc.SolrResourceLoader.locateSolrHome using system 
property solr.solr.home: 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr
   [junit4]   2> 20314 T16 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/'
   [junit4]   2> 20464 T16 oasc.CoreContainer.<init> New CoreContainer 
1549096623
   [junit4]   2> 20465 T16 oasc.CoreContainer.load Loading cores into 
CoreContainer 
[instanceDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/]
   [junit4]   2> 20467 T16 oashc.HttpShardHandlerFactory.getParameter Setting 
socketTimeout to: 0
   [junit4]   2> 20467 T16 oashc.HttpShardHandlerFactory.getParameter Setting 
urlScheme to: null
   [junit4]   2> 20468 T16 oashc.HttpShardHandlerFactory.getParameter Setting 
connTimeout to: 0
   [junit4]   2> 20468 T16 oashc.HttpShardHandlerFactory.getParameter Setting 
maxConnectionsPerHost to: 20
   [junit4]   2> 20469 T16 oashc.HttpShardHandlerFactory.getParameter Setting 
maxConnections to: 10000
   [junit4]   2> 20469 T16 oashc.HttpShardHandlerFactory.getParameter Setting 
corePoolSize to: 0
   [junit4]   2> 20470 T16 oashc.HttpShardHandlerFactory.getParameter Setting 
maximumPoolSize to: 2147483647
   [junit4]   2> 20470 T16 oashc.HttpShardHandlerFactory.getParameter Setting 
maxThreadIdleTime to: 5
   [junit4]   2> 20470 T16 oashc.HttpShardHandlerFactory.getParameter Setting 
sizeOfQueue to: -1
   [junit4]   2> 20471 T16 oashc.HttpShardHandlerFactory.getParameter Setting 
fairnessPolicy to: false
   [junit4]   2> 20472 T16 oasu.UpdateShardHandler.<init> Creating 
UpdateShardHandler HTTP client with params: 
socketTimeout=30000&connTimeout=30000&retry=false
   [junit4]   2> 20473 T16 oasl.LogWatcher.createWatcher SLF4J impl is 
org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 20473 T16 oasl.LogWatcher.newRegisteredLogWatcher Registering 
Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 20474 T16 oasc.CoreContainer.load Host Name: 
   [junit4]   2> 20481 T17 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/'
   [junit4]   2> 20483 T17 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/lib/classes/'
 to classloader
   [junit4]   2> 20484 T17 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/lib/README'
 to classloader
   [junit4]   2> 20485 T17 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/lib/.svn/'
 to classloader
   [junit4]   2> 20607 T17 oasc.SolrConfig.<init> Using Lucene MatchVersion: 
5.0.0
   [junit4]   2> 20683 T17 oasc.SolrConfig.<init> Loaded SolrConfig: 
solrconfig.xml
   [junit4]   2> 20684 T17 oass.IndexSchema.readSchema Reading Solr Schema from 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/conf/schema.xml
   [junit4]   2> 20758 T17 oass.IndexSchema.readSchema [collection1] Schema 
name=test
   [junit4]   2> 21184 T17 oass.OpenExchangeRatesOrgProvider.init Initialized 
with rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 21205 T17 oass.IndexSchema.readSchema default search field in 
schema is text
   [junit4]   2> 21208 T17 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 21236 T17 oass.FileExchangeRateProvider.reload Reloading 
exchange rates from file currency.xml
   [junit4]   2> 21243 T17 oass.FileExchangeRateProvider.reload Reloading 
exchange rates from file currency.xml
   [junit4]   2> 21249 T17 oass.OpenExchangeRatesOrgProvider.reload Reloading 
exchange rates from open-exchange-rates.json
   [junit4]   2> 21250 T17 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 21250 T17 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 21250 T17 oass.OpenExchangeRatesOrgProvider.reload Reloading 
exchange rates from open-exchange-rates.json
   [junit4]   2> 21251 T17 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 21252 T17 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 21252 T17 oasc.CoreContainer.create Creating SolrCore 
'collection1' using configuration from instancedir 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/
   [junit4]   2> 21253 T17 oasc.SolrCore.initDirectoryFactory 
org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 21253 T17 oasc.SolrCore.<init> [collection1] Opening new 
SolrCore at 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/,
 
dataDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.update.SoftAutoCommitTest-35CF872C8BE86DF0-001/init-core-data-001/
   [junit4]   2> 21262 T17 oasc.JmxMonitoredMap.<init> No JMX servers found, 
not exposing Solr information with JMX.
   [junit4]   2> 21286 T17 oasc.CachingDirectoryFactory.get return new 
directory for 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.update.SoftAutoCommitTest-35CF872C8BE86DF0-001/init-core-data-001
   [junit4]   2> 21286 T17 oasc.SolrCore.getNewIndexDir New index directory 
detected: old=null 
new=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.update.SoftAutoCommitTest-35CF872C8BE86DF0-001/init-core-data-001/index/
   [junit4]   2> 21287 T17 oasc.SolrCore.initIndex WARN [collection1] Solr 
index directory 
'/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.update.SoftAutoCommitTest-35CF872C8BE86DF0-001/init-core-data-001/index'
 doesn't exist. Creating new index...
   [junit4]   2> 21287 T17 oasc.CachingDirectoryFactory.get return new 
directory for 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.update.SoftAutoCommitTest-35CF872C8BE86DF0-001/init-core-data-001/index
   [junit4]   2> 21290 T17 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.AlcoholicMergePolicy: 
[AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=2104810282, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.1]
   [junit4]   2> 21291 T17 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>                
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@8e8ea0a
 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@735d3b17)),segFN=segments_1,generation=1}
   [junit4]   2> 21292 T17 oasc.SolrDeletionPolicy.updateCommits newest commit 
generation = 1
   [junit4]   2> 21382 T17 oasc.SolrCore.initWriters created xml: 
solr.XMLResponseWriter
   [junit4]   2> 21651 T17 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "dedupe"
   [junit4]   2> 21780 T17 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 21781 T17 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "dedupe-allfields"
   [junit4]   2> 21781 T17 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"dedupe-allfields"
   [junit4]   2> 21782 T17 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "stored_sig"
   [junit4]   2> 21782 T17 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 21783 T17 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 21827 T17 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 21828 T17 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
   [junit4]   2> 22070 T17 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 22071 T17 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"distrib-dup-test-chain-implicit"
   [junit4]   2> 22072 T17 oasc.SolrCore.loadUpdateProcessorChains no 
updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 22072 T17 oasc.RequestHandlers.initHandlersFromConfig created 
/update: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 22073 T17 oasc.RequestHandlers.initHandlersFromConfig created 
/update/json: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 22073 T17 oasc.RequestHandlers.initHandlersFromConfig created 
/update/csv: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 22074 T17 oasc.RequestHandlers.initHandlersFromConfig created 
/update/json/docs: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 22074 T17 oasc.RequestHandlers.initHandlersFromConfig created 
/config: org.apache.solr.handler.SolrConfigHandler
   [junit4]   2> 22075 T17 oasc.RequestHandlers.initHandlersFromConfig created 
/schema: org.apache.solr.handler.SchemaHandler
   [junit4]   2> 22075 T17 oasc.RequestHandlers.initHandlersFromConfig created 
/replication: org.apache.solr.handler.ReplicationHandler
   [junit4]   2> 22076 T17 oasc.RequestHandlers.initHandlersFromConfig created 
/get: org.apache.solr.handler.RealTimeGetHandler
   [junit4]   2> 22076 T17 oasc.RequestHandlers.initHandlersFromConfig created 
/admin/luke: org.apache.solr.handler.admin.LukeRequestHandler
   [junit4]   2> 22077 T17 oasc.RequestHandlers.initHandlersFromConfig created 
/admin/system: org.apache.solr.handler.admin.SystemInfoHandler
   [junit4]   2> 22078 T17 oasc.RequestHandlers.initHandlersFromConfig created 
/admin/mbeans: org.apache.solr.handler.admin.SolrInfoMBeanHandler
   [junit4]   2> 22078 T17 oasc.RequestHandlers.initHandlersFromConfig created 
/admin/plugins: org.apache.solr.handler.admin.PluginInfoHandler
   [junit4]   2> 22079 T17 oasc.RequestHandlers.initHandlersFromConfig created 
/admin/threads: org.apache.solr.handler.admin.ThreadDumpHandler
   [junit4]   2> 22079 T17 oasc.RequestHandlers.initHandlersFromConfig created 
/admin/properties: org.apache.solr.handler.admin.PropertiesRequestHandler
   [junit4]   2> 22080 T17 oasc.RequestHandlers.initHandlersFromConfig created 
/admin/logging: org.apache.solr.handler.admin.LoggingHandler
   [junit4]   2> 22080 T17 oasc.RequestHandlers.initHandlersFromConfig created 
/admin/ping: org.apache.solr.handler.PingRequestHandler
   [junit4]   2> 22081 T17 oasc.RequestHandlers.initHandlersFromConfig created 
standard: solr.StandardRequestHandler
   [junit4]   2> 22229 T17 oasc.RequestHandlers.initHandlersFromConfig created 
dismax: solr.SearchHandler
   [junit4]   2> 22231 T17 oasc.RequestHandlers.initHandlersFromConfig created 
mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
   [junit4]   2> 22281 T17 oasc.RequestHandlers.initHandlersFromConfig created 
/admin/file: solr.admin.ShowFileRequestHandler
   [junit4]   2> 22341 T17 oasc.RequestHandlers.initHandlersFromConfig created 
/admin/fileedit: solr.admin.EditFileRequestHandler
   [junit4]   2> 22342 T17 oasc.RequestHandlers.initHandlersFromConfig created 
defaults: solr.StandardRequestHandler
   [junit4]   2> 22342 T17 oasc.RequestHandlers.initHandlersFromConfig adding 
lazy requestHandler: solr.StandardRequestHandler
   [junit4]   2> 22349 T17 oasc.RequestHandlers.initHandlersFromConfig created 
lazy: solr.StandardRequestHandler
   [junit4]   2> 22349 T17 oasc.RequestHandlers.initHandlersFromConfig created 
/terms: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 22350 T17 oasc.RequestHandlers.initHandlersFromConfig created 
spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 22350 T17 oasc.RequestHandlers.initHandlersFromConfig created 
spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 22350 T17 oasc.RequestHandlers.initHandlersFromConfig created 
spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 22351 T17 oasc.RequestHandlers.initHandlersFromConfig created 
spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 22351 T17 oasc.RequestHandlers.initHandlersFromConfig created 
spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 22352 T17 oasc.RequestHandlers.initHandlersFromConfig created 
mltrh: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 22352 T17 oasc.RequestHandlers.initHandlersFromConfig created 
tvrh: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 22414 T17 oasc.RequestHandlers.initHandlersFromConfig created 
/mlt: solr.MoreLikeThisHandler
   [junit4]   2> 22475 T17 oasc.RequestHandlers.initHandlersFromConfig created 
/debug/dump: solr.DumpRequestHandler
   [junit4]   2> 22475 T17 oasc.RequestHandlers.initHandlersFromConfig created 
/search-facet-def: solr.SearchHandler
   [junit4]   2> 22476 T17 oasc.RequestHandlers.initHandlersFromConfig created 
/search-facet-invariants: solr.SearchHandler
   [junit4]   2> 22504 T17 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 22507 T17 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 22509 T17 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 22512 T17 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 22523 T17 oasc.SolrCore.initDeprecatedSupport WARN 
solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config 
to use the ShowFileRequestHandler.
   [junit4]   2> 22715 T17 oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 22715 T17 oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 22717 T17 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=47, maxMergeAtOnceExplicit=39, maxMergedSegmentMB=40.00390625, 
floorSegmentMB=1.9443359375, forceMergeDeletesPctAllowed=28.15125641046884, 
segmentsPerTier=42.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.6899212322034066
   [junit4]   2> 22718 T17 oasc.SolrDeletionPolicy.onInit 
SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>                
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@8e8ea0a
 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@735d3b17)),segFN=segments_1,generation=1}
   [junit4]   2> 22719 T17 oasc.SolrDeletionPolicy.updateCommits newest commit 
generation = 1
   [junit4]   2> 22720 T17 oass.SolrIndexSearcher.<init> Opening 
Searcher@60d495d7[collection1] main
   [junit4]   2> 22740 T17 oasr.RestManager.init Initializing RestManager with 
initArgs: 
{storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
   [junit4]   2> 22741 T17 oasr.ManagedResourceStorage.load Reading 
_rest_managed.json using InMemoryStorage
   [junit4]   2> 22742 T17 oasr.RestManager.init Initializing 0 registered 
ManagedResources
   [junit4]   2> 22742 T17 oashc.SpellCheckComponent.inform Initializing spell 
checkers
   [junit4]   2> 23207 T17 oass.DirectSolrSpellChecker.init init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 23911 T17 oash.ReplicationHandler.inform Commits will be 
reserved for  10000
   [junit4]   2> 23913 T18 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: default
   [junit4]   2> 23917 T18 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: direct
   [junit4]   2> 23917 T18 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: wordbreak
   [junit4]   2> 23917 T18 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: multipleFields
   [junit4]   2> 23921 T18 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: jarowinkler
   [junit4]   2> 23925 T18 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: external
   [junit4]   2> 23925 T17 oasc.CoreContainer.registerCore registering core: 
collection1
   [junit4]   2> 23927 T18 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: freq
   [junit4]   2> 23929 T18 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: fqcn
   [junit4]   2> 23931 T18 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: perDict
   [junit4]   2> 23931 T18 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@60d495d7[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 23951 T16 oas.SolrTestCaseJ4.initCore ####initCore end
   [junit4]   2> 23962 T16 oas.SolrTestCaseJ4.setUp ###Starting 
testSoftAndHardCommitMaxTimeRapidAdds
   [junit4]   2> 23963 T16 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/'
   [junit4]   2> 23964 T16 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/lib/classes/'
 to classloader
   [junit4]   2> 23965 T16 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/lib/README'
 to classloader
   [junit4]   2> 23966 T16 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/lib/.svn/'
 to classloader
   [junit4]   2> 24211 T16 oasc.SolrConfig.<init> Using Lucene MatchVersion: 
5.0.0
   [junit4]   2> 24294 T16 oasc.SolrConfig.<init> Loaded SolrConfig: 
solrconfig.xml
   [junit4]   2> 24295 T16 oass.IndexSchema.readSchema Reading Solr Schema from 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/conf/schema.xml
   [junit4]   2> 24363 T16 oass.IndexSchema.readSchema [collection1] Schema 
name=test
   [junit4]   2> 24783 T16 oass.OpenExchangeRatesOrgProvider.init Initialized 
with rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 24810 T16 oass.IndexSchema.readSchema default search field in 
schema is text
   [junit4]   2> 24814 T16 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 24848 T16 oass.FileExchangeRateProvider.reload Reloading 
exchange rates from file currency.xml
   [junit4]   2> 24856 T16 oass.FileExchangeRateProvider.reload Reloading 
exchange rates from file currency.xml
   [junit4]   2> 24863 T16 oass.OpenExchangeRatesOrgProvider.reload Reloading 
exchange rates from open-exchange-rates.json
   [junit4]   2> 24865 T16 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 24865 T16 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 24866 T16 oass.OpenExchangeRatesOrgProvider.reload Reloading 
exchange rates from open-exchange-rates.json
   [junit4]   2> 24867 T16 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 24868 T16 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 24869 T16 oasc.CoreContainer.reload Reloading SolrCore 
'collection1' using configuration from instancedir 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/
   [junit4]   2> 24870 T16 oasc.SolrCore.<init> [collection1] Opening new 
SolrCore at 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/,
 
dataDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.update.SoftAutoCommitTest-35CF872C8BE86DF0-001/init-core-data-001/
   [junit4]   2> 24871 T16 oasc.JmxMonitoredMap.<init> No JMX servers found, 
not exposing Solr information with JMX.
   [junit4]   2> 24872 T16 oasc.SolrCore.getNewIndexDir New index directory 
detected: old=null 
new=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.update.SoftAutoCommitTest-35CF872C8BE86DF0-001/init-core-data-001/index/
   [junit4]   2> 24873 T16 oasc.SolrCore.initWriters created xml: 
solr.XMLResponseWriter
   [junit4]   2> 24876 T16 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "dedupe"
   [junit4]   2> 24877 T16 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 24877 T16 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "dedupe-allfields"
   [junit4]   2> 24878 T16 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"dedupe-allfields"
   [junit4]   2> 24879 T16 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "stored_sig"
   [junit4]   2> 24880 T16 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 24881 T16 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 24881 T16 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 24882 T16 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
   [junit4]   2> 24883 T16 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 24884 T16 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"distrib-dup-test-chain-implicit"
   [junit4]   2> 24885 T16 oasc.SolrCore.loadUpdateProcessorChains no 
updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 24886 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/update: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 24887 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/update/json: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 24888 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/update/csv: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 24889 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/update/json/docs: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 24889 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/config: org.apache.solr.handler.SolrConfigHandler
   [junit4]   2> 24890 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/schema: org.apache.solr.handler.SchemaHandler
   [junit4]   2> 24891 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/replication: org.apache.solr.handler.ReplicationHandler
   [junit4]   2> 24892 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/get: org.apache.solr.handler.RealTimeGetHandler
   [junit4]   2> 24893 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/admin/luke: org.apache.solr.handler.admin.LukeRequestHandler
   [junit4]   2> 24894 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/admin/system: org.apache.solr.handler.admin.SystemInfoHandler
   [junit4]   2> 24895 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/admin/mbeans: org.apache.solr.handler.admin.SolrInfoMBeanHandler
   [junit4]   2> 24896 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/admin/plugins: org.apache.solr.handler.admin.PluginInfoHandler
   [junit4]   2> 24897 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/admin/threads: org.apache.solr.handler.admin.ThreadDumpHandler
   [junit4]   2> 24897 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/admin/properties: org.apache.solr.handler.admin.PropertiesRequestHandler
   [junit4]   2> 24898 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/admin/logging: org.apache.solr.handler.admin.LoggingHandler
   [junit4]   2> 24899 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/admin/ping: org.apache.solr.handler.PingRequestHandler
   [junit4]   2> 24900 T16 oasc.RequestHandlers.initHandlersFromConfig created 
standard: solr.StandardRequestHandler
   [junit4]   2> 24901 T16 oasc.RequestHandlers.initHandlersFromConfig created 
dismax: solr.SearchHandler
   [junit4]   2> 24901 T16 oasc.RequestHandlers.initHandlersFromConfig created 
mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
   [junit4]   2> 24902 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/admin/file: solr.admin.ShowFileRequestHandler
   [junit4]   2> 24903 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/admin/fileedit: solr.admin.EditFileRequestHandler
   [junit4]   2> 24904 T16 oasc.RequestHandlers.initHandlersFromConfig created 
defaults: solr.StandardRequestHandler
   [junit4]   2> 24904 T16 oasc.RequestHandlers.initHandlersFromConfig adding 
lazy requestHandler: solr.StandardRequestHandler
   [junit4]   2> 24905 T16 oasc.RequestHandlers.initHandlersFromConfig created 
lazy: solr.StandardRequestHandler
   [junit4]   2> 24906 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/terms: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 24907 T16 oasc.RequestHandlers.initHandlersFromConfig created 
spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 24907 T16 oasc.RequestHandlers.initHandlersFromConfig created 
spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 24909 T16 oasc.RequestHandlers.initHandlersFromConfig created 
spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 24909 T16 oasc.RequestHandlers.initHandlersFromConfig created 
spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 24910 T16 oasc.RequestHandlers.initHandlersFromConfig created 
spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 24911 T16 oasc.RequestHandlers.initHandlersFromConfig created 
mltrh: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 24912 T16 oasc.RequestHandlers.initHandlersFromConfig created 
tvrh: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 24912 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/mlt: solr.MoreLikeThisHandler
   [junit4]   2> 24913 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/debug/dump: solr.DumpRequestHandler
   [junit4]   2> 24914 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/search-facet-def: solr.SearchHandler
   [junit4]   2> 24915 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/search-facet-invariants: solr.SearchHandler
   [junit4]   2> 24948 T16 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 24951 T16 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 24954 T16 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 24957 T16 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 24960 T16 oasc.SolrCore.initDeprecatedSupport WARN 
solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config 
to use the ShowFileRequestHandler.
   [junit4]   2> 24973 T16 oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 24973 T16 oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 24975 T16 oass.SolrIndexSearcher.<init> Opening 
Searcher@7cf54ad7[collection1] main
   [junit4]   2> 24976 T16 oasr.RestManager.init Initializing RestManager with 
initArgs: 
{storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
   [junit4]   2> 24976 T16 oasr.ManagedResourceStorage.load Reading 
_rest_managed.json using InMemoryStorage
   [junit4]   2> 24977 T16 oasr.RestManager.init Initializing 0 registered 
ManagedResources
   [junit4]   2> 24978 T16 oashc.SpellCheckComponent.inform Initializing spell 
checkers
   [junit4]   2> 24983 T16 oass.DirectSolrSpellChecker.init init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 25007 T16 oash.ReplicationHandler.inform Commits will be 
reserved for  10000
   [junit4]   2> 25009 T20 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: default
   [junit4]   2> 25009 T16 oasu.DefaultSolrCoreState.newIndexWriter Creating 
new IndexWriter...
   [junit4]   2> 25010 T16 oasu.DefaultSolrCoreState.newIndexWriter Waiting 
until IndexWriter is unused... core=collection1
   [junit4]   2> 25011 T16 oasu.DefaultSolrCoreState.newIndexWriter Closing old 
IndexWriter... core=collection1
   [junit4]   2> 25011 T20 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: direct
   [junit4]   2> 25012 T20 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: wordbreak
   [junit4]   2> 25012 T16 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: 
[LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=33, 
maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, 
calibrateSizeByDeletes=false, maxMergeDocs=2147483647, 
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
   [junit4]   2> 25012 T20 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: multipleFields
   [junit4]   2> 25014 T16 oasc.SolrDeletionPolicy.onInit 
SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>                
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@8e8ea0a
 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@735d3b17)),segFN=segments_1,generation=1}
   [junit4]   2> 25015 T16 oasc.SolrDeletionPolicy.updateCommits newest commit 
generation = 1
   [junit4]   2> 25015 T20 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: jarowinkler
   [junit4]   2> 25016 T16 oasu.DefaultSolrCoreState.newIndexWriter New 
IndexWriter is ready to be used.
   [junit4]   2> 25017 T16 oasc.SolrCore.getSearcher WARN [collection1] 
PERFORMANCE WARNING: Overlapping onDeckSearchers=2
   [junit4]   2> 25018 T16 oass.SolrIndexSearcher.<init> Opening 
Searcher@5817a729[collection1] main
   [junit4]   2> 25018 T20 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: external
   [junit4]   2> 25019 T16 oasc.CoreContainer.registerCore replacing core: 
collection1
   [junit4]   2> 25019 T16 oasc.SolrCore.close [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@2e746d70
   [junit4]   2> 25020 T16 oasu.DirectUpdateHandler2.close closing 
DirectUpdateHandler2{commits=0,autocommits=0,soft 
autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0,transaction_logs_total_size=0,transaction_logs_total_number=0}
   [junit4]   2> 25020 T20 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: freq
   [junit4]   2> 25021 T16 oasc.SolrCore.closeSearcher [collection1] Closing 
main searcher on request.
   [junit4]   2> 25023 T20 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: fqcn
   [junit4]   2> 25025 T20 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: perDict
   [junit4]   2> 25026 T20 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@7cf54ad7[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 25026 T20 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: default
   [junit4]   2> 25028 T20 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: direct
   [junit4]   2> 25029 T20 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: wordbreak
   [junit4]   2> 25029 T20 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: multipleFields
   [junit4]   2> 25032 T20 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: jarowinkler
   [junit4]   2> 25034 T20 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: external
   [junit4]   2> 25036 T20 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: freq
   [junit4]   2> 25038 T20 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: fqcn
   [junit4]   2> 25040 T20 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: perDict
   [junit4]   2> 25041 T20 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@5817a729[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> ASYNC  NEW_CORE C0 name=collection1 
org.apache.solr.core.SolrCore@64cdcc2d
   [junit4]   2> 26602 T16 C0 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[5000 (1488571353034391552)]} 0 1558
   [junit4]   2> 26694 T16 C0 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[5001 (1488571353966575616)]} 0 2
   [junit4]   2> 26697 T16 C0 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[5002 (1488571353969721344)]} 0 1
   [junit4]   2> 26699 T16 C0 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[5003 (1488571353972867072)]} 0 0
   [junit4]   2> 26702 T16 C0 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[5004 (1488571353976012800)]} 0 1
   [junit4]   2> 27088 T22 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 27705 T16 oas.SolrTestCaseJ4.tearDown ###Ending 
testSoftAndHardCommitMaxTimeRapidAdds
   [junit4]   2> 27788 T21 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=SoftAutoCommitTest 
-Dtests.method=testSoftAndHardCommitMaxTimeRapidAdds 
-Dtests.seed=35CF872C8BE86DF0 -Dtests.multiplier=2 -Dtests.slow=true 
-Dtests.locale=es_DO -Dtests.timezone=America/North_Dakota/New_Salem 
-Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
   [junit4] FAILURE 3.85s J0 | 
SoftAutoCommitTest.testSoftAndHardCommitMaxTimeRapidAdds <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: 1: soft wasn't fast 
enough
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([35CF872C8BE86DF0:69DA2915606A2C88]:0)
   [junit4]    >        at 
org.apache.solr.update.SoftAutoCommitTest.testSoftAndHardCommitMaxTimeRapidAdds(SoftAutoCommitTest.java:316)
   [junit4]    >        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 27807 T16 oas.SolrTestCaseJ4.setUp ###Starting 
testSoftAndHardCommitMaxTimeDelete
   [junit4]   2> 27807 T16 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/'
   [junit4]   2> 27809 T16 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/lib/classes/'
 to classloader
   [junit4]   2> 27810 T16 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/lib/README'
 to classloader
   [junit4]   2> 27811 T16 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/lib/.svn/'
 to classloader
   [junit4]   2> 28035 T16 oasc.SolrConfig.<init> Using Lucene MatchVersion: 
5.0.0
   [junit4]   2> 28104 T16 oasc.SolrConfig.<init> Loaded SolrConfig: 
solrconfig.xml
   [junit4]   2> 28106 T16 oass.IndexSchema.readSchema Reading Solr Schema from 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/conf/schema.xml
   [junit4]   2> 28180 T16 oass.IndexSchema.readSchema [collection1] Schema 
name=test
   [junit4]   2> 28440 T22 oass.SolrIndexSearcher.<init> Opening 
Searcher@55d3e052[collection1] main
   [junit4]   2> 28458 T22 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 28460 T21 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@8e8ea0a
 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@735d3b17)),segFN=segments_1,generation=1}
   [junit4]   2>                
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@8e8ea0a
 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@735d3b17)),segFN=segments_2,generation=2}
   [junit4]   2> 28461 T21 oasc.SolrDeletionPolicy.updateCommits newest commit 
generation = 2
   [junit4]   2> 28461 T20 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@55d3e052[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.0.0):c5)))}
   [junit4]   2> 28462 T21 oasc.SolrCore.openNewSearcher SolrIndexSearcher has 
not changed - not re-opening: org.apache.solr.search.SolrIndexSearcher
   [junit4]   2> 28463 T21 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 28620 T16 oass.OpenExchangeRatesOrgProvider.init Initialized 
with rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 28641 T16 oass.IndexSchema.readSchema default search field in 
schema is text
   [junit4]   2> 28644 T16 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 28669 T16 oass.FileExchangeRateProvider.reload Reloading 
exchange rates from file currency.xml
   [junit4]   2> 28704 T16 oass.FileExchangeRateProvider.reload Reloading 
exchange rates from file currency.xml
   [junit4]   2> 28709 T16 oass.OpenExchangeRatesOrgProvider.reload Reloading 
exchange rates from open-exchange-rates.json
   [junit4]   2> 28710 T16 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 28711 T16 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 28711 T16 oass.OpenExchangeRatesOrgProvider.reload Reloading 
exchange rates from open-exchange-rates.json
   [junit4]   2> 28712 T16 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 28713 T16 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 28713 T16 oasc.CoreContainer.reload Reloading SolrCore 
'collection1' using configuration from instancedir 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/
   [junit4]   2> 28714 T16 oasc.SolrCore.<init> [collection1] Opening new 
SolrCore at 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/,
 
dataDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.update.SoftAutoCommitTest-35CF872C8BE86DF0-001/init-core-data-001/
   [junit4]   2> 28714 T16 oasc.JmxMonitoredMap.<init> No JMX servers found, 
not exposing Solr information with JMX.
   [junit4]   2> 28715 T16 oasc.SolrCore.getNewIndexDir New index directory 
detected: old=null 
new=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.update.SoftAutoCommitTest-35CF872C8BE86DF0-001/init-core-data-001/index/
   [junit4]   2> 28715 T16 oasc.SolrCore.initWriters created xml: 
solr.XMLResponseWriter
   [junit4]   2> 28717 T16 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "dedupe"
   [junit4]   2> 28718 T16 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 28718 T16 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "dedupe-allfields"
   [junit4]   2> 28719 T16 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"dedupe-allfields"
   [junit4]   2> 28719 T16 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "stored_sig"
   [junit4]   2> 28720 T16 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 28721 T16 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 28722 T16 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 28722 T16 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
   [junit4]   2> 28723 T16 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 28724 T16 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"distrib-dup-test-chain-implicit"
   [junit4]   2> 28724 T16 oasc.SolrCore.loadUpdateProcessorChains no 
updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 28725 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/update: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 28726 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/update/json: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 28726 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/update/csv: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 28727 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/update/json/docs: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 28727 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/config: org.apache.solr.handler.SolrConfigHandler
   [junit4]   2> 28728 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/schema: org.apache.solr.handler.SchemaHandler
   [junit4]   2> 28729 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/replication: org.apache.solr.handler.ReplicationHandler
   [junit4]   2> 28729 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/get: org.apache.solr.handler.RealTimeGetHandler
   [junit4]   2> 28730 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/admin/luke: org.apache.solr.handler.admin.LukeRequestHandler
   [junit4]   2> 28731 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/admin/system: org.apache.solr.handler.admin.SystemInfoHandler
   [junit4]   2> 28732 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/admin/mbeans: org.apache.solr.handler.admin.SolrInfoMBeanHandler
   [junit4]   2> 28732 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/admin/plugins: org.apache.solr.handler.admin.PluginInfoHandler
   [junit4]   2> 28733 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/admin/threads: org.apache.solr.handler.admin.ThreadDumpHandler
   [junit4]   2> 28733 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/admin/properties: org.apache.solr.handler.admin.PropertiesRequestHandler
   [junit4]   2> 28734 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/admin/logging: org.apache.solr.handler.admin.LoggingHandler
   [junit4]   2> 28735 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/admin/ping: org.apache.solr.handler.PingRequestHandler
   [junit4]   2> 28735 T16 oasc.RequestHandlers.initHandlersFromConfig created 
standard: solr.StandardRequestHandler
   [junit4]   2> 28736 T16 oasc.RequestHandlers.initHandlersFromConfig created 
dismax: solr.SearchHandler
   [junit4]   2> 28736 T16 oasc.RequestHandlers.initHandlersFromConfig created 
mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
   [junit4]   2> 28737 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/admin/file: solr.admin.ShowFileRequestHandler
   [junit4]   2> 28738 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/admin/fileedit: solr.admin.EditFileRequestHandler
   [junit4]   2> 28738 T16 oasc.RequestHandlers.initHandlersFromConfig created 
defaults: solr.StandardRequestHandler
   [junit4]   2> 28739 T16 oasc.RequestHandlers.initHandlersFromConfig adding 
lazy requestHandler: solr.StandardRequestHandler
   [junit4]   2> 28739 T16 oasc.RequestHandlers.initHandlersFromConfig created 
lazy: solr.StandardRequestHandler
   [junit4]   2> 28740 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/terms: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 28740 T16 oasc.RequestHandlers.initHandlersFromConfig created 
spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 28741 T16 oasc.RequestHandlers.initHandlersFromConfig created 
spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 28741 T16 oasc.RequestHandlers.initHandlersFromConfig created 
spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 28742 T16 oasc.RequestHandlers.initHandlersFromConfig created 
spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 28742 T16 oasc.RequestHandlers.initHandlersFromConfig created 
spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 28743 T16 oasc.RequestHandlers.initHandlersFromConfig created 
mltrh: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 28744 T16 oasc.RequestHandlers.initHandlersFromConfig created 
tvrh: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 28744 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/mlt: solr.MoreLikeThisHandler
   [junit4]   2> 28745 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/debug/dump: solr.DumpRequestHandler
   [junit4]   2> 28745 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/search-facet-def: solr.SearchHandler
   [junit4]   2> 28746 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/search-facet-invariants: solr.SearchHandler
   [junit4]   2> 28770 T16 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 28774 T16 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 28776 T16 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 28778 T16 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 28781 T16 oasc.SolrCore.initDeprecatedSupport WARN 
solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config 
to use the ShowFileRequestHandler.
   [junit4]   2> 28784 T16 oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 28785 T16 oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 28786 T16 oass.SolrIndexSearcher.<init> Opening 
Searcher@3e834538[collection1] main
   [junit4]   2> 28787 T16 oasr.RestManager.init Initializing RestManager with 
initArgs: 
{storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
   [junit4]   2> 28787 T16 oasr.ManagedResourceStorage.load Reading 
_rest_managed.json using InMemoryStorage
   [junit4]   2> 28788 T16 oasr.RestManager.init Initializing 0 registered 
ManagedResources
   [junit4]   2> 28788 T16 oashc.SpellCheckComponent.inform Initializing spell 
checkers
   [junit4]   2> 28792 T16 oass.DirectSolrSpellChecker.init init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 28809 T16 oash.ReplicationHandler.inform Commits will be 
reserved for  10000
   [junit4]   2> 28810 T23 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: default
   [junit4]   2> 28810 T16 oasu.DefaultSolrCoreState.newIndexWriter Creating 
new IndexWriter...
   [junit4]   2> 28811 T16 oasu.DefaultSolrCoreState.newIndexWriter Waiting 
until IndexWriter is unused... core=collection1
   [junit4]   2> 28812 T16 oasu.DefaultSolrCoreState.newIndexWriter Closing old 
IndexWriter... core=collection1
   [junit4]   2> 28813 T23 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: direct
   [junit4]   2> 28813 T16 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: 
[LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=35, 
maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, 
calibrateSizeByDeletes=false, maxMergeDocs=2147483647, 
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
   [junit4]   2> 28813 T23 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: wordbreak
   [junit4]   2> 28815 T23 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: multipleFields
   [junit4]   2> 28817 T23 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: jarowinkler
   [junit4]   2> 28817 T16 oasc.SolrDeletionPolicy.onInit 
SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>                
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@8e8ea0a
 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@735d3b17)),segFN=segments_2,generation=2}
   [junit4]   2> 28818 T16 oasc.SolrDeletionPolicy.updateCommits newest commit 
generation = 2
   [junit4]   2> 28818 T16 oasu.DefaultSolrCoreState.newIndexWriter New 
IndexWriter is ready to be used.
   [junit4]   2> 28819 T16 oasc.SolrCore.getSearcher WARN [collection1] 
PERFORMANCE WARNING: Overlapping onDeckSearchers=2
   [junit4]   2> 28819 T23 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: external
   [junit4]   2> 28822 T23 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: freq
   [junit4]   2> 28824 T23 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: fqcn
   [junit4]   2> 28825 T16 oass.SolrIndexSearcher.<init> Opening 
Searcher@23020bf9[collection1] main
   [junit4]   2> 28826 T16 oasc.CoreContainer.registerCore replacing core: 
collection1
   [junit4]   2> 28826 T23 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: perDict
   [junit4]   2> 28827 T16 oasc.SolrCore.close [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@64cdcc2d
   [junit4]   2> 28827 T23 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@3e834538[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.0.0):c5)))}
   [junit4]   2> 28828 T23 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: default
   [junit4]   2> 28828 T16 oasu.DirectUpdateHandler2.close closing 
DirectUpdateHandler2{commits=2,autocommit maxTime=1200ms,autocommits=1,soft 
autocommit maxTime=500ms,soft 
autocommits=1,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=5,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0,transaction_logs_total_size=339,transaction_logs_total_number=1}
   [junit4]   2> 28829 T16 oasc.SolrCore.closeSearcher [collection1] Closing 
main searcher on request.
   [junit4]   2> 28831 T23 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: direct
   [junit4]   2> 28831 T23 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: wordbreak
   [junit4]   2> 28832 T23 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: multipleFields
   [junit4]   2> 28834 T23 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: jarowinkler
   [junit4]   2> ASYNC  NEW_CORE C1 name=collection1 
org.apache.solr.core.SolrCore@17b5a325
   [junit4]   2> 28835 T16 C1 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[529 (1488571356208431104)]} 0 5
   [junit4]   2> 28836 T23 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: external
   [junit4]   2> 28838 T16 C1 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 28838 T23 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: freq
   [junit4]   2> 28841 T23 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: fqcn
   [junit4]   2> 28843 T23 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: perDict
   [junit4]   2> 28845 T23 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@23020bf9[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.0.0):c5)))}
   [junit4]   2> 28920 T16 C1 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@8e8ea0a
 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@735d3b17)),segFN=segments_2,generation=2}
   [junit4]   2>                
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@8e8ea0a
 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@735d3b17)),segFN=segments_3,generation=3}
   [junit4]   2> 28921 T16 C1 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 3
   [junit4]   2> 28927 T16 C1 oass.SolrIndexSearcher.<init> Opening 
Searcher@4eed4943[collection1] main
   [junit4]   2> 28928 T16 C1 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 28928 T23 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@4eed4943[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.0.0):c5)
 Uninverting(_1(5.0.0):c1)))}
   [junit4]   2> 28930 T16 C1 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {commit=} 0 92
   [junit4]   2> 28936 T16 C1 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {delete=[529 (-1488571356316434432)]} 0 3
   [junit4]   2> 29438 T25 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 29455 T25 oass.SolrIndexSearcher.<init> Opening 
Searcher@7ced8ea7[collection1] main
   [junit4]   2> 29456 T25 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 29457 T23 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@7ced8ea7[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.0.0):c5)))}
   [junit4]   2> 29461 T16 C1 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[550 (1488571356864839680)]} 0 4
   [junit4]   2> 29962 T25 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 29987 T25 oass.SolrIndexSearcher.<init> Opening 
Searcher@76effe43[collection1] main
   [junit4]   2> 29988 T25 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 29989 T23 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@76effe43[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.0.0):c5)
 Uninverting(_2(5.0.0):c1)))}
   [junit4]   2> 30138 T24 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 30140 T24 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@8e8ea0a
 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@735d3b17)),segFN=segments_3,generation=3}
   [junit4]   2>                
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@8e8ea0a
 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@735d3b17)),segFN=segments_4,generation=4}
   [junit4]   2> 30141 T24 oasc.SolrDeletionPolicy.updateCommits newest commit 
generation = 4
   [junit4]   2> 30142 T24 oasc.SolrCore.openNewSearcher SolrIndexSearcher has 
not changed - not re-opening: org.apache.solr.search.SolrIndexSearcher
   [junit4]   2> 30143 T24 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 32143 T16 oas.SolrTestCaseJ4.tearDown ###Ending 
testSoftAndHardCommitMaxTimeDelete
   [junit4]   2> 32159 T16 oas.SolrTestCaseJ4.setUp ###Starting 
testSoftAndHardCommitMaxTimeMixedAdds
   [junit4]   2> 32159 T16 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/'
   [junit4]   2> 32161 T16 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/lib/classes/'
 to classloader
   [junit4]   2> 32162 T16 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/lib/README'
 to classloader
   [junit4]   2> 32163 T16 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/lib/.svn/'
 to classloader
   [junit4]   2> 32358 T16 oasc.SolrConfig.<init> Using Lucene MatchVersion: 
5.0.0
   [junit4]   2> 32444 T16 oasc.SolrConfig.<init> Loaded SolrConfig: 
solrconfig.xml
   [junit4]   2> 32446 T16 oass.IndexSchema.readSchema Reading Solr Schema from 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/conf/schema.xml
   [junit4]   2> 32500 T16 oass.IndexSchema.readSchema [collection1] Schema 
name=test
   [junit4]   2> 32939 T16 oass.OpenExchangeRatesOrgProvider.init Initialized 
with rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 32953 T16 oass.IndexSchema.readSchema default search field in 
schema is text
   [junit4]   2> 32955 T16 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 32976 T16 oass.FileExchangeRateProvider.reload Reloading 
exchange rates from file currency.xml
   [junit4]   2> 32980 T16 oass.FileExchangeRateProvider.reload Reloading 
exchange rates from file currency.xml
   [junit4]   2> 32984 T16 oass.OpenExchangeRatesOrgProvider.reload Reloading 
exchange rates from open-exchange-rates.json
   [junit4]   2> 32985 T16 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 32985 T16 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 32986 T16 oass.OpenExchangeRatesOrgProvider.reload Reloading 
exchange rates from open-exchange-rates.json
   [junit4]   2> 32987 T16 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 32987 T16 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 32987 T16 oasc.CoreContainer.reload Reloading SolrCore 
'collection1' using configuration from instancedir 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/
   [junit4]   2> 32988 T16 oasc.SolrCore.<init> [collection1] Opening new 
SolrCore at 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/,
 
dataDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.update.SoftAutoCommitTest-35CF872C8BE86DF0-001/init-core-data-001/
   [junit4]   2> 32988 T16 oasc.JmxMonitoredMap.<init> No JMX servers found, 
not exposing Solr information with JMX.
   [junit4]   2> 32989 T16 oasc.SolrCore.getNewIndexDir New index directory 
detected: old=null 
new=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.update.SoftAutoCommitTest-35CF872C8BE86DF0-001/init-core-data-001/index/
   [junit4]   2> 32989 T16 oasc.SolrCore.initWriters created xml: 
solr.XMLResponseWriter
   [junit4]   2> 32991 T16 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "dedupe"
   [junit4]   2> 32991 T16 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 32992 T16 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "dedupe-allfields"
   [junit4]   2> 32992 T16 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"dedupe-allfields"
   [junit4]   2> 32993 T16 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "stored_sig"
   [junit4]   2> 32993 T16 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 32994 T16 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 32994 T16 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 32995 T16 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
   [junit4]   2> 32995 T16 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 32996 T16 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"distrib-dup-test-chain-implicit"
   [junit4]   2> 32997 T16 oasc.SolrCore.loadUpdateProcessorChains no 
updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 32997 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/update: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 32998 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/update/json: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 32998 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/update/csv: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 32999 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/update/json/docs: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 32999 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/config: org.apache.solr.handler.SolrConfigHandler
   [junit4]   2> 33000 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/schema: org.apache.solr.handler.SchemaHandler
   [junit4]   2> 33000 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/replication: org.apache.solr.handler.ReplicationHandler
   [junit4]   2> 33001 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/get: org.apache.solr.handler.RealTimeGetHandler
   [junit4]   2> 33001 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/admin/luke: org.apache.solr.handler.admin.LukeRequestHandler
   [junit4]   2> 33002 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/admin/system: org.apache.solr.handler.admin.SystemInfoHandler
   [junit4]   2> 33002 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/admin/mbeans: org.apache.solr.handler.admin.SolrInfoMBeanHandler
   [junit4]   2> 33003 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/admin/plugins: org.apache.solr.handler.admin.PluginInfoHandler
   [junit4]   2> 33003 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/admin/threads: org.apache.solr.handler.admin.ThreadDumpHandler
   [junit4]   2> 33004 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/admin/properties: org.apache.solr.handler.admin.PropertiesRequestHandler
   [junit4]   2> 33004 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/admin/logging: org.apache.solr.handler.admin.LoggingHandler
   [junit4]   2> 33005 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/admin/ping: org.apache.solr.handler.PingRequestHandler
   [junit4]   2> 33005 T16 oasc.RequestHandlers.initHandlersFromConfig created 
standard: solr.StandardRequestHandler
   [junit4]   2> 33006 T16 oasc.RequestHandlers.initHandlersFromConfig created 
dismax: solr.SearchHandler
   [junit4]   2> 33006 T16 oasc.RequestHandlers.initHandlersFromConfig created 
mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
   [junit4]   2> 33007 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/admin/file: solr.admin.ShowFileRequestHandler
   [junit4]   2> 33007 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/admin/fileedit: solr.admin.EditFileRequestHandler
   [junit4]   2> 33008 T16 oasc.RequestHandlers.initHandlersFromConfig created 
defaults: solr.StandardRequestHandler
   [junit4]   2> 33008 T16 oasc.RequestHandlers.initHandlersFromConfig adding 
lazy requestHandler: solr.StandardRequestHandler
   [junit4]   2> 33008 T16 oasc.RequestHandlers.initHandlersFromConfig created 
lazy: solr.StandardRequestHandler
   [junit4]   2> 33009 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/terms: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 33009 T16 oasc.RequestHandlers.initHandlersFromConfig created 
spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 33010 T16 oasc.RequestHandlers.initHandlersFromConfig created 
spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 33010 T16 oasc.RequestHandlers.initHandlersFromConfig created 
spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 33010 T16 oasc.RequestHandlers.initHandlersFromConfig created 
spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 33011 T16 oasc.RequestHandlers.initHandlersFromConfig created 
spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 33011 T16 oasc.RequestHandlers.initHandlersFromConfig created 
mltrh: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 33012 T16 oasc.RequestHandlers.initHandlersFromConfig created 
tvrh: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 33012 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/mlt: solr.MoreLikeThisHandler
   [junit4]   2> 33013 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/debug/dump: solr.DumpRequestHandler
   [junit4]   2> 33013 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/search-facet-def: solr.SearchHandler
   [junit4]   2> 33014 T16 oasc.RequestHandlers.initHandlersFromConfig created 
/search-facet-invariants: solr.SearchHandler
   [junit4]   2> 33034 T16 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 33036 T16 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 33038 T16 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 33040 T16 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 33041 T16 oasc.SolrCore.initDeprecatedSupport WARN 
solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config 
to use the ShowFileRequestHandler.
   [junit4]   2> 33044 T16 oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 33044 T16 oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 33045 T16 oass.SolrIndexSearcher.<init> Opening 
Searcher@461956ee[collection1] main
   [junit4]   2> 33046 T16 oasr.RestManager.init Initializing RestManager with 
initArgs: 
{storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
   [junit4]   2> 33047 T16 oasr.ManagedResourceStorage.load Reading 
_rest_managed.json using InMemoryStorage
   [junit4]   2> 33047 T16 oasr.RestManager.init Initializing 0 registered 
ManagedResources
   [junit4]   2> 33047 T16 oashc.SpellCheckComponent.inform Initializing spell 
checkers
   [junit4]   2> 33051 T16 oass.DirectSolrSpellChecker.init init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 33066 T16 oash.ReplicationHandler.inform Commits will be 
reserved for  10000
   [junit4]   2> 33067 T26 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: default
   [junit4]   2> 33067 T16 oasu.DefaultSolrCoreState.newIndexWriter Creating 
new IndexWriter...
   [junit4]   2> 33067 T16 oasu.DefaultSolrCoreState.newIndexWriter Waiting 
until IndexWriter is unused... core=collection1
   [junit4]   2> 33068 T16 oasu.DefaultSolrCoreState.newIndexWriter Closing old 
IndexWriter... core=collection1
   [junit4]   2> 33068 T26 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: direct
   [junit4]   2> 33069 T26 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: wordbreak
   [junit4]   2> 33069 T16 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=38, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.14617543283986534]
   [junit4]   2> 33069 T26 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: multipleFields
   [junit4]   2> 33071 T26 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: jarowinkler
   [junit4]   2> 33072 T26 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: external
   [junit4]   2> 33073 T16 oasc.SolrDeletionPolicy.onInit 
SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>                
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@8e8ea0a
 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@735d3b17)),segFN=segments_4,generation=4}
   [junit4]   2> 33074 T16 oasc.SolrDeletionPolicy.updateCommits newest commit 
generation = 4
   [junit4]   2> 33074 T26 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: freq
   [junit4]   2> 33074 T16 oasu.DefaultSolrCoreState.newIndexWriter New 
IndexWriter is ready to be used.
   [junit4]   2> 33075 T16 oasc.SolrCore.getSearcher WARN [collection1] 
PERFORMANCE WARNING: Overlapping onDeckSearchers=2
   [junit4]   2> 33076 T26 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: fqcn
   [junit4]   2> 33077 T26 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: perDict
   [junit4]   2> 33078 T26 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@461956ee[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.0.0):c5)
 Uninverting(_2(5.0.0):c1)))}
   [junit4]   2> 33083 T16 oass.SolrIndexSearcher.<init> Opening 
Searcher@5a9cc578[collection1] main
   [junit4]   2> 33084 T16 oasc.CoreContainer.registerCore replacing core: 
collection1
   [junit4]   2> 33084 T26 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@5a9cc578[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.0.0):c5)
 Uninverting(_2(5.0.0):c1)))}
   [junit4]   2> 33084 T16 oasc.SolrCore.close [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@17b5a325
   [junit4]   2> 33085 T16 oasu.DirectUpdateHandler2.close closing 
DirectUpdateHandler2{commits=4,autocommit maxTime=1200ms,autocommits=1,soft 
autocommit maxTime=500ms,soft 
autocommits=2,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=2,cumulative_deletesById=1,cumulative_deletesByQuery=0,cumulative_errors=0,transaction_logs_total_size=633,transaction_logs_total_number=3}
   [junit4]   2> 33086 T16 oasc.SolrCore.closeSearcher [collection1] Closing 
main searcher on request.
   [junit4]   2> ASYNC  NEW_CORE C2 name=collection1 
org.apache.solr.core.SolrCore@14242376
   [junit4]   2> 33091 T16 C2 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[529 (1488571360672219136)]} 0 4
   [junit4]   2> 33592 T28 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 33614 T28 oass.SolrIndexSearcher.<init> Opening 
Searcher@22fb1493[collection1] main
   [junit4]   2> 33615 T28 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 33615 T26 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@22fb1493[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.0.0):c5)
 Uninverting(_2(5.0.0):c1) Uninverting(_3(5.0.0):c1)))}
   [junit4]   2> 33618 T16 C2 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[530 (1488571361225867264)]} 0 3
   [junit4]   2> 34118 T28 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 34138 T28 oass.SolrIndexSearcher.<init> Opening 
Searcher@d06b1db[collection1] main
   [junit4]   2> 34140 T28 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 34140 T26 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@d06b1db[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.0.0):c5)
 Uninverting(_2(5.0.0):c1) Uninverting(_3(5.0.0):c1) 
Uninverting(_4(5.0.0):c1)))}
   [junit4]   2> 34292 T27 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 34294 T27 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@8e8ea0a
 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@735d3b17)),segFN=segments_4,generation=4}
   [junit4]   2>                
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@8e8ea0a
 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@735d3b17)),segFN=segments_5,generation=5}
   [junit4]   2> 34295 T27 oasc.SolrDeletionPolicy.updateCommits newest commit 
generation = 5
   [junit4]   2> 34295 T27 oasc.SolrCore.openNewSearcher SolrIndexSearcher has 
not changed - not re-opening: org.apache.solr.search.SolrIndexSearcher
   [junit4]   2> 34296 T27 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 37498 T16 oas.SolrTestCaseJ4.tearDown ###Ending 
testSoftAndHardCommitMaxTimeMixedAdds
   [junit4]   2> 37503 T16 oas.SolrTestCaseJ4.deleteCore ###deleteCore
   [junit4]   2> 37503 T16 oasc.CoreContainer.shutdown Shutting down 
CoreContainer instance=1549096623
   [junit4]   2> 37504 T16 oasc.SolrCore.close [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@14242376
   [junit4]   2> 37505 T16 oasu.DirectUpdateHandler2.close closing 
DirectUpdateHandler2{commits=3,autocommit maxTime=1200ms,autocommits=1,soft 
autocommit maxTime=500ms,soft 
autocommits=2,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=2,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0,transaction_logs_total_size=838,transaction_logs_total_number=4}
   [junit4]   2> 37506 T16 oasu.SolrCoreState.decrefSolrCoreState Closing 
SolrCoreState
   [junit4]   2> 37507 T16 oasu.DefaultSolrCoreState.closeIndexWriter 
SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 37507 T16 oasu.DefaultSolrCoreState.closeIndexWriter closing 
IndexWriter with IndexWriterCloser
   [junit4]   2> 37509 T16 oasc.SolrCore.closeSearcher [collection1] Closing 
main searcher on request.
   [junit4]   2> 37512 T16 oasc.CachingDirectoryFactory.close Closing 
MockDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 37512 T16 oasc.CachingDirectoryFactory.closeCacheValue looking 
to close 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.update.SoftAutoCommitTest-35CF872C8BE86DF0-001/init-core-data-001/index
 
[CachedDir<<refCount=0;path=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.update.SoftAutoCommitTest-35CF872C8BE86DF0-001/init-core-data-001/index;done=false>>]
   [junit4]   2> 37513 T16 oasc.CachingDirectoryFactory.close Closing 
directory: 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.update.SoftAutoCommitTest-35CF872C8BE86DF0-001/init-core-data-001/index
   [junit4]   2> 37513 T16 oasc.CachingDirectoryFactory.closeCacheValue looking 
to close 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.update.SoftAutoCommitTest-35CF872C8BE86DF0-001/init-core-data-001
 
[CachedDir<<refCount=0;path=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.update.SoftAutoCommitTest-35CF872C8BE86DF0-001/init-core-data-001;done=false>>]
   [junit4]   2> 37514 T16 oasc.CachingDirectoryFactory.close Closing 
directory: 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.update.SoftAutoCommitTest-35CF872C8BE86DF0-001/init-core-data-001
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.update.SoftAutoCommitTest-35CF872C8BE86DF0-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene50): 
{multiDefault=PostingsFormat(name=Direct), text=PostingsFormat(name=Asserting), 
id=PostingsFormat(name=LuceneFixedGap), timestamp=Lucene50(blocksize=128), 
range_facet_l=Lucene50(blocksize=128), subject=PostingsFormat(name=Direct), 
intDefault=Lucene50(blocksize=128), _version_=Lucene50(blocksize=128)}, 
docValues:{timestamp=DocValuesFormat(name=Lucene50)}, sim=DefaultSimilarity, 
locale=es_DO, timezone=America/North_Dakota/New_Salem
   [junit4]   2> NOTE: FreeBSD 9.1-RELEASE-p3 amd64/Oracle Corporation 1.7.0_65 
(64-bit)/cpus=16,threads=1,free=142169928,total=242221056
   [junit4]   2> NOTE: All tests run in this JVM: 
[TestLMDirichletSimilarityFactory, SoftAutoCommitTest]
   [junit4] Completed on J0 in 21.53s, 3 tests, 1 failure <<< FAILURES!

[...truncated 1473 lines...]
BUILD FAILED
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/build.xml:529:
 The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/build.xml:477:
 The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/build.xml:61:
 The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/extra-targets.xml:39:
 The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build.xml:190:
 The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/common-build.xml:508:
 The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/lucene/common-build.xml:1363:
 The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/lucene/common-build.xml:970:
 There were test failures: 453 suites, 1855 tests, 1 failure, 61 ignored (23 
assumptions)

Total time: 63 minutes 17 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Sending artifact delta relative to Lucene-Solr-Tests-5.x-Java7 #2381
Archived 5 artifacts
Archive block size is 32768
Received 0 blocks and 214155879 bytes
Compression is 0.0%
Took 40 sec
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure


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

Reply via email to