Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Linux/10952/
Java: 64bit/ibm-j9-jdk7 
-Xjit:exclude={org/apache/lucene/util/fst/FST.pack(IIF)Lorg/apache/lucene/util/fst/FST;}

1 tests failed.
REGRESSION:  org.apache.solr.update.AutoCommitTest.testMaxTime

Error Message:
Exception during query

Stack Trace:
java.lang.RuntimeException: Exception during query
        at 
__randomizedtesting.SeedInfo.seed([D9FA84AE2CFD88FD:430EF94CB26714C1]:0)
        at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:719)
        at 
org.apache.solr.update.AutoCommitTest.testMaxTime(AutoCommitTest.java:227)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:94)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:55)
        at java.lang.reflect.Method.invoke(Method.java:619)
        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: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:365)
        at java.lang.Thread.run(Thread.java:853)
Caused by: java.lang.RuntimeException: REQUEST FAILED: 
xpath=//result[@numFound=0]
        xml response was: <?xml version="1.0" encoding="UTF-8"?>
<response>
<lst name="responseHeader"><int name="status">0</int><int 
name="QTime">2892</int></lst><result name="response" numFound="1" 
start="0"><doc><int name="id">529</int><arr 
name="range_facet_l"><long>529</long></arr><arr name="field_t"><str>what's 
inside?</str></arr><arr name="subject"><str>info</str></arr><long 
name="_version_">1475408695659593728</long><int name="intDefault">42</int><arr 
name="multiDefault"><str>muLti-Default</str></arr><date 
name="timestamp">2014-08-03T09:49:39.253Z</date></doc></result>
</response>

        request was:version=2.2&qt=standard&rows=20&start=0&q=id:529
        at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:712)
        ... 41 more




Build Log:
[...truncated 11432 lines...]
   [junit4] Suite: org.apache.solr.update.AutoCommitTest
   [junit4]   2> Creating dataDir: 
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./temp/solr.update.AutoCommitTest-D9FA84AE2CFD88FD-001/init-core-data-001
   [junit4]   2> 357042 T1125 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl 
(false) and clientAuth (false)
   [junit4]   2> 357042 T1125 oas.SolrTestCaseJ4.initCore ####initCore
   [junit4]   2> 357043 T1125 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/'
   [junit4]   2> 357043 T1125 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/.svn/'
 to classloader
   [junit4]   2> 357043 T1125 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/classes/'
 to classloader
   [junit4]   2> 357044 T1125 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/README'
 to classloader
   [junit4]   2> 357076 T1125 oasc.SolrConfig.<init> Using Lucene MatchVersion: 
LUCENE_5_0
   [junit4]   2> 357124 T1125 oasc.SolrConfig.<init> Loaded SolrConfig: 
solrconfig.xml
   [junit4]   2> 357125 T1125 oass.IndexSchema.readSchema Reading Solr Schema 
from schema.xml
   [junit4]   2> 357131 T1125 oass.IndexSchema.readSchema [null] Schema 
name=test
   [junit4]   2> 357437 T1125 oass.OpenExchangeRatesOrgProvider.init 
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 357442 T1125 oass.IndexSchema.readSchema default search field 
in schema is text
   [junit4]   2> 357446 T1125 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 357451 T1125 oass.FileExchangeRateProvider.reload Reloading 
exchange rates from file currency.xml
   [junit4]   2> 357455 T1125 oass.FileExchangeRateProvider.reload Reloading 
exchange rates from file currency.xml
   [junit4]   2> 357458 T1125 oass.OpenExchangeRatesOrgProvider.reload 
Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 357458 T1125 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 357459 T1125 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 357459 T1125 oass.OpenExchangeRatesOrgProvider.reload 
Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 357460 T1125 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 357460 T1125 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 357461 T1125 oasc.SolrResourceLoader.locateSolrHome JNDI not 
configured for solr (NoInitialContextEx)
   [junit4]   2> 357461 T1125 oasc.SolrResourceLoader.locateSolrHome using 
system property solr.solr.home: 
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr
   [junit4]   2> 357461 T1125 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/'
   [junit4]   2> 357508 T1125 oasc.CoreContainer.<init> New CoreContainer 
-178802778
   [junit4]   2> 357508 T1125 oasc.CoreContainer.load Loading cores into 
CoreContainer 
[instanceDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/]
   [junit4]   2> 357509 T1125 oashc.HttpShardHandlerFactory.getParameter 
Setting socketTimeout to: 0
   [junit4]   2> 357510 T1125 oashc.HttpShardHandlerFactory.getParameter 
Setting urlScheme to: null
   [junit4]   2> 357510 T1125 oashc.HttpShardHandlerFactory.getParameter 
Setting connTimeout to: 0
   [junit4]   2> 357510 T1125 oashc.HttpShardHandlerFactory.getParameter 
Setting maxConnectionsPerHost to: 20
   [junit4]   2> 357510 T1125 oashc.HttpShardHandlerFactory.getParameter 
Setting corePoolSize to: 0
   [junit4]   2> 357511 T1125 oashc.HttpShardHandlerFactory.getParameter 
Setting maximumPoolSize to: 2147483647
   [junit4]   2> 357511 T1125 oashc.HttpShardHandlerFactory.getParameter 
Setting maxThreadIdleTime to: 5
   [junit4]   2> 357511 T1125 oashc.HttpShardHandlerFactory.getParameter 
Setting sizeOfQueue to: -1
   [junit4]   2> 357511 T1125 oashc.HttpShardHandlerFactory.getParameter 
Setting fairnessPolicy to: false
   [junit4]   2> 357512 T1125 oasu.UpdateShardHandler.<init> Creating 
UpdateShardHandler HTTP client with params: 
socketTimeout=30000&connTimeout=30000&retry=false
   [junit4]   2> 357512 T1125 oasl.LogWatcher.createWatcher SLF4J impl is 
org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 357512 T1125 oasl.LogWatcher.newRegisteredLogWatcher 
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 357513 T1125 oasc.CoreContainer.load Host Name: 
   [junit4]   2> 357516 T1126 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/'
   [junit4]   2> 357517 T1126 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/.svn/'
 to classloader
   [junit4]   2> 357517 T1126 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/classes/'
 to classloader
   [junit4]   2> 357517 T1126 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/README'
 to classloader
   [junit4]   2> 357551 T1126 oasc.SolrConfig.<init> Using Lucene MatchVersion: 
LUCENE_5_0
   [junit4]   2> 357594 T1126 oasc.SolrConfig.<init> Loaded SolrConfig: 
solrconfig.xml
   [junit4]   2> 357594 T1126 oass.IndexSchema.readSchema Reading Solr Schema 
from schema.xml
   [junit4]   2> 357599 T1126 oass.IndexSchema.readSchema [collection1] Schema 
name=test
   [junit4]   2> 357850 T1126 oass.OpenExchangeRatesOrgProvider.init 
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 357854 T1126 oass.IndexSchema.readSchema default search field 
in schema is text
   [junit4]   2> 357856 T1126 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 357860 T1126 oass.FileExchangeRateProvider.reload Reloading 
exchange rates from file currency.xml
   [junit4]   2> 357863 T1126 oass.FileExchangeRateProvider.reload Reloading 
exchange rates from file currency.xml
   [junit4]   2> 357866 T1126 oass.OpenExchangeRatesOrgProvider.reload 
Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 357866 T1126 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 357867 T1126 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 357867 T1126 oass.OpenExchangeRatesOrgProvider.reload 
Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 357867 T1126 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 357867 T1126 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 357868 T1126 oasc.CoreContainer.create Creating SolrCore 
'collection1' using configuration from instancedir 
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/
   [junit4]   2> 357868 T1126 oasc.SolrCore.initDirectoryFactory 
org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 357868 T1126 oasc.SolrCore.<init> [collection1] Opening new 
SolrCore at 
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/,
 
dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./temp/solr.update.AutoCommitTest-D9FA84AE2CFD88FD-001/init-core-data-001/
   [junit4]   2> 357868 T1126 oasc.JmxMonitoredMap.<init> JMX monitoring is 
enabled. Adding Solr mbeans to JMX Server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@c1481528
   [junit4]   2> 357869 T1126 oasc.CachingDirectoryFactory.get return new 
