Build: http://jenkins.thetaphi.de/job/Lucene-Solr-5.x-Linux/11934/
Java: 32bit/jdk1.8.0_60-ea-b06 -server -XX:+UseG1GC

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

Error Message:
Exception during query

Stack Trace:
java.lang.RuntimeException: Exception during query
        at 
__randomizedtesting.SeedInfo.seed([37A3D4B7AF676434:AD57A95531FDF808]:0)
        at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:794)
        at 
org.apache.solr.update.AutoCommitTest.testMaxTime(AutoCommitTest.java:237)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:497)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1627)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:836)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:872)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:886)
        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 
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:845)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:747)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:781)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:792)
        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 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
        at java.lang.Thread.run(Thread.java:745)
Caused by: java.lang.RuntimeException: REQUEST FAILED: 
xpath=//result[@numFound=1]
        xml response was: <?xml version="1.0" encoding="UTF-8"?>
<response>
<lst name="responseHeader"><int name="status">0</int><int 
name="QTime">1</int></lst><result name="response" numFound="0" 
start="0"></result>
</response>

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




Build Log:
[...truncated 10210 lines...]
   [junit4] Suite: org.apache.solr.update.AutoCommitTest
   [junit4]   2> Creating dataDir: 
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest
 37A3D4B7AF676434-001/init-core-data-001
   [junit4]   2> 856570 T5267 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl 
(false) and clientAuth (false)
   [junit4]   2> 856571 T5267 oas.SolrTestCaseJ4.initCore ####initCore
   [junit4]   2> 856571 T5267 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/'
   [junit4]   2> 856571 T5267 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes/'
 to classloader
   [junit4]   2> 856571 T5267 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/README'
 to classloader
   [junit4]   2> 856592 T5267 oasc.SolrConfig.refreshRequestParams current 
version of requestparams : -1
   [junit4]   2> 856599 T5267 oasc.SolrConfig.<init> Using Lucene MatchVersion: 
5.1.0
   [junit4]   2> 856615 T5267 oasc.SolrConfig.<init> Loaded SolrConfig: 
solrconfig.xml
   [junit4]   2> 856616 T5267 oass.IndexSchema.readSchema Reading Solr Schema 
from 
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/schema.xml
   [junit4]   2> 856620 T5267 oass.IndexSchema.readSchema [null] Schema 
name=test
   [junit4]   2> 856725 T5267 oass.OpenExchangeRatesOrgProvider.init 
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 856731 T5267 oass.IndexSchema.readSchema default search field 
in schema is text
   [junit4]   2> 856733 T5267 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 856738 T5267 oass.FileExchangeRateProvider.reload Reloading 
exchange rates from file currency.xml
   [junit4]   2> 856740 T5267 oass.FileExchangeRateProvider.reload Reloading 
exchange rates from file currency.xml
   [junit4]   2> 856741 T5267 oass.OpenExchangeRatesOrgProvider.reload 
Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 856742 T5267 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 856742 T5267 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 856742 T5267 oass.OpenExchangeRatesOrgProvider.reload 
Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 856743 T5267 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 856743 T5267 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 856744 T5267 oasc.SolrResourceLoader.locateSolrHome JNDI not 
configured for solr (NoInitialContextEx)
   [junit4]   2> 856744 T5267 oasc.SolrResourceLoader.locateSolrHome using 
system property solr.solr.home: 
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr
   [junit4]   2> 856744 T5267 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/'
   [junit4]   2> 856756 T5267 oasc.CoreContainer.<init> New CoreContainer 
16791538
   [junit4]   2> 856757 T5267 oasc.CoreContainer.load Loading cores into 
CoreContainer 
[instanceDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/]
   [junit4]   2> 856757 T5267 oasc.CoreContainer.load loading shared library: 
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/lib
   [junit4]   2> 856758 T5267 oasc.SolrResourceLoader.addToClassLoader WARN 
Can't find (or read) directory to add to classloader: lib (resolved as: 
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/lib).
   [junit4]   2> 856764 T5267 oashc.HttpShardHandlerFactory.getParameter 
Setting socketTimeout to: 600000
   [junit4]   2> 856764 T5267 oashc.HttpShardHandlerFactory.getParameter 
Setting urlScheme to: null
   [junit4]   2> 856764 T5267 oashc.HttpShardHandlerFactory.getParameter 
Setting connTimeout to: 60000
   [junit4]   2> 856765 T5267 oashc.HttpShardHandlerFactory.getParameter 
Setting maxConnectionsPerHost to: 20
   [junit4]   2> 856765 T5267 oashc.HttpShardHandlerFactory.getParameter 
Setting maxConnections to: 10000
   [junit4]   2> 856765 T5267 oashc.HttpShardHandlerFactory.getParameter 
Setting corePoolSize to: 0
   [junit4]   2> 856765 T5267 oashc.HttpShardHandlerFactory.getParameter 
Setting maximumPoolSize to: 2147483647
   [junit4]   2> 856765 T5267 oashc.HttpShardHandlerFactory.getParameter 
Setting maxThreadIdleTime to: 5
   [junit4]   2> 856766 T5267 oashc.HttpShardHandlerFactory.getParameter 
Setting sizeOfQueue to: -1
   [junit4]   2> 856766 T5267 oashc.HttpShardHandlerFactory.getParameter 
Setting fairnessPolicy to: false
   [junit4]   2> 856766 T5267 oashc.HttpShardHandlerFactory.getParameter 
Setting useRetries to: false
   [junit4]   2> 856766 T5267 oasu.UpdateShardHandler.<init> Creating 
UpdateShardHandler HTTP client with params: 
socketTimeout=30000&connTimeout=30000&retry=true
   [junit4]   2> 856767 T5267 oasl.LogWatcher.createWatcher SLF4J impl is 
org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 856767 T5267 oasl.LogWatcher.newRegisteredLogWatcher 
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 856767 T5267 oasc.CoreContainer.load Node Name: testNode
   [junit4]   2> 856768 T5267 oasc.CoreDescriptor.<init> CORE DESCRIPTOR: 
{name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml, 
loadOnStartup=true, instanceDir=collection1, collection=collection1, 
absoluteInstDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/,
 
dataDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest
 37A3D4B7AF676434-001/init-core-data-001, shard=shard1}
   [junit4]   2> 856768 T5268 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/'
   [junit4]   2> 856769 T5268 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes/'
 to classloader
   [junit4]   2> 856769 T5268 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/README'
 to classloader
   [junit4]   2> 856795 T5268 oasc.SolrConfig.refreshRequestParams current 
version of requestparams : -1
   [junit4]   2> 856807 T5268 oasc.SolrConfig.<init> Using Lucene MatchVersion: 
5.1.0
   [junit4]   2> 856834 T5268 oasc.SolrConfig.<init> Loaded SolrConfig: 
solrconfig.xml
   [junit4]   2> 856834 T5268 oass.IndexSchema.readSchema Reading Solr Schema 
from 
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/schema.xml
   [junit4]   2> 856839 T5268 oass.IndexSchema.readSchema [collection1] Schema 
name=test
   [junit4]   2> 856932 T5268 oass.OpenExchangeRatesOrgProvider.init 
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 856938 T5268 oass.IndexSchema.readSchema default search field 
in schema is text
   [junit4]   2> 856939 T5268 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 856943 T5268 oass.FileExchangeRateProvider.reload Reloading 
