Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Linux/11588/
Java: 64bit/ibm-j9-jdk7
-Xjit:exclude={org/apache/lucene/util/fst/FST.pack(IIF)Lorg/apache/lucene/util/fst/FST;}
(asserts: true)
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([AA7876B2A9F38E90:308C0B50376912AC]:0)
at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:723)
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: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: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">1455</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_">1484275664857071616</long><date
name="timestamp">2014-11-09T06:46:20.041Z</date><arr
name="multiDefault"><str>muLti-Default</str></arr><int
name="intDefault">42</int></doc></result>
</response>
request was:start=0&q=id:529&version=2.2&rows=20&qt=standard
at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:716)
... 41 more
Build Log:
[...truncated 10984 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-AA7876B2A9F38E90-001/init-core-data-001
[junit4] 2> 281994 T715 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl
(false) and clientAuth (true)
[junit4] 2> 281995 T715 oas.SolrTestCaseJ4.initCore ####initCore
[junit4] 2> 281995 T715 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/'
[junit4] 2> 281996 T715 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> 281996 T715 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> 281996 T715 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> 282028 T715 oasc.SolrConfig.<init> Using Lucene MatchVersion:
6.0.0
[junit4] 2> 282075 T715 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 282075 T715 oass.IndexSchema.readSchema Reading Solr Schema
from
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/conf/schema.xml
[junit4] 2> 282080 T715 oass.IndexSchema.readSchema [null] Schema name=test
[junit4] 2> 282330 T715 oass.OpenExchangeRatesOrgProvider.init Initialized
with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 282334 T715 oass.IndexSchema.readSchema default search field
in schema is text
[junit4] 2> 282336 T715 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 282342 T715 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 282345 T715 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 282348 T715 oass.OpenExchangeRatesOrgProvider.reload Reloading
exchange rates from open-exchange-rates.json
[junit4] 2> 282348 T715
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 282348 T715
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 282349 T715 oass.OpenExchangeRatesOrgProvider.reload Reloading
exchange rates from open-exchange-rates.json
[junit4] 2> 282349 T715
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 282350 T715
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 282350 T715 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 282350 T715 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> 282350 T715 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/'
[junit4] 2> 282388 T715 oasc.CoreContainer.<init> New CoreContainer
-1883073343
[junit4] 2> 282389 T715 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/]
[junit4] 2> 282389 T715 oashc.HttpShardHandlerFactory.getParameter Setting
socketTimeout to: 0
[junit4] 2> 282390 T715 oashc.HttpShardHandlerFactory.getParameter Setting
urlScheme to: null
[junit4] 2> 282390 T715 oashc.HttpShardHandlerFactory.getParameter Setting
connTimeout to: 0
[junit4] 2> 282390 T715 oashc.HttpShardHandlerFactory.getParameter Setting
maxConnectionsPerHost to: 20
[junit4] 2> 282391 T715 oashc.HttpShardHandlerFactory.getParameter Setting
maxConnections to: 10000
[junit4] 2> 282391 T715 oashc.HttpShardHandlerFactory.getParameter Setting
corePoolSize to: 0
[junit4] 2> 282391 T715 oashc.HttpShardHandlerFactory.getParameter Setting
maximumPoolSize to: 2147483647
[junit4] 2> 282391 T715 oashc.HttpShardHandlerFactory.getParameter Setting
maxThreadIdleTime to: 5
[junit4] 2> 282392 T715 oashc.HttpShardHandlerFactory.getParameter Setting
sizeOfQueue to: -1
[junit4] 2> 282392 T715 oashc.HttpShardHandlerFactory.getParameter Setting
fairnessPolicy to: false
[junit4] 2> 282392 T715 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=30000&connTimeout=30000&retry=false
[junit4] 2> 282393 T715 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 282393 T715 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 282393 T715 oasc.CoreContainer.load Host Name:
[junit4] 2> 282396 T716 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/'
[junit4] 2> 282397 T716 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> 282398 T716 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> 282398 T716 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> 282433 T716 oasc.SolrConfig.<init> Using Lucene MatchVersion:
6.0.0
[junit4] 2> 282504 T716 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 282505 T716 oass.IndexSchema.readSchema Reading Solr Schema
from
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/conf/schema.xml
[junit4] 2> 282512 T716 oass.IndexSchema.readSchema [collection1] Schema
name=test
[junit4] 2> 282851 T716 oass.OpenExchangeRatesOrgProvider.init Initialized
with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 282858 T716 oass.IndexSchema.readSchema default search field
in schema is text
[junit4] 2> 282861 T716 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 282870 T716 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 282875 T716 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 282879 T716 oass.OpenExchangeRatesOrgProvider.reload Reloading
exchange rates from open-exchange-rates.json
[junit4] 2> 282880 T716
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 282880 T716
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 282881 T716 oass.OpenExchangeRatesOrgProvider.reload Reloading
exchange rates from open-exchange-rates.json
[junit4] 2> 282881 T716
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 282881 T716
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 282882 T716 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> 282882 T716 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 282883 T716 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-AA7876B2A9F38E90-001/init-core-data-001/
[junit4] 2> 282883 T716 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@950e9771
[junit4] 2> 282884 T716 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-AA7876B2A9F38E90-001/init-core-data-001
[junit4] 2> 282884 T716 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-AA7876B2A9F38E90-001/init-core-data-001/index/
[junit4] 2> 282885 T716 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-AA7876B2A9F38E90-001/init-core-data-001/index'
doesn't exist. Creating new index...
[junit4] 2> 282885 T716 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-AA7876B2A9F38E90-001/init-core-data-001/index
[junit4] 2> 282886 T716 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=43, maxMergeAtOnceExplicit=45, maxMergedSegmentMB=94.8642578125,
floorSegmentMB=0.8662109375, forceMergeDeletesPctAllowed=17.77324546016267,
segmentsPerTier=17.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.6497595008745835
[junit4] 2> 282887 T716 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory(id=lucene-227e5adf))),segFN=segments_1,generation=1}
[junit4] 2> 282887 T716 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 282887 T716 oasc.SolrCore.initWriters created xml:
solr.XMLResponseWriter
[junit4] 2> 282890 T716 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 282891 T716 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 282891 T716 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 282892 T716 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"dedupe-allfields"
[junit4] 2> 282892 T716 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 282892 T716 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 282893 T716 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "uniq-fields"
[junit4] 2> 282893 T716 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4] 2> 282894 T716 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 282894 T716 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 282895 T716 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 282895 T716 oasc.SolrCore.loadUpdateProcessorChains no
updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 282896 T716 oasc.RequestHandlers.initHandlersFromConfig
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 282896 T716 oasc.RequestHandlers.initHandlersFromConfig
created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 282897 T716 oasc.RequestHandlers.initHandlersFromConfig
created /config: org.apache.solr.handler.SolrConfigHandler
[junit4] 2> 282897 T716 oasc.RequestHandlers.initHandlersFromConfig
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 282897 T716 oasc.RequestHandlers.initHandlersFromConfig adding
lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 282898 T716 oasc.RequestHandlers.initHandlersFromConfig
created /replication: solr.ReplicationHandler
[junit4] 2> 282898 T716 oasc.RequestHandlers.initHandlersFromConfig
created standard: solr.StandardRequestHandler
[junit4] 2> 282898 T716 oasc.RequestHandlers.initHandlersFromConfig
created /get: solr.RealTimeGetHandler
[junit4] 2> 282899 T716 oasc.RequestHandlers.initHandlersFromConfig
created dismax: solr.SearchHandler
[junit4] 2> 282899 T716 oasc.RequestHandlers.initHandlersFromConfig
created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4] 2> 282900 T716 oasc.RequestHandlers.initHandlersFromConfig
created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 282900 T716 oasc.RequestHandlers.initHandlersFromConfig
created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 282901 T716 oasc.RequestHandlers.initHandlersFromConfig
created /admin/fileedit: solr.admin.EditFileRequestHandler
[junit4] 2> 282901 T716 oasc.RequestHandlers.initHandlersFromConfig
created defaults: solr.StandardRequestHandler
[junit4] 2> 282902 T716 oasc.RequestHandlers.initHandlersFromConfig adding
lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 282902 T716 oasc.RequestHandlers.initHandlersFromConfig
created lazy: solr.StandardRequestHandler
[junit4] 2> 282902 T716 oasc.RequestHandlers.initHandlersFromConfig
created /update: solr.UpdateRequestHandler
[junit4] 2> 282903 T716 oasc.RequestHandlers.initHandlersFromConfig
created /terms: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 282903 T716 oasc.RequestHandlers.initHandlersFromConfig
created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 282904 T716 oasc.RequestHandlers.initHandlersFromConfig
created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 282904 T716 oasc.RequestHandlers.initHandlersFromConfig
created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 282905 T716 oasc.RequestHandlers.initHandlersFromConfig
created spellCheckWithWordbreak_Direct:
org.apache.solr.handler.component.SearchHandler
[junit4] 2> 282905 T716 oasc.RequestHandlers.initHandlersFromConfig
created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 282906 T716 oasc.RequestHandlers.initHandlersFromConfig
created mltrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 282906 T716 oasc.RequestHandlers.initHandlersFromConfig
created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 282907 T716 oasc.RequestHandlers.initHandlersFromConfig
created /mlt: solr.MoreLikeThisHandler
[junit4] 2> 282907 T716 oasc.RequestHandlers.initHandlersFromConfig
created /debug/dump: solr.DumpRequestHandler
[junit4] 2> 282909 T716 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 282911 T716 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 282912 T716 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 282914 T716 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 282916 T716 oasc.SolrCore.initDeprecatedSupport WARN
solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config
to use the ShowFileRequestHandler.
[junit4] 2> 282919 T716 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 282919 T716 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 282920 T716 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.LogByteSizeMergePolicy:
[LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=15,
maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807,
calibrateSizeByDeletes=false, maxMergeDocs=2147483647,
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5591138427634698]
[junit4] 2> 282920 T716 oasc.SolrDeletionPolicy.onInit
SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2>
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory(id=lucene-227e5adf))),segFN=segments_1,generation=1}
[junit4] 2> 282920 T716 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 282921 T716 oass.SolrIndexSearcher.<init> Opening
Searcher@df33a56d[collection1] main
[junit4] 2> 282921 T716 oasr.RestManager.init Initializing RestManager
with initArgs:
{storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
[junit4] 2> 282922 T716 oasr.ManagedResourceStorage.load Reading
_rest_managed.json using InMemoryStorage
[junit4] 2> 282922 T716 oasr.ManagedResource.reloadFromStorage WARN No
stored data found for /rest/managed
[junit4] 2> 282922 T716 oasr.ManagedResourceStorage$JsonStorage.store
Saved JSON object to path _rest_managed.json using InMemoryStorage
[junit4] 2> 282923 T716 oasr.RestManager.init Initializing 0 registered
ManagedResources
[junit4] 2> 282923 T716 oashc.SpellCheckComponent.inform Initializing
spell checkers
[junit4] 2> 283067 T716 oass.DirectSolrSpellChecker.init init:
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 283086 T717 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@df33a56d[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 283089 T716 oasc.CoreContainer.registerCore registering core:
collection1
[junit4] 2> 283091 T715 oas.SolrTestCaseJ4.initCore ####initCore end
[junit4] 2> 283094 T715 oas.SolrTestCaseJ4.setUp ###Starting testMaxTime
[junit4] 2> ASYNC NEW_CORE C393 name=collection1
org.apache.solr.core.SolrCore@9689c3ae
[junit4] 2> 283096 T715 C393 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null params={} {deleteByQuery=*:* (-1484275663587246080)} 0 1
[junit4] 2> 283100 T715 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/'
[junit4] 2> 283101 T715 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> 283102 T715 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> 283102 T715 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> 283156 T715 oasc.SolrConfig.<init> Using Lucene MatchVersion:
6.0.0
[junit4] 2> 283213 T715 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 283214 T715 oass.IndexSchema.readSchema Reading Solr Schema
from
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/conf/schema.xml
[junit4] 2> 283220 T715 oass.IndexSchema.readSchema [collection1] Schema
name=test
[junit4] 2> 283564 T715 oass.OpenExchangeRatesOrgProvider.init Initialized
with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 283571 T715 oass.IndexSchema.readSchema default search field
in schema is text
[junit4] 2> 283573 T715 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 283579 T715 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 283583 T715 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 283586 T715 oass.OpenExchangeRatesOrgProvider.reload Reloading
exchange rates from open-exchange-rates.json
[junit4] 2> 283587 T715
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 283587 T715
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 283587 T715 oass.OpenExchangeRatesOrgProvider.reload Reloading
exchange rates from open-exchange-rates.json
[junit4] 2> 283588 T715
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 283588 T715
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 283589 T715 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> 283589 T715 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-AA7876B2A9F38E90-001/init-core-data-001/
[junit4] 2> 283590 T715 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@950e9771
[junit4] 2> 283591 T715 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-AA7876B2A9F38E90-001/init-core-data-001/index/
[junit4] 2> 283591 T715 oasc.SolrCore.initWriters created xml:
solr.XMLResponseWriter
[junit4] 2> 283594 T715 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 283594 T715 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 283595 T715 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 283595 T715 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"dedupe-allfields"
[junit4] 2> 283595 T715 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 283596 T715 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 283596 T715 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "uniq-fields"
[junit4] 2> 283596 T715 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4] 2> 283597 T715 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 283597 T715 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 283598 T715 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 283598 T715 oasc.SolrCore.loadUpdateProcessorChains no
updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 283599 T715 oasc.RequestHandlers.initHandlersFromConfig
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 283599 T715 oasc.RequestHandlers.initHandlersFromConfig
created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 283600 T715 oasc.RequestHandlers.initHandlersFromConfig
created /config: org.apache.solr.handler.SolrConfigHandler
[junit4] 2> 283600 T715 oasc.RequestHandlers.initHandlersFromConfig
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 283600 T715 oasc.RequestHandlers.initHandlersFromConfig adding
lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 283601 T715 oasc.RequestHandlers.initHandlersFromConfig
created /replication: solr.ReplicationHandler
[junit4] 2> 283601 T715 oasc.RequestHandlers.initHandlersFromConfig
created standard: solr.StandardRequestHandler
[junit4] 2> 283602 T715 oasc.RequestHandlers.initHandlersFromConfig
created /get: solr.RealTimeGetHandler
[junit4] 2> 283602 T715 oasc.RequestHandlers.initHandlersFromConfig
created dismax: solr.SearchHandler
[junit4] 2> 283603 T715 oasc.RequestHandlers.initHandlersFromConfig
created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4] 2> 283604 T715 oasc.RequestHandlers.initHandlersFromConfig
created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 283605 T715 oasc.RequestHandlers.initHandlersFromConfig
created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 283605 T715 oasc.RequestHandlers.initHandlersFromConfig
created /admin/fileedit: solr.admin.EditFileRequestHandler
[junit4] 2> 283606 T715 oasc.RequestHandlers.initHandlersFromConfig
created defaults: solr.StandardRequestHandler
[junit4] 2> 283607 T715 oasc.RequestHandlers.initHandlersFromConfig adding
lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 283607 T715 oasc.RequestHandlers.initHandlersFromConfig
created lazy: solr.StandardRequestHandler
[junit4] 2> 283608 T715 oasc.RequestHandlers.initHandlersFromConfig
created /update: solr.UpdateRequestHandler
[junit4] 2> 283609 T715 oasc.RequestHandlers.initHandlersFromConfig
created /terms: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 283609 T715 oasc.RequestHandlers.initHandlersFromConfig
created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 283610 T715 oasc.RequestHandlers.initHandlersFromConfig
created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 283610 T715 oasc.RequestHandlers.initHandlersFromConfig
created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 283611 T715 oasc.RequestHandlers.initHandlersFromConfig
created spellCheckWithWordbreak_Direct:
org.apache.solr.handler.component.SearchHandler
[junit4] 2> 283611 T715 oasc.RequestHandlers.initHandlersFromConfig
created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 283612 T715 oasc.RequestHandlers.initHandlersFromConfig
created mltrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 283613 T715 oasc.RequestHandlers.initHandlersFromConfig
created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 283613 T715 oasc.RequestHandlers.initHandlersFromConfig
created /mlt: solr.MoreLikeThisHandler
[junit4] 2> 283614 T715 oasc.RequestHandlers.initHandlersFromConfig
created /debug/dump: solr.DumpRequestHandler
[junit4] 2> 283615 T715 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 283616 T715 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 283617 T715 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 283619 T715 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 283620 T715 oasc.SolrCore.initDeprecatedSupport WARN
solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config
to use the ShowFileRequestHandler.
[junit4] 2> 283622 T715 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 283622 T715 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 283623 T715 oass.SolrIndexSearcher.<init> Opening
Searcher@865d73c3[collection1] main
[junit4] 2> 283623 T715 oasr.RestManager.init Initializing RestManager
with initArgs:
{storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
[junit4] 2> 283624 T715 oasr.ManagedResourceStorage.load Reading
_rest_managed.json using InMemoryStorage
[junit4] 2> 283624 T715 oasr.ManagedResource.reloadFromStorage WARN No
stored data found for /rest/managed
[junit4] 2> 283624 T715 oasr.ManagedResourceStorage$JsonStorage.store
Saved JSON object to path _rest_managed.json using InMemoryStorage
[junit4] 2> 283625 T715 oasr.RestManager.init Initializing 0 registered
ManagedResources
[junit4] 2> 283625 T715 oashc.SpellCheckComponent.inform Initializing
spell checkers
[junit4] 2> 283627 T715 oass.DirectSolrSpellChecker.init init:
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 283636 T719 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@865d73c3[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 283641 T715 oasu.DefaultSolrCoreState.newIndexWriter Creating
new IndexWriter...
[junit4] 2> 283641 T715 oasu.DefaultSolrCoreState.newIndexWriter Waiting
until IndexWriter is unused... core=collection1
[junit4] 2> 283641 T715 oasu.DefaultSolrCoreState.newIndexWriter Closing
old IndexWriter... core=collection1
[junit4] 2> 283642 T715 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=42, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=1.0]
[junit4] 2> 283643 T715 oasc.SolrDeletionPolicy.onInit
SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2>
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory(id=lucene-227e5adf))),segFN=segments_1,generation=1}
[junit4] 2> 283643 T715 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 283643 T715 oasu.DefaultSolrCoreState.newIndexWriter New
IndexWriter is ready to be used.
[junit4] 2> 283644 T715 oass.SolrIndexSearcher.<init> Opening
Searcher@8ba4a0fb[collection1] main
[junit4] 2> 283644 T715 oasc.CoreContainer.registerCore replacing core:
collection1
[junit4] 2> 283645 T715 oasc.SolrCore.close [collection1] CLOSING
SolrCore org.apache.solr.core.SolrCore@9689c3ae
[junit4] 2> 283645 T715 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> 283645 T719 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@8ba4a0fb[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 283645 T715 oasc.SolrCore.closeSearcher [collection1] Closing
main searcher on request.
[junit4] 2> 284307 T715 oasup.LogUpdateProcessor.finish [collection1]
{add=[529 (1484275664857071616)]} 0 650
[junit4] 2> 285307 T720 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 285311 T720 oass.SolrIndexSearcher.<init> Opening
Searcher@8fa1b184[collection1] main
[junit4] 2> 285312 T720 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 285313 T719 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@8fa1b184[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):C1)))}
[junit4] 2> ASYNC NEW_CORE C394 name=collection1
org.apache.solr.core.SolrCore@3d44e98
[junit4] 2> 285763 T715 C394 oasc.SolrCore.execute [collection1]
webapp=null path=null params={start=0&q=id:529&version=2.2&rows=20&qt=standard}
hits=1 status=0 QTime=1455
[junit4] 2> 285776 T715 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">1455</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_">1484275664857071616</long><date
name="timestamp">2014-11-09T06:46:20.041Z</date><arr
name="multiDefault"><str>muLti-Default</str></arr><int
name="intDefault">42</int></doc></result>
[junit4] 2> </response>
[junit4] 2>
[junit4] 2> request
was:start=0&q=id:529&version=2.2&rows=20&qt=standard
[junit4] 2> 285777 T715 oasc.SolrException.log ERROR REQUEST FAILED:
start=0&q=id:529&version=2.2&rows=20&qt=standard: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">1455</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_">1484275664857071616</long><date
name="timestamp">2014-11-09T06:46:20.041Z</date><arr
name="multiDefault"><str>muLti-Default</str></arr><int
name="intDefault">42</int></doc></result>
[junit4] 2> </response>
[junit4] 2>
[junit4] 2> request
was:start=0&q=id:529&version=2.2&rows=20&qt=standard
[junit4] 2> at
org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:716)
[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: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:853)
[junit4] 2>
[junit4] 2> 285778 T715 oas.SolrTestCaseJ4.tearDown ###Ending testMaxTime
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=AutoCommitTest
-Dtests.method=testMaxTime -Dtests.seed=AA7876B2A9F38E90 -Dtests.multiplier=3
-Dtests.slow=true -Dtests.locale=nl -Dtests.timezone=America/Curacao
-Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] ERROR 2.70s J1 | AutoCommitTest.testMaxTime <<<
[junit4] > Throwable #1: java.lang.RuntimeException: Exception during
query
[junit4] > at
__randomizedtesting.SeedInfo.seed([AA7876B2A9F38E90:308C0B50376912AC]:0)
[junit4] > at
org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:723)
[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">1455</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_">1484275664857071616</long><date
name="timestamp">2014-11-09T06:46:20.041Z</date><arr
name="multiDefault"><str>muLti-Default</str></arr><int
name="intDefault">42</int></doc></result>
[junit4] > </response>
[junit4] > request
was:start=0&q=id:529&version=2.2&rows=20&qt=standard
[junit4] > at
org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:716)
[junit4] > ... 41 more
[junit4] 2> 285795 T715 oas.SolrTestCaseJ4.setUp ###Starting testMaxDocs
[junit4] 2> 285879 T715 C394 oass.SolrIndexSearcher.<init> Opening
Searcher@8380dc34[collection1] realtime
[junit4] 2> 285881 T715 C394 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null params={} {deleteByQuery=*:* (-1484275666506481664)} 0 85
[junit4] 2> 285886 T715 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/'
[junit4] 2> 285887 T715 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> 285887 T715 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> 285888 T715 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> 285939 T715 oasc.SolrConfig.<init> Using Lucene MatchVersion:
6.0.0
[junit4] 2> 285999 T715 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 286000 T715 oass.IndexSchema.readSchema Reading Solr Schema
from
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/conf/schema.xml
[junit4] 2> 286005 T715 oass.IndexSchema.readSchema [collection1] Schema
name=test
[junit4] 2> 286282 T715 oass.OpenExchangeRatesOrgProvider.init Initialized
with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 286286 T715 oass.IndexSchema.readSchema default search field
in schema is text
[junit4] 2> 286288 T715 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 286293 T715 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 286296 T715 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 286299 T715 oass.OpenExchangeRatesOrgProvider.reload Reloading
exchange rates from open-exchange-rates.json
[junit4] 2> 286300 T715
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 286300 T715
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 286300 T715 oass.OpenExchangeRatesOrgProvider.reload Reloading
exchange rates from open-exchange-rates.json
[junit4] 2> 286301 T715
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 286301 T715
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 286302 T715 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> 286302 T715 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-AA7876B2A9F38E90-001/init-core-data-001/
[junit4] 2> 286302 T715 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@950e9771
[junit4] 2> 286303 T715 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-AA7876B2A9F38E90-001/init-core-data-001/index/
[junit4] 2> 286304 T715 oasc.SolrCore.initWriters created xml:
solr.XMLResponseWriter
[junit4] 2> 286306 T715 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 286306 T715 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 286307 T715 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 286307 T715 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"dedupe-allfields"
[junit4] 2> 286307 T715 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 286308 T715 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 286308 T715 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "uniq-fields"
[junit4] 2> 286308 T715 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4] 2> 286309 T715 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 286309 T715 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 286310 T715 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 286310 T715 oasc.SolrCore.loadUpdateProcessorChains no
updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 286310 T715 oasc.RequestHandlers.initHandlersFromConfig
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 286311 T715 oasc.RequestHandlers.initHandlersFromConfig
created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 286311 T715 oasc.RequestHandlers.initHandlersFromConfig
created /config: org.apache.solr.handler.SolrConfigHandler
[junit4] 2> 286312 T715 oasc.RequestHandlers.initHandlersFromConfig
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 286312 T715 oasc.RequestHandlers.initHandlersFromConfig adding
lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 286312 T715 oasc.RequestHandlers.initHandlersFromConfig
created /replication: solr.ReplicationHandler
[junit4] 2> 286313 T715 oasc.RequestHandlers.initHandlersFromConfig
created standard: solr.StandardRequestHandler
[junit4] 2> 286313 T715 oasc.RequestHandlers.initHandlersFromConfig
created /get: solr.RealTimeGetHandler
[junit4] 2> 286314 T715 oasc.RequestHandlers.initHandlersFromConfig
created dismax: solr.SearchHandler
[junit4] 2> 286314 T715 oasc.RequestHandlers.initHandlersFromConfig
created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4] 2> 286315 T715 oasc.RequestHandlers.initHandlersFromConfig
created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 286315 T715 oasc.RequestHandlers.initHandlersFromConfig
created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 286316 T715 oasc.RequestHandlers.initHandlersFromConfig
created /admin/fileedit: solr.admin.EditFileRequestHandler
[junit4] 2> 286316 T715 oasc.RequestHandlers.initHandlersFromConfig
created defaults: solr.StandardRequestHandler
[junit4] 2> 286316 T715 oasc.RequestHandlers.initHandlersFromConfig adding
lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 286317 T715 oasc.RequestHandlers.initHandlersFromConfig
created lazy: solr.StandardRequestHandler
[junit4] 2> 286317 T715 oasc.RequestHandlers.initHandlersFromConfig
created /update: solr.UpdateRequestHandler
[junit4] 2> 286318 T715 oasc.RequestHandlers.initHandlersFromConfig
created /terms: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 286318 T715 oasc.RequestHandlers.initHandlersFromConfig
created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 286319 T715 oasc.RequestHandlers.initHandlersFromConfig
created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 286319 T715 oasc.RequestHandlers.initHandlersFromConfig
created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 286319 T715 oasc.RequestHandlers.initHandlersFromConfig
created spellCheckWithWordbreak_Direct:
org.apache.solr.handler.component.SearchHandler
[junit4] 2> 286320 T715 oasc.RequestHandlers.initHandlersFromConfig
created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 286320 T715 oasc.RequestHandlers.initHandlersFromConfig
created mltrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 286321 T715 oasc.RequestHandlers.initHandlersFromConfig
created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 286321 T715 oasc.RequestHandlers.initHandlersFromConfig
created /mlt: solr.MoreLikeThisHandler
[junit4] 2> 286322 T715 oasc.RequestHandlers.initHandlersFromConfig
created /debug/dump: solr.DumpRequestHandler
[junit4] 2> 286323 T715 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 286324 T715 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 286325 T715 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 286326 T715 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 286328 T715 oasc.SolrCore.initDeprecatedSupport WARN
solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config
to use the ShowFileRequestHandler.
[junit4] 2> 286329 T715 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 286329 T715 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 286330 T715 oass.SolrIndexSearcher.<init> Opening
Searcher@3ea90e7f[collection1] main
[junit4] 2> 286331 T715 oasr.RestManager.init Initializing RestManager
with initArgs:
{storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
[junit4] 2> 286331 T715 oasr.ManagedResourceStorage.load Reading
_rest_managed.json using InMemoryStorage
[junit4] 2> 286331 T715 oasr.ManagedResource.reloadFromStorage WARN No
stored data found for /rest/managed
[junit4] 2> 286332 T715 oasr.ManagedResourceStorage$JsonStorage.store
Saved JSON object to path _rest_managed.json using InMemoryStorage
[junit4] 2> 286332 T715 oasr.RestManager.init Initializing 0 registered
ManagedResources
[junit4] 2> 286332 T715 oashc.SpellCheckComponent.inform Initializing
spell checkers
[junit4] 2> 286334 T715 oass.DirectSolrSpellChecker.init init:
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 286342 T721 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@3ea90e7f[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 286346 T715 oasu.DefaultSolrCoreState.newIndexWriter Creating
new IndexWriter...
[junit4] 2> 286347 T715 oasu.DefaultSolrCoreState.newIndexWriter Waiting
until IndexWriter is unused... core=collection1
[junit4] 2> 286347 T715 oasu.DefaultSolrCoreState.newIndexWriter Closing
old IndexWriter... core=collection1
[junit4] 2> 286347 T715 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory(id=lucene-227e5adf))),segFN=segments_1,generation=1}
[junit4] 2>
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory(id=lucene-227e5adf))),segFN=segments_2,generation=2}
[junit4] 2> 286348 T715 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 2
[junit4] 2> 286348 T715 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.LogByteSizeMergePolicy:
[LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=25,
maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807,
calibrateSizeByDeletes=false, maxMergeDocs=2147483647,
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7039149154798221]
[junit4] 2> 286350 T715 oasc.SolrDeletionPolicy.onInit
SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2>
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory(id=lucene-227e5adf))),segFN=segments_2,generation=2}
[junit4] 2> 286350 T715 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 2
[junit4] 2> 286351 T715 oasu.DefaultSolrCoreState.newIndexWriter New
IndexWriter is ready to be used.
[junit4] 2> 286351 T715 oass.SolrIndexSearcher.<init> Opening
Searcher@29fecb18[collection1] main
[junit4] 2> 286352 T715 oasc.CoreContainer.registerCore replacing core:
collection1
[junit4] 2> 286352 T715 oasc.SolrCore.close [collection1] CLOSING
SolrCore org.apache.solr.core.SolrCore@3d44e98
[junit4] 2> 286352 T715 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> 286353 T721 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@29fecb18[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 286353 T715 oasc.SolrCore.closeSearcher [collection1] Closing
main searcher on request.
[junit4] 2> 286449 T715 oasup.LogUpdateProcessor.finish [collection1]
{add=[0 (1484275667104169984)]} 0 87
[junit4] 2> 286450 T715 oasup.LogUpdateProcessor.finish [collection1]
{add=[1 (1484275667105218560)]} 0 87
[junit4] 2> 286451 T715 oasup.LogUpdateProcessor.finish [collection1]
{add=[2 (1484275667105218561)]} 0 87
[junit4] 2> 286451 T715 oasup.LogUpdateProcessor.finish [collection1]
{add=[3 (1484275667106267136)]} 0 87
[junit4] 2> 286453 T715 oasup.LogUpdateProcessor.finish [collection1]
{add=[4 (1484275667107315712)]} 0 87
[junit4] 2> 286453 T715 oasup.LogUpdateProcessor.finish [collection1]
{add=[5 (1484275667108364288)]} 0 87
[junit4] 2> 286454 T715 oasup.LogUpdateProcessor.finish [collection1]
{add=[6 (1484275667109412864)]} 0 87
[junit4] 2> 286454 T715 oasup.LogUpdateProcessor.finish [collection1]
{add=[7 (1484275667109412865)]} 0 87
[junit4] 2> 286455 T715 oasup.LogUpdateProcessor.finish [collection1]
{add=[8 (1484275667110461440)]} 0 87
[junit4] 2> 286456 T715 oasup.LogUpdateProcessor.finish [collection1]
{add=[9 (1484275667111510016)]} 0 87
[junit4] 2> 286457 T715 oasup.LogUpdateProcessor.finish [collection1]
{add=[10 (1484275667112558592)]} 0 87
[junit4] 2> 286458 T715 oasup.LogUpdateProcessor.finish [collection1]
{add=[11 (1484275667113607168)]} 0 87
[junit4] 2> 286459 T715 oasup.LogUpdateProcessor.finish [collection1]
{add=[12 (1484275667114655744)]} 0 87
[junit4] 2> 286460 T715 oasup.LogUpdateProcessor.finish [collection1]
{add=[13 (1484275667115704320)]} 0 87
[junit4] 2> ASYNC NEW_CORE C395 name=collection1
org.apache.solr.core.SolrCore@fe356316
[junit4] 2> 286465 T715 C395 oasc.SolrCore.execute [collection1]
webapp=null path=null params={start=0&q=id:1&version=2.2&rows=20&qt=standard}
hits=0 status=0 QTime=5
[junit4] 2> 286466 T715 oasup.LogUpdateProcessor.finish [collection1]
{add=[14 (1484275667121995776)]} 0 87
[junit4] 2> 286467 T722 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 286472 T722 oass.SolrIndexSearcher.<init> Opening
Searcher@17ff4abd[collection1] main
[junit4] 2> 286473 T722 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 286474 T721 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@17ff4abd[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(6.0.0):C15)))}
[junit4] 2> 286718 T715 oasup.LogUpdateProcessor.finish [collection1]
{add=[15 (1484275667385188352)]} 0 87
[junit4] 2> 286718 T715 C395 oasc.SolrCore.execute [collection1]
webapp=null path=null params={start=0&q=id:14&version=2.2&rows=20&qt=standard}
hits=1 status=0 QTime=0
[junit4] 2> 286720 T715 C395 oasc.SolrCore.execute [collection1]
webapp=null path=null params={start=0&q=id:15&version=2.2&rows=20&qt=standard}
hits=0 status=0 QTime=0
[junit4] 2> 286721 T715 oas.SolrTestCaseJ4.tearDown ###Ending testMaxDocs
[junit4] 2> 286725 T715 oas.SolrTestCaseJ4.setUp ###Starting
testCommitWithin
[junit4] 2> 286778 T715 C395 oass.SolrIndexSearcher.<init> Opening
Searcher@12feb25d[collection1] realtime
[junit4] 2> 286779 T715 C395 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null params={} {deleteByQuery=*:* (-1484275667393576960)} 0 54
[junit4] 2> 286780 T715 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/'
[junit4] 2> 286781 T715 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> 286781 T715 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> 286782 T715 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> 286814 T715 oasc.SolrConfig.<init> Using Lucene MatchVersion:
6.0.0
[junit4] 2> 286867 T715 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 286867 T715 oass.IndexSchema.readSchema Reading Solr Schema
from
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/conf/schema.xml
[junit4] 2> 286872 T715 oass.IndexSchema.readSchema [collection1] Schema
name=test
[junit4] 2> 287142 T715 oass.OpenExchangeRatesOrgProvider.init Initialized
with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 287146 T715 oass.IndexSchema.readSchema default search field
in schema is text
[junit4] 2> 287149 T715 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 287154 T715 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 287158 T715 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 287163 T715 oass.OpenExchangeRatesOrgProvider.reload Reloading
exchange rates from open-exchange-rates.json
[junit4] 2> 287164 T715
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 287164 T715
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 287165 T715 oass.OpenExchangeRatesOrgProvider.reload Reloading
exchange rates from open-exchange-rates.json
[junit4] 2> 287166 T715
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 287167 T715
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 287167 T715 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> 287168 T715 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-AA7876B2A9F38E90-001/init-core-data-001/
[junit4] 2> 287169 T715 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@950e9771
[junit4] 2> 287170 T715 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-AA7876B2A9F38E90-001/init-core-data-001/index/
[junit4] 2> 287171 T715 oasc.SolrCore.initWriters created xml:
solr.XMLResponseWriter
[junit4] 2> 287174 T715 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 287175 T715 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 287175 T715 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 287176 T715 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"dedupe-allfields"
[junit4] 2> 287176 T715 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 287177 T715 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 287177 T715 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "uniq-fields"
[junit4] 2> 287179 T715 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4] 2> 287180 T715 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 287181 T715 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 287181 T715 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 287182 T715 oasc.SolrCore.loadUpdateProcessorChains no
updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 287183 T715 oasc.RequestHandlers.initHandlersFromConfig
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 287184 T715 oasc.RequestHandlers.initHandlersFromConfig
created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 287184 T715 oasc.RequestHandlers.initHandlersFromConfig
created /config: org.apache.solr.handler.SolrConfigHandler
[junit4] 2> 287185 T715 oasc.RequestHandlers.initHandlersFromConfig
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 287185 T715 oasc.RequestHandlers.initHandlersFromConfig adding
lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 287186 T715 oasc.RequestHandlers.initHandlersFromConfig
created /replication: solr.ReplicationHandler
[junit4] 2> 287187 T715 oasc.RequestHandlers.initHandlersFromConfig
created standard: solr.StandardRequestHandler
[junit4] 2> 287188 T715 oasc.RequestHandlers.initHandlersFromConfig
created /get: solr.RealTimeGetHandler
[junit4] 2> 287188 T715 oasc.RequestHandlers.initHandlersFromConfig
created dismax: solr.SearchHandler
[junit4] 2> 287189 T715 oasc.RequestHandlers.initHandlersFromConfig
created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4] 2> 287190 T715 oasc.RequestHandlers.initHandlersFromConfig
created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 287190 T715 oasc.RequestHandlers.initHandlersFromConfig
created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 287191 T715 oasc.RequestHandlers.initHandlersFromConfig
created /admin/fileedit: solr.admin.EditFileRequestHandler
[junit4] 2> 287192 T715 oasc.RequestHandlers.initHandlersFromConfig
created defaults: solr.StandardRequestHandler
[junit4] 2> 287192 T715 oasc.RequestHandlers.initHandlersFromConfig adding
lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 287193 T715 oasc.RequestHandlers.initHandlersFromConfig
created lazy: solr.StandardRequestHandler
[junit4] 2> 287194 T715 oasc.RequestHandlers.initHandlersFromConfig
created /update: solr.UpdateRequestHandler
[junit4] 2> 287195 T715 oasc.RequestHandlers.initHandlersFromConfig
created /terms: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 287195 T715 oasc.RequestHandlers.initHandlersFromConfig
created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 287196 T715 oasc.RequestHandlers.initHandlersFromConfig
created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 287197 T715 oasc.RequestHandlers.initHandlersFromConfig
created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 287198 T715 oasc.RequestHandlers.initHandlersFromConfig
created spellCheckWithWordbreak_Direct:
org.apache.solr.handler.component.SearchHandler
[junit4] 2> 287199 T715 oasc.RequestHandlers.initHandlersFromConfig
created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 287199 T715 oasc.RequestHandlers.initHandlersFromConfig
created mltrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 287200 T715 oasc.RequestHandlers.initHandlersFromConfig
created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 287201 T715 oasc.RequestHandlers.initHandlersFromConfig
created /mlt: solr.MoreLikeThisHandler
[junit4] 2> 287202 T715 oasc.RequestHandlers.initHandlersFromConfig
created /debug/dump: solr.DumpRequestHandler
[junit4] 2> 287204 T715 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 287205 T715 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 287207 T715 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 287209 T715 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 287211 T715 oasc.SolrCore.initDeprecatedSupport WARN
solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config
to use the ShowFileRequestHandler.
[junit4] 2> 287212 T715 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 287213 T715 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 287214 T715 oass.SolrIndexSearcher.<init> Opening
Searcher@8ac3cb7[collection1] main
[junit4] 2> 287214 T715 oasr.RestManager.init Initializing RestManager
with initArgs:
{storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
[junit4] 2> 287214 T715 oasr.ManagedResourceStorage.load Reading
_rest_managed.json using InMemoryStorage
[junit4] 2> 287215 T715 oasr.ManagedResource.reloadFromStorage WARN No
stored data found for /rest/managed
[junit4] 2> 287215 T715 oasr.ManagedResourceStorage$JsonStorage.store
Saved JSON object to path _rest_managed.json using InMemoryStorage
[junit4] 2> 287215 T715 oasr.RestManager.init Initializing 0 registered
ManagedResources
[junit4] 2> 287216 T715 oashc.SpellCheckComponent.inform Initializing
spell checkers
[junit4] 2> 287217 T715 oass.DirectSolrSpellChecker.init init:
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 287225 T723 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@8ac3cb7[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 287230 T715 oasu.DefaultSolrCoreState.newIndexWriter Creating
new IndexWriter...
[junit4] 2> 287230 T715 oasu.DefaultSolrCoreState.newIndexWriter Waiting
until IndexWriter is unused... core=collection1
[junit4] 2> 287230 T715 oasu.DefaultSolrCoreState.newIndexWriter Closing
old IndexWriter... core=collection1
[junit4] 2> 287231 T715 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory(id=lucene-227e5adf))),segFN=segments_2,generation=2}
[junit4] 2>
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory(id=lucene-227e5adf))),segFN=segments_3,generation=3}
[junit4] 2> 287231 T715 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 3
[junit4] 2> 287232 T715 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.LogByteSizeMergePolicy:
[LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=34,
maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807,
calibrateSizeByDeletes=false, maxMergeDocs=2147483647,
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 287233 T715 oasc.SolrDeletionPolicy.onInit
SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2>
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory(id=lucene-227e5adf))),segFN=segments_3,generation=3}
[junit4] 2> 287233 T715 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 3
[junit4] 2> 287234 T715 oasu.DefaultSolrCoreState.newIndexWriter New
IndexWriter is ready to be used.
[junit4] 2> 287234 T715 oass.SolrIndexSearcher.<init> Opening
Searcher@2b37f06d[collection1] main
[junit4] 2> 287234 T715 oasc.CoreContainer.registerCore replacing core:
collection1
[junit4] 2> 287235 T715 oasc.SolrCore.close [collection1] CLOSING
SolrCore org.apache.solr.core.SolrCore@fe356316
[junit4] 2> 287235 T715 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=1,errors=0,cumulative_adds=16,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=0,transaction_logs_total_size=0,transaction_logs_total_number=0}
[junit4] 2> 287235 T715 oasc.SolrCore.closeSearcher [collection1] Closing
main searcher on request.
[junit4] 2> 287236 T723 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@2b37f06d[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 287237 T715 oasc.JmxMonitoredMap$SolrDynamicMBean.getMBeanInfo
WARN Could not getStatistics on info bean
org.apache.solr.search.SolrIndexSearcher
org.apache.lucene.store.AlreadyClosedException: this IndexReader is closed
[junit4] 2> at
org.apache.lucene.index.IndexReader.ensureOpen(IndexReader.java:274)
[junit4] 2> at
org.apache.lucene.index.StandardDirectoryReader.getVersion(StandardDirectoryReader.java:326)
[junit4] 2> at
org.apache.lucene.index.FilterDirectoryReader.getVersion(FilterDirectoryReader.java:110)
[junit4] 2> at
org.apache.lucene.index.FilterDirectoryReader.getVersion(FilterDirectoryReader.java:110)
[junit4] 2> at
org.apache.solr.search.SolrIndexSearcher.getStatistics(SolrIndexSearcher.java:2243)
[junit4] 2> at
org.apache.solr.core.JmxMonitoredMap$SolrDynamicMBean.getMBeanInfo(JmxMonitoredMap.java:244)
[junit4] 2> at
com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.getClassName(DefaultMBeanServerInterceptor.java:1816)
[junit4] 2> at
com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.safeGetClassName(DefaultMBeanServerInterceptor.java:1607)
[junit4] 2> at
com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.objectInstancesFromFilteredNamedObjects(DefaultMBeanServerInterceptor.java:1568)
[junit4] 2> at
com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.queryMBeansImpl(DefaultMBeanServerInterceptor.java:525)
[junit4] 2> at
com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.queryNames(DefaultMBeanServerInterceptor.java:538)
[junit4] 2> at
com.sun.jmx.mbeanserver.JmxMBeanServer.queryNames(JmxMBeanServer.java:631)
[junit4] 2> at
org.apache.solr.core.JmxMonitoredMap.clear(JmxMonitoredMap.java:116)
[junit4] 2> at
org.apache.solr.core.SolrCore.close(SolrCore.java:1125)
[junit4] 2> at
org.apache.solr.core.CoreContainer.registerCore(CoreContainer.java:471)
[junit4] 2> at
org.apache.solr.core.CoreContainer.reload(CoreContainer.java:606)
[junit4] 2> at
org.apache.solr.update.AutoCommitTest.setUp(AutoCommitTest.java:135)
[junit4] 2> at sun.reflect.GeneratedMethodAccessor16.invoke(Unknown
Source)
[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$7.evaluate(RandomizedRunner.java:861)
[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: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:853)
[junit4] 2>
[junit4] 2> 287247 T715 oasup.LogUpdateProcessor.finish [collection1]
{add=[529 (1484275667939885056)]} 0 1
[junit4] 2> ASYNC NEW_CORE C396 name=collection1
org.apache.solr.core.SolrCore@7267f825
[junit4] 2> 287248 T715 C396 oasc.SolrCore.execute [collection1]
webapp=null path=null params={start=0&q=id:529&version=2.2&rows=20&qt=standard}
hits=0 status=0 QTime=0
[junit4] 2> 291247 T724 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 291250 T724 oass.SolrIndexSearcher.<init> Opening
Searcher@c872438e[collection1] main
[junit4] 2> 291251 T724 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 291252 T723 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@c872438e[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_3(6.0.0):C1)))}
[junit4] 2> 291501 T715 oasup.LogUpdateProcessor.finish [collection1]
{add=[530 (1484275672401575936)]} 0 1
[junit4] 2> 291502 T715 C396 oasc.SolrCore.execute [collection1]
webapp=null path=null params={start=0&q=id:530&version=2.2&rows=20&qt=standard}
hits=0 status=0 QTime=0
[junit4] 2> 291503 T715 oasup.LogUpdateProcessor.finish [collection1]
{delete=[529 (-1484275672403673088)]} 0 1
[junit4] 2> 291504 T715 C396 oasc.SolrCore.execute [collection1]
webapp=null path=null params={start=0&q=id:529&version=2.2&rows=20&qt=standard}
hits=1 status=0 QTime=0
[junit4] 2> 292504 T724 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 292508 T724 oass.SolrIndexSearcher.<init> Opening
Searcher@ef267407[collection1] main
[junit4] 2> 292508 T724 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 292509 T723 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@ef267407[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(6.0.0):C1)))}
[junit4] 2> 292756 T715 C396 oasc.SolrCore.execute [collection1]
webapp=null path=null params={start=0&q=id:529&version=2.2&rows=20&qt=standard}
hits=0 status=0 QTime=0
[junit4] 2> 292759 T715 C396 oasc.SolrCore.execute [collection1]
webapp=null path=null params={start=0&q=id:530&version=2.2&rows=20&qt=standard}
hits=1 status=0 QTime=0
[junit4] 2> 292762 T715 oasup.LogUpdateProcessor.finish [collection1]
{add=[500 (1484275673722781696)]} 0 1
[junit4] 2> 292763 T715 oasup.LogUpdateProcessor.finish [collection1]
{add=[500 (1484275673724878848)]} 0 1
[junit4] 2> 292763 T715 oasup.LogUpdateProcessor.finish [collection1]
{add=[500 (1484275673724878849)]} 0 1
[junit4] 2> 292764 T715 oasup.LogUpdateProcessor.finish [collection1]
{add=[500 (1484275673725927424)]} 0 1
[junit4] 2> 292765 T715 oasup.LogUpdateProcessor.finish [collection1]
{add=[500 (1484275673726976000)]} 0 1
[junit4] 2> 292766 T715 oasup.LogUpdateProcessor.finish [collection1]
{add=[500 (1484275673728024576)]} 0 1
[junit4] 2> 292767 T715 oasup.LogUpdateProcessor.finish [collection1]
{add=[500 (1484275673729073152)]} 0 1
[junit4] 2> 292768 T715 oasup.LogUpdateProcessor.finish [collection1]
{add=[500 (1484275673730121728)]} 0 1
[junit4] 2> 292769 T715 oasup.LogUpdateProcessor.finish [collection1]
{add=[500 (1484275673731170304)]} 0 1
[junit4] 2> 292770 T715 oasup.LogUpdateProcessor.finish [collection1]
{add=[500 (1484275673732218880)]} 0 1
[junit4] 2> 292772 T715 C396 oasc.SolrCore.execute [collection1]
webapp=null path=null params={start=0&q=id:500&version=2.2&rows=20&qt=standard}
hits=0 status=0 QTime=0
[junit4] 2> 292775 T715 oasup.LogUpdateProcessor.finish [collection1]
{delete=[530 (-1484275673737461760)]} 0 1
[junit4] 2> 292776 T715 oasup.LogUpdateProcessor.finish [collection1]
{delete=[530 (-1484275673738510336)]} 0 1
[junit4] 2> 292778 T715 oasup.LogUpdateProcessor.finish [collection1]
{delete=[530 (-1484275673740607488)]} 0 1
[junit4] 2> 292779 T715 oasup.LogUpdateProcessor.finish [collection1]
{delete=[530 (-1484275673741656064)]} 0 1
[junit4] 2> 292780 T715 oasup.LogUpdateProcessor.finish [collection1]
{delete=[530 (-1484275673742704640)]} 0 1
[junit4] 2> 292780 T715 oasup.LogUpdateProcessor.finish [collection1]
{delete=[530 (-1484275673742704641)]} 0 1
[junit4] 2> 292781 T715 oasup.LogUpdateProcessor.finish [collection1]
{delete=[530 (-1484275673743753216)]} 0 1
[junit4] 2> 292782 T715 oasup.LogUpdateProcessor.finish [collection1]
{delete=[530 (-1484275673744801792)]} 0 1
[junit4] 2> 292782 T715 oasup.LogUpdateProcessor.finish [collection1]
{delete=[530 (-1484275673744801793)]} 0 1
[junit4] 2> 292783 T715 oasup.LogUpdateProcessor.finish [collection1]
{delete=[530 (-1484275673745850368)]} 0 1
[junit4] 2> 292784 T715 C396 oasc.SolrCore.execute [collection1]
webapp=null path=null params={start=0&q=id:530&version=2.2&rows=20&qt=standard}
hits=1 status=0 QTime=0
[junit4] 2> 293775 T724 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 293778 T724 oass.SolrIndexSearcher.<init> Opening
Searcher@dc9b60e0[collection1] main
[junit4] 2> 293779 T724 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 293780 T723 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@dc9b60e0[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_5(6.0.0):C10/9:delGen=1)))}
[junit4] 2> 293786 T715 C396 oasc.SolrCore.execute [collection1]
webapp=null path=null params={start=0&q=id:500&version=2.2&rows=20&qt=standard}
hits=1 status=0 QTime=0
[junit4] 2> 293788 T715 C396 oasc.SolrCore.execute [collection1]
webapp=null path=null params={start=0&q=id:530&version=2.2&rows=20&qt=standard}
hits=0 status=0 QTime=1
[junit4] 2> 293789 T715 oas.SolrTestCaseJ4.tearDown ###Ending
testCommitWithin
[junit4] 2> 293791 T715 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> 293791 T715 oasc.CoreContainer.shutdown Shutting down
CoreContainer instance=-1883073343
[junit4] 2> 293791 T715 oasc.SolrCore.close [collection1] CLOSING
SolrCore org.apache.solr.core.SolrCore@7267f825
[junit4] 2> 293791 T715 oasu.DirectUpdateHandler2.close closing
DirectUpdateHand
[...truncated too long message...]
uate(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> 293805 T715 oasc.JmxMonitoredMap$SolrDynamicMBean.getMBeanInfo
WARN Could not getStatistics on info bean
org.apache.solr.search.SolrIndexSearcher
org.apache.lucene.store.AlreadyClosedException: this IndexReader is closed
[junit4] 2> at
org.apache.lucene.index.IndexReader.ensureOpen(IndexReader.java:274)
[junit4] 2> at
org.apache.lucene.index.StandardDirectoryReader.getVersion(StandardDirectoryReader.java:326)
[junit4] 2> at
org.apache.lucene.index.FilterDirectoryReader.getVersion(FilterDirectoryReader.java:110)
[junit4] 2> at
org.apache.lucene.index.FilterDirectoryReader.getVersion(FilterDirectoryReader.java:110)
[junit4] 2> at
org.apache.solr.search.SolrIndexSearcher.getStatistics(SolrIndexSearcher.java:2243)
[junit4] 2> at
org.apache.solr.core.JmxMonitoredMap$SolrDynamicMBean.getMBeanInfo(JmxMonitoredMap.java:244)
[junit4] 2> at
com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.getClassName(DefaultMBeanServerInterceptor.java:1816)
[junit4] 2> at
com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.safeGetClassName(DefaultMBeanServerInterceptor.java:1607)
[junit4] 2> at
com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.checkMBeanPermission(DefaultMBeanServerInterceptor.java:1825)
[junit4] 2> at
com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.exclusiveUnregisterMBean(DefaultMBeanServerInterceptor.java:442)
[junit4] 2> at
com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.unregisterMBean(DefaultMBeanServerInterceptor.java:427)
[junit4] 2> at
com.sun.jmx.mbeanserver.JmxMBeanServer.unregisterMBean(JmxMBeanServer.java:558)
[junit4] 2> at
org.apache.solr.core.JmxMonitoredMap.clear(JmxMonitoredMap.java:120)
[junit4] 2> at
org.apache.solr.core.SolrCore.close(SolrCore.java:1125)
[junit4] 2> at
org.apache.solr.core.SolrCores.close(SolrCores.java:117)
[junit4] 2> at
org.apache.solr.core.CoreContainer.shutdown(CoreContainer.java:366)
[junit4] 2> at
org.apache.solr.util.TestHarness.close(TestHarness.java:337)
[junit4] 2> at
org.apache.solr.SolrTestCaseJ4.deleteCore(SolrTestCaseJ4.java:634)
[junit4] 2> at
org.apache.solr.SolrTestCaseJ4.afterClass(SolrTestCaseJ4.java:185)
[junit4] 2> at sun.reflect.GeneratedMethodAccessor31.invoke(Unknown
Source)
[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$5.evaluate(RandomizedRunner.java:790)
[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: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:853)
[junit4] 2>
[junit4] 2> 293809 T715 oasc.CachingDirectoryFactory.close Closing
MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 293809 T715 oasc.CachingDirectoryFactory.closeCacheValue
looking to close
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest-AA7876B2A9F38E90-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-AA7876B2A9F38E90-001/init-core-data-001/index;done=false>>]
[junit4] 2> 293809 T715 oasc.CachingDirectoryFactory.close Closing
directory:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest-AA7876B2A9F38E90-001/init-core-data-001/index
[junit4] 2> 293810 T715 oasc.CachingDirectoryFactory.closeCacheValue
looking to close
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest-AA7876B2A9F38E90-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-AA7876B2A9F38E90-001/init-core-data-001;done=false>>]
[junit4] 2> 293810 T715 oasc.CachingDirectoryFactory.close Closing
directory:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest-AA7876B2A9F38E90-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-AA7876B2A9F38E90-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene50):
{multiDefault=PostingsFormat(name=Memory doPackFST= false),
subject=PostingsFormat(name=Memory doPackFST= false),
text=PostingsFormat(name=Direct), intDefault=Lucene50(blocksize=128),
timestamp=PostingsFormat(name=Memory doPackFST= false),
range_facet_l=PostingsFormat(name=Memory doPackFST= false),
_version_=Lucene50(blocksize=128), id=FSTOrd50, field_t=FSTOrd50},
docValues:{timestamp=DocValuesFormat(name=Lucene50)},
sim=RandomSimilarityProvider(queryNorm=true,coord=crazy): {}, locale=nl,
timezone=America/Curacao
[junit4] 2> NOTE: Linux 3.13.0-39-generic amd64/IBM Corporation 1.7.0
(64-bit)/cpus=8,threads=1,free=17118080,total=106037248
[junit4] 2> NOTE: All tests run in this JVM: [TestCollationField,
QueryElevationComponentTest, TestFieldTypeCollectionResource,
TestSchemaVersionResource, URLClassifyProcessorTest, FileBasedSpellCheckerTest,
SolrCoreTest, TestZkChroot, AnalysisAfterCoreReloadTest, ResourceLoaderTest,
TestSweetSpotSimilarityFactory, BasicZkTest, ScriptEngineTest,
BasicDistributedZk2Test, TestRealTimeGet, HdfsBasicDistributedZkTest,
TestWriterPerf, SolrRequestParserTest, CloudExitableDirectoryReaderTest,
LeaderInitiatedRecoveryOnCommitTest, DirectSolrConnectionTest,
DeleteReplicaTest, TestRecovery, ChaosMonkeySafeLeaderTest,
TestJmxMonitoredMap, OverseerStatusTest, TestSolrXml,
LegacyHTMLStripCharFilterTest, PreAnalyzedFieldTest,
CoreAdminRequestStatusTest, ConnectionManagerTest, SpatialFilterTest,
TestReversedWildcardFilterFactory, ZkSolrClientTest, TestExtendedDismaxParser,
TestJoin, SchemaVersionSpecificBehaviorTest, TestFunctionQuery,
QueryParsingTest, TestQueryUtils, TestInitParams, MigrateRouteKeyTest,
DistributedTermsComponentTest, AutoCommitTest]
[junit4] Completed on J1 in 11.84s, 3 tests, 1 error <<< FAILURES!
[...truncated 1122 lines...]
BUILD FAILED
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:525: The following
error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:486: The following
error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:61: The following
error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/extra-targets.xml:39: 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:502:
The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:1358:
The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:965:
There were test failures: 447 suites, 1820 tests, 1 error, 121 ignored (21
assumptions)
Total time: 71 minutes 2 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;}
(asserts: true)
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]