directory for 
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./temp/solr.update.AutoCommitTest-D9FA84AE2CFD88FD-001/init-core-data-001
   [junit4]   2> 357869 T1126 oasc.SolrCore.getNewIndexDir New index directory 
detected: old=null 
new=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./temp/solr.update.AutoCommitTest-D9FA84AE2CFD88FD-001/init-core-data-001/index/
   [junit4]   2> 357869 T1126 oasc.SolrCore.initIndex WARN [collection1] Solr 
index directory 
'/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./temp/solr.update.AutoCommitTest-D9FA84AE2CFD88FD-001/init-core-data-001/index'
 doesn't exist. Creating new index...
   [junit4]   2> 357870 T1126 oasc.CachingDirectoryFactory.get return new 
directory for 
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./temp/solr.update.AutoCommitTest-D9FA84AE2CFD88FD-001/init-core-data-001/index
   [junit4]   2> 357870 T1126 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.AlcoholicMergePolicy: 
[AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=740931249, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.1]
   [junit4]   2> 357870 T1126 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>                
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@fc558d27
 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@bf817c24)),segFN=segments_1,generation=1}
   [junit4]   2> 357871 T1126 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 1
   [junit4]   2> 357871 T1126 oasc.SolrCore.initWriters created xml: 
solr.XMLResponseWriter
   [junit4]   2> 357872 T1126 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "dedupe"
   [junit4]   2> 357872 T1126 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 357873 T1126 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "dedupe-allfields"
   [junit4]   2> 357873 T1126 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"dedupe-allfields"
   [junit4]   2> 357873 T1126 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "stored_sig"
   [junit4]   2> 357873 T1126 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 357873 T1126 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 357874 T1126 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 357874 T1126 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
   [junit4]   2> 357874 T1126 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 357874 T1126 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"distrib-dup-test-chain-implicit"
   [junit4]   2> 357875 T1126 oasc.SolrCore.loadUpdateProcessorChains no 
updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 357875 T1126 oasc.RequestHandlers.initHandlersFromConfig 
created /update: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 357875 T1126 oasc.RequestHandlers.initHandlersFromConfig 
created /update/json: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 357875 T1126 oasc.RequestHandlers.initHandlersFromConfig 
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 357876 T1126 oasc.RequestHandlers.initHandlersFromConfig 
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 357876 T1126 oasc.RequestHandlers.initHandlersFromConfig 
adding lazy requestHandler: solr.ReplicationHandler
   [junit4]   2> 357876 T1126 oasc.RequestHandlers.initHandlersFromConfig 
created /replication: solr.ReplicationHandler
   [junit4]   2> 357876 T1126 oasc.RequestHandlers.initHandlersFromConfig 
created standard: solr.StandardRequestHandler
   [junit4]   2> 357877 T1126 oasc.RequestHandlers.initHandlersFromConfig 
created /get: solr.RealTimeGetHandler
   [junit4]   2> 357877 T1126 oasc.RequestHandlers.initHandlersFromConfig 
created dismax: solr.SearchHandler
   [junit4]   2> 357877 T1126 oasc.RequestHandlers.initHandlersFromConfig 
created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
   [junit4]   2> 357877 T1126 oasc.RequestHandlers.initHandlersFromConfig 
created /admin/: org.apache.solr.handler.admin.AdminHandlers
   [junit4]   2> 357878 T1126 oasc.RequestHandlers.initHandlersFromConfig 
created /admin/file: solr.admin.ShowFileRequestHandler
   [junit4]   2> 357878 T1126 oasc.RequestHandlers.initHandlersFromConfig 
created /admin/fileedit: solr.admin.EditFileRequestHandler
   [junit4]   2> 357878 T1126 oasc.RequestHandlers.initHandlersFromConfig 
created defaults: solr.StandardRequestHandler
   [junit4]   2> 357878 T1126 oasc.RequestHandlers.initHandlersFromConfig 
adding lazy requestHandler: solr.StandardRequestHandler
   [junit4]   2> 357879 T1126 oasc.RequestHandlers.initHandlersFromConfig 
created lazy: solr.StandardRequestHandler
   [junit4]   2> 357879 T1126 oasc.RequestHandlers.initHandlersFromConfig WARN 
Multiple requestHandler registered to the same name: /update ignoring: 
org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 357879 T1126 oasc.RequestHandlers.initHandlersFromConfig 
created /update: solr.UpdateRequestHandler
   [junit4]   2> 357879 T1126 oasc.RequestHandlers.initHandlersFromConfig 
created /terms: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 357880 T1126 oasc.RequestHandlers.initHandlersFromConfig 
created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 357880 T1126 oasc.RequestHandlers.initHandlersFromConfig 
created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 357880 T1126 oasc.RequestHandlers.initHandlersFromConfig 
created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 357880 T1126 oasc.RequestHandlers.initHandlersFromConfig 
created spellCheckWithWordbreak_Direct: 
org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 357881 T1126 oasc.RequestHandlers.initHandlersFromConfig 
created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 357881 T1126 oasc.RequestHandlers.initHandlersFromConfig 
created mltrh: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 357881 T1126 oasc.RequestHandlers.initHandlersFromConfig 
created tvrh: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 357881 T1126 oasc.RequestHandlers.initHandlersFromConfig 
created /mlt: solr.MoreLikeThisHandler
   [junit4]   2> 357882 T1126 oasc.RequestHandlers.initHandlersFromConfig 
created /debug/dump: solr.DumpRequestHandler
   [junit4]   2> 357883 T1126 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 357884 T1126 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 357884 T1126 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 357885 T1126 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 357886 T1126 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 357887 T1126 oasc.SolrCore.initDeprecatedSupport WARN 
solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config 
to use the ShowFileRequestHandler.
   [junit4]   2> 357889 T1126 oasu.CommitTracker.<init> Hard AutoCommit: 
disabled
   [junit4]   2> 357889 T1126 oasu.CommitTracker.<init> Soft AutoCommit: 
disabled
   [junit4]   2> 357889 T1126 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=38, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.15729777216097487]
   [junit4]   2> 357890 T1126 oasc.SolrDeletionPolicy.onInit 
SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>                
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@fc558d27
 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@bf817c24)),segFN=segments_1,generation=1}
   [junit4]   2> 357890 T1126 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 1
   [junit4]   2> 357890 T1126 oass.SolrIndexSearcher.<init> Opening 
Searcher@517b24af[collection1] main
   [junit4]   2> 357891 T1126 oasr.RestManager.init Initializing RestManager 