exchange rates from file currency.xml
   [junit4]   2> 856946 T5268 oass.FileExchangeRateProvider.reload Reloading 
exchange rates from file currency.xml
   [junit4]   2> 856947 T5268 oass.OpenExchangeRatesOrgProvider.reload 
Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 856948 T5268 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 856948 T5268 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 856948 T5268 oass.OpenExchangeRatesOrgProvider.reload 
Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 856949 T5268 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 856949 T5268 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 856949 T5268 oasc.CoreContainer.create Creating SolrCore 
'collection1' using configuration from instancedir 
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/
   [junit4]   2> 856949 T5268 oasc.SolrCore.initDirectoryFactory 
org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 856950 T5268 oasc.SolrCore.<init> [collection1] Opening new 
SolrCore at 
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/,
 
dataDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest
 37A3D4B7AF676434-001/init-core-data-001/
   [junit4]   2> 856950 T5268 oasc.JmxMonitoredMap.<init> JMX monitoring is 
enabled. Adding Solr mbeans to JMX Server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@14d9a34
   [junit4]   2> 856952 T5268 oasc.CachingDirectoryFactory.get return new 
directory for 
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest
 37A3D4B7AF676434-001/init-core-data-001
   [junit4]   2> 856953 T5268 oasc.SolrCore.getNewIndexDir New index directory 
detected: old=null 
new=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest
 37A3D4B7AF676434-001/init-core-data-001/index/
   [junit4]   2> 856953 T5268 oasc.SolrCore.initIndex WARN [collection1] Solr 
index directory 
'/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest
 37A3D4B7AF676434-001/init-core-data-001/index' doesn't exist. Creating new 
index...
   [junit4]   2> 856953 T5268 oasc.CachingDirectoryFactory.get return new 
directory for 
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest
 37A3D4B7AF676434-001/init-core-data-001/index
   [junit4]   2> 856953 T5268 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=49, maxMergeAtOnceExplicit=27, maxMergedSegmentMB=2.333984375, 
floorSegmentMB=1.466796875, forceMergeDeletesPctAllowed=18.543978993002376, 
segmentsPerTier=33.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.42125833851737704
   [junit4]   2> 856954 T5268 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@5d0db5 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@18726e6),segFN=segments_1,generation=1}
   [junit4]   2> 856954 T5268 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 1
   [junit4]   2> 856959 T5268 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "dedupe"
   [junit4]   2> 856959 T5268 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 856959 T5268 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "dedupe-allfields"
   [junit4]   2> 856959 T5268 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"dedupe-allfields"
   [junit4]   2> 856960 T5268 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "stored_sig"
   [junit4]   2> 856960 T5268 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 856960 T5268 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 856960 T5268 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 856960 T5268 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
   [junit4]   2> 856961 T5268 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 856961 T5268 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"distrib-dup-test-chain-implicit"
   [junit4]   2> 856961 T5268 oasc.SolrCore.loadUpdateProcessorChains no 
updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 856963 T5268 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 856964 T5268 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 856965 T5268 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 856966 T5268 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 856970 T5268 oasc.PluginBag.createPlugin requestHandler : 
'lazy' created with startup=lazy 
   [junit4]   2> 856971 T5268 oasc.RequestHandlers.initHandlersFromConfig 
Registered paths: 
/admin/mbeans,standard,spellCheckCompRH,lazy,/update/json/docs,/admin/luke,spellCheckWithWordbreak_Direct,tvrh,/get,/admin/properties,/update/json,mltrh,/admin/threads,/search-facet-def,/update/csv,/search-facet-invariants,/admin/segments,spellCheckCompRH1,/mlt,/admin/system,/replication,dismax,defaults,/config,/schema,/admin/plugins,/admin/logging,spellCheckWithWordbreak,mock,/admin/ping,/update,/admin/file,/terms,spellCheckCompRH_Direct,/debug/dump
   [junit4]   2> 856972 T5268 oasc.SolrCore.initDeprecatedSupport WARN 
solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config 
to use the ShowFileRequestHandler.
   [junit4]   2> 856973 T5268 oasc.SolrCore.initStatsCache Using default 
statsCache cache: org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 856974 T5268 oasu.UpdateHandler.<init> Using UpdateLog 
implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 856974 T5268 oasu.UpdateLog.init Initializing UpdateLog: 
dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10
   [junit4]   2> 856975 T5268 oasu.CommitTracker.<init> Hard AutoCommit: 
disabled
   [junit4]   2> 856975 T5268 oasu.CommitTracker.<init> Soft AutoCommit: 
disabled
   [junit4]   2> 856975 T5268 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: 
[LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=33, 
maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, 
calibrateSizeByDeletes=false, maxMergeDocs=2147483647, 
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
   [junit4]   2> 856976 T5268 oasc.SolrDeletionPolicy.onInit 
SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@5d0db5 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@18726e6),segFN=segments_1,generation=1}
   [junit4]   2> 856976 T5268 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 1
   [junit4]   2> 856976 T5268 oass.SolrIndexSearcher.<init> Opening 
Searcher@124eb4[collection1] main
   [junit4]   2> 856977 T5268 oasr.RestManager.init Initializing RestManager 
