Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Linux/11610/
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([DE1A8C04CF37BCCD:44EEF1E651AD20F1]: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">1902</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_">1484719069957455872</long><arr
name="multiDefault"><str>muLti-Default</str></arr><int
name="intDefault">42</int><date
name="timestamp">2014-11-14T04:14:04.097Z</date></doc></result>
</response>
request was:start=0&q=id:529&rows=20&qt=standard&version=2.2
at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:716)
... 41 more
Build Log:
[...truncated 11010 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-DE1A8C04CF37BCCD-001/init-core-data-001
[junit4] 2> 190412 T514 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl
(false) and clientAuth (false)
[junit4] 2> 190413 T514 oas.SolrTestCaseJ4.initCore ####initCore
[junit4] 2> 190413 T514 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/'
[junit4] 2> 190414 T514 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> 190414 T514 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> 190415 T514 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> 190467 T514 oasc.SolrConfig.<init> Using Lucene MatchVersion:
6.0.0
[junit4] 2> 190547 T514 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 190548 T514 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> 190556 T514 oass.IndexSchema.readSchema [null] Schema name=test
[junit4] 2> 190969 T514 oass.OpenExchangeRatesOrgProvider.init Initialized
with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 190976 T514 oass.IndexSchema.readSchema default search field
in schema is text
[junit4] 2> 190979 T514 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 190989 T514 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 190994 T514 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 190998 T514 oass.OpenExchangeRatesOrgProvider.reload Reloading
exchange rates from open-exchange-rates.json
[junit4] 2> 190999 T514
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 190999 T514
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 191000 T514 oass.OpenExchangeRatesOrgProvider.reload Reloading
exchange rates from open-exchange-rates.json
[junit4] 2> 191001 T514
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 191001 T514
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 191002 T514 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 191002 T514 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> 191003 T514 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/'
[junit4] 2> 191062 T514 oasc.CoreContainer.<init> New CoreContainer
1510273709
[junit4] 2> 191062 T514 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/]
[junit4] 2> 191064 T514 oashc.HttpShardHandlerFactory.getParameter Setting
socketTimeout to: 0
[junit4] 2> 191064 T514 oashc.HttpShardHandlerFactory.getParameter Setting
urlScheme to: null
[junit4] 2> 191065 T514 oashc.HttpShardHandlerFactory.getParameter Setting
connTimeout to: 0
[junit4] 2> 191065 T514 oashc.HttpShardHandlerFactory.getParameter Setting
maxConnectionsPerHost to: 20
[junit4] 2> 191066 T514 oashc.HttpShardHandlerFactory.getParameter Setting
maxConnections to: 10000
[junit4] 2> 191066 T514 oashc.HttpShardHandlerFactory.getParameter Setting
corePoolSize to: 0
[junit4] 2> 191066 T514 oashc.HttpShardHandlerFactory.getParameter Setting
maximumPoolSize to: 2147483647
[junit4] 2> 191067 T514 oashc.HttpShardHandlerFactory.getParameter Setting
maxThreadIdleTime to: 5
[junit4] 2> 191067 T514 oashc.HttpShardHandlerFactory.getParameter Setting
sizeOfQueue to: -1
[junit4] 2> 191068 T514 oashc.HttpShardHandlerFactory.getParameter Setting
fairnessPolicy to: false
[junit4] 2> 191069 T514 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=30000&connTimeout=30000&retry=false
[junit4] 2> 191069 T514 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 191070 T514 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 191070 T514 oasc.CoreContainer.load Host Name:
[junit4] 2> 191074 T515 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/'
[junit4] 2> 191075 T515 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> 191075 T515 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> 191076 T515 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> 191109 T515 oasc.SolrConfig.<init> Using Lucene MatchVersion:
6.0.0
[junit4] 2> 191156 T515 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 191156 T515 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> 191162 T515 oass.IndexSchema.readSchema [collection1] Schema
name=test
[junit4] 2> 191606 T515 oass.OpenExchangeRatesOrgProvider.init Initialized
with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 191614 T515 oass.IndexSchema.readSchema default search field
in schema is text
[junit4] 2> 191618 T515 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 191628 T515 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 191633 T515 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 191639 T515 oass.OpenExchangeRatesOrgProvider.reload Reloading
exchange rates from open-exchange-rates.json
[junit4] 2> 191639 T515
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 191640 T515
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 191640 T515 oass.OpenExchangeRatesOrgProvider.reload Reloading
exchange rates from open-exchange-rates.json
[junit4] 2> 191641 T515
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 191641 T515
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 191641 T515 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> 191642 T515 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 191642 T515 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-DE1A8C04CF37BCCD-001/init-core-data-001/
[junit4] 2> 191643 T515 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@42b288df
[junit4] 2> 191644 T515 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-DE1A8C04CF37BCCD-001/init-core-data-001
[junit4] 2> 191644 T515 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-DE1A8C04CF37BCCD-001/init-core-data-001/index/
[junit4] 2> 191644 T515 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-DE1A8C04CF37BCCD-001/init-core-data-001/index'
doesn't exist. Creating new index...
[junit4] 2> 191645 T515 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-DE1A8C04CF37BCCD-001/init-core-data-001/index
[junit4] 2> 191645 T515 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.LogByteSizeMergePolicy:
[LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=40,
maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807,
calibrateSizeByDeletes=true, maxMergeDocs=2147483647,
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.47537444579038]
[junit4] 2> 191646 T515 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@88817f13
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@2b0ea15a)),segFN=segments_1,generation=1}
[junit4] 2> 191647 T515 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 191647 T515 oasc.SolrCore.initWriters created xml:
solr.XMLResponseWriter
[junit4] 2> 191650 T515 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 191651 T515 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 191651 T515 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 191652 T515 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"dedupe-allfields"
[junit4] 2> 191652 T515 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 191652 T515 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 191653 T515 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "uniq-fields"
[junit4] 2> 191653 T515 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4] 2> 191654 T515 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 191654 T515 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 191655 T515 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 191655 T515 oasc.SolrCore.loadUpdateProcessorChains no
updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 191656 T515 oasc.RequestHandlers.initHandlersFromConfig
created /config: org.apache.solr.handler.SolrConfigHandler
[junit4] 2> 191656 T515 oasc.RequestHandlers.initHandlersFromConfig
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 191657 T515 oasc.RequestHandlers.initHandlersFromConfig
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 191657 T515 oasc.RequestHandlers.initHandlersFromConfig
created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 191658 T515 oasc.RequestHandlers.initHandlersFromConfig adding
lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 191658 T515 oasc.RequestHandlers.initHandlersFromConfig
created /replication: solr.ReplicationHandler
[junit4] 2> 191659 T515 oasc.RequestHandlers.initHandlersFromConfig
created standard: solr.StandardRequestHandler
[junit4] 2> 191659 T515 oasc.RequestHandlers.initHandlersFromConfig
created /get: solr.RealTimeGetHandler
[junit4] 2> 191660 T515 oasc.RequestHandlers.initHandlersFromConfig
created dismax: solr.SearchHandler
[junit4] 2> 191660 T515 oasc.RequestHandlers.initHandlersFromConfig
created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4] 2> 191661 T515 oasc.RequestHandlers.initHandlersFromConfig
created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 191661 T515 oasc.RequestHandlers.initHandlersFromConfig
created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 191662 T515 oasc.RequestHandlers.initHandlersFromConfig
created /admin/fileedit: solr.admin.EditFileRequestHandler
[junit4] 2> 191662 T515 oasc.RequestHandlers.initHandlersFromConfig
created defaults: solr.StandardRequestHandler
[junit4] 2> 191663 T515 oasc.RequestHandlers.initHandlersFromConfig adding
lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 191663 T515 oasc.RequestHandlers.initHandlersFromConfig
created lazy: solr.StandardRequestHandler
[junit4] 2> 191664 T515 oasc.RequestHandlers.initHandlersFromConfig
created /update: solr.UpdateRequestHandler
[junit4] 2> 191664 T515 oasc.RequestHandlers.initHandlersFromConfig
created /terms: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 191665 T515 oasc.RequestHandlers.initHandlersFromConfig
created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 191665 T515 oasc.RequestHandlers.initHandlersFromConfig
created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 191666 T515 oasc.RequestHandlers.initHandlersFromConfig
created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 191666 T515 oasc.RequestHandlers.initHandlersFromConfig
created spellCheckWithWordbreak_Direct:
org.apache.solr.handler.component.SearchHandler
[junit4] 2> 191667 T515 oasc.RequestHandlers.initHandlersFromConfig
created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 191667 T515 oasc.RequestHandlers.initHandlersFromConfig
created mltrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 191668 T515 oasc.RequestHandlers.initHandlersFromConfig
created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 191668 T515 oasc.RequestHandlers.initHandlersFromConfig
created /mlt: solr.MoreLikeThisHandler
[junit4] 2> 191669 T515 oasc.RequestHandlers.initHandlersFromConfig
created /debug/dump: solr.DumpRequestHandler
[junit4] 2> 191671 T515 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 191673 T515 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 191674 T515 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 191676 T515 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 191678 T515 oasc.SolrCore.initDeprecatedSupport WARN
solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config
to use the ShowFileRequestHandler.
[junit4] 2> 191681 T515 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 191681 T515 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 191682 T515 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=49, maxMergeAtOnceExplicit=41, maxMergedSegmentMB=35.134765625,
floorSegmentMB=0.70703125, forceMergeDeletesPctAllowed=10.340606605404501,
segmentsPerTier=46.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.8070870434318352
[junit4] 2> 191682 T515 oasc.SolrDeletionPolicy.onInit
SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2>
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@88817f13
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@2b0ea15a)),segFN=segments_1,generation=1}
[junit4] 2> 191683 T515 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 191683 T515 oass.SolrIndexSearcher.<init> Opening
Searcher@33cd051[collection1] main
[junit4] 2> 191684 T515 oasr.RestManager.init Initializing RestManager
with initArgs:
{storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
[junit4] 2> 191684 T515 oasr.ManagedResourceStorage.load Reading
_rest_managed.json using InMemoryStorage
[junit4] 2> 191685 T515 oasr.ManagedResource.reloadFromStorage WARN No
stored data found for /rest/managed
[junit4] 2> 191685 T515 oasr.ManagedResourceStorage$JsonStorage.store
Saved JSON object to path _rest_managed.json using InMemoryStorage
[junit4] 2> 191685 T515 oasr.RestManager.init Initializing 0 registered
ManagedResources
[junit4] 2> 191686 T515 oashc.SpellCheckComponent.inform Initializing
spell checkers
[junit4] 2> 191695 T515 oass.DirectSolrSpellChecker.init init:
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 191720 T516 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@33cd051[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 191724 T515 oasc.CoreContainer.registerCore registering core:
collection1
[junit4] 2> 191726 T514 oas.SolrTestCaseJ4.initCore ####initCore end
[junit4] 2> 191730 T514 oas.SolrTestCaseJ4.setUp ###Starting testMaxTime
[junit4] 2> ASYNC NEW_CORE C390 name=collection1
org.apache.solr.core.SolrCore@5331e525
[junit4] 2> 191732 T514 C390 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null params={} {deleteByQuery=*:* (-1484719068721184768)} 0 1
[junit4] 2> 191737 T514 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/'
[junit4] 2> 191738 T514 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> 191738 T514 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> 191739 T514 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> 191796 T514 oasc.SolrConfig.<init> Using Lucene MatchVersion:
6.0.0
[junit4] 2> 191871 T514 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 191872 T514 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> 191881 T514 oass.IndexSchema.readSchema [collection1] Schema
name=test
[junit4] 2> 192254 T514 oass.OpenExchangeRatesOrgProvider.init Initialized
with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 192261 T514 oass.IndexSchema.readSchema default search field
in schema is text
[junit4] 2> 192264 T514 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 192273 T514 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 192278 T514 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 192283 T514 oass.OpenExchangeRatesOrgProvider.reload Reloading
exchange rates from open-exchange-rates.json
[junit4] 2> 192283 T514
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 192284 T514
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 192284 T514 oass.OpenExchangeRatesOrgProvider.reload Reloading
exchange rates from open-exchange-rates.json
[junit4] 2> 192285 T514
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 192286 T514
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 192286 T514 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> 192287 T514 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-DE1A8C04CF37BCCD-001/init-core-data-001/
[junit4] 2> 192287 T514 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@42b288df
[junit4] 2> 192288 T514 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-DE1A8C04CF37BCCD-001/init-core-data-001/index/
[junit4] 2> 192289 T514 oasc.SolrCore.initWriters created xml:
solr.XMLResponseWriter
[junit4] 2> 192292 T514 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 192293 T514 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 192294 T514 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 192294 T514 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"dedupe-allfields"
[junit4] 2> 192295 T514 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 192295 T514 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 192296 T514 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "uniq-fields"
[junit4] 2> 192296 T514 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4] 2> 192297 T514 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 192298 T514 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 192298 T514 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 192299 T514 oasc.SolrCore.loadUpdateProcessorChains no
updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 192300 T514 oasc.RequestHandlers.initHandlersFromConfig
created /config: org.apache.solr.handler.SolrConfigHandler
[junit4] 2> 192300 T514 oasc.RequestHandlers.initHandlersFromConfig
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 192301 T514 oasc.RequestHandlers.initHandlersFromConfig
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 192302 T514 oasc.RequestHandlers.initHandlersFromConfig
created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 192302 T514 oasc.RequestHandlers.initHandlersFromConfig adding
lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 192303 T514 oasc.RequestHandlers.initHandlersFromConfig
created /replication: solr.ReplicationHandler
[junit4] 2> 192304 T514 oasc.RequestHandlers.initHandlersFromConfig
created standard: solr.StandardRequestHandler
[junit4] 2> 192304 T514 oasc.RequestHandlers.initHandlersFromConfig
created /get: solr.RealTimeGetHandler
[junit4] 2> 192305 T514 oasc.RequestHandlers.initHandlersFromConfig
created dismax: solr.SearchHandler
[junit4] 2> 192306 T514 oasc.RequestHandlers.initHandlersFromConfig
created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4] 2> 192307 T514 oasc.RequestHandlers.initHandlersFromConfig
created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 192307 T514 oasc.RequestHandlers.initHandlersFromConfig
created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 192308 T514 oasc.RequestHandlers.initHandlersFromConfig
created /admin/fileedit: solr.admin.EditFileRequestHandler
[junit4] 2> 192309 T514 oasc.RequestHandlers.initHandlersFromConfig
created defaults: solr.StandardRequestHandler
[junit4] 2> 192309 T514 oasc.RequestHandlers.initHandlersFromConfig adding
lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 192310 T514 oasc.RequestHandlers.initHandlersFromConfig
created lazy: solr.StandardRequestHandler
[junit4] 2> 192311 T514 oasc.RequestHandlers.initHandlersFromConfig
created /update: solr.UpdateRequestHandler
[junit4] 2> 192312 T514 oasc.RequestHandlers.initHandlersFromConfig
created /terms: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 192312 T514 oasc.RequestHandlers.initHandlersFromConfig
created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 192313 T514 oasc.RequestHandlers.initHandlersFromConfig
created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 192314 T514 oasc.RequestHandlers.initHandlersFromConfig
created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 192315 T514 oasc.RequestHandlers.initHandlersFromConfig
created spellCheckWithWordbreak_Direct:
org.apache.solr.handler.component.SearchHandler
[junit4] 2> 192316 T514 oasc.RequestHandlers.initHandlersFromConfig
created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 192316 T514 oasc.RequestHandlers.initHandlersFromConfig
created mltrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 192317 T514 oasc.RequestHandlers.initHandlersFromConfig
created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 192318 T514 oasc.RequestHandlers.initHandlersFromConfig
created /mlt: solr.MoreLikeThisHandler
[junit4] 2> 192319 T514 oasc.RequestHandlers.initHandlersFromConfig
created /debug/dump: solr.DumpRequestHandler
[junit4] 2> 192321 T514 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 192322 T514 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 192324 T514 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 192326 T514 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 192328 T514 oasc.SolrCore.initDeprecatedSupport WARN
solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config
to use the ShowFileRequestHandler.
[junit4] 2> 192330 T514 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 192331 T514 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 192332 T514 oass.SolrIndexSearcher.<init> Opening
Searcher@d4bc4400[collection1] main
[junit4] 2> 192332 T514 oasr.RestManager.init Initializing RestManager
with initArgs:
{storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
[junit4] 2> 192333 T514 oasr.ManagedResourceStorage.load Reading
_rest_managed.json using InMemoryStorage
[junit4] 2> 192334 T514 oasr.ManagedResource.reloadFromStorage WARN No
stored data found for /rest/managed
[junit4] 2> 192334 T514 oasr.ManagedResourceStorage$JsonStorage.store
Saved JSON object to path _rest_managed.json using InMemoryStorage
[junit4] 2> 192335 T514 oasr.RestManager.init Initializing 0 registered
ManagedResources
[junit4] 2> 192335 T514 oashc.SpellCheckComponent.inform Initializing
spell checkers
[junit4] 2> 192337 T514 oass.DirectSolrSpellChecker.init init:
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 192349 T518 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@d4bc4400[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 192357 T514 oasu.DefaultSolrCoreState.newIndexWriter Creating
new IndexWriter...
[junit4] 2> 192358 T514 oasu.DefaultSolrCoreState.newIndexWriter Waiting
until IndexWriter is unused... core=collection1
[junit4] 2> 192358 T514 oasu.DefaultSolrCoreState.newIndexWriter Closing
old IndexWriter... core=collection1
[junit4] 2> 192359 T514 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=24, maxMergeAtOnceExplicit=16, maxMergedSegmentMB=52.09375,
floorSegmentMB=1.1005859375, forceMergeDeletesPctAllowed=9.035585229273503,
segmentsPerTier=19.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 192360 T514 oasc.SolrDeletionPolicy.onInit
SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2>
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@88817f13
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@2b0ea15a)),segFN=segments_1,generation=1}
[junit4] 2> 192361 T514 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 192361 T514 oasu.DefaultSolrCoreState.newIndexWriter New
IndexWriter is ready to be used.
[junit4] 2> 192362 T514 oass.SolrIndexSearcher.<init> Opening
Searcher@3109df78[collection1] main
[junit4] 2> 192363 T514 oasc.CoreContainer.registerCore replacing core:
collection1
[junit4] 2> 192363 T514 oasc.SolrCore.close [collection1] CLOSING
SolrCore org.apache.solr.core.SolrCore@5331e525
[junit4] 2> 192364 T514 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> 192364 T518 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@3109df78[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 192364 T514 oasc.SolrCore.closeSearcher [collection1] Closing
main searcher on request.
[junit4] 2> 192912 T514 oasup.LogUpdateProcessor.finish [collection1]
{add=[529 (1484719069957455872)]} 0 529
[junit4] 2> 193911 T519 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 193966 T519 oass.SolrIndexSearcher.<init> Opening
Searcher@c461f2cc[collection1] main
[junit4] 2> 193967 T519 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 194037 T518 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@c461f2cc[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):C1)))}
[junit4] 2> ASYNC NEW_CORE C391 name=collection1
org.apache.solr.core.SolrCore@dff11c4
[junit4] 2> 194814 T514 C391 oasc.SolrCore.execute [collection1]
webapp=null path=null params={start=0&q=id:529&rows=20&qt=standard&version=2.2}
hits=1 status=0 QTime=1902
[junit4] 2> 194868 T514 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">1902</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_">1484719069957455872</long><arr
name="multiDefault"><str>muLti-Default</str></arr><int
name="intDefault">42</int><date
name="timestamp">2014-11-14T04:14:04.097Z</date></doc></result>
[junit4] 2> </response>
[junit4] 2>
[junit4] 2> request
was:start=0&q=id:529&rows=20&qt=standard&version=2.2
[junit4] 2> 194869 T514 oasc.SolrException.log ERROR REQUEST FAILED:
start=0&q=id:529&rows=20&qt=standard&version=2.2: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">1902</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_">1484719069957455872</long><arr
name="multiDefault"><str>muLti-Default</str></arr><int
name="intDefault">42</int><date
name="timestamp">2014-11-14T04:14:04.097Z</date></doc></result>
[junit4] 2> </response>
[junit4] 2>
[junit4] 2> request
was:start=0&q=id:529&rows=20&qt=standard&version=2.2
[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> 194870 T514 oas.SolrTestCaseJ4.tearDown ###Ending testMaxTime
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=AutoCommitTest
-Dtests.method=testMaxTime -Dtests.seed=DE1A8C04CF37BCCD -Dtests.multiplier=3
-Dtests.slow=true -Dtests.locale=nb_NO -Dtests.timezone=PRC
-Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] ERROR 3.16s J1 | AutoCommitTest.testMaxTime <<<
[junit4] > Throwable #1: java.lang.RuntimeException: Exception during
query
[junit4] > at
__randomizedtesting.SeedInfo.seed([DE1A8C04CF37BCCD:44EEF1E651AD20F1]: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">1902</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_">1484719069957455872</long><arr
name="multiDefault"><str>muLti-Default</str></arr><int
name="intDefault">42</int><date
name="timestamp">2014-11-14T04:14:04.097Z</date></doc></result>
[junit4] > </response>
[junit4] > request
was:start=0&q=id:529&rows=20&qt=standard&version=2.2
[junit4] > at
org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:716)
[junit4] > ... 41 more
[junit4] 2> 194886 T514 oas.SolrTestCaseJ4.setUp ###Starting testMaxDocs
[junit4] 2> 194888 T514 C391 oass.SolrIndexSearcher.<init> Opening
Searcher@f7a0ef32[collection1] realtime
[junit4] 2> 194889 T514 C391 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null params={} {deleteByQuery=*:* (-1484719072030490624)} 0 2
[junit4] 2> 194923 T514 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/'
[junit4] 2> 194924 T514 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> 194924 T514 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> 194925 T514 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> 194971 T514 oasc.SolrConfig.<init> Using Lucene MatchVersion:
6.0.0
[junit4] 2> 195051 T514 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 195052 T514 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> 195061 T514 oass.IndexSchema.readSchema [collection1] Schema
name=test
[junit4] 2> 195504 T514 oass.OpenExchangeRatesOrgProvider.init Initialized
with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 195511 T514 oass.IndexSchema.readSchema default search field
in schema is text
[junit4] 2> 195515 T514 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 195524 T514 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 195529 T514 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 195534 T514 oass.OpenExchangeRatesOrgProvider.reload Reloading
exchange rates from open-exchange-rates.json
[junit4] 2> 195535 T514
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 195535 T514
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 195536 T514 oass.OpenExchangeRatesOrgProvider.reload Reloading
exchange rates from open-exchange-rates.json
[junit4] 2> 195537 T514
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 195537 T514
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 195538 T514 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> 195538 T514 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-DE1A8C04CF37BCCD-001/init-core-data-001/
[junit4] 2> 195539 T514 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@42b288df
[junit4] 2> 195540 T514 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-DE1A8C04CF37BCCD-001/init-core-data-001/index/
[junit4] 2> 195541 T514 oasc.SolrCore.initWriters created xml:
solr.XMLResponseWriter
[junit4] 2> 195545 T514 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 195545 T514 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 195546 T514 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 195546 T514 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"dedupe-allfields"
[junit4] 2> 195547 T514 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 195547 T514 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 195548 T514 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "uniq-fields"
[junit4] 2> 195549 T514 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4] 2> 195549 T514 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 195550 T514 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 195550 T514 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 195551 T514 oasc.SolrCore.loadUpdateProcessorChains no
updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 195552 T514 oasc.RequestHandlers.initHandlersFromConfig
created /config: org.apache.solr.handler.SolrConfigHandler
[junit4] 2> 195553 T514 oasc.RequestHandlers.initHandlersFromConfig
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 195553 T514 oasc.RequestHandlers.initHandlersFromConfig
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 195554 T514 oasc.RequestHandlers.initHandlersFromConfig
created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 195555 T514 oasc.RequestHandlers.initHandlersFromConfig adding
lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 195555 T514 oasc.RequestHandlers.initHandlersFromConfig
created /replication: solr.ReplicationHandler
[junit4] 2> 195556 T514 oasc.RequestHandlers.initHandlersFromConfig
created standard: solr.StandardRequestHandler
[junit4] 2> 195557 T514 oasc.RequestHandlers.initHandlersFromConfig
created /get: solr.RealTimeGetHandler
[junit4] 2> 195557 T514 oasc.RequestHandlers.initHandlersFromConfig
created dismax: solr.SearchHandler
[junit4] 2> 195558 T514 oasc.RequestHandlers.initHandlersFromConfig
created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4] 2> 195559 T514 oasc.RequestHandlers.initHandlersFromConfig
created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 195560 T514 oasc.RequestHandlers.initHandlersFromConfig
created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 195560 T514 oasc.RequestHandlers.initHandlersFromConfig
created /admin/fileedit: solr.admin.EditFileRequestHandler
[junit4] 2> 195561 T514 oasc.RequestHandlers.initHandlersFromConfig
created defaults: solr.StandardRequestHandler
[junit4] 2> 195562 T514 oasc.RequestHandlers.initHandlersFromConfig adding
lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 195562 T514 oasc.RequestHandlers.initHandlersFromConfig
created lazy: solr.StandardRequestHandler
[junit4] 2> 195563 T514 oasc.RequestHandlers.initHandlersFromConfig
created /update: solr.UpdateRequestHandler
[junit4] 2> 195564 T514 oasc.RequestHandlers.initHandlersFromConfig
created /terms: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 195565 T514 oasc.RequestHandlers.initHandlersFromConfig
created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 195565 T514 oasc.RequestHandlers.initHandlersFromConfig
created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 195566 T514 oasc.RequestHandlers.initHandlersFromConfig
created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 195567 T514 oasc.RequestHandlers.initHandlersFromConfig
created spellCheckWithWordbreak_Direct:
org.apache.solr.handler.component.SearchHandler
[junit4] 2> 195568 T514 oasc.RequestHandlers.initHandlersFromConfig
created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 195568 T514 oasc.RequestHandlers.initHandlersFromConfig
created mltrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 195569 T514 oasc.RequestHandlers.initHandlersFromConfig
created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 195570 T514 oasc.RequestHandlers.initHandlersFromConfig
created /mlt: solr.MoreLikeThisHandler
[junit4] 2> 195571 T514 oasc.RequestHandlers.initHandlersFromConfig
created /debug/dump: solr.DumpRequestHandler
[junit4] 2> 195573 T514 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 195574 T514 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 195576 T514 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 195578 T514 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 195580 T514 oasc.SolrCore.initDeprecatedSupport WARN
solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config
to use the ShowFileRequestHandler.
[junit4] 2> 195582 T514 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 195582 T514 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 195583 T514 oass.SolrIndexSearcher.<init> Opening
Searcher@496cc277[collection1] main
[junit4] 2> 195584 T514 oasr.RestManager.init Initializing RestManager
with initArgs:
{storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
[junit4] 2> 195585 T514 oasr.ManagedResourceStorage.load Reading
_rest_managed.json using InMemoryStorage
[junit4] 2> 195585 T514 oasr.ManagedResource.reloadFromStorage WARN No
stored data found for /rest/managed
[junit4] 2> 195586 T514 oasr.ManagedResourceStorage$JsonStorage.store
Saved JSON object to path _rest_managed.json using InMemoryStorage
[junit4] 2> 195586 T514 oasr.RestManager.init Initializing 0 registered
ManagedResources
[junit4] 2> 195587 T514 oashc.SpellCheckComponent.inform Initializing
spell checkers
[junit4] 2> 195589 T514 oass.DirectSolrSpellChecker.init init:
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 195600 T520 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@496cc277[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 195608 T514 oasu.DefaultSolrCoreState.newIndexWriter Creating
new IndexWriter...
[junit4] 2> 195608 T514 oasu.DefaultSolrCoreState.newIndexWriter Waiting
until IndexWriter is unused... core=collection1
[junit4] 2> 195609 T514 oasu.DefaultSolrCoreState.newIndexWriter Closing
old IndexWriter... core=collection1
[junit4] 2> 195610 T514 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@88817f13
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@2b0ea15a)),segFN=segments_1,generation=1}
[junit4] 2>
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@88817f13
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@2b0ea15a)),segFN=segments_2,generation=2}
[junit4] 2> 195610 T514 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 2
[junit4] 2> 195611 T514 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.AlcoholicMergePolicy:
[AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=738673923,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.1]
[junit4] 2> 195614 T514 oasc.SolrDeletionPolicy.onInit
SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2>
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@88817f13
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@2b0ea15a)),segFN=segments_2,generation=2}
[junit4] 2> 195614 T514 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 2
[junit4] 2> 195615 T514 oasu.DefaultSolrCoreState.newIndexWriter New
IndexWriter is ready to be used.
[junit4] 2> 195616 T514 oass.SolrIndexSearcher.<init> Opening
Searcher@ce1f8cce[collection1] main
[junit4] 2> 195617 T514 oasc.CoreContainer.registerCore replacing core:
collection1
[junit4] 2> 195617 T514 oasc.SolrCore.close [collection1] CLOSING
SolrCore org.apache.solr.core.SolrCore@dff11c4
[junit4] 2> 195617 T514 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> 195618 T520 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@ce1f8cce[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 195620 T514 oasc.SolrCore.closeSearcher [collection1] Closing
main searcher on request.
[junit4] 2> 195950 T514 oasup.LogUpdateProcessor.finish [collection1]
{add=[0 (1484719073145126912)]} 0 313
[junit4] 2> 195951 T514 oasup.LogUpdateProcessor.finish [collection1]
{add=[1 (1484719073146175488)]} 0 313
[junit4] 2> 195952 T514 oasup.LogUpdateProcessor.finish [collection1]
{add=[2 (1484719073147224064)]} 0 313
[junit4] 2> 195953 T514 oasup.LogUpdateProcessor.finish [collection1]
{add=[3 (1484719073148272640)]} 0 313
[junit4] 2> 195954 T514 oasup.LogUpdateProcessor.finish [collection1]
{add=[4 (1484719073149321216)]} 0 313
[junit4] 2> 195955 T514 oasup.LogUpdateProcessor.finish [collection1]
{add=[5 (1484719073150369792)]} 0 313
[junit4] 2> 195956 T514 oasup.LogUpdateProcessor.finish [collection1]
{add=[6 (1484719073151418368)]} 0 313
[junit4] 2> 195957 T514 oasup.LogUpdateProcessor.finish [collection1]
{add=[7 (1484719073151418369)]} 0 313
[junit4] 2> 195958 T514 oasup.LogUpdateProcessor.finish [collection1]
{add=[8 (1484719073152466944)]} 0 313
[junit4] 2> 195958 T514 oasup.LogUpdateProcessor.finish [collection1]
{add=[9 (1484719073153515520)]} 0 313
[junit4] 2> 195959 T514 oasup.LogUpdateProcessor.finish [collection1]
{add=[10 (1484719073154564096)]} 0 313
[junit4] 2> 195960 T514 oasup.LogUpdateProcessor.finish [collection1]
{add=[11 (1484719073155612672)]} 0 313
[junit4] 2> 195961 T514 oasup.LogUpdateProcessor.finish [collection1]
{add=[12 (1484719073156661248)]} 0 313
[junit4] 2> 195962 T514 oasup.LogUpdateProcessor.finish [collection1]
{add=[13 (1484719073157709824)]} 0 313
[junit4] 2> ASYNC NEW_CORE C392 name=collection1
org.apache.solr.core.SolrCore@7b6822a3
[junit4] 2> 196564 T514 C392 oasc.SolrCore.execute [collection1]
webapp=null path=null params={start=0&q=id:1&rows=20&qt=standard&version=2.2}
hits=0 status=0 QTime=601
[junit4] 2> 196585 T514 oasup.LogUpdateProcessor.finish [collection1]
{add=[14 (1484719073809924096)]} 0 313
[junit4] 2> 196586 T521 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 196592 T521 oass.SolrIndexSearcher.<init> Opening
Searcher@a3f5a90b[collection1] main
[junit4] 2> 196598 T520 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@a3f5a90b[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(6.0.0):C15)))}
[junit4] 2> 196598 T521 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 196837 T514 oasup.LogUpdateProcessor.finish [collection1]
{add=[15 (1484719074074165248)]} 0 313
[junit4] 2> 196838 T514 C392 oasc.SolrCore.execute [collection1]
webapp=null path=null params={start=0&q=id:14&rows=20&qt=standard&version=2.2}
hits=1 status=0 QTime=1
[junit4] 2> 196840 T514 C392 oasc.SolrCore.execute [collection1]
webapp=null path=null params={start=0&q=id:15&rows=20&qt=standard&version=2.2}
hits=0 status=0 QTime=0
[junit4] 2> 196841 T514 oas.SolrTestCaseJ4.tearDown ###Ending testMaxDocs
[junit4] 2> 196847 T514 oas.SolrTestCaseJ4.setUp ###Starting
testCommitWithin
[junit4] 2> 196856 T514 C392 oass.SolrIndexSearcher.<init> Opening
Searcher@f5ed23d[collection1] realtime
[junit4] 2> 196857 T514 C392 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null params={} {deleteByQuery=*:* (-1484719074086748160)} 0 9
[junit4] 2> 196859 T514 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/'
[junit4] 2> 196860 T514 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> 196861 T514 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> 196861 T514 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> 196919 T514 oasc.SolrConfig.<init> Using Lucene MatchVersion:
6.0.0
[junit4] 2> 197008 T514 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 197009 T514 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> 197018 T514 oass.IndexSchema.readSchema [collection1] Schema
name=test
[junit4] 2> 197470 T514 oass.OpenExchangeRatesOrgProvider.init Initialized
with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 197481 T514 oass.IndexSchema.readSchema default search field
in schema is text
[junit4] 2> 197485 T514 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 197495 T514 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 197501 T514 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 197506 T514 oass.OpenExchangeRatesOrgProvider.reload Reloading
exchange rates from open-exchange-rates.json
[junit4] 2> 197507 T514
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 197508 T514
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 197508 T514 oass.OpenExchangeRatesOrgProvider.reload Reloading
exchange rates from open-exchange-rates.json
[junit4] 2> 197509 T514
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 197510 T514
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 197511 T514 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> 197511 T514 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-DE1A8C04CF37BCCD-001/init-core-data-001/
[junit4] 2> 197512 T514 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@42b288df
[junit4] 2> 197513 T514 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-DE1A8C04CF37BCCD-001/init-core-data-001/index/
[junit4] 2> 197514 T514 oasc.SolrCore.initWriters created xml:
solr.XMLResponseWriter
[junit4] 2> 197519 T514 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 197519 T514 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 197520 T514 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 197521 T514 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"dedupe-allfields"
[junit4] 2> 197521 T514 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 197522 T514 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 197522 T514 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "uniq-fields"
[junit4] 2> 197523 T514 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4] 2> 197524 T514 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 197525 T514 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 197525 T514 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 197526 T514 oasc.SolrCore.loadUpdateProcessorChains no
updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 197527 T514 oasc.RequestHandlers.initHandlersFromConfig
created /config: org.apache.solr.handler.SolrConfigHandler
[junit4] 2> 197528 T514 oasc.RequestHandlers.initHandlersFromConfig
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 197529 T514 oasc.RequestHandlers.initHandlersFromConfig
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 197530 T514 oasc.RequestHandlers.initHandlersFromConfig
created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 197530 T514 oasc.RequestHandlers.initHandlersFromConfig adding
lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 197531 T514 oasc.RequestHandlers.initHandlersFromConfig
created /replication: solr.ReplicationHandler
[junit4] 2> 197532 T514 oasc.RequestHandlers.initHandlersFromConfig
created standard: solr.StandardRequestHandler
[junit4] 2> 197533 T514 oasc.RequestHandlers.initHandlersFromConfig
created /get: solr.RealTimeGetHandler
[junit4] 2> 197534 T514 oasc.RequestHandlers.initHandlersFromConfig
created dismax: solr.SearchHandler
[junit4] 2> 197535 T514 oasc.RequestHandlers.initHandlersFromConfig
created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4] 2> 197536 T514 oasc.RequestHandlers.initHandlersFromConfig
created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 197537 T514 oasc.RequestHandlers.initHandlersFromConfig
created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 197538 T514 oasc.RequestHandlers.initHandlersFromConfig
created /admin/fileedit: solr.admin.EditFileRequestHandler
[junit4] 2> 197538 T514 oasc.RequestHandlers.initHandlersFromConfig
created defaults: solr.StandardRequestHandler
[junit4] 2> 197539 T514 oasc.RequestHandlers.initHandlersFromConfig adding
lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 197540 T514 oasc.RequestHandlers.initHandlersFromConfig
created lazy: solr.StandardRequestHandler
[junit4] 2> 197541 T514 oasc.RequestHandlers.initHandlersFromConfig
created /update: solr.UpdateRequestHandler
[junit4] 2> 197542 T514 oasc.RequestHandlers.initHandlersFromConfig
created /terms: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 197542 T514 oasc.RequestHandlers.initHandlersFromConfig
created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 197543 T514 oasc.RequestHandlers.initHandlersFromConfig
created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 197544 T514 oasc.RequestHandlers.initHandlersFromConfig
created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 197545 T514 oasc.RequestHandlers.initHandlersFromConfig
created spellCheckWithWordbreak_Direct:
org.apache.solr.handler.component.SearchHandler
[junit4] 2> 197546 T514 oasc.RequestHandlers.initHandlersFromConfig
created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 197547 T514 oasc.RequestHandlers.initHandlersFromConfig
created mltrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 197548 T514 oasc.RequestHandlers.initHandlersFromConfig
created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 197549 T514 oasc.RequestHandlers.initHandlersFromConfig
created /mlt: solr.MoreLikeThisHandler
[junit4] 2> 197550 T514 oasc.RequestHandlers.initHandlersFromConfig
created /debug/dump: solr.DumpRequestHandler
[junit4] 2> 197552 T514 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 197554 T514 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 197556 T514 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 197558 T514 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 197560 T514 oasc.SolrCore.initDeprecatedSupport WARN
solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config
to use the ShowFileRequestHandler.
[junit4] 2> 197563 T514 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 197563 T514 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 197565 T514 oass.SolrIndexSearcher.<init> Opening
Searcher@f9c4feb6[collection1] main
[junit4] 2> 197565 T514 oasr.RestManager.init Initializing RestManager
with initArgs:
{storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
[junit4] 2> 197566 T514 oasr.ManagedResourceStorage.load Reading
_rest_managed.json using InMemoryStorage
[junit4] 2> 197567 T514 oasr.ManagedResource.reloadFromStorage WARN No
stored data found for /rest/managed
[junit4] 2> 197567 T514 oasr.ManagedResourceStorage$JsonStorage.store
Saved JSON object to path _rest_managed.json using InMemoryStorage
[junit4] 2> 197568 T514 oasr.RestManager.init Initializing 0 registered
ManagedResources
[junit4] 2> 197569 T514 oashc.SpellCheckComponent.inform Initializing
spell checkers
[junit4] 2> 197571 T514 oass.DirectSolrSpellChecker.init init:
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 197584 T522 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@f9c4feb6[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 197593 T514 oasu.DefaultSolrCoreState.newIndexWriter Creating
new IndexWriter...
[junit4] 2> 197594 T514 oasu.DefaultSolrCoreState.newIndexWriter Waiting
until IndexWriter is unused... core=collection1
[junit4] 2> 197594 T514 oasu.DefaultSolrCoreState.newIndexWriter Closing
old IndexWriter... core=collection1
[junit4] 2> 197595 T514 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@88817f13
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@2b0ea15a)),segFN=segments_2,generation=2}
[junit4] 2>
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@88817f13
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@2b0ea15a)),segFN=segments_3,generation=3}
[junit4] 2> 197596 T514 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 3
[junit4] 2> 197597 T514 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.MockRandomMergePolicy:
org.apache.lucene.index.MockRandomMergePolicy@92dd297d
[junit4] 2> 197599 T514 oasc.SolrDeletionPolicy.onInit
SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2>
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@88817f13
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@2b0ea15a)),segFN=segments_3,generation=3}
[junit4] 2> 197599 T514 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 3
[junit4] 2> 197601 T514 oasu.DefaultSolrCoreState.newIndexWriter New
IndexWriter is ready to be used.
[junit4] 2> 197601 T514 oass.SolrIndexSearcher.<init> Opening
Searcher@488df0c7[collection1] main
[junit4] 2> 197602 T514 oasc.CoreContainer.registerCore replacing core:
collection1
[junit4] 2> 197603 T514 oasc.SolrCore.close [collection1] CLOSING
SolrCore org.apache.solr.core.SolrCore@7b6822a3
[junit4] 2> 197603 T522 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@488df0c7[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 197603 T514 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> 197604 T514 oasc.SolrCore.closeSearcher [collection1] Closing
main searcher on request.
[junit4] 2> 198152 T514 oasup.LogUpdateProcessor.finish [collection1]
{add=[529 (1484719075453042688)]} 0 527
[junit4] 2> ASYNC NEW_CORE C393 name=collection1
org.apache.solr.core.SolrCore@56865afb
[junit4] 2> 198153 T514 C393 oasc.SolrCore.execute [collection1]
webapp=null path=null params={start=0&q=id:529&rows=20&qt=standard&version=2.2}
hits=0 status=0 QTime=0
[junit4] 2> 202152 T523 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 202156 T523 oass.SolrIndexSearcher.<init> Opening
Searcher@f93cd5b9[collection1] main
[junit4] 2> 202156 T523 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 202157 T522 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@f93cd5b9[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_3(6.0.0):C1)))}
[junit4] 2> 202169 T514 oasup.LogUpdateProcessor.finish [collection1]
{add=[530 (1484719079665172480)]} 0 527
[junit4] 2> 202170 T514 C393 oasc.SolrCore.execute [collection1]
webapp=null path=null params={start=0&q=id:530&rows=20&qt=standard&version=2.2}
hits=0 status=0 QTime=0
[junit4] 2> 202172 T514 oasup.LogUpdateProcessor.finish [collection1]
{delete=[529 (-1484719079669366784)]} 0 527
[junit4] 2> 202172 T514 C393 oasc.SolrCore.execute [collection1]
webapp=null path=null params={start=0&q=id:529&rows=20&qt=standard&version=2.2}
hits=1 status=0 QTime=0
[junit4] 2> 203172 T523 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 203178 T523 oass.SolrIndexSearcher.<init> Opening
Searcher@4ead9dc9[collection1] main
[junit4] 2> 203178 T523 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 203180 T522 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@4ead9dc9[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(6.0.0):C1)))}
[junit4] 2> 203425 T514 C393 oasc.SolrCore.execute [collection1]
webapp=null path=null params={start=0&q=id:529&rows=20&qt=standard&version=2.2}
hits=0 status=0 QTime=0
[junit4] 2> 203426 T514 C393 oasc.SolrCore.execute [collection1]
webapp=null path=null params={start=0&q=id:530&rows=20&qt=standard&version=2.2}
hits=1 status=0 QTime=0
[junit4] 2> 203428 T514 oasup.LogUpdateProcessor.finish [collection1]
{add=[500 (1484719080986378240)]} 0 527
[junit4] 2> 203429 T514 oasup.LogUpdateProcessor.finish [collection1]
{add=[500 (1484719080987426816)]} 0 527
[junit4] 2> 203429 T514 oasup.LogUpdateProcessor.finish [collection1]
{add=[500 (1484719080987426817)]} 0 527
[junit4] 2> 203430 T514 oasup.LogUpdateProcessor.finish [collection1]
{add=[500 (1484719080988475392)]} 0 527
[junit4] 2> 203430 T514 oasup.LogUpdateProcessor.finish [collection1]
{add=[500 (1484719080988475393)]} 0 527
[junit4] 2> 203431 T514 oasup.LogUpdateProcessor.finish [collection1]
{add=[500 (1484719080989523968)]} 0 527
[junit4] 2> 203431 T514 oasup.LogUpdateProcessor.finish [collection1]
{add=[500 (1484719080989523969)]} 0 527
[junit4] 2> 203432 T514 oasup.LogUpdateProcessor.finish [collection1]
{add=[500 (1484719080990572544)]} 0 527
[junit4] 2> 203432 T514 oasup.LogUpdateProcessor.finish [collection1]
{add=[500 (1484719080990572545)]} 0 527
[junit4] 2> 203433 T514 oasup.LogUpdateProcessor.finish [collection1]
{add=[500 (1484719080991621120)]} 0 527
[junit4] 2> 203433 T514 C393 oasc.SolrCore.execute [collection1]
webapp=null path=null params={start=0&q=id:500&rows=20&qt=standard&version=2.2}
hits=0 status=0 QTime=0
[junit4] 2> 203434 T514 oasup.LogUpdateProcessor.finish [collection1]
{delete=[530 (-1484719080992669696)]} 0 527
[junit4] 2> 203435 T514 oasup.LogUpdateProcessor.finish [collection1]
{delete=[530 (-1484719080993718272)]} 0 527
[junit4] 2> 203435 T514 oasup.LogUpdateProcessor.finish [collection1]
{delete=[530 (-1484719080993718273)]} 0 527
[junit4] 2> 203436 T514 oasup.LogUpdateProcessor.finish [collection1]
{delete=[530 (-1484719080994766848)]} 0 527
[junit4] 2> 203436 T514 oasup.LogUpdateProcessor.finish [collection1]
{delete=[530 (-1484719080994766849)]} 0 527
[junit4] 2> 203437 T514 oasup.LogUpdateProcessor.finish [collection1]
{delete=[530 (-1484719080995815424)]} 0 527
[junit4] 2> 203437 T514 oasup.LogUpdateProcessor.finish [collection1]
{delete=[530 (-1484719080995815425)]} 0 527
[junit4] 2> 203438 T514 oasup.LogUpdateProcessor.finish [collection1]
{delete=[530 (-1484719080996864000)]} 0 527
[junit4] 2> 203438 T514 oasup.LogUpdateProcessor.finish [collection1]
{delete=[530 (-1484719080996864001)]} 0 527
[junit4] 2> 203439 T514 oasup.LogUpdateProcessor.finish [collection1]
{delete=[530 (-1484719080997912576)]} 0 527
[junit4] 2> 203439 T514 C393 oasc.SolrCore.execute [collection1]
webapp=null path=null params={start=0&q=id:530&rows=20&qt=standard&version=2.2}
hits=1 status=0 QTime=0
[junit4] 2> 204435 T523 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 204438 T523 oass.SolrIndexSearcher.<init> Opening
Searcher@55570908[collection1] main
[junit4] 2> 204438 T523 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 204441 T522 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@55570908[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_5(6.0.0):C10/9:delGen=1)))}
[junit4] 2> 204442 T514 C393 oasc.SolrCore.execute [collection1]
webapp=null path=null params={start=0&q=id:500&rows=20&qt=standard&version=2.2}
hits=1 status=0 QTime=0
[junit4] 2> 204445 T514 C393 oasc.SolrCore.execute [collection1]
webapp=null path=null params={start=0&q=id:530&rows=20&qt=standard&version=2.2}
hits=0 status=0 QTime=0
[junit4] 2> 204447 T514 oas.SolrTestCaseJ4.tearDown ###Ending
testCommitWithin
[junit4] 2> 204449 T514 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> 204449 T514 oasc.CoreContainer.shutdown Shutting down
CoreContainer instance=1510273709
[junit4] 2> 204450 T514 oasc.SolrCore.close [collection1] CLOSING
SolrCore org.apache.solr.core.SolrCore@56865afb
[junit4] 2> 204450 T514 oasu.DirectUpdateHandler2.close closing
DirectUpdateHandler2{commits=3,autocommits=0,soft
autocommits=3,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=12,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=12,cumulative_deletesById=11,cumulative_deletesByQuery=0,cumulative_errors=0,transaction_logs_total_size=0,transaction_logs_total_number=0}
[junit4] 2> 204450 T514 oasu.SolrCoreState.decrefSolrCoreState Closing
SolrCoreState
[junit4] 2> 204450 T514 oasu.DefaultSolrCoreState.closeIndexWriter
SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 204451 T514 oasu.DefaultSolrCoreState.closeIndexWriter closing
IndexWriter with IndexWriterCloser
[junit4] 2> 204451 T514 C393 oasu.DirectUpdateHandler2.closeWriter
Committing on IndexWriter close.
[junit4] 2> 204452 T514 C393 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@88817f13
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@2b0ea15a)),segFN=segments_3,generation=3}
[junit4] 2>
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@88817f13
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@2b0ea15a)),segFN=segments_4,generation=4}
[junit4] 2> 204452 T514 C393 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 4
[junit4] 2> 204453 T514 oasc.SolrCore.closeSearcher [collection1] Closing
main searcher on request.
[junit4] 2> 204454 T514 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.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.ru
[...truncated too long message...]
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> 204469 T514 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> 204471 T514 oasc.CachingDirectoryFactory.close Closing
MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 204471 T514 oasc.CachingDirectoryFactory.closeCacheValue
looking to close
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest-DE1A8C04CF37BCCD-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-DE1A8C04CF37BCCD-001/init-core-data-001;done=false>>]
[junit4] 2> 204471 T514 oasc.CachingDirectoryFactory.close Closing
directory:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest-DE1A8C04CF37BCCD-001/init-core-data-001
[junit4] 2> 204471 T514 oasc.CachingDirectoryFactory.closeCacheValue
looking to close
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest-DE1A8C04CF37BCCD-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-DE1A8C04CF37BCCD-001/init-core-data-001/index;done=false>>]
[junit4] 2> 204472 T514 oasc.CachingDirectoryFactory.close Closing
directory:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest-DE1A8C04CF37BCCD-001/init-core-data-001/index
[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-DE1A8C04CF37BCCD-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene50):
{intDefault=PostingsFormat(name=LuceneFixedGap),
_version_=PostingsFormat(name=LuceneFixedGap), timestamp=FSTOrd50,
range_facet_l=FSTOrd50, multiDefault=FSTOrd50,
field_t=PostingsFormat(name=Direct), id=PostingsFormat(name=Direct),
subject=FSTOrd50, text=PostingsFormat(name=MockRandom)},
docValues:{timestamp=DocValuesFormat(name=Memory)}, sim=DefaultSimilarity,
locale=nb_NO, timezone=PRC
[junit4] 2> NOTE: Linux 3.13.0-39-generic amd64/IBM Corporation 1.7.0
(64-bit)/cpus=8,threads=1,free=12883760,total=86179840
[junit4] 2> NOTE: All tests run in this JVM:
[DistributedQueryElevationComponentTest, QueryParsingTest,
TestSweetSpotSimilarityFactory, IndexSchemaRuntimeFieldTest,
MigrateRouteKeyTest, TestManagedSchema, StatsComponentTest,
TestSolrConfigHandlerConcurrent, SynonymTokenizerTest, TestSolrXml,
DocValuesMissingTest, UUIDFieldTest, PolyFieldTest, DistanceFunctionTest,
TestDistributedGrouping, BJQParserTest, TestValueSourceCache, DeleteShardTest,
ExternalCollectionsTest, TestInitParams,
AddSchemaFieldsUpdateProcessorFactoryTest, SuggesterFSTTest,
TestPHPSerializedResponseWriter, ScriptEngineTest,
SharedFSAutoReplicaFailoverUtilsTest, TestSerializedLuceneMatchVersion,
OutputWriterTest, TestExtendedDismaxParser, TestDistribDocBasedVersion,
LegacyHTMLStripCharFilterTest, DistributedQueueTest,
TermVectorComponentDistributedTest, AnalysisAfterCoreReloadTest, TestUpdate,
MergeStrategyTest, TestDistributedMissingSort, TestElisionMultitermQuery,
ZkSolrClientTest, SOLR749Test, DebugComponentTest,
SchemaVersionSpecificBehaviorTest, SortByFunctionTest, TestCharFilters,
LeaderInitiatedRecoveryOnCommitTest, LoggingHandlerTest, TestJoin,
TermVectorComponentTest, TestPostingsSolrHighlighter, CircularListTest,
AutoCommitTest]
[junit4] Completed on J1 in 14.09s, 3 tests, 1 error <<< FAILURES!
[...truncated 1113 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:186: The
following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/common-build.xml:508:
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]