with initArgs: 
{storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
   [junit4]   2> 357891 T1126 oasr.ManagedResourceStorage.load Reading 
_rest_managed.json using InMemoryStorage
   [junit4]   2> 357891 T1126 oasr.ManagedResource.reloadFromStorage WARN No 
stored data found for /rest/managed
   [junit4]   2> 357891 T1126 oasr.ManagedResourceStorage$JsonStorage.store 
Saved JSON object to path _rest_managed.json using InMemoryStorage
   [junit4]   2> 357891 T1126 oasr.RestManager.init Initializing 0 registered 
ManagedResources
   [junit4]   2> 357892 T1126 oashc.SpellCheckComponent.inform Initializing 
spell checkers
   [junit4]   2> 358009 T1126 oass.DirectSolrSpellChecker.init init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 358033 T1127 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@517b24af[collection1] 
main{UninvertingDirectoryReader()}
   [junit4]   2> 358038 T1126 oasc.CoreContainer.registerCore registering core: 
collection1
   [junit4]   2> 358041 T1125 oas.SolrTestCaseJ4.initCore ####initCore end
   [junit4]   2> 358046 T1125 oas.SolrTestCaseJ4.setUp ###Starting testMaxTime
   [junit4]   2> ASYNC  NEW_CORE C597 name=collection1 
org.apache.solr.core.SolrCore@73821357
   [junit4]   2> 358048 T1125 C597 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {deleteByQuery=*:* 
(-1475408695045128192)} 0 2
   [junit4]   2> 358055 T1125 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/'
   [junit4]   2> 358056 T1125 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/.svn/'
 to classloader
   [junit4]   2> 358057 T1125 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/classes/'
 to classloader
   [junit4]   2> 358058 T1125 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/README'
 to classloader
   [junit4]   2> 358095 T1125 oasc.SolrConfig.<init> Using Lucene MatchVersion: 
LUCENE_5_0
   [junit4]   2> 358146 T1125 oasc.SolrConfig.<init> Loaded SolrConfig: 
solrconfig.xml
   [junit4]   2> 358147 T1125 oass.IndexSchema.readSchema Reading Solr Schema 
from schema.xml
   [junit4]   2> 358153 T1125 oass.IndexSchema.readSchema [collection1] Schema 
name=test
   [junit4]   2> 358409 T1125 oass.OpenExchangeRatesOrgProvider.init 
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 358413 T1125 oass.IndexSchema.readSchema default search field 
in schema is text
   [junit4]   2> 358415 T1125 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 358420 T1125 oass.FileExchangeRateProvider.reload Reloading 
exchange rates from file currency.xml
   [junit4]   2> 358423 T1125 oass.FileExchangeRateProvider.reload Reloading 
exchange rates from file currency.xml
   [junit4]   2> 358425 T1125 oass.OpenExchangeRatesOrgProvider.reload 
Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 358426 T1125 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 358426 T1125 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 358427 T1125 oass.OpenExchangeRatesOrgProvider.reload 
Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 358427 T1125 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 358427 T1125 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 358428 T1125 oasc.CoreContainer.reload Reloading SolrCore 
'collection1' using configuration from instancedir 
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/
   [junit4]   2> 358428 T1125 oasc.SolrCore.<init> [collection1] Opening new 
SolrCore at 
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/,
 
dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./temp/solr.update.AutoCommitTest-D9FA84AE2CFD88FD-001/init-core-data-001/
   [junit4]   2> 358428 T1125 oasc.JmxMonitoredMap.<init> JMX monitoring is 
enabled. Adding Solr mbeans to JMX Server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@c1481528
   [junit4]   2> 358429 T1125 oasc.SolrCore.getNewIndexDir New index directory 
detected: old=null 
new=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./temp/solr.update.AutoCommitTest-D9FA84AE2CFD88FD-001/init-core-data-001/index/
   [junit4]   2> 358429 T1125 oasc.SolrCore.initWriters created xml: 
solr.XMLResponseWriter
   [junit4]   2> 358431 T1125 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "dedupe"
   [junit4]   2> 358431 T1125 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 358432 T1125 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "dedupe-allfields"
   [junit4]   2> 358432 T1125 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"dedupe-allfields"
   [junit4]   2> 358432 T1125 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "stored_sig"
   [junit4]   2> 358433 T1125 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 358433 T1125 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 358433 T1125 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 358434 T1125 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
   [junit4]   2> 358434 T1125 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 358435 T1125 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"distrib-dup-test-chain-implicit"
   [junit4]   2> 358435 T1125 oasc.SolrCore.loadUpdateProcessorChains no 
updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 358435 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created /update: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 358436 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created /update/json: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 358436 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 358437 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 358437 T1125 oasc.RequestHandlers.initHandlersFromConfig 
adding lazy requestHandler: solr.ReplicationHandler
   [junit4]   2> 358437 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created /replication: solr.ReplicationHandler
   [junit4]   2> 358438 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created standard: solr.StandardRequestHandler
   [junit4]   2> 358441 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created /get: solr.RealTimeGetHandler
   [junit4]   2> 358442 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created dismax: solr.SearchHandler
   [junit4]   2> 358443 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
   [junit4]   2> 358443 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created /admin/: org.apache.solr.handler.admin.AdminHandlers
   [junit4]   2> 358444 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created /admin/file: solr.admin.ShowFileRequestHandler
   [junit4]   2> 358444 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created /admin/fileedit: solr.admin.EditFileRequestHandler
   [junit4]   2> 358445 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created defaults: solr.StandardRequestHandler
   [junit4]   2> 358445 T1125 oasc.RequestHandlers.initHandlersFromConfig 
adding lazy requestHandler: solr.StandardRequestHandler
   [junit4]   2> 358445 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created lazy: solr.StandardRequestHandler
   [junit4]   2> 358446 T1125 oasc.RequestHandlers.initHandlersFromConfig WARN 
Multiple requestHandler registered to the same name: /update ignoring: 
org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 358447 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created /update: solr.UpdateRequestHandler
   [junit4]   2> 358447 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created /terms: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 358447 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 358448 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 358448 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 358449 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created spellCheckWithWordbreak_Direct: 
org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 358449 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 358450 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created mltrh: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 358451 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created tvrh: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 358451 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created /mlt: solr.MoreLikeThisHandler
   [junit4]   2> 358452 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created /debug/dump: solr.DumpRequestHandler
   [junit4]   2> 358453 T1125 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 358454 T1125 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 358455 T1125 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 358456 T1125 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 358458 T1125 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 358459 T1125 oasc.SolrCore.initDeprecatedSupport WARN 
solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config 
to use the ShowFileRequestHandler.
   [junit4]   2> 358461 T1125 oasu.CommitTracker.<init> Hard AutoCommit: 
disabled
   [junit4]   2> 358461 T1125 oasu.CommitTracker.<init> Soft AutoCommit: 
disabled
   [junit4]   2> 358462 T1125 oass.SolrIndexSearcher.<init> Opening 
Searcher@32e646ff[collection1] main
   [junit4]   2> 358462 T1125 oasr.RestManager.init Initializing RestManager 
with initArgs: 
{storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
   [junit4]   2> 358463 T1125 oasr.ManagedResourceStorage.load Reading 
_rest_managed.json using InMemoryStorage
   [junit4]   2> 358463 T1125 oasr.ManagedResource.reloadFromStorage WARN No 
stored data found for /rest/managed
   [junit4]   2> 358463 T1125 oasr.ManagedResourceStorage$JsonStorage.store 
Saved JSON object to path _rest_managed.json using InMemoryStorage
   [junit4]   2> 358464 T1125 oasr.RestManager.init Initializing 0 registered 
ManagedResources
   [junit4]   2> 358464 T1125 oashc.SpellCheckComponent.inform Initializing 
spell checkers
   [junit4]   2> 358465 T1125 oass.DirectSolrSpellChecker.init init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 358470 T1129 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@32e646ff[collection1] 
main{UninvertingDirectoryReader()}
   [junit4]   2> 358475 T1125 oasu.DefaultSolrCoreState.newIndexWriter Creating 
new IndexWriter...
   [junit4]   2> 358475 T1125 oasu.DefaultSolrCoreState.newIndexWriter Waiting 
until IndexWriter is unused... core=collection1
   [junit4]   2> 358475 T1125 oasu.DefaultSolrCoreState.newIndexWriter Closing 
old IndexWriter... core=collection1
   [junit4]   2> 358476 T1125 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: 
[LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=21, 
maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, 
calibrateSizeByDeletes=false, maxMergeDocs=2147483647, 
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.48668226134596504]
   [junit4]   2> 358476 T1125 oasc.SolrDeletionPolicy.onInit 
SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>                
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@fc558d27
 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@bf817c24)),segFN=segments_1,generation=1}
   [junit4]   2> 358477 T1125 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 1
   [junit4]   2> 358477 T1125 oasu.DefaultSolrCoreState.newIndexWriter New 
IndexWriter is ready to be used.
   [junit4]   2> 358477 T1125 oass.SolrIndexSearcher.<init> Opening 
Searcher@d55e9529[collection1] main
   [junit4]   2> 358478 T1125 oasc.CoreContainer.registerCore replacing core: 
collection1
   [junit4]   2> 358478 T1125 oasc.SolrCore.close [collection1]  CLOSING 
SolrCore org.apache.solr.core.SolrCore@73821357
   [junit4]   2> 358479 T1129 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@d55e9529[collection1] 
main{UninvertingDirectoryReader()}
   [junit4]   2> 358482 T1125 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=1,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=0,transaction_logs_total_size=0,transaction_logs_total_number=0}
   [junit4]   2> 358483 T1125 oasc.SolrCore.closeSearcher [collection1] Closing 
main searcher on request.
   [junit4]   2> 358635 T1125 oasup.LogUpdateProcessor.finish [collection1] 
{add=[529 (1475408695659593728)]} 0 150
   [junit4]   2> 359635 T1130 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 359637 T1130 oass.SolrIndexSearcher.<init> Opening 
Searcher@d0ade47a[collection1] main
   [junit4]   2> 359638 T1130 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 359638 T1129 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@d0ade47a[collection1] 