with initArgs: 
{storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
   [junit4]   2> 856977 T5268 oasr.ManagedResourceStorage.load Reading 
_rest_managed.json using InMemoryStorage
   [junit4]   2> 856977 T5268 oasr.RestManager.init Initializing 0 registered 
ManagedResources
   [junit4]   2> 856977 T5268 oashc.SpellCheckComponent.inform Initializing 
spell checkers
   [junit4]   2> 857022 T5268 oass.DirectSolrSpellChecker.init init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 857145 T5268 oash.ReplicationHandler.inform Commits will be 
reserved for  10000
   [junit4]   2> 857145 T5269 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: default
   [junit4]   2> 857146 T5268 oasc.CoreContainer.registerCore registering core: 
collection1
   [junit4]   2> 857146 T5269 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: direct
   [junit4]   2> 857146 T5269 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: wordbreak
   [junit4]   2> 857146 T5269 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: multipleFields
   [junit4]   2> 857146 T5269 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: jarowinkler
   [junit4]   2> 857147 T5269 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: external
   [junit4]   2> 857147 T5267 oas.SolrTestCaseJ4.initCore ####initCore end
   [junit4]   2> 857147 T5269 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: freq
   [junit4]   2> 857147 T5269 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: fqcn
   [junit4]   2> 857148 T5269 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: perDict
   [junit4]   2> 857149 T5267 oas.SolrTestCaseJ4.setUp ###Starting testMaxTime
   [junit4]   2> 857149 T5269 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@124eb4[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> ASYNC  NEW_CORE C547 name=collection1 
org.apache.solr.core.SolrCore@13ac357
   [junit4]   2> 857151 T5267 C547 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {deleteByQuery=*:* 
(-1496725137372741632)} 0 1
   [junit4]   2> 857153 T5267 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/'
   [junit4]   2> 857154 T5267 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes/'
 to classloader
   [junit4]   2> 857154 T5267 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/README'
 to classloader
   [junit4]   2> 857171 T5267 oasc.SolrConfig.refreshRequestParams current 
version of requestparams : -1
   [junit4]   2> 857179 T5267 oasc.SolrConfig.<init> Using Lucene MatchVersion: 
5.1.0
   [junit4]   2> 857198 T5267 oasc.SolrConfig.<init> Loaded SolrConfig: 
solrconfig.xml
   [junit4]   2> 857199 T5267 oass.IndexSchema.readSchema Reading Solr Schema 
from 
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/schema.xml
   [junit4]   2> 857204 T5267 oass.IndexSchema.readSchema [collection1] Schema 
name=test
   [junit4]   2> 857325 T5267 oass.OpenExchangeRatesOrgProvider.init 
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 857331 T5267 oass.IndexSchema.readSchema default search field 
in schema is text
   [junit4]   2> 857332 T5267 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 857338 T5267 oass.FileExchangeRateProvider.reload Reloading 
exchange rates from file currency.xml
   [junit4]   2> 857340 T5267 oass.FileExchangeRateProvider.reload Reloading 
exchange rates from file currency.xml
   [junit4]   2> 857342 T5267 oass.OpenExchangeRatesOrgProvider.reload 
Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 857343 T5267 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 857343 T5267 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 857343 T5267 oass.OpenExchangeRatesOrgProvider.reload 
Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 857344 T5267 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 857344 T5267 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 857345 T5267 oasc.CoreContainer.reload Reloading SolrCore 
'collection1' using configuration from instancedir 
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/
   [junit4]   2> 857345 T5267 oasc.SolrCore.<init> [collection1] Opening new 
SolrCore at 
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/,
 
dataDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest
 37A3D4B7AF676434-001/init-core-data-001/
   [junit4]   2> 857346 T5267 oasc.JmxMonitoredMap.<init> JMX monitoring is 
enabled. Adding Solr mbeans to JMX Server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@14d9a34
   [junit4]   2> 857346 T5267 oasc.SolrCore.getNewIndexDir New index directory 
detected: old=null 
new=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest
 37A3D4B7AF676434-001/init-core-data-001/index/
   [junit4]   2> 857351 T5267 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "dedupe"
   [junit4]   2> 857352 T5267 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 857352 T5267 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "dedupe-allfields"
   [junit4]   2> 857353 T5267 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"dedupe-allfields"
   [junit4]   2> 857353 T5267 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "stored_sig"
   [junit4]   2> 857353 T5267 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 857354 T5267 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 857354 T5267 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 857354 T5267 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
   [junit4]   2> 857355 T5267 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 857355 T5267 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"distrib-dup-test-chain-implicit"
   [junit4]   2> 857356 T5267 oasc.SolrCore.loadUpdateProcessorChains no 
updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 857357 T5267 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 857359 T5267 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 857360 T5267 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 857361 T5267 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 857366 T5267 oasc.PluginBag.createPlugin requestHandler : 
'lazy' created with startup=lazy 
   [junit4]   2> 857369 T5267 oasc.RequestHandlers.initHandlersFromConfig 
Registered paths: 
/admin/mbeans,standard,spellCheckCompRH,lazy,/update/json/docs,/admin/luke,spellCheckWithWordbreak_Direct,tvrh,/get,/admin/properties,/update/json,mltrh,/admin/threads,/search-facet-def,/update/csv,/search-facet-invariants,/admin/segments,spellCheckCompRH1,/mlt,/admin/system,/replication,dismax,defaults,/config,/schema,/admin/plugins,/admin/logging,spellCheckWithWordbreak,mock,/admin/ping,/update,/admin/file,/terms,spellCheckCompRH_Direct,/debug/dump
   [junit4]   2> 857370 T5267 oasc.SolrCore.initDeprecatedSupport WARN 
solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config 
to use the ShowFileRequestHandler.
   [junit4]   2> 857371 T5267 oasc.SolrCore.initStatsCache Using default 
statsCache cache: org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 857373 T5267 oasu.CommitTracker.<init> Hard AutoCommit: 
disabled
   [junit4]   2> 857373 T5267 oasu.CommitTracker.<init> Soft AutoCommit: 
disabled
   [junit4]   2> 857374 T5267 oass.SolrIndexSearcher.<init> Opening 
Searcher@1970ffe[collection1] main
   [junit4]   2> 857375 T5267 oasr.RestManager.init Initializing RestManager 
with initArgs: 
{storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
   [junit4]   2> 857375 T5267 oasr.ManagedResourceStorage.load Reading 
_rest_managed.json using InMemoryStorage
   [junit4]   2> 857375 T5267 oasr.RestManager.init Initializing 0 registered 
ManagedResources
   [junit4]   2> 857375 T5267 oashc.SpellCheckComponent.inform Initializing 
spell checkers
   [junit4]   2> 857376 T5267 oass.DirectSolrSpellChecker.init init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 857380 T5267 oash.ReplicationHandler.inform Commits will be 
reserved for  10000
   [junit4]   2> 857381 T5271 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: default
   [junit4]   2> 857381 T5271 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: direct
   [junit4]   2> 857381 T5271 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: wordbreak
   [junit4]   2> 857382 T5271 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: multipleFields
   [junit4]   2> 857382 T5271 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: jarowinkler
   [junit4]   2> 857382 T5271 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: external
   [junit4]   2> 857382 T5271 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: freq
   [junit4]   2> 857383 T5271 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: fqcn
   [junit4]   2> 857383 T5271 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: perDict
   [junit4]   2> 857384 T5271 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@1970ffe[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 857384 T5267 oasu.DefaultSolrCoreState.newIndexWriter Creating 
new IndexWriter...
   [junit4]   2> 857385 T5267 oasu.DefaultSolrCoreState.newIndexWriter Waiting 
until IndexWriter is unused... core=collection1
   [junit4]   2> 857385 T5267 oasu.DefaultSolrCoreState.newIndexWriter Closing 
old IndexWriter... core=collection1
   [junit4]   2> 857386 T5267 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=50, maxMergeAtOnceExplicit=38, maxMergedSegmentMB=60.734375, 
floorSegmentMB=0.349609375, forceMergeDeletesPctAllowed=11.762320886745888, 
segmentsPerTier=19.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.46601321159287223
   [junit4]   2> 857386 T5267 oasc.SolrDeletionPolicy.onInit 
SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@5d0db5 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@18726e6),segFN=segments_1,generation=1}
   [junit4]   2> 857387 T5267 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 1
   [junit4]   2> 857388 T5267 oasu.DefaultSolrCoreState.newIndexWriter New 
IndexWriter is ready to be used.
   [junit4]   2> 857388 T5267 oass.SolrIndexSearcher.<init> Opening 
Searcher@709f7[collection1] main
   [junit4]   2> 857389 T5267 oasc.CoreContainer.registerCore replacing core: 
collection1
   [junit4]   2> 857390 T5267 oasc.SolrCore.close [collection1]  CLOSING 
SolrCore org.apache.solr.core.SolrCore@13ac357
   [junit4]   2> 857390 T5267 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> 857390 T5267 oasc.SolrCore.closeSearcher [collection1] Closing 
main searcher on request.
   [junit4]   2> 857406 T5271 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@709f7[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 857415 T5267 oasup.LogUpdateProcessor.finish [collection1] 
{add=[529 (1496725137640128512)]} 0 11
   [junit4]   2> ASYNC  NEW_CORE C548 name=collection1 
org.apache.solr.core.SolrCore@100565
   [junit4]   2> 857416 T5267 C548 oasc.SolrCore.execute [collection1] 
webapp=null path=null params={q=id:529&qt=standard&start=0&rows=20&version=2.2} 
hits=0 status=0 QTime=0 
   [junit4]   2> 857418 T5267 oasup.LogUpdateProcessor.finish [collection1] 
{add=[530 (1496725137652711424)]} 0 14
   [junit4]   2> 857419 T5267 C548 oasc.SolrCore.execute [collection1] 
webapp=null path=null params={q=id:529&qt=standard&start=0&rows=20&version=2.2} 
hits=0 status=0 QTime=1 
   [junit4]   2> 857420 T5267 oas.SolrTestCaseJ4.assertQ ERROR REQUEST FAILED: 
xpath=//result[@numFound=1]
   [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">1</int></lst><result name="response" 
numFound="0" start="0"></result>
   [junit4]   2>        </response>
   [junit4]   2>        
   [junit4]   2>                request 
was:q=id:529&qt=standard&start=0&rows=20&version=2.2
   [junit4]   2> 857421 T5267 oasc.SolrException.log ERROR REQUEST FAILED: 
q=id:529&qt=standard&start=0&rows=20&version=2.2:java.lang.RuntimeException: 
REQUEST FAILED: xpath=//result[@numFound=1]
   [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">1</int></lst><result name="response" 
numFound="0" start="0"></result>
   [junit4]   2>        </response>
   [junit4]   2>        
   [junit4]   2>                request 
was:q=id:529&qt=standard&start=0&rows=20&version=2.2
   [junit4]   2>                at 
org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:787)
   [junit4]   2>                at 
org.apache.solr.update.AutoCommitTest.testMaxTime(AutoCommitTest.java:237)
   [junit4]   2>                at 
sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   [junit4]   2>                at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
   [junit4]   2>                at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   [junit4]   2>                at 
java.lang.reflect.Method.invoke(Method.java:497)
   [junit4]   2>                at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1627)
   [junit4]   2>                at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:836)
   [junit4]   2>                at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:872)
   [junit4]   2>                at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:886)
   [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 
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:845)
   [junit4]   2>                at 
