Build: http://jenkins.thetaphi.de/job/Lucene-Solr-5.x-MacOSX/2188/
Java: 64bit/jdk1.8.0 -XX:-UseCompressedOops -XX:+UseG1GC
3 tests failed.
FAILED:
junit.framework.TestSuite.org.apache.solr.handler.component.TestPivotHelperCode
Error Message:
Some resources were not closed, shutdown, or released.
Stack Trace:
java.lang.AssertionError: Some resources were not closed, shutdown, or released.
at __randomizedtesting.SeedInfo.seed([69FB965D0AED992D]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.apache.solr.SolrTestCaseJ4.afterClass(SolrTestCaseJ4.java:234)
at sun.reflect.GeneratedMethodAccessor51.invoke(Unknown Source)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:497)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1627)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:799)
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)
FAILED: junit.framework.TestSuite.org.apache.solr.update.SoftAutoCommitTest
Error Message:
1
Stack Trace:
java.lang.AssertionError: 1
at __randomizedtesting.SeedInfo.seed([69FB965D0AED992D]:0)
at
org.apache.solr.core.CachingDirectoryFactory.close(CachingDirectoryFactory.java:201)
at org.apache.solr.core.SolrCore.close(SolrCore.java:1235)
at org.apache.solr.core.SolrCores.close(SolrCores.java:117)
at org.apache.solr.core.CoreContainer.shutdown(CoreContainer.java:375)
at org.apache.solr.util.TestHarness.close(TestHarness.java:359)
at org.apache.solr.SolrTestCaseJ4.deleteCore(SolrTestCaseJ4.java:704)
at org.apache.solr.SolrTestCaseJ4.afterClass(SolrTestCaseJ4.java:230)
at sun.reflect.GeneratedMethodAccessor51.invoke(Unknown Source)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:497)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1627)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:799)
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)
FAILED: junit.framework.TestSuite.org.apache.solr.update.SoftAutoCommitTest
Error Message:
Clean up static fields (in @AfterClass?), your test seems to hang on to
approximately 12,015,808 bytes (threshold is 10,485,760). Field reference sizes
(counted individually): - 12,701,064 bytes, protected static
org.apache.solr.util.TestHarness$LocalRequestFactory
org.apache.solr.SolrTestCaseJ4.lrf - 12,700,688 bytes, protected static
org.apache.solr.util.TestHarness org.apache.solr.SolrTestCaseJ4.h - 8,089,712
bytes, protected static org.apache.solr.core.SolrConfig
org.apache.solr.SolrTestCaseJ4.solrConfig - 296 bytes, public static
org.junit.rules.TestRule org.apache.solr.SolrTestCaseJ4.solrClassRules - 216
bytes, protected static java.lang.String
org.apache.solr.SolrTestCaseJ4.testSolrHome - 144 bytes, private static
java.lang.String org.apache.solr.SolrTestCaseJ4.factoryProp - 88 bytes,
protected static java.lang.String org.apache.solr.SolrTestCaseJ4.configString
- 80 bytes, private static java.lang.String
org.apache.solr.SolrTestCaseJ4.coreName - 80 bytes, protected static
java.lang.String org.apache.solr.SolrTestCaseJ4.schemaString
Stack Trace:
junit.framework.AssertionFailedError: Clean up static fields (in @AfterClass?),
your test seems to hang on to approximately 12,015,808 bytes (threshold is
10,485,760). Field reference sizes (counted individually):
- 12,701,064 bytes, protected static
org.apache.solr.util.TestHarness$LocalRequestFactory
org.apache.solr.SolrTestCaseJ4.lrf
- 12,700,688 bytes, protected static org.apache.solr.util.TestHarness
org.apache.solr.SolrTestCaseJ4.h
- 8,089,712 bytes, protected static org.apache.solr.core.SolrConfig
org.apache.solr.SolrTestCaseJ4.solrConfig
- 296 bytes, public static org.junit.rules.TestRule
org.apache.solr.SolrTestCaseJ4.solrClassRules
- 216 bytes, protected static java.lang.String
org.apache.solr.SolrTestCaseJ4.testSolrHome
- 144 bytes, private static java.lang.String
org.apache.solr.SolrTestCaseJ4.factoryProp
- 88 bytes, protected static java.lang.String
org.apache.solr.SolrTestCaseJ4.configString
- 80 bytes, private static java.lang.String
org.apache.solr.SolrTestCaseJ4.coreName
- 80 bytes, protected static java.lang.String
org.apache.solr.SolrTestCaseJ4.schemaString
at
com.carrotsearch.randomizedtesting.rules.StaticFieldsInvariantRule$1.afterAlways(StaticFieldsInvariantRule.java:127)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:43)
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)
Build Log:
[...truncated 9909 lines...]
[junit4] Suite: org.apache.solr.update.SoftAutoCommitTest
[junit4] 2> Creating dataDir:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.update.SoftAutoCommitTest
69FB965D0AED992D-001/init-core-data-001
[junit4] 2> 650805 T2283 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl
(false) and clientAuth (false)
[junit4] 2> 650808 T2283 oas.SolrTestCaseJ4.initCore ####initCore
[junit4] 2> 650808 T2283 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/'
[junit4] 2> 650809 T2283 oasc.SolrResourceLoader.replaceClassLoader Adding
'file:/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/lib/classes/'
to classloader
[junit4] 2> 650809 T2283 oasc.SolrResourceLoader.replaceClassLoader Adding
'file:/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/lib/README'
to classloader
[junit4] 2> 650901 T2283 oasc.SolrConfig.refreshRequestParams current
version of requestparams : -1
[junit4] 2> 650912 T2283 oasc.SolrConfig.<init> Using Lucene MatchVersion:
5.2.0
[junit4] 2> 650968 T2283 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 651009 T2283 oass.IndexSchema.readSchema Reading Solr Schema
from
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/schema.xml
[junit4] 2> 651016 T2283 oass.IndexSchema.readSchema [null] Schema
name=test
[junit4] 2> 651277 T2283 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 651287 T2283 oass.IndexSchema.readSchema default search field
in schema is text
[junit4] 2> 651288 T2283 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 651294 T2283 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 651298 T2283 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 651300 T2283 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 651301 T2283
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 651301 T2283
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 651301 T2283 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 651302 T2283
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 651302 T2283
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 651303 T2283 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 651303 T2283 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr
[junit4] 2> 651303 T2283 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/'
[junit4] 2> 651321 T2283 oasc.CoreContainer.<init> New CoreContainer
494795900
[junit4] 2> 651321 T2283 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/]
[junit4] 2> 651322 T2283 oasc.CoreContainer.load loading shared library:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/lib
[junit4] 2> 651333 T2283 oasc.SolrResourceLoader.addToClassLoader WARN
Can't find (or read) directory to add to classloader: lib (resolved as:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/lib).
[junit4] 2> 651382 T2283 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> 651394 T2283 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=30000&connTimeout=30000&retry=true
[junit4] 2> 651395 T2283 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 651395 T2283 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 651396 T2283 oasc.CoreContainer.load Node Name: testNode
[junit4] 2> 651398 T2283 oasc.CoreDescriptor.<init> CORE DESCRIPTOR:
{name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml,
loadOnStartup=true, instanceDir=collection1, collection=collection1,
absoluteInstDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/,
dataDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.update.SoftAutoCommitTest
69FB965D0AED992D-001/init-core-data-001, shard=shard1}
[junit4] 2> 651399 T2284 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/'
[junit4] 2> 651400 T2284 oasc.SolrResourceLoader.replaceClassLoader Adding
'file:/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/lib/classes/'
to classloader
[junit4] 2> 651401 T2284 oasc.SolrResourceLoader.replaceClassLoader Adding
'file:/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/lib/README'
to classloader
[junit4] 2> 651430 T2284 oasc.SolrConfig.refreshRequestParams current
version of requestparams : -1
[junit4] 2> 651465 T2284 oasc.SolrConfig.<init> Using Lucene MatchVersion:
5.2.0
[junit4] 2> 651537 T2284 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 651537 T2284 oass.IndexSchema.readSchema Reading Solr Schema
from
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/schema.xml
[junit4] 2> 651542 T2284 oass.IndexSchema.readSchema [collection1] Schema
name=test
[junit4] 2> 651758 T2284 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 651763 T2284 oass.IndexSchema.readSchema default search field
in schema is text
[junit4] 2> 651764 T2284 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 651772 T2284 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 651775 T2284 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 651809 T2284 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 651809 T2284
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 651809 T2284
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 651810 T2284 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 651810 T2284
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 651810 T2284
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 651810 T2284 oasc.CoreContainer.create Creating SolrCore
'collection1' using configuration from instancedir
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/
[junit4] 2> 651810 T2284 x:collection1 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 651811 T2284 x:collection1 oasc.SolrCore.<init> [[collection1]
] Opening new SolrCore at
[/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/],
dataDir=[null]
[junit4] 2> 651811 T2284 x:collection1 oasc.JmxMonitoredMap.<init> JMX
monitoring is enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@10cee76b
[junit4] 2> 651811 T2284 x:collection1 oasc.CachingDirectoryFactory.get
return new directory for
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.update.SoftAutoCommitTest
69FB965D0AED992D-001/init-core-data-001
[junit4] 2> 651812 T2284 x:collection1 oasc.SolrCore.getNewIndexDir New
index directory detected: old=null
new=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.update.SoftAutoCommitTest
69FB965D0AED992D-001/init-core-data-001/index/
[junit4] 2> 651812 T2284 x:collection1 oasc.SolrCore.initIndex WARN
[collection1] Solr index directory
'/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.update.SoftAutoCommitTest
69FB965D0AED992D-001/init-core-data-001/index' doesn't exist. Creating new
index...
[junit4] 2> 651812 T2284 x:collection1 oasc.CachingDirectoryFactory.get
return new directory for
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.update.SoftAutoCommitTest
69FB965D0AED992D-001/init-core-data-001/index
[junit4] 2> 651812 T2284 x:collection1 oasu.RandomMergePolicy.<init>
RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy:
[TieredMergePolicy: maxMergeAtOnce=21, maxMergeAtOnceExplicit=50,
maxMergedSegmentMB=69.7578125, floorSegmentMB=1.9951171875,
forceMergeDeletesPctAllowed=3.026353749273314, segmentsPerTier=46.0,
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1788366779839044
[junit4] 2> 651822 T2284 x:collection1 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@72182fda
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7a3d6b52),segFN=segments_1,generation=1}
[junit4] 2> 651822 T2284 x:collection1
oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 651826 T2284 x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"dedupe"
[junit4] 2> 651826 T2284 x:collection1
oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 651826 T2284 x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"dedupe-allfields"
[junit4] 2> 651826 T2284 x:collection1
oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"dedupe-allfields"
[junit4] 2> 651826 T2284 x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"stored_sig"
[junit4] 2> 651827 T2284 x:collection1
oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 651827 T2284 x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"uniq-fields"
[junit4] 2> 651827 T2284 x:collection1
oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4] 2> 651827 T2284 x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"distrib-dup-test-chain-explicit"
[junit4] 2> 651828 T2284 x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 651828 T2284 x:collection1
oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 651828 T2284 x:collection1
oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined
as default, creating implicit default
[junit4] 2> 651835 T2284 x:collection1 oashl.XMLLoader.init
xsltCacheLifetimeSeconds=60
[junit4] 2> 651836 T2284 x:collection1 oashl.XMLLoader.init
xsltCacheLifetimeSeconds=60
[junit4] 2> 651837 T2284 x:collection1 oashl.XMLLoader.init
xsltCacheLifetimeSeconds=60
[junit4] 2> 651843 T2284 x:collection1 oashl.XMLLoader.init
xsltCacheLifetimeSeconds=60
[junit4] 2> 651872 T2284 x:collection1 oasc.PluginBag.createPlugin
requestHandler : 'lazy' created with startup=lazy
[junit4] 2> 651874 T2284 x:collection1
oasc.RequestHandlers.initHandlersFromConfig Registered paths:
/admin/mbeans,standard,spellCheckCompRH,lazy,/update/json/docs,/admin/luke,spellCheckWithWordbreak_Direct,tvrh,/get,/admin/properties,/update/json,mltrh,/admin/threads,/search-facet-def,/update/csv,/search-facet-invariants,/admin/segments,spellCheckCompRH1,/mlt,/admin/system,/replication,dismax,defaults,/config,/schema,/admin/plugins,/admin/logging,spellCheckWithWordbreak,mock,/admin/ping,/update,/admin/file,/terms,spellCheckCompRH_Direct,/debug/dump
[junit4] 2> 651875 T2284 x:collection1 oasc.SolrCore.initDeprecatedSupport
WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your
config to use the ShowFileRequestHandler.
[junit4] 2> 651875 T2284 x:collection1 oasc.SolrCore.initStatsCache Using
default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 651877 T2284 x:collection1 oasu.UpdateHandler.<init> Using
UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 651877 T2284 x:collection1 oasu.UpdateLog.init Initializing
UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10
[junit4] 2> 651877 T2284 x:collection1 oasu.CommitTracker.<init> Hard
AutoCommit: disabled
[junit4] 2> 651877 T2284 x:collection1 oasu.CommitTracker.<init> Soft
AutoCommit: disabled
[junit4] 2> 651878 T2284 x:collection1 oasu.RandomMergePolicy.<init>
RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy:
[AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=226023787,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.1]
[junit4] 2> 651879 T2284 x:collection1 oasc.SolrDeletionPolicy.onInit
SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@72182fda
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7a3d6b52),segFN=segments_1,generation=1}
[junit4] 2> 651880 T2284 x:collection1
oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 651880 T2284 x:collection1 oass.SolrIndexSearcher.<init>
Opening Searcher@e45a14a[collection1] main
[junit4] 2> 651880 T2284 x:collection1 oasr.RestManager.init Initializing
RestManager with initArgs:
{storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
[junit4] 2> 651880 T2284 x:collection1 oasr.ManagedResourceStorage.load
Reading _rest_managed.json using InMemoryStorage
[junit4] 2> 651881 T2284 x:collection1 oasr.RestManager.init Initializing
0 registered ManagedResources
[junit4] 2> 651881 T2284 x:collection1 oashc.SpellCheckComponent.inform
Initializing spell checkers
[junit4] 2> 651889 T2284 x:collection1 oass.DirectSolrSpellChecker.init
init:
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 652009 T2284 x:collection1 oash.ReplicationHandler.inform
Commits will be reserved for 10000
[junit4] 2> 652019 T2285 x:collection1
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index
for spellchecker: default
[junit4] 2> 652019 T2284 x:collection1 oasc.CoreContainer.registerCore
registering core: collection1
[junit4] 2> 652019 T2285 x:collection1
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index
for spellchecker: direct
[junit4] 2> 652019 T2285 x:collection1
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index
for spellchecker: wordbreak
[junit4] 2> 652020 T2285 x:collection1
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index
for spellchecker: multipleFields
[junit4] 2> 652020 T2285 x:collection1
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index
for spellchecker: jarowinkler
[junit4] 2> 652021 T2285 x:collection1
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index
for spellchecker: external
[junit4] 2> 652021 T2283 oas.SolrTestCaseJ4.initCore ####initCore end
[junit4] 2> 652022 T2285 x:collection1
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index
for spellchecker: freq
[junit4] 2> 652022 T2285 x:collection1
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index
for spellchecker: fqcn
[junit4] 2> 652024 T2285 x:collection1
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index
for spellchecker: perDict
[junit4] 2> 652025 T2283 oas.SolrTestCaseJ4.setUp ###Starting
testSoftAndHardCommitMaxTimeMixedAdds
[junit4] 2> 652025 T2283 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/'
[junit4] 2> 652025 T2285 x:collection1 oasc.SolrCore.registerSearcher
[collection1] Registered new searcher Searcher@e45a14a[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 652027 T2283 oasc.SolrResourceLoader.replaceClassLoader Adding
'file:/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/lib/classes/'
to classloader
[junit4] 2> 652027 T2283 oasc.SolrResourceLoader.replaceClassLoader Adding
'file:/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/lib/README'
to classloader
[junit4] 2> 652080 T2283 oasc.SolrConfig.refreshRequestParams current
version of requestparams : -1
[junit4] 2> 652089 T2283 oasc.SolrConfig.<init> Using Lucene MatchVersion:
5.2.0
[junit4] 2> 652166 T2283 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 652167 T2283 oass.IndexSchema.readSchema Reading Solr Schema
from
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/schema.xml
[junit4] 2> 652174 T2283 oass.IndexSchema.readSchema [collection1] Schema
name=test
[junit4] 2> 652377 T2283 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 652405 T2283 oass.IndexSchema.readSchema default search field
in schema is text
[junit4] 2> 652406 T2283 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 652440 T2283 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 652442 T2283 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 652444 T2283 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 652444 T2283
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 652446 T2283
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 652446 T2283 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 652453 T2283
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 652455 T2283
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 652456 T2283 oasc.CoreContainer.reload Reloading SolrCore
'collection1' using configuration from instancedir
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/
[junit4] 2> 652458 T2283 x:collection1 oasc.SolrCore.<init> [[collection1]
] Opening new SolrCore at
[/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/],
dataDir=[/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.update.SoftAutoCommitTest
69FB965D0AED992D-001/init-core-data-001/]
[junit4] 2> 652458 T2283 x:collection1 oasc.JmxMonitoredMap.<init> JMX
monitoring is enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@10cee76b
[junit4] 2> 652459 T2283 x:collection1 oasc.SolrCore.getNewIndexDir New
index directory detected: old=null
new=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.update.SoftAutoCommitTest
69FB965D0AED992D-001/init-core-data-001/index/
[junit4] 2> 652471 T2283 x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"dedupe"
[junit4] 2> 652471 T2283 x:collection1
oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 652471 T2283 x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"dedupe-allfields"
[junit4] 2> 652472 T2283 x:collection1
oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"dedupe-allfields"
[junit4] 2> 652472 T2283 x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"stored_sig"
[junit4] 2> 652472 T2283 x:collection1
oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 652475 T2283 x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"uniq-fields"
[junit4] 2> 652476 T2283 x:collection1
oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4] 2> 652492 T2283 x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"distrib-dup-test-chain-explicit"
[junit4] 2> 652492 T2283 x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 652493 T2283 x:collection1
oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 652493 T2283 x:collection1
oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined
as default, creating implicit default
[junit4] 2> 652494 T2283 x:collection1 oashl.XMLLoader.init
xsltCacheLifetimeSeconds=60
[junit4] 2> 652495 T2283 x:collection1 oashl.XMLLoader.init
xsltCacheLifetimeSeconds=60
[junit4] 2> 652497 T2283 x:collection1 oashl.XMLLoader.init
xsltCacheLifetimeSeconds=60
[junit4] 2> 652499 T2283 x:collection1 oashl.XMLLoader.init
xsltCacheLifetimeSeconds=60
[junit4] 2> 652530 T2283 x:collection1 oasc.PluginBag.createPlugin
requestHandler : 'lazy' created with startup=lazy
[junit4] 2> 652540 T2283 x:collection1
oasc.RequestHandlers.initHandlersFromConfig Registered paths:
/admin/mbeans,standard,spellCheckCompRH,lazy,/update/json/docs,/admin/luke,spellCheckWithWordbreak_Direct,tvrh,/get,/admin/properties,/update/json,mltrh,/admin/threads,/search-facet-def,/update/csv,/search-facet-invariants,/admin/segments,spellCheckCompRH1,/mlt,/admin/system,/replication,dismax,defaults,/config,/schema,/admin/plugins,/admin/logging,spellCheckWithWordbreak,mock,/admin/ping,/update,/admin/file,/terms,spellCheckCompRH_Direct,/debug/dump
[junit4] 2> 652545 T2283 x:collection1 oasc.SolrCore.initDeprecatedSupport
WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your
config to use the ShowFileRequestHandler.
[junit4] 2> 652546 T2283 x:collection1 oasc.SolrCore.initStatsCache Using
default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 652548 T2283 x:collection1 oasu.CommitTracker.<init> Hard
AutoCommit: disabled
[junit4] 2> 652548 T2283 x:collection1 oasu.CommitTracker.<init> Soft
AutoCommit: disabled
[junit4] 2> 652552 T2283 x:collection1 oass.SolrIndexSearcher.<init>
Opening Searcher@171f195d[collection1] main
[junit4] 2> 652553 T2283 x:collection1 oasr.RestManager.init Initializing
RestManager with initArgs:
{storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
[junit4] 2> 652554 T2283 x:collection1 oasr.ManagedResourceStorage.load
Reading _rest_managed.json using InMemoryStorage
[junit4] 2> 652555 T2283 x:collection1 oasr.RestManager.init Initializing
0 registered ManagedResources
[junit4] 2> 652555 T2283 x:collection1 oashc.SpellCheckComponent.inform
Initializing spell checkers
[junit4] 2> 652556 T2283 x:collection1 oass.DirectSolrSpellChecker.init
init:
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 652565 T2283 x:collection1 oash.ReplicationHandler.inform
Commits will be reserved for 10000
[junit4] 2> 652565 T2287 x:collection1
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index
for spellchecker: default
[junit4] 2> 652566 T2283 x:collection1
oasu.DefaultSolrCoreState.newIndexWriter Creating new IndexWriter...
[junit4] 2> 652566 T2287 x:collection1
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index
for spellchecker: direct
[junit4] 2> 652566 T2287 x:collection1
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index
for spellchecker: wordbreak
[junit4] 2> 652566 T2287 x:collection1
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index
for spellchecker: multipleFields
[junit4] 2> 652566 T2283 x:collection1
oasu.DefaultSolrCoreState.newIndexWriter Waiting until IndexWriter is unused...
core=collection1
[junit4] 2> 652567 T2283 x:collection1
oasu.DefaultSolrCoreState.newIndexWriter Closing old IndexWriter...
core=collection1
[junit4] 2> 652567 T2287 x:collection1
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index
for spellchecker: jarowinkler
[junit4] 2> 652568 T2283 x:collection1 oasu.RandomMergePolicy.<init>
RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy:
[LogDocMergePolicy: minMergeSize=1000, mergeFactor=29,
maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=1.0]
[junit4] 2> 652568 T2283 x:collection1 oasc.SolrDeletionPolicy.onInit
SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@72182fda
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7a3d6b52),segFN=segments_1,generation=1}
[junit4] 2> 652569 T2287 x:collection1
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index
for spellchecker: external
[junit4] 2> 652570 T2283 x:collection1
oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 652570 T2283 x:collection1
oasu.DefaultSolrCoreState.newIndexWriter New IndexWriter is ready to be used.
[junit4] 2> 652570 T2283 x:collection1 oasc.SolrCore.getSearcher WARN
[collection1] PERFORMANCE WARNING: Overlapping onDeckSearchers=2
[junit4] 2> 652570 T2287 x:collection1
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index
for spellchecker: freq
[junit4] 2> 652572 T2287 x:collection1
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index
for spellchecker: fqcn
[junit4] 2> 652573 T2287 x:collection1
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index
for spellchecker: perDict
[junit4] 2> 652574 T2287 x:collection1 oasc.SolrCore.registerSearcher
[collection1] Registered new searcher Searcher@171f195d[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 652570 T2283 x:collection1 oass.SolrIndexSearcher.<init>
Opening Searcher@5fb58e57[collection1] main
[junit4] 2> 652590 T2283 x:collection1 oasc.CoreContainer.registerCore
replacing core: collection1
[junit4] 2> 652590 T2283 x:collection1 oasc.SolrCore.close [collection1]
CLOSING SolrCore org.apache.solr.core.SolrCore@16827f0e
[junit4] 2> 652591 T2283 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=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0,transaction_logs_total_size=0,transaction_logs_total_number=0}
[junit4] 2> 652591 T2287 x:collection1 oasc.SolrCore.registerSearcher
[collection1] Registered new searcher Searcher@5fb58e57[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 652592 T2283 x:collection1 oasc.SolrCore.closeSearcher
[collection1] Closing main searcher on request.
[junit4] 2> ASYNC NEW_CORE C1750 name=collection1
org.apache.solr.core.SolrCore@29403fce
[junit4] 2> 652685 T2283 x:collection1 C1750
oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={}
{add=[529 (1499659578733756416)]} 0 70
[junit4] 2> 653177 T2289 x:collection1 oasu.DirectUpdateHandler2.commit
start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 653186 T2289 x:collection1 oass.SolrIndexSearcher.<init>
Opening Searcher@78f9061[collection1] main
[junit4] 2> 653193 T2287 x:collection1 oasc.SolrCore.registerSearcher
[collection1] Registered new searcher Searcher@78f9061[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.2.0):C1)))}
[junit4] 2> 653193 T2289 x:collection1 oasu.DirectUpdateHandler2.commit
end_commit_flush
[junit4] 2> 653215 T2283 x:collection1 C1750
oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={}
{add=[530 (1499659579349270528)]} 0 11
[junit4] 2> 653717 T2289 x:collection1 oasu.DirectUpdateHandler2.commit
start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 653748 T2289 x:collection1 oass.SolrIndexSearcher.<init>
Opening Searcher@6f9be25f[collection1] main
[junit4] 2> 653751 T2289 x:collection1 oasu.DirectUpdateHandler2.commit
end_commit_flush
[junit4] 2> 653752 T2287 x:collection1 oasc.SolrCore.registerSearcher
[collection1] Registered new searcher Searcher@6f9be25f[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.2.0):C1)
Uninverting(_1(5.2.0):C1)))}
[junit4] 2> 653877 T2288 x:collection1 oasu.DirectUpdateHandler2.commit
start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 653878 T2288 x:collection1 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@72182fda
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7a3d6b52),segFN=segments_1,generation=1}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@72182fda
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7a3d6b52),segFN=segments_2,generation=2}
[junit4] 2> 653878 T2288 x:collection1
oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
[junit4] 2> 653878 T2288 x:collection1 oasc.SolrCore.openNewSearcher
SolrIndexSearcher has not changed - not re-opening:
org.apache.solr.search.SolrIndexSearcher
[junit4] 2> 653878 T2288 x:collection1 oasu.DirectUpdateHandler2.commit
end_commit_flush
[junit4] 2> 657085 T2283 x:collection1 oas.SolrTestCaseJ4.tearDown
###Ending testSoftAndHardCommitMaxTimeMixedAdds
[junit4] 2> 657089 T2283 x:collection1 oas.SolrTestCaseJ4.setUp
###Starting testSoftAndHardCommitMaxTimeRapidAdds
[junit4] 2> 657090 T2283 x:collection1 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/'
[junit4] 2> 657091 T2283 x:collection1
oasc.SolrResourceLoader.replaceClassLoader Adding
'file:/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/lib/classes/'
to classloader
[junit4] 2> 657091 T2283 x:collection1
oasc.SolrResourceLoader.replaceClassLoader Adding
'file:/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/lib/README'
to classloader
[junit4] 2> 657117 T2283 x:collection1
oasc.SolrConfig.refreshRequestParams current version of requestparams : -1
[junit4] 2> 657130 T2283 x:collection1 oasc.SolrConfig.<init> Using Lucene
MatchVersion: 5.2.0
[junit4] 2> 657166 T2283 x:collection1 oasc.SolrConfig.<init> Loaded
SolrConfig: solrconfig.xml
[junit4] 2> 657167 T2283 x:collection1 oass.IndexSchema.readSchema Reading
Solr Schema from
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/schema.xml
[junit4] 2> 657173 T2283 x:collection1 oass.IndexSchema.readSchema
[collection1] Schema name=test
[junit4] 2> 657565 T2283 x:collection1
oass.OpenExchangeRatesOrgProvider.init Initialized with
rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 657571 T2283 x:collection1 oass.IndexSchema.readSchema default
search field in schema is text
[junit4] 2> 657635 T2283 x:collection1 oass.IndexSchema.readSchema unique
key field: id
[junit4] 2> 657663 T2283 x:collection1
oass.FileExchangeRateProvider.reload Reloading exchange rates from file
currency.xml
[junit4] 2> 657667 T2283 x:collection1
oass.FileExchangeRateProvider.reload Reloading exchange rates from file
currency.xml
[junit4] 2> 657738 T2283 x:collection1
oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from
open-exchange-rates.json
[junit4] 2> 657739 T2283 x:collection1
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 657739 T2283 x:collection1
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 657740 T2283 x:collection1
oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from
open-exchange-rates.json
[junit4] 2> 657743 T2283 x:collection1
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 657743 T2283 x:collection1
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 657743 T2283 x:collection1 oasc.CoreContainer.reload Reloading
SolrCore 'collection1' using configuration from instancedir
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/
[junit4] 2> 657744 T2283 x:collection1 oasc.SolrCore.<init> [[collection1]
] Opening new SolrCore at
[/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/],
dataDir=[/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.update.SoftAutoCommitTest
69FB965D0AED992D-001/init-core-data-001/]
[junit4] 2> 657744 T2283 x:collection1 oasc.JmxMonitoredMap.<init> JMX
monitoring is enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@10cee76b
[junit4] 2> 657745 T2283 x:collection1 oasc.SolrCore.getNewIndexDir New
index directory detected: old=null
new=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.update.SoftAutoCommitTest
69FB965D0AED992D-001/init-core-data-001/index/
[junit4] 2> 657764 T2283 x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"dedupe"
[junit4] 2> 657764 T2283 x:collection1
oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 657775 T2283 x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"dedupe-allfields"
[junit4] 2> 657776 T2283 x:collection1
oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"dedupe-allfields"
[junit4] 2> 657777 T2283 x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"stored_sig"
[junit4] 2> 657786 T2283 x:collection1
oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 657787 T2283 x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"uniq-fields"
[junit4] 2> 657787 T2283 x:collection1
oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4] 2> 657803 T2283 x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"distrib-dup-test-chain-explicit"
[junit4] 2> 657804 T2283 x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 657805 T2283 x:collection1
oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 657805 T2283 x:collection1
oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined
as default, creating implicit default
[junit4] 2> 657808 T2283 x:collection1 oashl.XMLLoader.init
xsltCacheLifetimeSeconds=60
[junit4] 2> 657810 T2283 x:collection1 oashl.XMLLoader.init
xsltCacheLifetimeSeconds=60
[junit4] 2> 657821 T2283 x:collection1 oashl.XMLLoader.init
xsltCacheLifetimeSeconds=60
[junit4] 2> 657824 T2283 x:collection1 oashl.XMLLoader.init
xsltCacheLifetimeSeconds=60
[junit4] 2> 657842 T2283 x:collection1 oasc.PluginBag.createPlugin
requestHandler : 'lazy' created with startup=lazy
[junit4] 2> 657863 T2283 x:collection1
oasc.RequestHandlers.initHandlersFromConfig Registered paths:
/admin/mbeans,standard,spellCheckCompRH,lazy,/update/json/docs,/admin/luke,spellCheckWithWordbreak_Direct,tvrh,/get,/admin/properties,/update/json,mltrh,/admin/threads,/search-facet-def,/update/csv,/search-facet-invariants,/admin/segments,spellCheckCompRH1,/mlt,/admin/system,/replication,dismax,defaults,/config,/schema,/admin/plugins,/admin/logging,spellCheckWithWordbreak,mock,/admin/ping,/update,/admin/file,/terms,spellCheckCompRH_Direct,/debug/dump
[junit4] 2> 657865 T2283 x:collection1 oasc.SolrCore.initDeprecatedSupport
WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your
config to use the ShowFileRequestHandler.
[junit4] 2> 657866 T2283 x:collection1 oasc.SolrCore.initStatsCache Using
default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 657866 T2283 x:collection1 oasu.CommitTracker.<init> Hard
AutoCommit: disabled
[junit4] 2> 657867 T2283 x:collection1 oasu.CommitTracker.<init> Soft
AutoCommit: disabled
[junit4] 2> 657868 T2283 x:collection1 oass.SolrIndexSearcher.<init>
Opening Searcher@44022d95[collection1] main
[junit4] 2> 657869 T2283 x:collection1 oasr.RestManager.init Initializing
RestManager with initArgs:
{storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
[junit4] 2> 657869 T2283 x:collection1 oasr.ManagedResourceStorage.load
Reading _rest_managed.json using InMemoryStorage
[junit4] 2> 657870 T2283 x:collection1 oasr.RestManager.init Initializing
0 registered ManagedResources
[junit4] 2> 657871 T2283 x:collection1 oashc.SpellCheckComponent.inform
Initializing spell checkers
[junit4] 2> 657873 T2283 x:collection1 oass.DirectSolrSpellChecker.init
init:
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 657887 T2283 x:collection1 oash.ReplicationHandler.inform
Commits will be reserved for 10000
[junit4] 2> 657888 T2290 x:collection1
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index
for spellchecker: default
[junit4] 2> 657889 T2290 x:collection1
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index
for spellchecker: direct
[junit4] 2> 657889 T2290 x:collection1
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index
for spellchecker: wordbreak
[junit4] 2> 657889 T2290 x:collection1
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index
for spellchecker: multipleFields
[junit4] 2> 657890 T2290 x:collection1
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index
for spellchecker: jarowinkler
[junit4] 2> 657890 T2283 x:collection1
oasu.DefaultSolrCoreState.newIndexWriter Creating new IndexWriter...
[junit4] 2> 657890 T2283 x:collection1
oasu.DefaultSolrCoreState.newIndexWriter Waiting until IndexWriter is unused...
core=collection1
[junit4] 2> 657891 T2283 x:collection1
oasu.DefaultSolrCoreState.newIndexWriter Closing old IndexWriter...
core=collection1
[junit4] 2> 657890 T2290 x:collection1
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index
for spellchecker: external
[junit4] 2> 657892 T2290 x:collection1
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index
for spellchecker: freq
[junit4] 2> 657893 T2290 x:collection1
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index
for spellchecker: fqcn
[junit4] 2> 657895 T2290 x:collection1
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index
for spellchecker: perDict
[junit4] 2> 657896 T2290 x:collection1 oasc.SolrCore.registerSearcher
[collection1] Registered new searcher Searcher@44022d95[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.2.0):C1)
Uninverting(_1(5.2.0):C1)))}
[junit4] 2> 657898 T2283 x:collection1 oasu.RandomMergePolicy.<init>
RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy:
[TieredMergePolicy: maxMergeAtOnce=22, maxMergeAtOnceExplicit=22,
maxMergedSegmentMB=2.5673828125, floorSegmentMB=0.6572265625,
forceMergeDeletesPctAllowed=2.777906487707631, segmentsPerTier=30.0,
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
[junit4] 2> 657902 T2283 x:collection1 oasc.SolrDeletionPolicy.onInit
SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@72182fda
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7a3d6b52),segFN=segments_2,generation=2}
[junit4] 2> 657903 T2283 x:collection1
oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
[junit4] 2> 657903 T2283 x:collection1
oasu.DefaultSolrCoreState.newIndexWriter New IndexWriter is ready to be used.
[junit4] 2> 657914 T2283 x:collection1 oass.SolrIndexSearcher.<init>
Opening Searcher@20b307b0[collection1] main
[junit4] 2> 657915 T2283 x:collection1 oasc.CoreContainer.registerCore
replacing core: collection1
[junit4] 2> 657916 T2283 x:collection1 oasc.SolrCore.close [collection1]
CLOSING SolrCore org.apache.solr.core.SolrCore@29403fce
[junit4] 2> 657917 T2283 x:collection1 oasu.DirectUpdateHandler2.close
closing DirectUpdateHandler2{commits=3,autocommit
maxTime=1200ms,autocommits=1,soft autocommit maxTime=500ms,soft
autocommits=2,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=2,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0,transaction_logs_total_size=205,transaction_logs_total_number=1}
[junit4] 2> 657920 T2290 x:collection1 oasc.SolrCore.registerSearcher
[collection1] Registered new searcher Searcher@20b307b0[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.2.0):C1)
Uninverting(_1(5.2.0):C1)))}
[junit4] 2> 657921 T2283 x:collection1 oasc.SolrCore.closeSearcher
[collection1] Closing main searcher on request.
[junit4] 2> ASYNC NEW_CORE C1751 name=collection1
org.apache.solr.core.SolrCore@40bfb4f3
[junit4] 2> 657976 T2283 x:collection1 C1751
oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={}
{add=[5000 (1499659584345735168)]} 0 9
[junit4] 2> 657978 T2283 x:collection1 C1751
oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={}
{add=[5001 (1499659584354123776)]} 0 1
[junit4] 2> 657981 T2283 x:collection1 C1751
oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={}
{add=[5002 (1499659584356220928)]} 0 2
[junit4] 2> 657983 T2283 x:collection1 C1751
oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={}
{add=[5003 (1499659584359366656)]} 0 1
[junit4] 2> 657986 T2283 x:collection1 C1751
oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={}
{add=[5004 (1499659584363560960)]} 0 0
[junit4] 2> 657987 T2283 x:collection1 oas.SolrTestCaseJ4.tearDown
###Ending testSoftAndHardCommitMaxTimeRapidAdds
[junit4] 2> 657998 T2283 x:collection1 oas.SolrTestCaseJ4.setUp
###Starting testSoftAndHardCommitMaxTimeDelete
[junit4] 2> 657999 T2283 x:collection1 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/'
[junit4] 2> 658000 T2283 x:collection1
oasc.SolrResourceLoader.replaceClassLoader Adding
'file:/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/lib/classes/'
to classloader
[junit4] 2> 658001 T2283 x:collection1
oasc.SolrResourceLoader.replaceClassLoader Adding
'file:/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/lib/README'
to classloader
[junit4] 2> 658055 T2283 x:collection1
oasc.SolrConfig.refreshRequestParams current version of requestparams : -1
[junit4] 2> 658067 T2283 x:collection1 oasc.SolrConfig.<init> Using Lucene
MatchVersion: 5.2.0
[junit4] 2> 658257 T2283 x:collection1 oasc.SolrConfig.<init> Loaded
SolrConfig: solrconfig.xml
[junit4] 2> 658258 T2283 x:collection1 oass.IndexSchema.readSchema Reading
Solr Schema from
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/schema.xml
[junit4] 2> 658273 T2283 x:collection1 oass.IndexSchema.readSchema
[collection1] Schema name=test
[junit4] 2> 658537 T2292 x:collection1 oasu.DirectUpdateHandler2.commit
start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 658620 T2292 x:collection1 oass.SolrIndexSearcher.<init>
Opening Searcher@496ea656[collection1] main
[junit4] 2> 658630 T2290 x:collection1 oasc.SolrCore.registerSearcher
[collection1] Registered new searcher Searcher@496ea656[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.2.0):C1)
Uninverting(_1(5.2.0):C1) Uninverting(_2(5.2.0):C5)))}
[junit4] 2> 658632 T2292 x:collection1 oasu.DirectUpdateHandler2.commit
end_commit_flush
[junit4] 2> 658661 T2283 x:collection1
oass.OpenExchangeRatesOrgProvider.init Initialized with
rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 658709 T2283 x:collection1 oass.IndexSchema.readSchema default
search field in schema is text
[junit4] 2> 658712 T2283 x:collection1 oass.IndexSchema.readSchema unique
key field: id
[junit4] 2> 658798 T2283 x:collection1
oass.FileExchangeRateProvider.reload Reloading exchange rates from file
currency.xml
[junit4] 2> 658805 T2283 x:collection1
oass.FileExchangeRateProvider.reload Reloading exchange rates from file
currency.xml
[junit4] 2> 658808 T2283 x:collection1
oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from
open-exchange-rates.json
[junit4] 2> 658808 T2283 x:collection1
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 658809 T2283 x:collection1
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 658809 T2283 x:collection1
oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from
open-exchange-rates.json
[junit4] 2> 658810 T2283 x:collection1
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 658810 T2283 x:collection1
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 658810 T2283 x:collection1 oasc.CoreContainer.reload Reloading
SolrCore 'collection1' using configuration from instancedir
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/
[junit4] 2> 658811 T2283 x:collection1 oasc.SolrCore.<init> [[collection1]
] Opening new SolrCore at
[/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/],
dataDir=[/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.update.SoftAutoCommitTest
69FB965D0AED992D-001/init-core-data-001/]
[junit4] 2> 658811 T2283 x:collection1 oasc.JmxMonitoredMap.<init> JMX
monitoring is enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@10cee76b
[junit4] 2> 658812 T2283 x:collection1 oasc.SolrCore.getNewIndexDir New
index directory detected: old=null
new=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.update.SoftAutoCommitTest
69FB965D0AED992D-001/init-core-data-001/index/
[junit4] 2> 658880 T2283 x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"dedupe"
[junit4] 2> 658881 T2283 x:collection1
oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 658881 T2283 x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"dedupe-allfields"
[junit4] 2> 658881 T2283 x:collection1
oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"dedupe-allfields"
[junit4] 2> 658882 T2283 x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"stored_sig"
[junit4] 2> 658888 T2283 x:collection1
oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 658895 T2283 x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"uniq-fields"
[junit4] 2> 658896 T2283 x:collection1
oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4] 2> 658896 T2283 x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"distrib-dup-test-chain-explicit"
[junit4] 2> 658897 T2283 x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 658897 T2283 x:collection1
oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 658897 T2283 x:collection1
oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined
as default, creating implicit default
[junit4] 2> 658899 T2283 x:collection1 oashl.XMLLoader.init
xsltCacheLifetimeSeconds=60
[junit4] 2> 658902 T2283 x:collection1 oashl.XMLLoader.init
xsltCacheLifetimeSeconds=60
[junit4] 2> 658904 T2283 x:collection1 oashl.XMLLoader.init
xsltCacheLifetimeSeconds=60
[junit4] 2> 658908 T2283 x:collection1 oashl.XMLLoader.init
xsltCacheLifetimeSeconds=60
[junit4] 2> 658981 T2283 x:collection1 oasc.PluginBag.createPlugin
requestHandler : 'lazy' created with startup=lazy
[junit4] 2> 659010 T2283 x:collection1
oasc.RequestHandlers.initHandlersFromConfig Registered paths:
/admin/mbeans,standard,spellCheckCompRH,lazy,/update/json/docs,/admin/luke,spellCheckWithWordbreak_Direct,tvrh,/get,/admin/properties,/update/json,mltrh,/admin/threads,/search-facet-def,/update/csv,/search-facet-invariants,/admin/segments,spellCheckCompRH1,/mlt,/admin/system,/replication,dismax,defaults,/config,/schema,/admin/plugins,/admin/logging,spellCheckWithWordbreak,mock,/admin/ping,/update,/admin/file,/terms,spellCheckCompRH_Direct,/debug/dump
[junit4] 2> 659011 T2283 x:collection1 oasc.SolrCore.initDeprecatedSupport
WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your
config to use the ShowFileRequestHandler.
[junit4] 2> 659012 T2283 x:collection1 oasc.SolrCore.initStatsCache Using
default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 659070 T2283 x:collection1 oasu.CommitTracker.<init> Hard
AutoCommit: disabled
[junit4] 2> 659072 T2283 x:collection1 oasu.CommitTracker.<init> Soft
AutoCommit: disabled
[junit4] 2> 659080 T2283 x:collection1 oass.SolrIndexSearcher.<init>
Opening Searcher@15a08b85[collection1] main
[junit4] 2> 659081 T2283 x:collection1 oasr.RestManager.init Initializing
RestManager with initArgs:
{storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
[junit4] 2> 659082 T2283 x:collection1 oasr.ManagedResourceStorage.load
Reading _rest_managed.json using InMemoryStorage
[junit4] 2> 659082 T2283 x:collection1 oasr.RestManager.init Initializing
0 registered ManagedResources
[junit4] 2> 659083 T2283 x:collection1 oashc.SpellCheckComponent.inform
Initializing spell checkers
[junit4] 2> 659085 T2283 x:collection1 oass.DirectSolrSpellChecker.init
init:
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 659174 T2283 x:collection1 oash.ReplicationHandler.inform
Commits will be reserved for 10000
[junit4] 2> 659175 T2293 x:collection1
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index
for spellchecker: default
[junit4] 2> 659176 T2293 x:collection1
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index
for spellchecker: direct
[junit4] 2> 659176 T2283 x:collection1
oasu.DefaultSolrCoreState.newIndexWriter Creating new IndexWriter...
[junit4] 2> 659176 T2283 x:collection1
oasu.DefaultSolrCoreState.newIndexWriter Waiting until IndexWriter is unused...
core=collection1
[junit4] 2> 659176 T2283 x:collection1
oasu.DefaultSolrCoreState.newIndexWriter Closing old IndexWriter...
core=collection1
[junit4] 2> 659176 T2293 x:collection1
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index
for spellchecker: wordbreak
[junit4] 2> 659178 T2293 x:collection1
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index
for spellchecker: multipleFields
[junit4] 2> 659178 T2293 x:collection1
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index
for spellchecker: jarowinkler
[junit4] 2> 659179 T2293 x:collection1
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index
for spellchecker: external
[junit4] 2> 659186 T2293 x:collection1
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index
for spellchecker: freq
[junit4] 2> 659187 T2293 x:collection1
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index
for spellchecker: fqcn
[junit4] 2> 659187 T2291 x:collection1 oasu.DirectUpdateHandler2.commit
start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 659187 T2293 x:collection1
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index
for spellchecker: perDict
[junit4] 2> 659188 T2293 x:collection1 oasc.SolrCore.registerSearcher
[collection1] Registered new searcher Searcher@15a08b85[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.2.0):C1)
Uninverting(_1(5.2.0):C1) Uninverting(_2(5.2.0):C5)))}
[junit4] 2> 659194 T2283 x:collection1 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@72182fda
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7a3d6b52),segFN=segments_2,generation=2}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@72182fda
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7a3d6b52),segFN=segments_3,generation=3}
[junit4] 2> 659194 T2283 x:collection1
oasc.SolrDeletionPolicy.updateCommits newest commit generation = 3
[junit4] 2> 659197 T2283 x:collection1 oasu.RandomMergePolicy.<init>
RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy:
[TieredMergePolicy: maxMergeAtOnce=43, maxMergeAtOnceExplicit=26,
maxMergedSegmentMB=43.7021484375, floorSegmentMB=0.4365234375,
forceMergeDeletesPctAllowed=10.859965919365616, segmentsPerTier=21.0,
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 659201 T2283 x:collection1 oasc.SolrDeletionPolicy.onInit
SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@72182fda
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7a3d6b52),segFN=segments_3,generation=3}
[junit4] 2> 659203 T2283 x:collection1
oasc.SolrDeletionPolicy.updateCommits newest commit generation = 3
[junit4] 2> 659203 T2283 x:collection1
oasu.DefaultSolrCoreState.newIndexWriter New IndexWriter is ready to be used.
[junit4] 2> 659204 T2291 x:collection1 oasu.DirectUpdateHandler2.commit No
uncommitted changes. Skipping IW.commit.
[junit4] 2> 659217 T2283 x:collection1 oass.SolrIndexSearcher.<init>
Opening Searcher@3c56cff7[collection1] main
[junit4] 2> 659218 T2283 x:collection1 oasc.CoreContainer.registerCore
replacing core: collection1
[junit4] 2> 659218 T2283 x:collection1 oasc.SolrCore.close [collection1]
CLOSING SolrCore org.apache.solr.core.SolrCore@40bfb4f3
[junit4] 2> 659219 T2283 x:collection1 oasu.DirectUpdateHandler2.close
closing DirectUpdateHandler2{commits=2,autocommit
maxTime=1200ms,autocommits=1,soft autocommit maxTime=500ms,soft
autocommits=1,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=5,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0,transaction_logs_total_size=205,transaction_logs_total_number=1}
[junit4] 2> 659219 T2293 x:collection1 oasc.SolrCore.registerSearcher
[collection1] Registered new searcher Searcher@3c56cff7[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.2.0):C1)
Uninverting(_1(5.2.0):C1) Uninverting(_2(5.2.0):C5)))}
[junit4] 2> 659220 T2283 x:collection1 oasc.SolrCore.closeSearcher
[collection1] Closing main searcher on request.
[junit4] 2> 659221 T2291 x:collection1 oass.SolrIndexSearcher.<init>
Opening Searcher@1daaf9cd[collection1] main
[junit4] 2> 659222 T2291 x:collection1 oasc.SolrException.log ERROR auto
commit error...:org.apache.solr.common.SolrException:
java.util.concurrent.RejectedExecutionException: Task
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1@69fdab02
rejected from
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor@1614a926[Terminated,
pool size = 0, active threads = 0, queued tasks = 0, completed tasks = 9]
[junit4] 2> at
org.apache.solr.core.SolrCore.getSearcher(SolrCore.java:1889)
[junit4] 2> at
org.apache.solr.core.SolrCore.getSearcher(SolrCore.java:1505)
[junit4] 2> at
org.apache.solr.update.DirectUpdateHandler2.commit(DirectUpdateHandler2.java:617)
[junit4] 2> at
org.apache.solr.update.CommitTracker.run(CommitTracker.java:216)
[junit4] 2> at
java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
[junit4] 2> at
java.util.concurrent.FutureTask.run(FutureTask.java:266)
[junit4] 2> at
java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180)
[junit4] 2> at
java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> Caused by:
java.util.concurrent.RejectedExecutionException: Task
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1@69fdab02
rejected from
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor@1614a926[Terminated,
pool size = 0, active threads = 0, queued tasks = 0, completed tasks = 9]
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor$AbortPolicy.rejectedExecution(ThreadPoolExecutor.java:2047)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.reject(ThreadPoolExecutor.java:823)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.execute(ThreadPoolExecutor.java:1369)
[junit4] 2> at
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.execute(ExecutorUtil.java:135)
[junit4] 2> at
java.util.concurrent.AbstractExecutorService.submit(AbstractExecutorService.java:134)
[junit4] 2> at
org.apache.solr.core.SolrCore.getSearcher(SolrCore.java:1809)
[junit4] 2> ... 10 more
[junit4] 2>
[junit4] 2> ASYNC NEW_CORE C1752 name=collection1
org.apache.solr.core.SolrCore@72bbfc87
[junit4] 2> 659255 T2283 x:collection1 C1752
oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={}
{add=[529 (1499659585686863872)]} 0 7
[junit4] 2> 659258 T2283 x:collection1 C1752
oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 659309 T2283 x:collection1 C1752
oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@72182fda
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7a3d6b52),segFN=segments_3,generation=3}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@72182fda
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7a3d6b52),segFN=segments_4,generation=4}
[junit4] 2> 659310 T2283 x:collection1 C1752
oasc.SolrDeletionPolicy.updateCommits newest commit generation = 4
[junit4] 2> 659316 T2283 x:collection1 C1752 oass.SolrIndexSearcher.<init>
Opening Searcher@d8c042[collection1] main
[junit4] 2> 659317 T2283 x:collection1 C1752
oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 659319 T2293 x:collection1 oasc.SolrCore.registerSearcher
[collection1] Registered new searcher Searcher@d8c042[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(5.2.0):C1)
Uninverting(_2(5.2.0):C5) Uninverting(_3(5.2.0):C1)))}
[junit4] 2> 659320 T2283 x:collection1 C1752
oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={}
{commit=} 0 62
[junit4] 2> 659329 T2283 x:collection1 C1752
oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={}
{delete=[529 (-1499659585766555648)]} 0 6
[junit4] 2> 659832 T2295 x:collection1 oasu.DirectUpdateHandler2.commit
start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 659842 T2295 x:collection1 oass.SolrIndexSearcher.<init>
Opening Searcher@338ae42a[collection1] main
[junit4] 2> 659843 T2295 x:collection1 oasu.DirectUpdateHandler2.commit
end_commit_flush
[junit4] 2> 659844 T2283 x:collection1 C1752
oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={}
{add=[550 (1499659586311815168)]} 0 1
[junit4] 2> 659845 T2293 x:collection1 oasc.SolrCore.registerSearcher
[collection1] Registered new searcher Searcher@338ae42a[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(5.2.0):C1)
Uninverting(_2(5.2.0):C5)))}
[junit4] 2> 660345 T2295 x:collection1 oasu.DirectUpdateHandler2.commit
start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 660351 T2295 x:collection1 oass.SolrIndexSearcher.<init>
Opening Searcher@37ae2f5f[collection1] main
[junit4] 2> 660351 T2295 x:collection1 oasu.DirectUpdateHandler2.commit
end_commit_flush
[junit4] 2> 660353 T2293 x:collection1 oasc.SolrCore.registerSearcher
[collection1] Registered new searcher Searcher@37ae2f5f[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(5.2.0):C1)
Uninverting(_2(5.2.0):C5) Uninverting(_4(5.2.0):C1)))}
[junit4] 2> 660531 T2294 x:collection1 oasu.DirectUpdateHandler2.commit
start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 660544 T2294 x:collection1 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@72182fda
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7a3d6b52),segFN=segments_4,generation=4}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@72182fda
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7a3d6b52),segFN=segments_5,generation=5}
[junit4] 2> 660545 T2294 x:collection1
oasc.SolrDeletionPolicy.updateCommits newest commit generation = 5
[junit4] 2> 660546 T2294 x:collection1 oasc.SolrCore.openNewSearcher
SolrIndexSearcher has not changed - not re-opening:
org.apache.solr.search.SolrIndexSearcher
[junit4] 2> 660547 T2294 x:collection1 oasu.DirectUpdateHandler2.commit
end_commit_flush
[junit4] 2> 662548 T2283 x:collection1 oas.SolrTestCaseJ4.tearDown
###Ending testSoftAndHardCommitMaxTimeDelete
[junit4] 2> 662549 T2283 x:collection1 oas.SolrTestCaseJ4.deleteCore
###deleteCore
[junit4] 2> 662549 T2283 x:collection1 oasc.CoreContainer.shutdown
Shutting down CoreContainer instance=494795900
[junit4] 2> 662549 T2283 x:collection1 oasc.SolrCore.close [collection1]
CLOSING SolrCore org.apache.solr.core.SolrCore@72bbfc87
[junit4] 2> 662555 T2283 x:collection1 oasu.DirectUpdateHandler2.close
closing DirectUpdateHandler2{commits=4,autocommit
maxTime=1200ms,autocommits=1,soft autocommit maxTime=500ms,soft
autocommits=2,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=2,cumulative_deletesById=1,cumulative_deletesByQuery=0,cumulative_errors=0,transaction_logs_total_size=502,transaction_logs_total_number=3}
[junit4] 2> 662556 T2283 x:collection1
oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 662559 T2283 x:collection1
oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached
0 - closing IndexWriter
[junit4] 2> 662559 T2283 x:collection1
oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with
IndexWriterCloser
[junit4] 2> 662561 T2283 x:collection1 oasc.SolrCore.closeSearcher
[collection1] Closing main searcher on request.
[junit4] 2> 662596 T2283 x:collection1 oasc.CachingDirectoryFactory.close
Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 674877 T2283 x:collection1 oasc.CachingDirectoryFactory.close
ERROR Timeout waiting for all directory ref counts to be released - gave up
waiting on
CachedDir<<refCount=1;path=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.update.SoftAutoCommitTest
69FB965D0AED992D-001/init-core-data-001/index;done=false>>
[junit4] 2> 674878 T2283 x:collection1 oasc.SolrException.log ERROR Error
closing directory:org.apache.solr.common.SolrException: Timeout waiting for all
directory ref counts to be released - gave up waiting on
CachedDir<<refCount=1;path=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.update.SoftAutoCommitTest
69FB965D0AED992D-001/init-core-data-001/index;done=false>>
[junit4] 2> at
org.apache.solr.core.CachingDirectoryFactory.close(CachingDirectoryFactory.java:187)
[junit4] 2> at
org.apache.solr.core.SolrCore.close(SolrCore.java:1235)
[junit4] 2> at
org.apache.solr.core.SolrCores.close(SolrCores.java:117)
[junit4] 2> at
org.apache.solr.core.CoreContainer.shutdown(CoreContainer.java:375)
[junit4] 2> at
org.apache.solr.util.TestHarness.close(TestHarness.java:359)
[junit4] 2> at
org.apache.solr.SolrTestCaseJ4.deleteCore(SolrTestCaseJ4.java:704)
[junit4] 2> at
org.apache.solr.SolrTestCaseJ4.afterClass(SolrTestCaseJ4.java:230)
[junit4] 2> at
sun.reflect.GeneratedMethodAccessor51.invoke(Unknown Source)
[junit4] 2> at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4] 2> at
java.lang.reflect.Method.invoke(Method.java:497)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1627)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:799)
[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> 674878 T2283 x:collection1 oasc.SolrException.log ERROR
java.lang.AssertionError: 1
[junit4] 2> at
org.apache.solr.core.CachingDirectoryFactory.close(CachingDirectoryFactory.java:201)
[junit4] 2> at
org.apache.solr.core.SolrCore.close(SolrCore.java:1235)
[junit4] 2> at
org.apache.solr.core.SolrCores.close(SolrCores.java:117)
[junit4] 2> at
org.apache.solr.core.CoreContainer.shutdown(CoreContainer.java:375)
[junit4] 2> at
org.apache.solr.util.TestHarness.close(TestHarness.java:359)
[junit4] 2> at
org.apache.solr.SolrTestCaseJ4.deleteCore(SolrTestCaseJ4.java:704)
[junit4] 2> at
org.apache.solr.SolrTestCaseJ4.afterClass(SolrTestCaseJ4.java:230)
[junit4] 2> at
sun.reflect.GeneratedMethodAccessor51.invoke(Unknown Source)
[junit4] 2> at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4] 2> at
java.lang.reflect.Method.invoke(Method.java:497)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1627)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:799)
[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> 674880 T2283 x:collection1 oasc.SolrException.log ERROR Error
shutting down core:java.lang.AssertionError: 1
[junit4] 2> at
org.apache.solr.core.CachingDirectoryFactory.close(CachingDirectoryFactory.java:201)
[junit4] 2> at
org.apache.solr.core.SolrCore.close(SolrCore.java:1235)
[junit4] 2> at
org.apache.solr.core.SolrCores.close(SolrCores.java:117)
[junit4] 2> at
org.apache.solr.core.CoreContainer.shutdown(CoreContainer.java:375)
[junit4] 2> at
org.apache.solr.util.TestHarness.close(TestHarness.java:359)
[junit4] 2> at
org.apache.solr.SolrTestCaseJ4.deleteCore(SolrTestCaseJ4.java:704)
[junit4] 2> at
org.apache.solr.SolrTestCaseJ4.afterClass(SolrTestCaseJ4.java:230)
[junit4] 2> at
sun.reflect.GeneratedMethodAccessor51.invoke(Unknown Source)
[junit4] 2> at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4] 2> at
java.lang.reflect.Method.invoke(Method.java:497)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1627)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:799)
[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> NOTE: test params are: codec=Asserting(Lucene50):
{range_facet_l_dv=PostingsFormat(name=MockRandom),
_version_=PostingsFormat(name=Direct),
multiDefault=PostingsFormat(name=LuceneVarGapDocFreqInterval),
subject=PostingsFormat(name=LuceneVarGapDocFreqInterval),
intDefault=PostingsFormat(name=Direct), id=PostingsFormat(name=MockRandom),
range_facet_i_dv=PostingsFormat(name=Direct),
text=PostingsFormat(name=LuceneVarGapFixedInterval),
range_facet_l=PostingsFormat(name=Direct),
timestamp=PostingsFormat(name=Direct)},
docValues:{range_facet_l_dv=DocValuesFormat(name=Lucene50),
range_facet_i_dv=DocValuesFormat(name=Direct),
timestamp=DocValuesFormat(name=Direct)},
sim=RandomSimilarityProvider(queryNorm=false,coord=yes): {}, locale=ms,
timezone=PRT
[junit4] 2> NOTE: Mac OS X 10.8.5 x86_64/Oracle Corporation 1.8.0_45
(64-bit)/cpus=3,threads=1,free=307455664,total=536870912
[junit4] 2> NOTE: All tests run in this JVM: [TestCollationFieldDocValues,
TestCoreContainer, TestElisionMultitermQuery, TestLazyCores, TestOrdValues,
TestSurroundQueryParser, SolrInfoMBeanTest, TestStressVersions, PrimUtilsTest,
HardAutoCommitTest, IndexSchemaRuntimeFieldTest, TestConfigSets,
AddSchemaFieldsUpdateProcessorFactoryTest, TestManagedSchemaFieldResource,
TestFaceting, TestBinaryResponseWriter, SolrCloudExampleTest,
TestJmxIntegration, TestSchemaManager, CoreAdminRequestStatusTest,
TestStressLucene, TestMaxScoreQueryParser, SuggesterWFSTTest,
URLClassifyProcessorTest, TestRestManager, TestSchemaNameResource,
TimeZoneUtilsTest, LukeRequestHandlerTest, XmlUpdateRequestHandlerTest,
TestQueryUtils, TestHighFrequencyDictionaryFactory, SimpleFacetsTest,
TestBinaryField, DOMUtilTest, CollectionsAPIAsyncDistributedZkTest,
BasicDistributedZkTest, TestPartialUpdateDeduplication,
TestManagedSchemaDynamicFieldResource, TestHighlightDedupGrouping,
TestCloudSchemaless, TestFieldTypeCollectionResource, TestDistributedSearch,
OverseerRolesTest, QueryResultKeyTest, SoftAutoCommitTest]
[...truncated too long message...]
addDoc(DirectUpdateHandler2.java:163)
[junit4] 2> at
org.apache.solr.update.processor.RunUpdateProcessor.processAdd(RunUpdateProcessorFactory.java:69)
[junit4] 2> at
org.apache.solr.update.processor.UpdateRequestProcessor.processAdd(UpdateRequestProcessor.java:51)
[junit4] 2> at
org.apache.solr.update.processor.DistributedUpdateProcessor.doLocalAdd(DistributedUpdateProcessor.java:955)
[junit4] 2> at
org.apache.solr.update.processor.DistributedUpdateProcessor.versionAdd(DistributedUpdateProcessor.java:1110)
[junit4] 2> at
org.apache.solr.update.processor.DistributedUpdateProcessor.processAdd(DistributedUpdateProcessor.java:706)
[junit4] 2> at
org.apache.solr.update.processor.LogUpdateProcessor.processAdd(LogUpdateProcessorFactory.java:104)
[junit4] 2> at
org.apache.solr.handler.loader.XMLLoader.processUpdate(XMLLoader.java:250)
[junit4] 2> at
org.apache.solr.handler.loader.XMLLoader.load(XMLLoader.java:177)
[junit4] 2> at
org.apache.solr.handler.UpdateRequestHandler$1.load(UpdateRequestHandler.java:98)
[junit4] 2> at
org.apache.solr.handler.ContentStreamHandlerBase.handleRequestBody(ContentStreamHandlerBase.java:74)
[junit4] 2> at
org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:143)
[junit4] 2> at
org.apache.solr.core.SolrCore.execute(SolrCore.java:2047)
[junit4] 2> at
org.apache.solr.servlet.DirectSolrConnection.request(DirectSolrConnection.java:131)
[junit4] 2> at
org.apache.solr.util.TestHarness.update(TestHarness.java:267)
[junit4] 2> at
org.apache.solr.util.BaseTestHarness.checkUpdateStatus(BaseTestHarness.java:282)
[junit4] 2> at
org.apache.solr.util.BaseTestHarness.validateUpdate(BaseTestHarness.java:252)
[junit4] 2> at
org.apache.solr.SolrTestCaseJ4.checkUpdateU(SolrTestCaseJ4.java:748)
[junit4] 2> at
org.apache.solr.SolrTestCaseJ4.assertU(SolrTestCaseJ4.java:727)
[junit4] 2> at
org.apache.solr.SolrTestCaseJ4.assertU(SolrTestCaseJ4.java:721)
[junit4] 2> at
org.apache.solr.update.SoftAutoCommitTest.testSoftAndHardCommitMaxTimeRapidAdds(SoftAutoCommitTest.java:303)
[junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native
Method)
[junit4] 2> at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
[junit4] 2> at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4] 2> at java.lang.reflect.Method.invoke(Method.java:497)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1627)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:836)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:872)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:886)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java: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> NOTE: test params are: codec=Asserting(Lucene50),
sim=DefaultSimilarity, locale=ar, timezone=America/Louisville
[junit4] 2> NOTE: Mac OS X 10.8.5 x86_64/Oracle Corporation 1.8.0_45
(64-bit)/cpus=3,threads=1,free=285081280,total=536870912
[junit4] 2> NOTE: All tests run in this JVM: [TestCollationFieldDocValues,
TestCoreContainer, TestElisionMultitermQuery, TestLazyCores, TestOrdValues,
TestSurroundQueryParser, SolrInfoMBeanTest, TestStressVersions, PrimUtilsTest,
HardAutoCommitTest, IndexSchemaRuntimeFieldTest, TestConfigSets,
AddSchemaFieldsUpdateProcessorFactoryTest, TestManagedSchemaFieldResource,
TestFaceting, TestBinaryResponseWriter, SolrCloudExampleTest,
TestJmxIntegration, TestSchemaManager, CoreAdminRequestStatusTest,
TestStressLucene, TestMaxScoreQueryParser, SuggesterWFSTTest,
URLClassifyProcessorTest, TestRestManager, TestSchemaNameResource,
TimeZoneUtilsTest, LukeRequestHandlerTest, XmlUpdateRequestHandlerTest,
TestQueryUtils, TestHighFrequencyDictionaryFactory, SimpleFacetsTest,
TestBinaryField, DOMUtilTest, CollectionsAPIAsyncDistributedZkTest,
BasicDistributedZkTest, TestPartialUpdateDeduplication,
TestManagedSchemaDynamicFieldResource, TestHighlightDedupGrouping,
TestCloudSchemaless, TestFieldTypeCollectionResource, TestDistributedSearch,
OverseerRolesTest, QueryResultKeyTest, SoftAutoCommitTest, TestPivotHelperCode]
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestPivotHelperCode
-Dtests.seed=69FB965D0AED992D -Dtests.slow=true -Dtests.locale=ar
-Dtests.timezone=America/Louisville -Dtests.asserts=true
-Dtests.file.encoding=ISO-8859-1
[junit4] ERROR 0.00s J0 | TestPivotHelperCode (suite) <<<
[junit4] > Throwable #1: java.lang.AssertionError: Some resources were
not closed, shutdown, or released.
[junit4] > at
__randomizedtesting.SeedInfo.seed([69FB965D0AED992D]:0)
[junit4] > at
org.apache.solr.SolrTestCaseJ4.afterClass(SolrTestCaseJ4.java:234)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] Completed [137/484] on J0 in 0.07s, 3 tests, 1 failure <<< FAILURES!
[...truncated 1073 lines...]
BUILD FAILED
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/build.xml:536: The following
error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/build.xml:484: The following
error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/build.xml:61: The following
error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/extra-targets.xml:39: The
following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build.xml:229: The
following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/common-build.xml:511: The
following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/lucene/common-build.xml:1433:
The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/lucene/common-build.xml:991:
There were test failures: 484 suites, 1946 tests, 3 suite-level errors, 59
ignored (24 assumptions)
Total time: 72 minutes 0 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]