main{UninvertingDirectoryReader(Uninverting(_0(5.0):c1))}
   [junit4]   2> ASYNC  NEW_CORE C598 name=collection1 
org.apache.solr.core.SolrCore@e783c475
   [junit4]   2> 361528 T1125 C598 oasc.SolrCore.execute [collection1] 
webapp=null path=null params={version=2.2&qt=standard&rows=20&start=0&q=id:529} 
hits=1 status=0 QTime=2892 
   [junit4]   2> 361606 T1125 oas.SolrTestCaseJ4.assertQ ERROR REQUEST FAILED: 
xpath=//result[@numFound=0]
   [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">2892</int></lst><result name="response" 
numFound="1" start="0"><doc><int name="id">529</int><arr 
name="range_facet_l"><long>529</long></arr><arr name="field_t"><str>what's 
inside?</str></arr><arr name="subject"><str>info</str></arr><long 
name="_version_">1475408695659593728</long><int name="intDefault">42</int><arr 
name="multiDefault"><str>muLti-Default</str></arr><date 
name="timestamp">2014-08-03T09:49:39.253Z</date></doc></result>
   [junit4]   2>        </response>
   [junit4]   2>        
   [junit4]   2>                request 
was:version=2.2&qt=standard&rows=20&start=0&q=id:529
   [junit4]   2> 361609 T1125 oasc.SolrException.log ERROR REQUEST FAILED: 
version=2.2&qt=standard&rows=20&start=0&q=id:529:java.lang.RuntimeException: 
REQUEST FAILED: xpath=//result[@numFound=0]
   [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">2892</int></lst><result name="response" 
numFound="1" start="0"><doc><int name="id">529</int><arr 
name="range_facet_l"><long>529</long></arr><arr name="field_t"><str>what's 
inside?</str></arr><arr name="subject"><str>info</str></arr><long 
name="_version_">1475408695659593728</long><int name="intDefault">42</int><arr 
name="multiDefault"><str>muLti-Default</str></arr><date 
name="timestamp">2014-08-03T09:49:39.253Z</date></doc></result>
   [junit4]   2>        </response>
   [junit4]   2>        
   [junit4]   2>                request 
was:version=2.2&qt=standard&rows=20&start=0&q=id:529
   [junit4]   2>                at 
org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:712)
   [junit4]   2>                at 
org.apache.solr.update.AutoCommitTest.testMaxTime(AutoCommitTest.java:227)
   [junit4]   2>                at 
sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   [junit4]   2>                at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:94)
   [junit4]   2>                at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:55)
   [junit4]   2>                at 
java.lang.reflect.Method.invoke(Method.java:619)
   [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.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:365)
   [junit4]   2>                at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798)
   [junit4]   2>                at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458)
   [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:365)
   [junit4]   2>                at java.lang.Thread.run(Thread.java:853)
   [junit4]   2>        
   [junit4]   2> 361610 T1125 oas.SolrTestCaseJ4.tearDown ###Ending testMaxTime
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=AutoCommitTest 
-Dtests.method=testMaxTime -Dtests.seed=D9FA84AE2CFD88FD -Dtests.multiplier=3 
-Dtests.slow=true -Dtests.locale=it -Dtests.timezone=America/Danmarkshavn 
-Dtests.file.encoding=US-ASCII
   [junit4] ERROR   3.58s J1 | AutoCommitTest.testMaxTime <<<
   [junit4]    > Throwable #1: java.lang.RuntimeException: Exception during 
query
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([D9FA84AE2CFD88FD:430EF94CB26714C1]:0)
   [junit4]    >        at 
org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:719)
   [junit4]    >        at 
org.apache.solr.update.AutoCommitTest.testMaxTime(AutoCommitTest.java:227)
   [junit4]    >        at java.lang.Thread.run(Thread.java:853)
   [junit4]    > Caused by: java.lang.RuntimeException: REQUEST FAILED: 
xpath=//result[@numFound=0]
   [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">2892</int></lst><result name="response" numFound="1" 
start="0"><doc><int name="id">529</int><arr 
name="range_facet_l"><long>529</long></arr><arr name="field_t"><str>what's 
inside?</str></arr><arr name="subject"><str>info</str></arr><long 
name="_version_">1475408695659593728</long><int name="intDefault">42</int><arr 
name="multiDefault"><str>muLti-Default</str></arr><date 
name="timestamp">2014-08-03T09:49:39.253Z</date></doc></result>
   [junit4]    > </response>
   [junit4]    >        request 
was:version=2.2&qt=standard&rows=20&start=0&q=id:529
   [junit4]    >        at 
org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:712)
   [junit4]    >        ... 41 more
   [junit4]   2> 361621 T1125 oas.SolrTestCaseJ4.setUp ###Starting 
testCommitWithin
   [junit4]   2> 361621 T1125 C598 oass.SolrIndexSearcher.<init> Opening 
Searcher@735989d0[collection1] realtime
   [junit4]   2> 361622 T1125 C598 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {deleteByQuery=*:* 
(-1475408698792738816)} 0 1
   [junit4]   2> 361884 T1125 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/'
   [junit4]   2> 361885 T1125 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/.svn/'
 to classloader
   [junit4]   2> 361886 T1125 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/classes/'
 to classloader
   [junit4]   2> 361887 T1125 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/README'
 to classloader
   [junit4]   2> 361933 T1125 oasc.SolrConfig.<init> Using Lucene MatchVersion: 
LUCENE_5_0
   [junit4]   2> 361989 T1125 oasc.SolrConfig.<init> Loaded SolrConfig: 
solrconfig.xml
   [junit4]   2> 361989 T1125 oass.IndexSchema.readSchema Reading Solr Schema 
from schema.xml
   [junit4]   2> 361995 T1125 oass.IndexSchema.readSchema [collection1] Schema 
name=test
   [junit4]   2> 362277 T1125 oass.OpenExchangeRatesOrgProvider.init 
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 362281 T1125 oass.IndexSchema.readSchema default search field 
in schema is text
   [junit4]   2> 362283 T1125 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 362288 T1125 oass.FileExchangeRateProvider.reload Reloading 
exchange rates from file currency.xml
   [junit4]   2> 362291 T1125 oass.FileExchangeRateProvider.reload Reloading 
exchange rates from file currency.xml
   [junit4]   2> 362293 T1125 oass.OpenExchangeRatesOrgProvider.reload 
Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 362294 T1125 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 362294 T1125 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 362294 T1125 oass.OpenExchangeRatesOrgProvider.reload 
Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 362295 T1125 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 362295 T1125 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 362295 T1125 oasc.CoreContainer.reload Reloading SolrCore 
'collection1' using configuration from instancedir 
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/
   [junit4]   2> 362296 T1125 oasc.SolrCore.<init> [collection1] Opening new 
SolrCore at 
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/,
 
dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./temp/solr.update.AutoCommitTest-D9FA84AE2CFD88FD-001/init-core-data-001/
   [junit4]   2> 362296 T1125 oasc.JmxMonitoredMap.<init> JMX monitoring is 
enabled. Adding Solr mbeans to JMX Server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@c1481528
   [junit4]   2> 362297 T1125 oasc.SolrCore.getNewIndexDir New index directory 
detected: old=null 
new=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./temp/solr.update.AutoCommitTest-D9FA84AE2CFD88FD-001/init-core-data-001/index/
   [junit4]   2> 362297 T1125 oasc.SolrCore.initWriters created xml: 
solr.XMLResponseWriter
   [junit4]   2> 362299 T1125 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "dedupe"
   [junit4]   2> 362299 T1125 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 362300 T1125 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "dedupe-allfields"
   [junit4]   2> 362300 T1125 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"dedupe-allfields"
   [junit4]   2> 362300 T1125 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "stored_sig"
   [junit4]   2> 362300 T1125 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 362301 T1125 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 362301 T1125 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 362301 T1125 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
   [junit4]   2> 362302 T1125 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 362302 T1125 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"distrib-dup-test-chain-implicit"
   [junit4]   2> 362303 T1125 oasc.SolrCore.loadUpdateProcessorChains no 
updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 362303 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created /update: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 362303 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created /update/json: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 362304 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 362304 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 362305 T1125 oasc.RequestHandlers.initHandlersFromConfig 
adding lazy requestHandler: solr.ReplicationHandler
   [junit4]   2> 362305 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created /replication: solr.ReplicationHandler
   [junit4]   2> 362305 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created standard: solr.StandardRequestHandler
   [junit4]   2> 362306 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created /get: solr.RealTimeGetHandler
   [junit4]   2> 362306 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created dismax: solr.SearchHandler
   [junit4]   2> 362307 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
   [junit4]   2> 362307 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created /admin/: org.apache.solr.handler.admin.AdminHandlers
   [junit4]   2> 362308 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created /admin/file: solr.admin.ShowFileRequestHandler
   [junit4]   2> 362308 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created /admin/fileedit: solr.admin.EditFileRequestHandler
   [junit4]   2> 362308 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created defaults: solr.StandardRequestHandler
   [junit4]   2> 362309 T1125 oasc.RequestHandlers.initHandlersFromConfig 
adding lazy requestHandler: solr.StandardRequestHandler
   [junit4]   2> 362309 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created lazy: solr.StandardRequestHandler
   [junit4]   2> 362309 T1125 oasc.RequestHandlers.initHandlersFromConfig WARN 
Multiple requestHandler registered to the same name: /update ignoring: 
org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 362310 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created /update: solr.UpdateRequestHandler
   [junit4]   2> 362310 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created /terms: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 362311 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 362311 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 362311 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 362312 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created spellCheckWithWordbreak_Direct: 
org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 362312 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 362313 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created mltrh: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 362313 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created tvrh: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 362314 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created /mlt: solr.MoreLikeThisHandler
   [junit4]   2> 362314 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created /debug/dump: solr.DumpRequestHandler
   [junit4]   2> 362315 T1125 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 362316 T1125 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 362317 T1125 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 362318 T1125 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 362319 T1125 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 362320 T1125 oasc.SolrCore.initDeprecatedSupport WARN 
solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config 
to use the ShowFileRequestHandler.
   [junit4]   2> 362322 T1125 oasu.CommitTracker.<init> Hard AutoCommit: 
disabled
   [junit4]   2> 362322 T1125 oasu.CommitTracker.<init> Soft AutoCommit: 
disabled
   [junit4]   2> 362323 T1125 oass.SolrIndexSearcher.<init> Opening 
Searcher@a38b0aa0[collection1] main
   [junit4]   2> 362323 T1125 oasr.RestManager.init Initializing RestManager 
with initArgs: 
{storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
   [junit4]   2> 362324 T1125 oasr.ManagedResourceStorage.load Reading 
_rest_managed.json using InMemoryStorage
   [junit4]   2> 362324 T1125 oasr.ManagedResource.reloadFromStorage WARN No 
stored data found for /rest/managed
   [junit4]   2> 362324 T1125 oasr.ManagedResourceStorage$JsonStorage.store 
Saved JSON object to path _rest_managed.json using InMemoryStorage
   [junit4]   2> 362325 T1125 oasr.RestManager.init Initializing 0 registered 
ManagedResources
   [junit4]   2> 362325 T1125 oashc.SpellCheckComponent.inform Initializing 
spell checkers
   [junit4]   2> 362326 T1125 oass.DirectSolrSpellChecker.init init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 362331 T1131 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@a38b0aa0[collection1] 
main{UninvertingDirectoryReader()}
   [junit4]   2> 362335 T1125 oasu.DefaultSolrCoreState.newIndexWriter Creating 
new IndexWriter...
   [junit4]   2> 362335 T1125 oasu.DefaultSolrCoreState.newIndexWriter Waiting 
until IndexWriter is unused... core=collection1
   [junit4]   2> 362335 T1125 oasu.DefaultSolrCoreState.newIndexWriter Closing 
old IndexWriter... core=collection1
   [junit4]   2> 362336 T1125 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@fc558d27
 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@bf817c24)),segFN=segments_1,generation=1}
   [junit4]   2>                
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@fc558d27
 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@bf817c24)),segFN=segments_2,generation=2}
   [junit4]   2> 362336 T1125 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 2
   [junit4]   2> 362337 T1125 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: 
[LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=41, 
maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, 
calibrateSizeByDeletes=true, maxMergeDocs=2147483647, 
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.42504873883330097]
   [junit4]   2> 362338 T1125 oasc.SolrDeletionPolicy.onInit 
SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>                
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@fc558d27
 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@bf817c24)),segFN=segments_2,generation=2}
   [junit4]   2> 362338 T1125 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 2
   [junit4]   2> 362338 T1125 oasu.DefaultSolrCoreState.newIndexWriter New 
IndexWriter is ready to be used.
   [junit4]   2> 362339 T1125 oass.SolrIndexSearcher.<init> Opening 
Searcher@18a4adfc[collection1] main
   [junit4]   2> 362339 T1125 oasc.CoreContainer.registerCore replacing core: 
collection1
   [junit4]   2> 362339 T1125 oasc.SolrCore.close [collection1]  CLOSING 
SolrCore org.apache.solr.core.SolrCore@e783c475
   [junit4]   2> 362340 T1131 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@18a4adfc[collection1] 
main{UninvertingDirectoryReader()}
   [junit4]   2> 362343 T1125 oasu.DirectUpdateHandler2.close closing 
DirectUpdateHandler2{commits=1,autocommits=0,soft autocommit 
maxTime=1000ms,soft 
autocommits=1,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=1,adds=0,deletesById=0,deletesByQuery=1,errors=0,cumulative_adds=1,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=0,transaction_logs_total_size=0,transaction_logs_total_number=0}
   [junit4]   2> 362344 T1125 oasc.SolrCore.closeSearcher [collection1] Closing 
main searcher on request.
   [junit4]   2> 362350 T1125 oasup.LogUpdateProcessor.finish [collection1] 
{add=[529 (1475408699556102144)]} 0 5
   [junit4]   2> ASYNC  NEW_CORE C599 name=collection1 
org.apache.solr.core.SolrCore@e40d02fb
   [junit4]   2> 362363 T1125 C599 oasc.SolrCore.execute [collection1] 
webapp=null path=null params={version=2.2&qt=standard&rows=20&start=0&q=id:529} 
hits=0 status=0 QTime=13 
   [junit4]   2> 366350 T1132 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 366353 T1132 oass.SolrIndexSearcher.<init> Opening 
Searcher@698aedd2[collection1] main
   [junit4]   2> 366354 T1132 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 366366 T1131 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@698aedd2[collection1] 
main{UninvertingDirectoryReader(Uninverting(_1(5.0):c1))}
   [junit4]   2> 366388 T1125 oasup.LogUpdateProcessor.finish [collection1] 
{add=[530 (1475408703790252032)]} 0 5
   [junit4]   2> ASYNC  NEW_CORE C600 name=collection1 
org.apache.solr.core.SolrCore@e40d02fb
   [junit4]   2> 366389 T1125 C600 oasc.SolrCore.execute [collection1] 
webapp=null path=null params={version=2.2&qt=standard&rows=20&start=0&q=id:530} 
hits=0 status=0 QTime=0 
   [junit4]   2> 366391 T1125 oasup.LogUpdateProcessor.finish [collection1] 
{delete=[529 (-1475408703794446336)]} 0 5
   [junit4]   2> 366392 T1125 C600 oasc.SolrCore.execute [collection1] 
webapp=null path=null params={version=2.2&qt=standard&rows=20&start=0&q=id:529} 
hits=1 status=0 QTime=0 
   [junit4]   2> 367391 T1132 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 367395 T1132 oass.SolrIndexSearcher.<init> Opening 
Searcher@bf158217[collection1] main
   [junit4]   2> 367395 T1132 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 367397 T1131 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@bf158217[collection1] 
main{UninvertingDirectoryReader(Uninverting(_2(5.0):c1))}
   [junit4]   2> 367645 T1125 C600 oasc.SolrCore.execute [collection1] 
webapp=null path=null params={version=2.2&qt=standard&rows=20&start=0&q=id:529} 
hits=0 status=0 QTime=0 
   [junit4]   2> 367647 T1125 C600 oasc.SolrCore.execute [collection1] 