com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:747)
   [junit4]   2>                at 
com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:781)
   [junit4]   2>                at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:792)
   [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 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>                at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
   [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:54)
   [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:745)
   [junit4]   2>        
   [junit4]   2> 857422 T5267 oas.SolrTestCaseJ4.tearDown ###Ending testMaxTime
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=AutoCommitTest 
-Dtests.method=testMaxTime -Dtests.seed=37A3D4B7AF676434 -Dtests.multiplier=3 
-Dtests.slow=true -Dtests.locale=sr_RS -Dtests.timezone=GB -Dtests.asserts=true 
-Dtests.file.encoding=ISO-8859-1
   [junit4] ERROR   0.28s J1 | AutoCommitTest.testMaxTime <<<
   [junit4]    > Throwable #1: java.lang.RuntimeException: Exception during 
query
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([37A3D4B7AF676434:AD57A95531FDF808]:0)
   [junit4]    >        at 
org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:794)
   [junit4]    >        at 
org.apache.solr.update.AutoCommitTest.testMaxTime(AutoCommitTest.java:237)
   [junit4]    >        at java.lang.Thread.run(Thread.java:745)
   [junit4]    > Caused by: java.lang.RuntimeException: REQUEST FAILED: 
xpath=//result[@numFound=1]
   [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">1</int></lst><result name="response" numFound="0" 
start="0"></result>
   [junit4]    > </response>
   [junit4]    >        request 
was:q=id:529&qt=standard&start=0&rows=20&version=2.2
   [junit4]    >        at 
org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:787)
   [junit4]    >        ... 40 more
   [junit4]   2> 857459 T5267 oas.SolrTestCaseJ4.setUp ###Starting 
testCommitWithin
   [junit4]   2> 857463 T5267 C548 oass.SolrIndexSearcher.<init> Opening 
Searcher@1b2040f[collection1] realtime
   [junit4]   2> 857464 T5267 C548 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {deleteByQuery=*:* 
(-1496725137696751616)} 0 5
   [junit4]   2> 857464 T5267 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/'
   [junit4]   2> 857465 T5267 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes/'
 to classloader
   [junit4]   2> 857465 T5267 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/README'
 to classloader
   [junit4]   2> 857482 T5267 oasc.SolrConfig.refreshRequestParams current 
version of requestparams : -1
   [junit4]   2> 857489 T5267 oasc.SolrConfig.<init> Using Lucene MatchVersion: 
5.1.0
   [junit4]   2> 857504 T5267 oasc.SolrConfig.<init> Loaded SolrConfig: 
solrconfig.xml
   [junit4]   2> 857505 T5267 oass.IndexSchema.readSchema Reading Solr Schema 
from 
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/schema.xml
   [junit4]   2> 857509 T5267 oass.IndexSchema.readSchema [collection1] Schema 
name=test
   [junit4]   2> 857575 T5267 oass.OpenExchangeRatesOrgProvider.init 
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 857580 T5267 oass.IndexSchema.readSchema default search field 
in schema is text
   [junit4]   2> 857582 T5267 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 857586 T5267 oass.FileExchangeRateProvider.reload Reloading 
exchange rates from file currency.xml
   [junit4]   2> 857588 T5267 oass.FileExchangeRateProvider.reload Reloading 
exchange rates from file currency.xml
   [junit4]   2> 857589 T5267 oass.OpenExchangeRatesOrgProvider.reload 
Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 857590 T5267 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 857590 T5267 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 857590 T5267 oass.OpenExchangeRatesOrgProvider.reload 
Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 857591 T5267 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 857591 T5267 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 857591 T5267 oasc.CoreContainer.reload Reloading SolrCore 
'collection1' using configuration from instancedir 
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/
   [junit4]   2> 857592 T5267 oasc.SolrCore.<init> [collection1] Opening new 
SolrCore at 
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/,
 
dataDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest
 37A3D4B7AF676434-001/init-core-data-001/
   [junit4]   2> 857592 T5267 oasc.JmxMonitoredMap.<init> JMX monitoring is 
enabled. Adding Solr mbeans to JMX Server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@14d9a34
   [junit4]   2> 857592 T5267 oasc.SolrCore.getNewIndexDir New index directory 
detected: old=null 
new=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest
 37A3D4B7AF676434-001/init-core-data-001/index/
   [junit4]   2> 857597 T5267 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "dedupe"
   [junit4]   2> 857597 T5267 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 857598 T5267 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "dedupe-allfields"
   [junit4]   2> 857598 T5267 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"dedupe-allfields"
   [junit4]   2> 857598 T5267 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "stored_sig"
   [junit4]   2> 857598 T5267 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 857599 T5267 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 857599 T5267 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 857599 T5267 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
   [junit4]   2> 857600 T5267 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 857600 T5267 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"distrib-dup-test-chain-implicit"
   [junit4]   2> 857600 T5267 oasc.SolrCore.loadUpdateProcessorChains no 
updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 857602 T5267 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 857603 T5267 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 857604 T5267 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 857606 T5267 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 857611 T5267 oasc.PluginBag.createPlugin requestHandler : 
'lazy' created with startup=lazy 
   [junit4]   2> 857613 T5267 oasc.RequestHandlers.initHandlersFromConfig 
Registered paths: 
/admin/mbeans,standard,spellCheckCompRH,lazy,/update/json/docs,/admin/luke,spellCheckWithWordbreak_Direct,tvrh,/get,/admin/properties,/update/json,mltrh,/admin/threads,/search-facet-def,/update/csv,/search-facet-invariants,/admin/segments,spellCheckCompRH1,/mlt,/admin/system,/replication,dismax,defaults,/config,/schema,/admin/plugins,/admin/logging,spellCheckWithWordbreak,mock,/admin/ping,/update,/admin/file,/terms,spellCheckCompRH_Direct,/debug/dump
   [junit4]   2> 857614 T5267 oasc.SolrCore.initDeprecatedSupport WARN 
solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config 
to use the ShowFileRequestHandler.
   [junit4]   2> 857614 T5267 oasc.SolrCore.initStatsCache Using default 
statsCache cache: org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 857615 T5267 oasu.CommitTracker.<init> Hard AutoCommit: 
disabled
   [junit4]   2> 857615 T5267 oasu.CommitTracker.<init> Soft AutoCommit: 
disabled
   [junit4]   2> 857616 T5267 oass.SolrIndexSearcher.<init> Opening 
Searcher@62c12f[collection1] main
   [junit4]   2> 857616 T5267 oasr.RestManager.init Initializing RestManager 
with initArgs: 
{storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
   [junit4]   2> 857617 T5267 oasr.ManagedResourceStorage.load Reading 
_rest_managed.json using InMemoryStorage
   [junit4]   2> 857617 T5267 oasr.RestManager.init Initializing 0 registered 
ManagedResources
   [junit4]   2> 857618 T5267 oashc.SpellCheckComponent.inform Initializing 
spell checkers
   [junit4]   2> 857619 T5267 oass.DirectSolrSpellChecker.init init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 857621 T5267 oash.ReplicationHandler.inform Commits will be 
reserved for  10000
   [junit4]   2> 857622 T5273 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: default
   [junit4]   2> 857622 T5273 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: direct
   [junit4]   2> 857623 T5273 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: wordbreak
   [junit4]   2> 857623 T5273 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: multipleFields
   [junit4]   2> 857623 T5267 oasu.DefaultSolrCoreState.newIndexWriter Creating 
new IndexWriter...
   [junit4]   2> 857623 T5267 oasu.DefaultSolrCoreState.newIndexWriter Waiting 
until IndexWriter is unused... core=collection1
   [junit4]   2> 857623 T5267 oasu.DefaultSolrCoreState.newIndexWriter Closing 
old IndexWriter... core=collection1
   [junit4]   2> 857623 T5273 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: jarowinkler
   [junit4]   2> 857624 T5267 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@5d0db5 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@18726e6),segFN=segments_1,generation=1}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@5d0db5 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@18726e6),segFN=segments_2,generation=2}
   [junit4]   2> 857624 T5267 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 2
   [junit4]   2> 857624 T5273 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: external
   [junit4]   2> 857624 T5267 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=17, maxMergeAtOnceExplicit=27, maxMergedSegmentMB=46.5751953125, 
floorSegmentMB=0.90234375, forceMergeDeletesPctAllowed=22.018378058801066, 
segmentsPerTier=22.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 857624 T5273 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: freq
   [junit4]   2> 857625 T5267 oasc.SolrDeletionPolicy.onInit 
SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@5d0db5 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@18726e6),segFN=segments_2,generation=2}
   [junit4]   2> 857625 T5267 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 2
   [junit4]   2> 857625 T5273 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: fqcn
   [junit4]   2> 857626 T5267 oasu.DefaultSolrCoreState.newIndexWriter New 
IndexWriter is ready to be used.
   [junit4]   2> 857626 T5273 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: perDict
   [junit4]   2> 857626 T5267 oasc.SolrCore.getSearcher WARN [collection1] 
PERFORMANCE WARNING: Overlapping onDeckSearchers=2
   [junit4]   2> 857627 T5273 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@62c12f[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 857627 T5267 oass.SolrIndexSearcher.<init> Opening 
Searcher@e36a89[collection1] main
   [junit4]   2> 857628 T5267 oasc.CoreContainer.registerCore replacing core: 
collection1
   [junit4]   2> 857628 T5267 oasc.SolrCore.close [collection1]  CLOSING 
SolrCore org.apache.solr.core.SolrCore@100565
   [junit4]   2> 857628 T5267 oasu.DirectUpdateHandler2.close closing 
DirectUpdateHandler2{commits=0,autocommits=0,soft autocommit 
maxTime=1000ms,soft 
autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=2,adds=2,deletesById=0,deletesByQuery=1,errors=0,cumulative_adds=2,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=0,transaction_logs_total_size=0,transaction_logs_total_number=0}
   [junit4]   2> 857629 T5273 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@e36a89[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 857630 T5267 oasc.SolrCore.closeSearcher [collection1] Closing 
main searcher on request.
   [junit4]   2> 857641 T5267 oasup.LogUpdateProcessor.finish [collection1] 
{add=[529 (1496725137886543872)]} 0 1
   [junit4]   2> ASYNC  NEW_CORE C549 name=collection1 
org.apache.solr.core.SolrCore@40b155
   [junit4]   2> 857642 T5267 C549 oasc.SolrCore.execute [collection1] 
webapp=null path=null params={q=id:529&qt=standard&start=0&rows=20&version=2.2} 
hits=0 status=0 QTime=1 
   [junit4]   2> 861641 T5274 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 861644 T5274 oass.SolrIndexSearcher.<init> Opening 
Searcher@1319c70[collection1] main
   [junit4]   2> 861645 T5274 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 861646 T5273 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@1319c70[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(5.1.0):c1)))}
   [junit4]   2> 861895 T5267 oasup.LogUpdateProcessor.finish [collection1] 
{add=[530 (1496725142347186176)]} 0 4255
   [junit4]   2> 861896 T5267 C549 oasc.SolrCore.execute [collection1] 
webapp=null path=null params={q=id:530&qt=standard&start=0&rows=20&version=2.2} 
hits=0 status=0 QTime=0 
   [junit4]   2> 861898 T5267 oasup.LogUpdateProcessor.finish [collection1] 
{delete=[529 (-1496725142351380480)]} 0 4258
   [junit4]   2> 861899 T5267 C549 oasc.SolrCore.execute [collection1] 
webapp=null path=null params={q=id:529&qt=standard&start=0&rows=20&version=2.2} 
hits=1 status=0 QTime=0 
   [junit4]   2> 862898 T5274 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 862900 T5274 oass.SolrIndexSearcher.<init> Opening 
Searcher@12c13f2[collection1] main
   [junit4]   2> 862901 T5274 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 862902 T5273 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@12c13f2[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(5.1.0):c1)))}
   [junit4]   2> 863150 T5267 C549 oasc.SolrCore.execute [collection1] 
webapp=null path=null params={q=id:529&qt=standard&start=0&rows=20&version=2.2} 
hits=0 status=0 QTime=0 
   [junit4]   2> 863151 T5267 C549 oasc.SolrCore.execute [collection1] 
