Build: http://jenkins.thetaphi.de/job/Lucene-Solr-5.x-Windows/4729/
Java: 64bit/jdk1.7.0_80 -XX:+UseCompressedOops -XX:+UseG1GC
1 tests failed.
FAILED: org.apache.solr.update.HardAutoCommitTest.testCommitWithin
Error Message:
Exception during query
Stack Trace:
java.lang.RuntimeException: Exception during query
at
__randomizedtesting.SeedInfo.seed([FC41AA66F118B9C1:4693C51E723657D4]:0)
at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:795)
at
org.apache.solr.update.HardAutoCommitTest.testCommitWithin(HardAutoCommitTest.java:100)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1627)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:836)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:872)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:886)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:845)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:747)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:781)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:792)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at java.lang.Thread.run(Thread.java:745)
Caused by: java.lang.RuntimeException: REQUEST FAILED:
xpath=//result[@numFound=1]
xml response was: <?xml version="1.0" encoding="UTF-8"?>
<response>
<lst name="responseHeader"><int name="status">0</int><int
name="QTime">1</int></lst><result name="response" numFound="0"
start="0"></result>
</response>
request was:q=id:529&version=2.2&qt=standard&start=0&rows=20
at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:788)
... 40 more
Build Log:
[...truncated 9853 lines...]
[junit4] Suite: org.apache.solr.update.HardAutoCommitTest
[junit4] 2> Creating dataDir:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.update.HardAutoCommitTest
FC41AA66F118B9C1-001\init-core-data-001
[junit4] 2> 440073 T2149 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl
(false) and clientAuth (false)
[junit4] 2> 440073 T2149 oas.SolrTestCaseJ4.initCore ####initCore
[junit4] 2> 440073 T2149 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\'
[junit4] 2> 440075 T2149 oasc.SolrResourceLoader.replaceClassLoader Adding
'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-5.x-Windows/solr/core/src/test-files/solr/collection1/lib/classes/'
to classloader
[junit4] 2> 440076 T2149 oasc.SolrResourceLoader.replaceClassLoader Adding
'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-5.x-Windows/solr/core/src/test-files/solr/collection1/lib/README'
to classloader
[junit4] 2> 440144 T2149 oasc.SolrConfig.refreshRequestParams current
version of requestparams : -1
[junit4] 2> 440163 T2149 oasc.SolrConfig.<init> Using Lucene MatchVersion:
5.3.0
[junit4] 2> 440199 T2149 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 440199 T2149 oass.IndexSchema.readSchema Reading Solr Schema
from
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\schema.xml
[junit4] 2> 440206 T2149 oass.IndexSchema.readSchema [null] Schema
name=test
[junit4] 2> 440471 T2149 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 440480 T2149 oass.IndexSchema.readSchema default search field
in schema is text
[junit4] 2> 440481 T2149 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 440487 T2149 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 440489 T2149 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 440491 T2149 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 440491 T2149
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 440492 T2149
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 440492 T2149 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 440493 T2149
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 440493 T2149
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 440493 T2149 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 440494 T2149 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr
[junit4] 2> 440494 T2149 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\'
[junit4] 2> 440508 T2149 oasc.CoreContainer.<init> New CoreContainer
1842458019
[junit4] 2> 440508 T2149 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\]
[junit4] 2> 440509 T2149 oasc.CoreContainer.load loading shared library:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\lib
[junit4] 2> 440509 T2149 oasc.SolrResourceLoader.addToClassLoader WARN
Can't find (or read) directory to add to classloader: lib (resolved as:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\lib).
[junit4] 2> 440519 T2149 oashc.HttpShardHandlerFactory.init created with
socketTimeout : 600000,connTimeout : 60000,maxConnectionsPerHost :
20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize :
2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy :
false,useRetries : false,
[junit4] 2> 440522 T2149 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=30000&connTimeout=30000&retry=true
[junit4] 2> 440523 T2149 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 440523 T2149 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 440524 T2149 oasc.CoreContainer.load Node Name: testNode
[junit4] 2> 440524 T2149 oasc.CoreContainer.initializeAuthenticationPlugin
No authentication plugin used.
[junit4] 2> 440526 T2149 oasc.CoreDescriptor.<init> CORE DESCRIPTOR:
{config=solrconfig.xml, schema=schema.xml, instanceDir=collection1,
absoluteInstDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\,
loadOnStartup=true, shard=shard1, collection=collection1, transient=false,
name=collection1,
dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.update.HardAutoCommitTest
FC41AA66F118B9C1-001\init-core-data-001}
[junit4] 2> 440526 T2150 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\'
[junit4] 2> 440528 T2150 oasc.SolrResourceLoader.replaceClassLoader Adding
'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-5.x-Windows/solr/core/src/test-files/solr/collection1/lib/classes/'
to classloader
[junit4] 2> 440528 T2150 oasc.SolrResourceLoader.replaceClassLoader Adding
'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-5.x-Windows/solr/core/src/test-files/solr/collection1/lib/README'
to classloader
[junit4] 2> 440549 T2150 oasc.SolrConfig.refreshRequestParams current
version of requestparams : -1
[junit4] 2> 440565 T2150 oasc.SolrConfig.<init> Using Lucene MatchVersion:
5.3.0
[junit4] 2> 440600 T2150 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 440600 T2150 oass.IndexSchema.readSchema Reading Solr Schema
from
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\schema.xml
[junit4] 2> 440607 T2150 oass.IndexSchema.readSchema [collection1] Schema
name=test
[junit4] 2> 440889 T2150 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 440898 T2150 oass.IndexSchema.readSchema default search field
in schema is text
[junit4] 2> 440900 T2150 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 440909 T2150 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 440912 T2150 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 440917 T2150 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 440918 T2150
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 440919 T2150
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 440919 T2150 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 440919 T2150
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 440919 T2150
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 440919 T2150 oasc.CoreContainer.create Creating SolrCore
'collection1' using configuration from instancedir
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\
[junit4] 2> 440919 T2150 x:collection1 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 440920 T2150 x:collection1 oasc.SolrCore.<init> [[collection1]
] Opening new SolrCore at
[C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\],
dataDir=[null]
[junit4] 2> 440920 T2150 x:collection1 oasc.JmxMonitoredMap.<init> JMX
monitoring is enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@6b839a22
[junit4] 2> 440921 T2150 x:collection1 oasc.CachingDirectoryFactory.get
return new directory for
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.update.HardAutoCommitTest
FC41AA66F118B9C1-001\init-core-data-001\
[junit4] 2> 440921 T2150 x:collection1 oasc.SolrCore.getNewIndexDir New
index directory detected: old=null
new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.update.HardAutoCommitTest
FC41AA66F118B9C1-001\init-core-data-001\index/
[junit4] 2> 440922 T2150 x:collection1 oasc.SolrCore.initIndex WARN
[collection1] Solr index directory
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.update.HardAutoCommitTest
FC41AA66F118B9C1-001\init-core-data-001\index' doesn't exist. Creating new
index...
[junit4] 2> 440922 T2150 x:collection1 oasc.CachingDirectoryFactory.get
return new directory for
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.update.HardAutoCommitTest
FC41AA66F118B9C1-001\init-core-data-001\index
[junit4] 2> 440923 T2150 x:collection1 oasu.RandomMergePolicy.<init>
RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy:
[TieredMergePolicy: maxMergeAtOnce=32, maxMergeAtOnceExplicit=36,
maxMergedSegmentMB=32.1904296875, floorSegmentMB=1.330078125,
forceMergeDeletesPctAllowed=11.224153620713647, segmentsPerTier=16.0,
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 440923 T2150 x:collection1 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@43f617fd
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@51a105e6),segFN=segments_1,generation=1}
[junit4] 2> 440923 T2150 x:collection1
oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 440930 T2150 x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"dedupe"
[junit4] 2> 440930 T2150 x:collection1
oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 440930 T2150 x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"dedupe-allfields"
[junit4] 2> 440931 T2150 x:collection1
oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"dedupe-allfields"
[junit4] 2> 440931 T2150 x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"stored_sig"
[junit4] 2> 440931 T2150 x:collection1
oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 440932 T2150 x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"uniq-fields"
[junit4] 2> 440932 T2150 x:collection1
oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4] 2> 440932 T2150 x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"distrib-dup-test-chain-explicit"
[junit4] 2> 440933 T2150 x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 440933 T2150 x:collection1
oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 440933 T2150 x:collection1
oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined
as default, creating implicit default
[junit4] 2> 440940 T2150 x:collection1 oashl.XMLLoader.init
xsltCacheLifetimeSeconds=60
[junit4] 2> 440943 T2150 x:collection1 oashl.XMLLoader.init
xsltCacheLifetimeSeconds=60
[junit4] 2> 440944 T2150 x:collection1 oashl.XMLLoader.init
xsltCacheLifetimeSeconds=60
[junit4] 2> 440947 T2150 x:collection1 oashl.XMLLoader.init
xsltCacheLifetimeSeconds=60
[junit4] 2> 440951 T2150 x:collection1 oasc.PluginBag.createPlugin
requestHandler : 'lazy' created with startup=lazy
[junit4] 2> 440954 T2150 x:collection1
oasc.RequestHandlers.initHandlersFromConfig Registered paths:
/mlt,/replication,defaults,/admin/ping,/admin/threads,/config,dismax,/admin/file,/search-facet-invariants,/admin/segments,spellCheckWithWordbreak,spellCheckCompRH_Direct,/update/json,/get,/admin/plugins,spellCheckCompRH,mltrh,/update/json/docs,spellCheckCompRH1,/admin/luke,mock,/debug/dump,/terms,/schema,/search-facet-def,spellCheckWithWordbreak_Direct,/admin/mbeans,/admin/logging,/update/csv,standard,tvrh,/admin/system,/update,/admin/properties,lazy
[junit4] 2> 440955 T2150 x:collection1 oasc.SolrCore.initDeprecatedSupport
WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your
config to use the ShowFileRequestHandler.
[junit4] 2> 440956 T2150 x:collection1 oasc.SolrCore.initStatsCache Using
default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 440957 T2150 x:collection1 oasu.UpdateHandler.<init> Using
UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 440957 T2150 x:collection1 oasu.UpdateLog.init Initializing
UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 440958 T2150 x:collection1 oasu.CommitTracker.<init> Hard
AutoCommit: disabled
[junit4] 2> 440958 T2150 x:collection1 oasu.CommitTracker.<init> Soft
AutoCommit: disabled
[junit4] 2> 440958 T2150 x:collection1 oasu.RandomMergePolicy.<init>
RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=15, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.788816591092725]
[junit4] 2> 440959 T2150 x:collection1 oasc.SolrDeletionPolicy.onInit
SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@43f617fd
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@51a105e6),segFN=segments_1,generation=1}
[junit4] 2> 440959 T2150 x:collection1
oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 440959 T2150 x:collection1 oass.SolrIndexSearcher.<init>
Opening Searcher@3477f175[collection1] main
[junit4] 2> 440959 T2150 x:collection1 oasr.RestManager.init Initializing
RestManager with initArgs:
{storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
[junit4] 2> 440960 T2150 x:collection1 oasr.ManagedResourceStorage.load
Reading _rest_managed.json using InMemoryStorage
[junit4] 2> 440960 T2150 x:collection1 oasr.RestManager.init Initializing
0 registered ManagedResources
[junit4] 2> 440960 T2150 x:collection1 oashc.SpellCheckComponent.inform
Initializing spell checkers
[junit4] 2> 440968 T2150 x:collection1 oass.DirectSolrSpellChecker.init
init:
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 440995 T2150 x:collection1 oash.ReplicationHandler.inform
Commits will be reserved for 10000
[junit4] 2> 440995 T2151 x:collection1
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index
for spellchecker: default
[junit4] 2> 440996 T2150 x:collection1 oasu.UpdateLog.onFirstSearcher On
first searcher opened, looking up max value of version field
[junit4] 2> 440996 T2151 x:collection1
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index
for spellchecker: direct
[junit4] 2> 440996 T2150 x:collection1
oasu.VersionInfo.getMaxVersionFromIndex Refreshing highest value of _version_
for 65536 version buckets from index
[junit4] 2> 440996 T2150 x:collection1
oasu.VersionInfo.getMaxVersionFromIndex No terms found for _version_, cannot
seed version bucket highest value from index
[junit4] 2> 440997 T2150 x:collection1
oasu.UpdateLog.seedBucketsWithHighestVersion Could not find max version in
index or recent updates, using new clock 1502171106156478464
[junit4] 2> 440996 T2151 x:collection1
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index
for spellchecker: wordbreak
[junit4] 2> 440997 T2151 x:collection1
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index
for spellchecker: multipleFields
[junit4] 2> 440997 T2151 x:collection1
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index
for spellchecker: jarowinkler
[junit4] 2> 440997 T2151 x:collection1
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index
for spellchecker: external
[junit4] 2> 440997 T2150 x:collection1
oasu.UpdateLog.seedBucketsWithHighestVersion Took 1 ms to seed version buckets
with highest version 1502171106156478464
[junit4] 2> 440997 T2150 x:collection1 oasc.CoreContainer.registerCore
registering core: collection1
[junit4] 2> 440997 T2151 x:collection1
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index
for spellchecker: freq
[junit4] 2> 440998 T2151 x:collection1
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index
for spellchecker: fqcn
[junit4] 2> 440999 T2151 x:collection1
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index
for spellchecker: perDict
[junit4] 2> 441000 T2149 oas.SolrTestCaseJ4.initCore ####initCore end
[junit4] 2> 441000 T2151 x:collection1 oasc.SolrCore.registerSearcher
[collection1] Registered new searcher Searcher@3477f175[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 441002 T2149 oas.SolrTestCaseJ4.setUp ###Starting
testCommitWithin
[junit4] 2> ASYNC NEW_CORE C279 name=collection1
org.apache.solr.core.SolrCore@4d5539af
[junit4] 2> 441004 T2149 C279 oasup.LogUpdateProcessor.finish
[collection1] webapp=null path=null params={} {deleteByQuery=*:*
(-1502171106163818496)} 0 1
[junit4] 2> 441006 T2149 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\'
[junit4] 2> 441007 T2149 oasc.SolrResourceLoader.replaceClassLoader Adding
'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-5.x-Windows/solr/core/src/test-files/solr/collection1/lib/classes/'
to classloader
[junit4] 2> 441007 T2149 oasc.SolrResourceLoader.replaceClassLoader Adding
'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-5.x-Windows/solr/core/src/test-files/solr/collection1/lib/README'
to classloader
[junit4] 2> 441046 T2149 oasc.SolrConfig.refreshRequestParams current
version of requestparams : -1
[junit4] 2> 441063 T2149 oasc.SolrConfig.<init> Using Lucene MatchVersion:
5.3.0
[junit4] 2> 441114 T2149 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 441115 T2149 oass.IndexSchema.readSchema Reading Solr Schema
from
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\schema.xml
[junit4] 2> 441121 T2149 oass.IndexSchema.readSchema [collection1] Schema
name=test
[junit4] 2> 441540 T2149 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 441626 T2149 oass.IndexSchema.readSchema default search field
in schema is text
[junit4] 2> 441629 T2149 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 441636 T2149 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 441657 T2149 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 441660 T2149 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 441660 T2149
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 441661 T2149
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 441661 T2149 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 441662 T2149
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 441662 T2149
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 441662 T2149 oasc.CoreContainer.reload Reloading SolrCore
'collection1' using configuration from instancedir
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\
[junit4] 2> 441681 T2149 x:collection1 oasc.SolrCore.<init> [[collection1]
] Opening new SolrCore at
[C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\],
dataDir=[C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.update.HardAutoCommitTest
FC41AA66F118B9C1-001\init-core-data-001\]
[junit4] 2> 441681 T2149 x:collection1 oasc.JmxMonitoredMap.<init> JMX
monitoring is enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@6b839a22
[junit4] 2> 441682 T2149 x:collection1 oasc.SolrCore.getNewIndexDir New
index directory detected: old=null
new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.update.HardAutoCommitTest
FC41AA66F118B9C1-001\init-core-data-001\index/
[junit4] 2> 441687 T2149 x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"dedupe"
[junit4] 2> 441688 T2149 x:collection1
oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 441688 T2149 x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"dedupe-allfields"
[junit4] 2> 441688 T2149 x:collection1
oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"dedupe-allfields"
[junit4] 2> 441688 T2149 x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"stored_sig"
[junit4] 2> 441688 T2149 x:collection1
oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 441689 T2149 x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"uniq-fields"
[junit4] 2> 441689 T2149 x:collection1
oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4] 2> 441689 T2149 x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"distrib-dup-test-chain-explicit"
[junit4] 2> 441689 T2149 x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 441689 T2149 x:collection1
oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 441689 T2149 x:collection1
oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined
as default, creating implicit default
[junit4] 2> 441695 T2149 x:collection1 oashl.XMLLoader.init
xsltCacheLifetimeSeconds=60
[junit4] 2> 441696 T2149 x:collection1 oashl.XMLLoader.init
xsltCacheLifetimeSeconds=60
[junit4] 2> 441699 T2149 x:collection1 oashl.XMLLoader.init
xsltCacheLifetimeSeconds=60
[junit4] 2> 441701 T2149 x:collection1 oashl.XMLLoader.init
xsltCacheLifetimeSeconds=60
[junit4] 2> 441717 T2149 x:collection1 oasc.PluginBag.createPlugin
requestHandler : 'lazy' created with startup=lazy
[junit4] 2> 441720 T2149 x:collection1
oasc.RequestHandlers.initHandlersFromConfig Registered paths:
/mlt,/replication,defaults,/admin/ping,/admin/threads,/config,dismax,/admin/file,/search-facet-invariants,/admin/segments,spellCheckWithWordbreak,spellCheckCompRH_Direct,/update/json,/get,/admin/plugins,spellCheckCompRH,mltrh,/update/json/docs,spellCheckCompRH1,/admin/luke,mock,/debug/dump,/terms,/schema,/search-facet-def,spellCheckWithWordbreak_Direct,/admin/mbeans,/admin/logging,/update/csv,standard,tvrh,/admin/system,/update,/admin/properties,lazy
[junit4] 2> 441721 T2149 x:collection1 oasc.SolrCore.initDeprecatedSupport
WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your
config to use the ShowFileRequestHandler.
[junit4] 2> 441722 T2149 x:collection1 oasc.SolrCore.initStatsCache Using
default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 441735 T2149 x:collection1 oasu.CommitTracker.<init> Hard
AutoCommit: disabled
[junit4] 2> 441735 T2149 x:collection1 oasu.CommitTracker.<init> Soft
AutoCommit: disabled
[junit4] 2> 441776 T2149 x:collection1 oass.SolrIndexSearcher.<init>
Opening Searcher@34bbfa63[collection1] main
[junit4] 2> 441787 T2149 x:collection1 oasr.RestManager.init Initializing
RestManager with initArgs:
{storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
[junit4] 2> 441787 T2149 x:collection1 oasr.ManagedResourceStorage.load
Reading _rest_managed.json using InMemoryStorage
[junit4] 2> 441787 T2149 x:collection1 oasr.RestManager.init Initializing
0 registered ManagedResources
[junit4] 2> 441792 T2149 x:collection1 oashc.SpellCheckComponent.inform
Initializing spell checkers
[junit4] 2> 441794 T2149 x:collection1 oass.DirectSolrSpellChecker.init
init:
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 441847 T2149 x:collection1 oash.ReplicationHandler.inform
Commits will be reserved for 10000
[junit4] 2> 441849 T2149 x:collection1 oasu.UpdateLog.onFirstSearcher On
first searcher opened, looking up max value of version field
[junit4] 2> 441849 T2149 x:collection1
oasu.VersionInfo.getMaxVersionFromIndex Refreshing highest value of _version_
for 65536 version buckets from index
[junit4] 2> 441850 T2149 x:collection1
oasu.VersionInfo.getMaxVersionFromIndex No terms found for _version_, cannot
seed version bucket highest value from index
[junit4] 2> 441851 T2149 x:collection1
oasu.UpdateLog.seedBucketsWithHighestVersion Took 2 ms to seed version buckets
with highest version 1502171106163818496
[junit4] 2> 441851 T2149 x:collection1
oasu.DefaultSolrCoreState.newIndexWriter Creating new IndexWriter...
[junit4] 2> 441851 T2149 x:collection1
oasu.DefaultSolrCoreState.newIndexWriter Waiting until IndexWriter is unused...
core=collection1
[junit4] 2> 441851 T2149 x:collection1
oasu.DefaultSolrCoreState.newIndexWriter Closing old IndexWriter...
core=collection1
[junit4] 2> 441852 T2153 x:collection1
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index
for spellchecker: default
[junit4] 2> 441852 T2153 x:collection1
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index
for spellchecker: direct
[junit4] 2> 441852 T2153 x:collection1
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index
for spellchecker: wordbreak
[junit4] 2> 441852 T2153 x:collection1
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index
for spellchecker: multipleFields
[junit4] 2> 441853 T2153 x:collection1
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index
for spellchecker: jarowinkler
[junit4] 2> 441853 T2153 x:collection1
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index
for spellchecker: external
[junit4] 2> 441854 T2153 x:collection1
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index
for spellchecker: freq
[junit4] 2> 441854 T2153 x:collection1
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index
for spellchecker: fqcn
[junit4] 2> 441854 T2153 x:collection1
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index
for spellchecker: perDict
[junit4] 2> 441855 T2153 x:collection1 oasc.SolrCore.registerSearcher
[collection1] Registered new searcher Searcher@34bbfa63[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 441856 T2149 x:collection1 oasu.RandomMergePolicy.<init>
RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy:
[TieredMergePolicy: maxMergeAtOnce=29, maxMergeAtOnceExplicit=39,
maxMergedSegmentMB=1.458984375, floorSegmentMB=0.5380859375,
forceMergeDeletesPctAllowed=4.686031518508513, segmentsPerTier=21.0,
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.17914822261973226
[junit4] 2> 441856 T2149 x:collection1 oasc.SolrDeletionPolicy.onInit
SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@43f617fd
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@51a105e6),segFN=segments_1,generation=1}
[junit4] 2> 441859 T2149 x:collection1
oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 441860 T2149 x:collection1
oasu.DefaultSolrCoreState.newIndexWriter New IndexWriter is ready to be used.
[junit4] 2> 441860 T2149 x:collection1 oass.SolrIndexSearcher.<init>
Opening Searcher@6684c1e1[collection1] main
[junit4] 2> 441860 T2149 x:collection1 oasc.CoreContainer.registerCore
replacing core: collection1
[junit4] 2> 441860 T2149 x:collection1 oasc.SolrCore.close [collection1]
CLOSING SolrCore org.apache.solr.core.SolrCore@4d5539af
[junit4] 2> 441861 T2149 x:collection1 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> 441861 T2149 x:collection1 oasc.SolrCore.closeSearcher
[collection1] Closing main searcher on request.
[junit4] 2> 441872 T2149 x:collection1 oasup.LogUpdateProcessor.finish
[collection1] {add=[529 (1502171107073982464)]} 0 4
[junit4] 2> ASYNC NEW_CORE C280 name=collection1
org.apache.solr.core.SolrCore@2633798c
[junit4] 2> 441873 T2149 x:collection1 C280 oasc.SolrCore.execute
[collection1] webapp=null path=null
params={q=id:529&version=2.2&qt=standard&start=0&rows=20} hits=0 status=0
QTime=1
[junit4] 2> 441890 T2153 x:collection1 oasc.SolrCore.registerSearcher
[collection1] Registered new searcher Searcher@6684c1e1[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 442074 T2149 x:collection1 oasup.LogUpdateProcessor.finish
[collection1] {add=[530 (1502171107285794816)]} 0 206
[junit4] 2> 442075 T2149 x:collection1 C280 oasc.SolrCore.execute
[collection1] webapp=null path=null
params={q=id:530&version=2.2&qt=standard&start=0&rows=20} hits=0 status=0
QTime=1
[junit4] 2> 442076 T2149 x:collection1 oasup.LogUpdateProcessor.finish
[collection1] {delete=[529 (-1502171107288940544)]} 0 208
[junit4] 2> 442077 T2149 x:collection1 C280 oasc.SolrCore.execute
[collection1] webapp=null path=null
params={q=id:529&version=2.2&qt=standard&start=0&rows=20} hits=0 status=0
QTime=1
[junit4] 2> 442078 T2149 x:collection1 oas.SolrTestCaseJ4.assertQ ERROR
REQUEST FAILED: xpath=//result[@numFound=1]
[junit4] 2> xml response was: <?xml version="1.0"
encoding="UTF-8"?>
[junit4] 2> <response>
[junit4] 2> <lst name="responseHeader"><int
name="status">0</int><int name="QTime">1</int></lst><result name="response"
numFound="0" start="0"></result>
[junit4] 2> </response>
[junit4] 2>
[junit4] 2> request
was:q=id:529&version=2.2&qt=standard&start=0&rows=20
[junit4] 2> 442079 T2149 x:collection1 oasc.SolrException.log ERROR
REQUEST FAILED:
q=id:529&version=2.2&qt=standard&start=0&rows=20:java.lang.RuntimeException:
REQUEST FAILED: xpath=//result[@numFound=1]
[junit4] 2> xml response was: <?xml version="1.0"
encoding="UTF-8"?>
[junit4] 2> <response>
[junit4] 2> <lst name="responseHeader"><int
name="status">0</int><int name="QTime">1</int></lst><result name="response"
numFound="0" start="0"></result>
[junit4] 2> </response>
[junit4] 2>
[junit4] 2> request
was:q=id:529&version=2.2&qt=standard&start=0&rows=20
[junit4] 2> at
org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:788)
[junit4] 2> at
org.apache.solr.update.HardAutoCommitTest.testCommitWithin(HardAutoCommitTest.java:100)
[junit4] 2> at
sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit4] 2> at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
[junit4] 2> at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4] 2> at
java.lang.reflect.Method.invoke(Method.java:606)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1627)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:836)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:872)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:886)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
[junit4] 2> at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
[junit4] 2> at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
[junit4] 2> at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
[junit4] 2> at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
[junit4] 2> at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
[junit4] 2> at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798)
[junit4] 2> at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:845)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:747)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:781)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:792)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
[junit4] 2> at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54)
[junit4] 2> at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4] 2> at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
[junit4] 2> at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2>
[junit4] 2> 442079 T2149 x:collection1 oas.SolrTestCaseJ4.tearDown
###Ending testCommitWithin
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=HardAutoCommitTest
-Dtests.method=testCommitWithin -Dtests.seed=FC41AA66F118B9C1 -Dtests.slow=true
-Dtests.locale=ar_YE -Dtests.timezone=Europe/Tirane -Dtests.asserts=true
-Dtests.file.encoding=US-ASCII
[junit4] ERROR 1.08s J0 | HardAutoCommitTest.testCommitWithin <<<
[junit4] > Throwable #1: java.lang.RuntimeException: Exception during
query
[junit4] > at
__randomizedtesting.SeedInfo.seed([FC41AA66F118B9C1:4693C51E723657D4]:0)
[junit4] > at
org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:795)
[junit4] > at
org.apache.solr.update.HardAutoCommitTest.testCommitWithin(HardAutoCommitTest.java:100)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] > Caused by: java.lang.RuntimeException: REQUEST FAILED:
xpath=//result[@numFound=1]
[junit4] > xml response was: <?xml version="1.0" encoding="UTF-8"?>
[junit4] > <response>
[junit4] > <lst name="responseHeader"><int name="status">0</int><int
name="QTime">1</int></lst><result name="response" numFound="0"
start="0"></result>
[junit4] > </response>
[junit4] > request
was:q=id:529&version=2.2&qt=standard&start=0&rows=20
[junit4] > at
org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:788)
[junit4] > ... 40 more
[junit4] 2> 442083 T2149 x:collection1 oas.SolrTestCaseJ4.deleteCore
###deleteCore
[junit4] 2> 442083 T2149 x:collection1 oasc.CoreContainer.shutdown
Shutting down CoreContainer instance=1842458019
[junit4] 2> 442084 T2149 x:collection1 oasc.SolrCore.close [collection1]
CLOSING SolrCore org.apache.solr.core.SolrCore@2633798c
[junit4] 2> 442084 T2149 x:collection1 oasu.DirectUpdateHandler2.close
closing DirectUpdateHandler2{commits=0,autocommits=0,soft
autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=2,adds=2,deletesById=1,deletesByQuery=0,errors=0,cumulative_adds=2,cumulative_deletesById=1,cumulative_deletesByQuery=0,cumulative_errors=0,transaction_logs_total_size=0,transaction_logs_total_number=0}
[junit4] 2> 442084 T2149 x:collection1
oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 442084 T2149 x:collection1
oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached
0 - closing IndexWriter
[junit4] 2> 442085 T2149 x:collection1
oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with
IndexWriterCloser
[junit4] 2> 442085 T2149 x:collection1 C280
oasu.DirectUpdateHandler2.closeWriter Committing on IndexWriter close.
[junit4] 2> 442086 T2149 x:collection1 C280
oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@43f617fd
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@51a105e6),segFN=segments_1,generation=1}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@43f617fd
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@51a105e6),segFN=segments_2,generation=2}
[junit4] 2> 442087 T2149 x:collection1 C280
oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
[junit4] 2> 442088 T2149 x:collection1 oasc.SolrCore.closeSearcher
[collection1] Closing main searcher on request.
[junit4] 2> 442097 T2149 x:collection1 oasc.CachingDirectoryFactory.close
Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 442097 T2149 x:collection1
oasc.CachingDirectoryFactory.closeCacheValue looking to close
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.update.HardAutoCommitTest
FC41AA66F118B9C1-001\init-core-data-001\index
[CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.update.HardAutoCommitTest
FC41AA66F118B9C1-001\init-core-data-001\index;done=false>>]
[junit4] 2> 442097 T2149 x:collection1 oasc.CachingDirectoryFactory.close
Closing directory:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.update.HardAutoCommitTest
FC41AA66F118B9C1-001\init-core-data-001\index
[junit4] 2> 442097 T2149 x:collection1
oasc.CachingDirectoryFactory.closeCacheValue looking to close
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.update.HardAutoCommitTest
FC41AA66F118B9C1-001\init-core-data-001\
[CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.update.HardAutoCommitTest
FC41AA66F118B9C1-001\init-core-data-001\;done=false>>]
[junit4] 2> 442098 T2149 x:collection1 oasc.CachingDirectoryFactory.close
Closing directory:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.update.HardAutoCommitTest
FC41AA66F118B9C1-001\init-core-data-001\
[junit4] 2> NOTE: leaving temporary files on disk at:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.update.HardAutoCommitTest
FC41AA66F118B9C1-001
[junit4] 2> NOTE: test params are: codec=Lucene50, sim=DefaultSimilarity,
locale=ar_YE, timezone=Europe/Tirane
[junit4] 2> NOTE: Windows 7 6.1 amd64/Oracle Corporation 1.7.0_80
(64-bit)/cpus=3,threads=1,free=71048872,total=476053504
[junit4] 2> NOTE: All tests run in this JVM: [TestLFUCache,
RuleEngineTest, TestWordDelimiterFilterFactory, TestFastLRUCache, TestLRUCache,
DistributedQueryComponentOptimizationTest, TestCloudInspectUtil,
AnalyticsMergeStrategyTest, TestExpandComponent, CustomCollectionTest,
TestFunctionQuery, IgnoreCommitOptimizeUpdateProcessorFactoryTest,
TestStressVersions, HighlighterMaxOffsetTest, TestDefaultSearchFieldResource,
QueryElevationComponentTest, DistribDocExpirationUpdateProcessorTest,
DistributedDebugComponentTest, DocValuesTest, HdfsNNFailoverTest,
TestLRUStatsCache, RulesTest, SynonymTokenizerTest, BadComponentTest,
TestNonDefinedSimilarityFactory, DeleteShardTest, TestMiniSolrCloudClusterSSL,
OutputWriterTest, TestMissingGroups, TestHashQParserPlugin,
TestPivotHelperCode, TestStressRecovery, PreAnalyzedFieldTest,
TestFieldResource, TestBM25SimilarityFactory, XmlUpdateRequestHandlerTest,
MergeStrategyTest, AnalysisAfterCoreReloadTest, TestOrdValues,
DirectSolrConnectionTest, SolrTestCaseJ4Test, SuggesterTest, UUIDFieldTest,
TestPartialUpdateDeduplication, AssignTest, DocValuesMultiTest,
TestSolrQueryParserResource, PeerSyncTest, TestQueryTypes,
HdfsBasicDistributedZkTest, TestObjectReleaseTracker, HardAutoCommitTest]
[junit4] Completed [81/496] on J0 in 2.04s, 1 test, 1 error <<< FAILURES!
[...truncated 1329 lines...]
BUILD FAILED
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\build.xml:536: The
following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\build.xml:484: The
following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\build.xml:61: The
following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\extra-targets.xml:39:
The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build.xml:229: The
following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\common-build.xml:511:
The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\lucene\common-build.xml:1433:
The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\lucene\common-build.xml:991:
There were test failures: 496 suites, 1973 tests, 1 error, 66 ignored (34
assumptions)
Total time: 75 minutes 40 seconds
Build step 'Invoke Ant' marked build as failure
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]