webapp=null path=null params={version=2.2&qt=standard&rows=20&start=0&q=id:530} 
hits=1 status=0 QTime=0 
   [junit4]   2> 367650 T1125 oasup.LogUpdateProcessor.finish [collection1] 
{add=[500 (1475408705113554944)]} 0 5
   [junit4]   2> 367650 T1125 oasup.LogUpdateProcessor.finish [collection1] 
{add=[500 (1475408705114603520)]} 0 5
   [junit4]   2> 367652 T1125 oasup.LogUpdateProcessor.finish [collection1] 
{add=[500 (1475408705115652096)]} 0 5
   [junit4]   2> 367653 T1125 oasup.LogUpdateProcessor.finish [collection1] 
{add=[500 (1475408705117749248)]} 0 5
   [junit4]   2> 367654 T1125 oasup.LogUpdateProcessor.finish [collection1] 
{add=[500 (1475408705118797824)]} 0 5
   [junit4]   2> 367655 T1125 oasup.LogUpdateProcessor.finish [collection1] 
{add=[500 (1475408705119846400)]} 0 5
   [junit4]   2> 367657 T1125 oasup.LogUpdateProcessor.finish [collection1] 
{add=[500 (1475408705121943552)]} 0 5
   [junit4]   2> 367658 T1125 oasup.LogUpdateProcessor.finish [collection1] 
{add=[500 (1475408705122992128)]} 0 5
   [junit4]   2> 367659 T1125 oasup.LogUpdateProcessor.finish [collection1] 
{add=[500 (1475408705124040704)]} 0 5
   [junit4]   2> 367660 T1125 oasup.LogUpdateProcessor.finish [collection1] 
{add=[500 (1475408705125089280)]} 0 5
   [junit4]   2> 367661 T1125 C600 oasc.SolrCore.execute [collection1] 
webapp=null path=null params={version=2.2&qt=standard&rows=20&start=0&q=id:500} 
hits=0 status=0 QTime=0 
   [junit4]   2> 367664 T1125 oasup.LogUpdateProcessor.finish [collection1] 
{delete=[530 (-1475408705128235008)]} 0 5
   [junit4]   2> 367664 T1125 oasup.LogUpdateProcessor.finish [collection1] 
{delete=[530 (-1475408705129283584)]} 0 5
   [junit4]   2> 367665 T1125 oasup.LogUpdateProcessor.finish [collection1] 
{delete=[530 (-1475408705130332160)]} 0 5
   [junit4]   2> 367665 T1125 oasup.LogUpdateProcessor.finish [collection1] 
{delete=[530 (-1475408705130332161)]} 0 5
   [junit4]   2> 367666 T1125 oasup.LogUpdateProcessor.finish [collection1] 
{delete=[530 (-1475408705131380736)]} 0 5
   [junit4]   2> 367667 T1125 oasup.LogUpdateProcessor.finish [collection1] 
{delete=[530 (-1475408705132429312)]} 0 5
   [junit4]   2> 367667 T1125 oasup.LogUpdateProcessor.finish [collection1] 
{delete=[530 (-1475408705132429313)]} 0 5
   [junit4]   2> 367668 T1125 oasup.LogUpdateProcessor.finish [collection1] 
{delete=[530 (-1475408705133477888)]} 0 5
   [junit4]   2> 367669 T1125 oasup.LogUpdateProcessor.finish [collection1] 
{delete=[530 (-1475408705133477889)]} 0 5
   [junit4]   2> 367669 T1125 oasup.LogUpdateProcessor.finish [collection1] 
{delete=[530 (-1475408705134526464)]} 0 5
   [junit4]   2> 367670 T1125 C600 oasc.SolrCore.execute [collection1] 
webapp=null path=null params={version=2.2&qt=standard&rows=20&start=0&q=id:530} 
hits=1 status=0 QTime=0 
   [junit4]   2> 368664 T1132 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 368667 T1132 oass.SolrIndexSearcher.<init> Opening 
Searcher@351bd944[collection1] main
   [junit4]   2> 368668 T1132 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 368670 T1131 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@351bd944[collection1] 
main{UninvertingDirectoryReader(Uninverting(_3(5.0):c10/9:delGen=1))}
   [junit4]   2> 368672 T1125 C600 oasc.SolrCore.execute [collection1] 
webapp=null path=null params={version=2.2&qt=standard&rows=20&start=0&q=id:500} 
hits=1 status=0 QTime=0 
   [junit4]   2> 368674 T1125 C600 oasc.SolrCore.execute [collection1] 
webapp=null path=null params={version=2.2&qt=standard&rows=20&start=0&q=id:530} 
hits=0 status=0 QTime=0 
   [junit4]   2> 368675 T1125 oas.SolrTestCaseJ4.tearDown ###Ending 
testCommitWithin
   [junit4]   2> 368679 T1125 oas.SolrTestCaseJ4.setUp ###Starting testMaxDocs
   [junit4]   2> 368680 T1125 C600 oass.SolrIndexSearcher.<init> Opening 
Searcher@ddff0902[collection1] realtime
   [junit4]   2> 368681 T1125 C600 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {deleteByQuery=*:* 
(-1475408706193588224)} 0 2
   [junit4]   2> 368682 T1125 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/'
   [junit4]   2> 368683 T1125 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/.svn/'
 to classloader
   [junit4]   2> 368683 T1125 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/classes/'
 to classloader
   [junit4]   2> 368684 T1125 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/README'
 to classloader
   [junit4]   2> 368716 T1125 oasc.SolrConfig.<init> Using Lucene MatchVersion: 
LUCENE_5_0
   [junit4]   2> 368760 T1125 oasc.SolrConfig.<init> Loaded SolrConfig: 
solrconfig.xml
   [junit4]   2> 368761 T1125 oass.IndexSchema.readSchema Reading Solr Schema 
from schema.xml
   [junit4]   2> 368766 T1125 oass.IndexSchema.readSchema [collection1] Schema 
name=test
   [junit4]   2> 369060 T1125 oass.OpenExchangeRatesOrgProvider.init 
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 369064 T1125 oass.IndexSchema.readSchema default search field 
in schema is text
   [junit4]   2> 369066 T1125 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 369071 T1125 oass.FileExchangeRateProvider.reload Reloading 
exchange rates from file currency.xml
   [junit4]   2> 369074 T1125 oass.FileExchangeRateProvider.reload Reloading 
exchange rates from file currency.xml
   [junit4]   2> 369077 T1125 oass.OpenExchangeRatesOrgProvider.reload 
Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 369077 T1125 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 369077 T1125 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 369078 T1125 oass.OpenExchangeRatesOrgProvider.reload 
Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 369078 T1125 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 369078 T1125 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 369079 T1125 oasc.CoreContainer.reload Reloading SolrCore 
'collection1' using configuration from instancedir 
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/
   [junit4]   2> 369079 T1125 oasc.SolrCore.<init> [collection1] Opening new 
SolrCore at 
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/,
 
dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./temp/solr.update.AutoCommitTest-D9FA84AE2CFD88FD-001/init-core-data-001/
   [junit4]   2> 369079 T1125 oasc.JmxMonitoredMap.<init> JMX monitoring is 
enabled. Adding Solr mbeans to JMX Server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@c1481528
   [junit4]   2> 369080 T1125 oasc.SolrCore.getNewIndexDir New index directory 
detected: old=null 
new=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./temp/solr.update.AutoCommitTest-D9FA84AE2CFD88FD-001/init-core-data-001/index/
   [junit4]   2> 369080 T1125 oasc.SolrCore.initWriters created xml: 
solr.XMLResponseWriter
   [junit4]   2> 369082 T1125 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "dedupe"
   [junit4]   2> 369083 T1125 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 369083 T1125 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "dedupe-allfields"
   [junit4]   2> 369083 T1125 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"dedupe-allfields"
   [junit4]   2> 369084 T1125 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "stored_sig"
   [junit4]   2> 369084 T1125 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 369084 T1125 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 369085 T1125 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 369085 T1125 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
   [junit4]   2> 369085 T1125 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 369086 T1125 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"distrib-dup-test-chain-implicit"
   [junit4]   2> 369086 T1125 oasc.SolrCore.loadUpdateProcessorChains no 
updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 369087 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created /update: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 369087 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created /update/json: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 369088 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 369088 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 369088 T1125 oasc.RequestHandlers.initHandlersFromConfig 
adding lazy requestHandler: solr.ReplicationHandler
   [junit4]   2> 369089 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created /replication: solr.ReplicationHandler
   [junit4]   2> 369089 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created standard: solr.StandardRequestHandler
   [junit4]   2> 369090 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created /get: solr.RealTimeGetHandler
   [junit4]   2> 369090 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created dismax: solr.SearchHandler
   [junit4]   2> 369091 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
   [junit4]   2> 369091 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created /admin/: org.apache.solr.handler.admin.AdminHandlers
   [junit4]   2> 369091 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created /admin/file: solr.admin.ShowFileRequestHandler
   [junit4]   2> 369092 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created /admin/fileedit: solr.admin.EditFileRequestHandler
   [junit4]   2> 369092 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created defaults: solr.StandardRequestHandler
   [junit4]   2> 369093 T1125 oasc.RequestHandlers.initHandlersFromConfig 
adding lazy requestHandler: solr.StandardRequestHandler
   [junit4]   2> 369093 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created lazy: solr.StandardRequestHandler
   [junit4]   2> 369093 T1125 oasc.RequestHandlers.initHandlersFromConfig WARN 
Multiple requestHandler registered to the same name: /update ignoring: 
org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 369094 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created /update: solr.UpdateRequestHandler
   [junit4]   2> 369094 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created /terms: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 369095 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 369095 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 369095 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 369096 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created spellCheckWithWordbreak_Direct: 
org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 369096 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 369097 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created mltrh: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 369097 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created tvrh: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 369098 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created /mlt: solr.MoreLikeThisHandler
   [junit4]   2> 369098 T1125 oasc.RequestHandlers.initHandlersFromConfig 
created /debug/dump: solr.DumpRequestHandler
   [junit4]   2> 369099 T1125 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 369100 T1125 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 369101 T1125 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 369103 T1125 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 369104 T1125 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 369105 T1125 oasc.SolrCore.initDeprecatedSupport WARN 
solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config 
to use the ShowFileRequestHandler.
   [junit4]   2> 369106 T1125 oasu.CommitTracker.<init> Hard AutoCommit: 
disabled
   [junit4]   2> 369106 T1125 oasu.CommitTracker.<init> Soft AutoCommit: 
disabled
   [junit4]   2> 369107 T1125 oass.SolrIndexSearcher.<init> Opening 
Searcher@84e573d5[collection1] main
   [junit4]   2> 369107 T1125 oasr.RestManager.init Initializing RestManager 
with initArgs: 
{storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
   [junit4]   2> 369108 T1125 oasr.ManagedResourceStorage.load Reading 
_rest_managed.json using InMemoryStorage
   [junit4]   2> 369108 T1125 oasr.ManagedResource.reloadFromStorage WARN No 
stored data found for /rest/managed
   [junit4]   2> 369108 T1125 oasr.ManagedResourceStorage$JsonStorage.store 
Saved JSON object to path _rest_managed.json using InMemoryStorage
   [junit4]   2> 369109 T1125 oasr.RestManager.init Initializing 0 registered 
ManagedResources
   [junit4]   2> 369109 T1125 oashc.SpellCheckComponent.inform Initializing 
spell checkers
   [junit4]   2> 369110 T1125 oass.DirectSolrSpellChecker.init init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 369116 T1133 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@84e573d5[collection1] 
main{UninvertingDirectoryReader()}
   [junit4]   2> 369121 T1125 oasu.DefaultSolrCoreState.newIndexWriter Creating 
new IndexWriter...
   [junit4]   2> 369121 T1125 oasu.DefaultSolrCoreState.newIndexWriter Waiting 
until IndexWriter is unused... core=collection1
   [junit4]   2> 369121 T1125 oasu.DefaultSolrCoreState.newIndexWriter Closing 
old IndexWriter... core=collection1
   [junit4]   2> 369122 T1125 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@fc558d27
 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@bf817c24)),segFN=segments_2,generation=2}
   [junit4]   2>                
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@fc558d27
 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@bf817c24)),segFN=segments_3,generation=3}
   [junit4]   2> 369122 T1125 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 3
   [junit4]   2> 369123 T1125 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=14, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.3289482187257374]
   [junit4]   2> 369123 T1125 oasc.SolrDeletionPolicy.onInit 
SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>                
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@fc558d27
 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@bf817c24)),segFN=segments_3,generation=3}
   [junit4]   2> 369124 T1125 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 3
   [junit4]   2> 369124 T1125 oasu.DefaultSolrCoreState.newIndexWriter New 
IndexWriter is ready to be used.
   [junit4]   2> 369124 T1125 oass.SolrIndexSearcher.<init> Opening 
Searcher@84457638[collection1] main
   [junit4]   2> 369125 T1125 oasc.CoreContainer.registerCore replacing core: 
collection1
   [junit4]   2> 369125 T1125 oasc.SolrCore.close [collection1]  CLOSING 
SolrCore org.apache.solr.core.SolrCore@e40d02fb
   [junit4]   2> 369126 T1133 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@84457638[collection1] 
main{UninvertingDirectoryReader()}
   [junit4]   2> 369130 T1125 oasu.DirectUpdateHandler2.close closing 
DirectUpdateHandler2{commits=3,autocommits=0,soft 
autocommits=3,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=12,adds=0,deletesById=0,deletesByQuery=1,errors=0,cumulative_adds=12,cumulative_deletesById=11,cumulative_deletesByQuery=1,cumulative_errors=0,transaction_logs_total_size=0,transaction_logs_total_number=0}
   [junit4]   2> 369130 T1125 oasc.SolrCore.closeSearcher [collection1] Closing 
main searcher on request.
   [junit4]   2> 369144 T1125 oasup.LogUpdateProcessor.finish [collection1] 
{add=[0 (1475408706680127488)]} 0 12
   [junit4]   2> 369144 T1125 oasup.LogUpdateProcessor.finish [collection1] 
{add=[1 (1475408706681176064)]} 0 12
   [junit4]   2> 369145 T1125 oasup.LogUpdateProcessor.finish [collection1] 
{add=[2 (1475408706682224640)]} 0 12
   [junit4]   2> 369145 T1125 oasup.LogUpdateProcessor.finish [collection1] 
{add=[3 (1475408706682224641)]} 0 12
   [junit4]   2> 369146 T1125 oasup.LogUpdateProcessor.finish [collection1] 
{add=[4 (1475408706683273216)]} 0 12
   [junit4]   2> 369146 T1125 oasup.LogUpdateProcessor.finish [collection1] 
{add=[5 (1475408706683273217)]} 0 12
   [junit4]   2> 369147 T1125 oasup.LogUpdateProcessor.finish [collection1] 
{add=[6 (1475408706684321792)]} 0 12
   [junit4]   2> 369148 T1125 oasup.LogUpdateProcessor.finish [collection1] 
{add=[7 (1475408706685370368)]} 0 12
   [junit4]   2> 369149 T1125 oasup.LogUpdateProcessor.finish [collection1] 
{add=[8 (1475408706686418944)]} 0 12
   [junit4]   2> 369150 T1125 oasup.LogUpdateProcessor.finish [collection1] 
{add=[9 (1475408706686418945)]} 0 12
   [junit4]   2> 369150 T1125 oasup.LogUpdateProcessor.finish [collection1] 
{add=[10 (1475408706687467520)]} 0 12
   [junit4]   2> 369151 T1125 oasup.LogUpdateProcessor.finish [collection1] 
{add=[11 (1475408706688516096)]} 0 12
   [junit4]   2> 369152 T1125 oasup.LogUpdateProcessor.finish [collection1] 
{add=[12 (1475408706689564672)]} 0 12
   [junit4]   2> 369153 T1125 oasup.LogUpdateProcessor.finish [collection1] 
{add=[13 (1475408706690613248)]} 0 12
   [junit4]   2> ASYNC  NEW_CORE C601 name=collection1 
org.apache.solr.core.SolrCore@8d309ae2
   [junit4]   2> 369153 T1125 C601 oasc.SolrCore.execute [collection1] 
webapp=null path=null params={version=2.2&qt=standard&rows=20&start=0&q=id:1} 
hits=0 status=0 QTime=0 
   [junit4]   2> 369176 T1125 oasup.LogUpdateProcessor.finish [collection1] 
{add=[14 (1475408706714730496)]} 0 12
   [junit4]   2> 369177 T1134 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 369180 T1134 oass.SolrIndexSearcher.<init> Opening 