webapp=null path=null params={q=id:530&qt=standard&start=0&rows=20&version=2.2} 
hits=1 status=0 QTime=0 
   [junit4]   2> 863153 T5267 oasup.LogUpdateProcessor.finish [collection1] 
{add=[500 (1496725143666294784)]} 0 5513
   [junit4]   2> 863154 T5267 oasup.LogUpdateProcessor.finish [collection1] 
{add=[500 (1496725143668391936)]} 0 5514
   [junit4]   2> 863154 T5267 oasup.LogUpdateProcessor.finish [collection1] 
{add=[500 (1496725143668391937)]} 0 5514
   [junit4]   2> 863155 T5267 oasup.LogUpdateProcessor.finish [collection1] 
{add=[500 (1496725143669440512)]} 0 5515
   [junit4]   2> 863155 T5267 oasup.LogUpdateProcessor.finish [collection1] 
{add=[500 (1496725143669440513)]} 0 5515
   [junit4]   2> 863155 T5267 oasup.LogUpdateProcessor.finish [collection1] 
{add=[500 (1496725143669440514)]} 0 5515
   [junit4]   2> 863156 T5267 oasup.LogUpdateProcessor.finish [collection1] 
{add=[500 (1496725143670489088)]} 0 5516
   [junit4]   2> 863156 T5267 oasup.LogUpdateProcessor.finish [collection1] 
{add=[500 (1496725143670489089)]} 0 5516
   [junit4]   2> 863157 T5267 oasup.LogUpdateProcessor.finish [collection1] 
{add=[500 (1496725143671537664)]} 0 5517
   [junit4]   2> 863157 T5267 oasup.LogUpdateProcessor.finish [collection1] 
{add=[500 (1496725143671537665)]} 0 5517
   [junit4]   2> 863158 T5267 C549 oasc.SolrCore.execute [collection1] 
webapp=null path=null params={q=id:500&qt=standard&start=0&rows=20&version=2.2} 
hits=0 status=0 QTime=0 
   [junit4]   2> 863158 T5267 oasup.LogUpdateProcessor.finish [collection1] 
{delete=[530 (-1496725143672586240)]} 0 5518
   [junit4]   2> 863159 T5267 oasup.LogUpdateProcessor.finish [collection1] 
{delete=[530 (-1496725143673634816)]} 0 5519
   [junit4]   2> 863159 T5267 oasup.LogUpdateProcessor.finish [collection1] 
{delete=[530 (-1496725143673634817)]} 0 5519
   [junit4]   2> 863159 T5267 oasup.LogUpdateProcessor.finish [collection1] 
{delete=[530 (-1496725143673634818)]} 0 5519
   [junit4]   2> 863159 T5267 oasup.LogUpdateProcessor.finish [collection1] 
{delete=[530 (-1496725143673634819)]} 0 5519
   [junit4]   2> 863169 T5267 oasup.LogUpdateProcessor.finish [collection1] 
{delete=[530 (-1496725143684120576)]} 0 5529
   [junit4]   2> 863170 T5267 oasup.LogUpdateProcessor.finish [collection1] 
{delete=[530 (-1496725143685169152)]} 0 5530
   [junit4]   2> 863170 T5267 oasup.LogUpdateProcessor.finish [collection1] 
{delete=[530 (-1496725143685169153)]} 0 5530
   [junit4]   2> 863170 T5267 oasup.LogUpdateProcessor.finish [collection1] 
{delete=[530 (-1496725143685169154)]} 0 5530
   [junit4]   2> 863171 T5267 oasup.LogUpdateProcessor.finish [collection1] 
{delete=[530 (-1496725143685169155)]} 0 5530
   [junit4]   2> ASYNC  NEW_CORE C550 name=collection1 
org.apache.solr.core.SolrCore@40b155
   [junit4]   2> 863171 T5267 C550 oasc.SolrCore.execute [collection1] 
webapp=null path=null params={q=id:530&qt=standard&start=0&rows=20&version=2.2} 
hits=1 status=0 QTime=0 
   [junit4]   2> 864158 T5274 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 864162 T5274 oass.SolrIndexSearcher.<init> Opening 
Searcher@20424a[collection1] main
   [junit4]   2> 864162 T5274 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 864163 T5273 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@20424a[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_3(5.1.0):c10/9:delGen=1)))}
   [junit4]   2> 864172 T5267 C550 oasc.SolrCore.execute [collection1] 
webapp=null path=null params={q=id:500&qt=standard&start=0&rows=20&version=2.2} 
hits=1 status=0 QTime=0 
   [junit4]   2> 864174 T5267 C550 oasc.SolrCore.execute [collection1] 
webapp=null path=null params={q=id:530&qt=standard&start=0&rows=20&version=2.2} 
hits=0 status=0 QTime=0 
   [junit4]   2> 864175 T5267 oas.SolrTestCaseJ4.tearDown ###Ending 
testCommitWithin
   [junit4]   2> 864177 T5267 oas.SolrTestCaseJ4.setUp ###Starting testMaxDocs
   [junit4]   2> 864179 T5267 C550 oass.SolrIndexSearcher.<init> Opening 
Searcher@eab9ee[collection1] realtime
   [junit4]   2> 864180 T5267 C550 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {deleteByQuery=*:* 
(-1496725144742133760)} 0 2
   [junit4]   2> 864180 T5267 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/'
   [junit4]   2> 864181 T5267 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes/'
 to classloader
   [junit4]   2> 864181 T5267 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/README'
 to classloader
   [junit4]   2> 864203 T5267 oasc.SolrConfig.refreshRequestParams current 
version of requestparams : -1
   [junit4]   2> 864215 T5267 oasc.SolrConfig.<init> Using Lucene MatchVersion: 
5.1.0
   [junit4]   2> 864241 T5267 oasc.SolrConfig.<init> Loaded SolrConfig: 
solrconfig.xml
   [junit4]   2> 864241 T5267 oass.IndexSchema.readSchema Reading Solr Schema 
from 
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/schema.xml
   [junit4]   2> 864247 T5267 oass.IndexSchema.readSchema [collection1] Schema 
name=test
   [junit4]   2> 864341 T5267 oass.OpenExchangeRatesOrgProvider.init 
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 864346 T5267 oass.IndexSchema.readSchema default search field 
in schema is text
   [junit4]   2> 864347 T5267 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 864350 T5267 oass.FileExchangeRateProvider.reload Reloading 
exchange rates from file currency.xml
   [junit4]   2> 864351 T5267 oass.FileExchangeRateProvider.reload Reloading 
exchange rates from file currency.xml
   [junit4]   2> 864353 T5267 oass.OpenExchangeRatesOrgProvider.reload 
Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 864353 T5267 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 864353 T5267 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 864354 T5267 oass.OpenExchangeRatesOrgProvider.reload 
Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 864354 T5267 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 864354 T5267 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 864354 T5267 oasc.CoreContainer.reload Reloading SolrCore 
'collection1' using configuration from instancedir 
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/
   [junit4]   2> 864355 T5267 oasc.SolrCore.<init> [collection1] Opening new 
SolrCore at 
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/,
 
dataDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest
 37A3D4B7AF676434-001/init-core-data-001/
   [junit4]   2> 864355 T5267 oasc.JmxMonitoredMap.<init> JMX monitoring is 
enabled. Adding Solr mbeans to JMX Server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@14d9a34
   [junit4]   2> 864356 T5267 oasc.SolrCore.getNewIndexDir New index directory 
detected: old=null 
new=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest
 37A3D4B7AF676434-001/init-core-data-001/index/
   [junit4]   2> 864360 T5267 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "dedupe"
   [junit4]   2> 864361 T5267 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 864361 T5267 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "dedupe-allfields"
   [junit4]   2> 864362 T5267 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"dedupe-allfields"
   [junit4]   2> 864362 T5267 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "stored_sig"
   [junit4]   2> 864362 T5267 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 864362 T5267 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 864363 T5267 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 864363 T5267 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
   [junit4]   2> 864363 T5267 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 864364 T5267 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"distrib-dup-test-chain-implicit"
   [junit4]   2> 864364 T5267 oasc.SolrCore.loadUpdateProcessorChains no 
updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 864365 T5267 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 864367 T5267 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 864368 T5267 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 864368 T5267 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 864373 T5267 oasc.PluginBag.createPlugin requestHandler : 
'lazy' created with startup=lazy 
   [junit4]   2> 864376 T5267 oasc.RequestHandlers.initHandlersFromConfig 
Registered paths: 
/admin/mbeans,standard,spellCheckCompRH,lazy,/update/json/docs,/admin/luke,spellCheckWithWordbreak_Direct,tvrh,/get,/admin/properties,/update/json,mltrh,/admin/threads,/search-facet-def,/update/csv,/search-facet-invariants,/admin/segments,spellCheckCompRH1,/mlt,/admin/system,/replication,dismax,defaults,/config,/schema,/admin/plugins,/admin/logging,spellCheckWithWordbreak,mock,/admin/ping,/update,/admin/file,/terms,spellCheckCompRH_Direct,/debug/dump
   [junit4]   2> 864377 T5267 oasc.SolrCore.initDeprecatedSupport WARN 
solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config 
to use the ShowFileRequestHandler.
   [junit4]   2> 864377 T5267 oasc.SolrCore.initStatsCache Using default 
statsCache cache: org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 864385 T5267 oasu.CommitTracker.<init> Hard AutoCommit: 
disabled
   [junit4]   2> 864385 T5267 oasu.CommitTracker.<init> Soft AutoCommit: 
disabled
   [junit4]   2> 864386 T5267 oass.SolrIndexSearcher.<init> Opening 
Searcher@c03cc4[collection1] main
   [junit4]   2> 864386 T5267 oasr.RestManager.init Initializing RestManager 
with initArgs: 
{storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
   [junit4]   2> 864387 T5267 oasr.ManagedResourceStorage.load Reading 
_rest_managed.json using InMemoryStorage
   [junit4]   2> 864387 T5267 oasr.RestManager.init Initializing 0 registered 
ManagedResources
   [junit4]   2> 864387 T5267 oashc.SpellCheckComponent.inform Initializing 
spell checkers
   [junit4]   2> 864388 T5267 oass.DirectSolrSpellChecker.init init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 864392 T5267 oash.ReplicationHandler.inform Commits will be 
reserved for  10000
   [junit4]   2> 864393 T5275 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: default
   [junit4]   2> 864394 T5267 oasu.DefaultSolrCoreState.newIndexWriter Creating 
new IndexWriter...
   [junit4]   2> 864395 T5275 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: direct
   [junit4]   2> 864395 T5275 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: wordbreak
   [junit4]   2> 864396 T5275 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: multipleFields
   [junit4]   2> 864395 T5267 oasu.DefaultSolrCoreState.newIndexWriter Waiting 
until IndexWriter is unused... core=collection1
   [junit4]   2> 864396 T5275 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: jarowinkler
   [junit4]   2> 864396 T5267 oasu.DefaultSolrCoreState.newIndexWriter Closing 
old IndexWriter... core=collection1
   [junit4]   2> 864396 T5275 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: external
   [junit4]   2> 864396 T5267 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@5d0db5 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@18726e6),segFN=segments_2,generation=2}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@5d0db5 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@18726e6),segFN=segments_3,generation=3}
   [junit4]   2> 864397 T5267 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 3
   [junit4]   2> 864397 T5275 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: freq
   [junit4]   2> 864397 T5267 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: 
[LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=33, 
maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, 
calibrateSizeByDeletes=false, maxMergeDocs=2147483647, 
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
   [junit4]   2> 864397 T5275 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: fqcn
   [junit4]   2> 864398 T5275 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: perDict
   [junit4]   2> 864399 T5267 oasc.SolrDeletionPolicy.onInit 
SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@5d0db5 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@18726e6),segFN=segments_3,generation=3}
   [junit4]   2> 864400 T5267 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 3
   [junit4]   2> 864400 T5267 oasu.DefaultSolrCoreState.newIndexWriter New 
IndexWriter is ready to be used.
   [junit4]   2> 864402 T5275 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@c03cc4[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 864402 T5267 oass.SolrIndexSearcher.<init> Opening 
Searcher@1aab24a[collection1] main
   [junit4]   2> 864403 T5267 oasc.CoreContainer.registerCore replacing core: 
collection1
   [junit4]   2> 864403 T5267 oasc.SolrCore.close [collection1]  CLOSING 
SolrCore org.apache.solr.core.SolrCore@40b155
   [junit4]   2> 864403 T5267 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> 864404 T5267 oasc.SolrCore.closeSearcher [collection1] Closing 
main searcher on request.
   [junit4]   2> 864404 T5275 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@1aab24a[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 864416 T5267 oasup.LogUpdateProcessor.finish [collection1] 
{add=[0 (1496725144991694848)]} 0 1
   [junit4]   2> 864417 T5267 oasup.LogUpdateProcessor.finish [collection1] 
{add=[1 (1496725144992743424)]} 0 2
   [junit4]   2> 864417 T5267 oasup.LogUpdateProcessor.finish [collection1] 
{add=[2 (1496725144992743425)]} 0 2
   [junit4]   2> 864422 T5267 oasup.LogUpdateProcessor.finish [collection1] 
{add=[3 (1496725144995889152)]} 0 7
   [junit4]   2> 864424 T5267 oasup.LogUpdateProcessor.finish [collection1] 
{add=[4 (1496725145000083456)]} 0 9
   [junit4]   2> 864426 T5267 oasup.LogUpdateProcessor.finish [collection1] 
{add=[5 (1496725145001132032)]} 0 11
   [junit4]   2> 864426 T5267 oasup.LogUpdateProcessor.finish [collection1] 
{add=[6 (1496725145002180608)]} 0 11
   [junit4]   2> 864427 T5267 oasup.LogUpdateProcessor.finish [collection1] 
{add=[7 (1496725145003229184)]} 0 12
   [junit4]   2> 864427 T5267 oasup.LogUpdateProcessor.finish [collection1] 
{add=[8 (1496725145003229185)]} 0 12
   [junit4]   2> 864428 T5267 oasup.LogUpdateProcessor.finish [collection1] 
{add=[9 (1496725145004277760)]} 0 13
   [junit4]   2> 864431 T5267 oasup.LogUpdateProcessor.finish [collection1] 
{add=[10 (1496725145004277761)]} 0 16
   [junit4]   2> 864432 T5267 oasup.LogUpdateProcessor.finish [collection1] 
{add=[11 (1496725145007423488)]} 0 17
   [junit4]   2> 864432 T5267 oasup.LogUpdateProcessor.finish [collection1] 
{add=[12 (1496725145008472064)]} 0 17
   [junit4]   2> 864433 T5267 oasup.LogUpdateProcessor.finish [collection1] 
{add=[13 (1496725145009520640)]} 0 18
   [junit4]   2> ASYNC  NEW_CORE C551 name=collection1 
org.apache.solr.core.SolrCore@cf3bd7
   [junit4]   2> 864433 T5267 C551 oasc.SolrCore.execute [collection1] 
webapp=null path=null params={q=id:1&qt=standard&start=0&rows=20&version=2.2} 
hits=0 status=0 QTime=0 
   [junit4]   2> 864461 T5267 oasup.LogUpdateProcessor.finish [collection1] 
{add=[14 (1496725145017909248)]} 0 46
   [junit4]   2> 864473 T5276 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 864498 T5276 oass.SolrIndexSearcher.<init> Opening 
Searcher@4f722c[collection1] main
   [junit4]   2> 864500 T5275 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@4f722c[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(5.1.0):c15)))}
   [junit4]   2> 864500 T5276 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 864712 T5267 oasup.LogUpdateProcessor.finish [collection1] 
{add=[15 (1496725145302073344)]} 0 297
   [junit4]   2> 864714 T5267 C551 oasc.SolrCore.execute [collection1] 