Searcher@31132b98[collection1] main
   [junit4]   2> 369181 T1134 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 369183 T1133 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@31132b98[collection1] 
main{UninvertingDirectoryReader(Uninverting(_4(5.0):c15))}
   [junit4]   2> 369428 T1125 oasup.LogUpdateProcessor.finish [collection1] 
{add=[15 (1475408706977923072)]} 0 12
   [junit4]   2> 369429 T1125 C601 oasc.SolrCore.execute [collection1] 
webapp=null path=null params={version=2.2&qt=standard&rows=20&start=0&q=id:14} 
hits=1 status=0 QTime=0 
   [junit4]   2> 369431 T1125 C601 oasc.SolrCore.execute [collection1] 
webapp=null path=null params={version=2.2&qt=standard&rows=20&start=0&q=id:15} 
hits=0 status=0 QTime=0 
   [junit4]   2> 369432 T1125 oas.SolrTestCaseJ4.tearDown ###Ending testMaxDocs
   [junit4]   2> 369435 T1125 oas.SolrTestCaseJ4.deleteCore ###deleteCore
   [junit4]   2> 369435 T1125 oasc.CoreContainer.shutdown Shutting down 
CoreContainer instance=-178802778
   [junit4]   2> 369436 T1125 oasc.SolrCore.close [collection1]  CLOSING 
SolrCore org.apache.solr.core.SolrCore@8d309ae2
   [junit4]   2> 369446 T1125 oasu.DirectUpdateHandler2.close closing 
DirectUpdateHandler2{commits=1,autocommits=0,soft autocommit maxDocs=14,soft 
autocommits=1,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=16,adds=1,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=16,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0,transaction_logs_total_size=0,transaction_logs_total_number=0}
   [junit4]   2> 369446 T1125 oasu.SolrCoreState.decrefSolrCoreState Closing 
SolrCoreState
   [junit4]   2> 369446 T1125 oasu.DefaultSolrCoreState.closeIndexWriter 
SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 369453 T1125 oasu.DefaultSolrCoreState.closeIndexWriter 
closing IndexWriter with IndexWriterCloser
   [junit4]   2> ASYNC  NEW_CORE C602 name=collection1 
org.apache.solr.core.SolrCore@8d309ae2
   [junit4]   2> 369453 T1125 C602 oasu.DirectUpdateHandler2.closeWriter 
Committing on IndexWriter close.
   [junit4]   2> 369455 T1125 C602 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@fc558d27
 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@bf817c24)),segFN=segments_3,generation=3}
   [junit4]   2>                
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@fc558d27
 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@bf817c24)),segFN=segments_4,generation=4}
   [junit4]   2> 369455 T1125 C602 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 4
   [junit4]   2> 369456 T1125 oasc.SolrCore.closeSearcher [collection1] Closing 
main searcher on request.
   [junit4]   2> 369456 T1125 oasc.CachingDirectoryFactory.close Closing 
MockDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 369456 T1125 oasc.CachingDirectoryFactory.closeCacheValue 
looking to close 
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./temp/solr.update.AutoCommitTest-D9FA84AE2CFD88FD-001/init-core-data-001/index
 
[CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./temp/solr.update.AutoCommitTest-D9FA84AE2CFD88FD-001/init-core-data-001/index;done=false>>]
   [junit4]   2> 369456 T1125 oasc.CachingDirectoryFactory.close Closing 
directory: 
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./temp/solr.update.AutoCommitTest-D9FA84AE2CFD88FD-001/init-core-data-001/index
   [junit4]   2> 369457 T1125 oasc.CachingDirectoryFactory.closeCacheValue 
looking to close 
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./temp/solr.update.AutoCommitTest-D9FA84AE2CFD88FD-001/init-core-data-001
 
[CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./temp/solr.update.AutoCommitTest-D9FA84AE2CFD88FD-001/init-core-data-001;done=false>>]
   [junit4]   2> 369457 T1125 oasc.CachingDirectoryFactory.close Closing 
directory: 
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./temp/solr.update.AutoCommitTest-D9FA84AE2CFD88FD-001/init-core-data-001
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./temp/solr.update.AutoCommitTest-D9FA84AE2CFD88FD-001
   [junit4]   2> NOTE: test params are: codec=Lucene46, sim=DefaultSimilarity, 
locale=it, timezone=America/Danmarkshavn
   [junit4]   2> NOTE: Linux 3.13.0-32-generic amd64/IBM Corporation 1.7.0 
(64-bit)/cpus=8,threads=1,free=36293560,total=100859904
   [junit4]   2> NOTE: All tests run in this JVM: [TestSolrXmlPersistor, 
StressHdfsTest, QueryFacetTest, TestModifyConfFiles, TestJmxMonitoredMap, 
UpdateRequestProcessorFactoryTest, MultiThreadedOCPTest, 
TestMiniSolrCloudCluster, TestPseudoReturnFields, TestFieldSortValues, 
TestZkChroot, OverseerRolesTest, TestFreeTextSuggestions, 
AnalysisAfterCoreReloadTest, CollectionsAPIAsyncDistributedZkTest, BasicZkTest, 
TestLRUCache, DocValuesTest, SolrIndexConfigTest, 
TestHighFrequencyDictionaryFactory, TestExtendedDismaxParser, UUIDFieldTest, 
CSVRequestHandlerTest, TestQueryTypes, DistributedQueryElevationComponentTest, 
TestSolrQueryParserResource, InfoHandlerTest, TestCloudManagedSchema, 
FieldAnalysisRequestHandlerTest, TestMaxScoreQueryParser, AliasIntegrationTest, 
TestFunctionQuery, RequestHandlersTest, NoFacetTest, 
UniqFieldsUpdateProcessorFactoryTest, SolrCoreTest, CacheHeaderTest, 
HardAutoCommitTest, TestImplicitCoreProperties, PolyFieldTest, 
AsyncMigrateRouteKeyTest, TestRecovery, HdfsLockFactoryTest, 
DirectSolrConnectionTest, TestSolrXMLSerializer, HttpPartitionTest, 
UUIDUpdateProcessorFallbackTest, BasicDistributedZk2Test, 
TestMultiCoreConfBootstrap, SortByFunctionTest, SynonymTokenizerTest, 
TestLazyCores, DirectUpdateHandlerOptimizeTest, 
SchemaVersionSpecificBehaviorTest, DefaultValueUpdateProcessorTest, 
TestFieldCollectionResource, HdfsUnloadDistributedZkTest, EnumFieldTest, 
TestWriterPerf, ConnectionManagerTest, TestCoreContainer, 
TestCursorMarkWithoutUniqueKey, TestSystemIdResolver, ZkSolrClientTest, 
SuggesterFSTTest, ShardSplitTest, TestPostingsSolrHighlighter, 
TestCollectionAPI, SampleTest, TestQuerySenderNoQuery, BJQParserTest, 
TestPerFieldSimilarity, TermVectorComponentDistributedTest, 
ConvertedLegacyTest, AtomicUpdatesTest, TestPHPSerializedResponseWriter, 
LoggingHandlerTest, TestRandomFaceting, IndexSchemaRuntimeFieldTest, 
TestIBSimilarityFactory, HdfsDirectoryTest, TestBM25SimilarityFactory, 
TestRecoveryHdfs, DateRangeFieldTest, RankQueryTest, 
CoreContainerCoreInitFailuresTest, SOLR749Test, AutoCommitTest]
   [junit4] Completed on J1 in 12.43s, 3 tests, 1 error <<< FAILURES!

[...truncated 780 lines...]
BUILD FAILED
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:467: The following 
error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:460: The following 
error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:45: The following 
error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/extra-targets.xml:37: The 
following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build.xml:189: The 
following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/common-build.xml:496: 
The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:1298:
 The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:922: 
There were test failures: 422 suites, 1756 tests, 1 error, 98 ignored (18 
assumptions)

Total time: 61 minutes 34 seconds
Build step 'Invoke Ant' marked build as failure
[description-setter] Description set: Java: 64bit/ibm-j9-jdk7 
-Xjit:exclude={org/apache/lucene/util/fst/FST.pack(IIF)Lorg/apache/lucene/util/fst/FST;}
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any


---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org

Reply via email to