webapp=null path=null params={q=id:14&qt=standard&start=0&rows=20&version=2.2} 
hits=1 status=0 QTime=1 
   [junit4]   2> 864715 T5267 C551 oasc.SolrCore.execute [collection1] 
webapp=null path=null params={q=id:15&qt=standard&start=0&rows=20&version=2.2} 
hits=0 status=0 QTime=0 
   [junit4]   2> 864715 T5267 oas.SolrTestCaseJ4.tearDown ###Ending testMaxDocs
   [junit4]   2> 864716 T5267 oas.SolrTestCaseJ4.deleteCore ###deleteCore
   [junit4]   2> 864716 T5267 oasc.CoreContainer.shutdown Shutting down 
CoreContainer instance=16791538
   [junit4]   2> 864717 T5267 oasc.SolrCore.close [collection1]  CLOSING 
SolrCore org.apache.solr.core.SolrCore@cf3bd7
   [junit4]   2> 864717 T5267 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> 864718 T5267 oasu.SolrCoreState.decrefSolrCoreState Closing 
SolrCoreState
   [junit4]   2> 864718 T5267 oasu.DefaultSolrCoreState.closeIndexWriter 
SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 864718 T5267 oasu.DefaultSolrCoreState.closeIndexWriter 
closing IndexWriter with IndexWriterCloser
   [junit4]   2> 864718 T5267 C551 oasu.DirectUpdateHandler2.closeWriter 
Committing on IndexWriter close.
   [junit4]   2> 864722 T5267 C551 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@5d0db5 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@18726e6),segFN=segments_3,generation=3}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@5d0db5 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@18726e6),segFN=segments_4,generation=4}
   [junit4]   2> 864723 T5267 C551 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 4
   [junit4]   2> 864723 T5267 oasc.SolrCore.closeSearcher [collection1] Closing 
main searcher on request.
   [junit4]   2> 864739 T5267 oasc.CachingDirectoryFactory.close Closing 
MockDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 864739 T5267 oasc.CachingDirectoryFactory.closeCacheValue 
looking to close 
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest
 37A3D4B7AF676434-001/init-core-data-001/index 
[CachedDir<<refCount=0;path=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest
 37A3D4B7AF676434-001/init-core-data-001/index;done=false>>]
   [junit4]   2> 864739 T5267 oasc.CachingDirectoryFactory.close Closing 
directory: 
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest
 37A3D4B7AF676434-001/init-core-data-001/index
   [junit4]   2> 864740 T5267 oasc.CachingDirectoryFactory.closeCacheValue 
looking to close 
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest
 37A3D4B7AF676434-001/init-core-data-001 
[CachedDir<<refCount=0;path=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest
 37A3D4B7AF676434-001/init-core-data-001;done=false>>]
   [junit4]   2> 864740 T5267 oasc.CachingDirectoryFactory.close Closing 
directory: 
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest
 37A3D4B7AF676434-001/init-core-data-001
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest
 37A3D4B7AF676434-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene50), 
sim=RandomSimilarityProvider(queryNorm=true,coord=yes): {}, locale=sr_RS, 
timezone=GB
   [junit4]   2> NOTE: Linux 3.13.0-46-generic i386/Oracle Corporation 
1.8.0_60-ea (32-bit)/cpus=12,threads=1,free=172979696,total=533725184
   [junit4]   2> NOTE: All tests run in this JVM: [HttpPartitionTest, 
PreAnalyzedFieldTest, SliceStateTest, TestBulkSchemaConcurrent, 
SpatialHeatmapFacetsTest, TestUtils, TestBlobHandler, JsonLoaderTest, 
ConvertedLegacyTest, TestFieldCollectionResource, TestValueSourceCache, 
DirectSolrConnectionTest, TriLevelCompositeIdRoutingTest, ZkSolrClientTest, 
TestSchemaSimilarityResource, DocumentAnalysisRequestHandlerTest, 
TestCursorMarkWithoutUniqueKey, SolrPluginUtilsTest, TestRandomMergePolicy, 
TestMiniSolrCloudClusterSSL, TestCustomSort, ResourceLoaderTest, 
ShardRoutingTest, TestTolerantSearch, TestIndexSearcher, 
TestManagedSchemaDynamicFieldResource, TestWriterPerf, TestExceedMaxTermLength, 
IgnoreCommitOptimizeUpdateProcessorFactoryTest, BasicFunctionalityTest, 
BlockDirectoryTest, ActionThrottleTest, PreAnalyzedUpdateProcessorTest, 
TestSolr4Spatial2, TestReloadAndDeleteDocs, CSVRequestHandlerTest, 
SpellCheckComponentTest, MBeansHandlerTest, TestSolrQueryParserResource, 
DocValuesMultiTest, TestFiltering, ChaosMonkeySafeLeaderTest, 
TestRequestStatusCollectionAPI, UUIDUpdateProcessorFallbackTest, 
FacetPivotSmallTest, DistanceFunctionTest, CopyFieldTest, 
LukeRequestHandlerTest, TestCollationFieldDocValues, TestConfigSets, 
EchoParamsTest, FieldMutatingUpdateProcessorTest, TestBlendedInfixSuggestions, 
TestDynamicLoading, RequiredFieldsTest, 
DistributedQueryComponentCustomSortTest, ZkControllerTest, 
TestLMDirichletSimilarityFactory, SpatialRPTFieldTypeTest, 
TestElisionMultitermQuery, TestMacros, TestSerializedLuceneMatchVersion, 
CollectionsAPIDistributedZkTest, FieldAnalysisRequestHandlerTest, 
ShowFileRequestHandlerTest, IndexSchemaRuntimeFieldTest, TestCollationField, 
TestNRTOpen, OverseerStatusTest, MultiTermTest, HdfsRecoveryZkTest, 
TestCoreContainer, TestJettySolrRunner, CurrencyFieldOpenExchangeTest, 
TestAddFieldRealTimeGet, SpatialFilterTest, TestCoreDiscovery, 
BasicDistributedZk2Test, SyncSliceTest, LeaderElectionIntegrationTest, 
AutoCommitTest]
   [junit4] Completed on J1 in 8.18s, 3 tests, 1 error <<< FAILURES!

[...truncated 744 lines...]
BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/build.xml:529: The following 
error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/build.xml:477: The following 
error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/build.xml:61: The following error 
occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/extra-targets.xml:39: The 
following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build.xml:191: The following 
error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/common-build.xml:509: The 
following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/lucene/common-build.xml:1370: The 
following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/lucene/common-build.xml:976: 
There were test failures: 478 suites, 1900 tests, 1 error, 48 ignored (21 
assumptions)

Total time: 45 minutes 25 seconds
Build step 'Invoke Ant' marked build as failure
[description-setter] Description set: Java: 32bit/jdk1.8.0_60-ea-b06 -server 
-XX:+UseG1GC
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any


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

Reply via email to