Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Linux/14456/
Java: 32bit/jdk1.8.0_60 -client -XX:+UseG1GC
2 tests failed.
FAILED: org.apache.solr.search.TestFiltering.testRandomFiltering
Error Message:
FAILURE: indexSize=2 iiter=4 qiter=410 request=[q, {! cache=true
tag=t}-_query_:"{!frange v=val_i l=1 u=2}", fq, {! tag=t}val_s:[00001 TO
00001], facet, true, facet.query, *:*, facet.query, {!key=multiSelect ex=t}*:*,
facet.query, {!key=facetQuery}-_query_:"{!frange v=val_i l=0 u=1}"]
Stack Trace:
java.lang.AssertionError: FAILURE: indexSize=2 iiter=4 qiter=410 request=[q, {!
cache=true tag=t}-_query_:"{!frange v=val_i l=1 u=2}", fq, {!
tag=t}val_s:[00001 TO 00001], facet, true, facet.query, *:*, facet.query,
{!key=multiSelect ex=t}*:*, facet.query, {!key=facetQuery}-_query_:"{!frange
v=val_i l=0 u=1}"]
at
__randomizedtesting.SeedInfo.seed([4D1EBAC1E185F817:527D190404A2B81E]:0)
at org.junit.Assert.fail(Assert.java:93)
at
org.apache.solr.search.TestFiltering.testRandomFiltering(TestFiltering.java:419)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:497)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1665)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:864)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:900)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:914)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:873)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:775)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:809)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:820)
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:367)
at java.lang.Thread.run(Thread.java:745)
FAILED:
org.apache.solr.cloud.SolrCloudExampleTest.testLoadDocsIntoGettingStartedCollection
Error Message:
Delete action failed!
Stack Trace:
java.lang.AssertionError: Delete action failed!
at
__randomizedtesting.SeedInfo.seed([4D1EBAC1E185F817:5E7D88AED0EA41B1]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at
org.apache.solr.cloud.SolrCloudExampleTest.doTestDeleteAction(SolrCloudExampleTest.java:169)
at
org.apache.solr.cloud.SolrCloudExampleTest.testLoadDocsIntoGettingStartedCollection(SolrCloudExampleTest.java:145)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:497)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1665)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:864)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:900)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:914)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:963)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:938)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:873)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:775)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:809)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:820)
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:367)
at java.lang.Thread.run(Thread.java:745)
Build Log:
[...truncated 9541 lines...]
[junit4] Suite: org.apache.solr.search.TestFiltering
[junit4] 2> Creating dataDir:
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.search.TestFiltering_4D1EBAC1E185F817-001/init-core-data-001
[junit4] 2> 432054 INFO
(SUITE-TestFiltering-seed#[4D1EBAC1E185F817]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false)
[junit4] 2> 432054 INFO
(SUITE-TestFiltering-seed#[4D1EBAC1E185F817]-worker) [ ]
o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 432054 INFO
(SUITE-TestFiltering-seed#[4D1EBAC1E185F817]-worker) [ ]
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
'/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/'
[junit4] 2> 432054 INFO
(SUITE-TestFiltering-seed#[4D1EBAC1E185F817]-worker) [ ]
o.a.s.c.SolrResourceLoader Adding
'file:/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/classes/'
to classloader
[junit4] 2> 432054 INFO
(SUITE-TestFiltering-seed#[4D1EBAC1E185F817]-worker) [ ]
o.a.s.c.SolrResourceLoader Adding
'file:/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/README'
to classloader
[junit4] 2> 432073 INFO
(SUITE-TestFiltering-seed#[4D1EBAC1E185F817]-worker) [ ] o.a.s.c.SolrConfig
current version of requestparams : -1
[junit4] 2> 432081 INFO
(SUITE-TestFiltering-seed#[4D1EBAC1E185F817]-worker) [ ] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 6.0.0
[junit4] 2> 432100 INFO
(SUITE-TestFiltering-seed#[4D1EBAC1E185F817]-worker) [ ] o.a.s.c.Config
Loaded SolrConfig: solrconfig.xml
[junit4] 2> 432100 INFO
(SUITE-TestFiltering-seed#[4D1EBAC1E185F817]-worker) [ ] o.a.s.s.IndexSchema
Reading Solr Schema from
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/conf/schema_latest.xml
[junit4] 2> 432104 INFO
(SUITE-TestFiltering-seed#[4D1EBAC1E185F817]-worker) [ ] o.a.s.s.IndexSchema
[null] Schema name=example
[junit4] 2> 432155 WARN
(SUITE-TestFiltering-seed#[4D1EBAC1E185F817]-worker) [ ]
o.a.s.s.SpatialRecursivePrefixTreeFieldType units parameter is deprecated,
please use distanceUnits instead for field types with class
SpatialRecursivePrefixTreeFieldType
[junit4] 2> 432157 INFO
(SUITE-TestFiltering-seed#[4D1EBAC1E185F817]-worker) [ ] o.a.s.s.IndexSchema
unique key field: id
[junit4] 2> 432173 INFO
(SUITE-TestFiltering-seed#[4D1EBAC1E185F817]-worker) [ ]
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 432174 INFO
(SUITE-TestFiltering-seed#[4D1EBAC1E185F817]-worker) [ ]
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 432175 INFO
(SUITE-TestFiltering-seed#[4D1EBAC1E185F817]-worker) [ ]
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 432175 INFO
(SUITE-TestFiltering-seed#[4D1EBAC1E185F817]-worker) [ ]
o.a.s.c.SolrResourceLoader using system property solr.solr.home:
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr
[junit4] 2> 432176 INFO
(SUITE-TestFiltering-seed#[4D1EBAC1E185F817]-worker) [ ]
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
'/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/'
[junit4] 2> 432187 INFO
(SUITE-TestFiltering-seed#[4D1EBAC1E185F817]-worker) [ ]
o.a.s.c.CoreContainer New CoreContainer 580110
[junit4] 2> 432187 INFO
(SUITE-TestFiltering-seed#[4D1EBAC1E185F817]-worker) [ ]
o.a.s.c.CoreContainer Loading cores into CoreContainer
[instanceDir=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/]
[junit4] 2> 432187 INFO
(SUITE-TestFiltering-seed#[4D1EBAC1E185F817]-worker) [ ]
o.a.s.c.CoreContainer loading shared library:
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/lib
[junit4] 2> 432187 WARN
(SUITE-TestFiltering-seed#[4D1EBAC1E185F817]-worker) [ ]
o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to
classloader: lib (resolved as:
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/lib).
[junit4] 2> 432192 INFO
(SUITE-TestFiltering-seed#[4D1EBAC1E185F817]-worker) [ ]
o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout :
600000,connTimeout : 60000,maxConnectionsPerHost : 20,maxConnections :
10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime :
5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,
[junit4] 2> 432193 INFO
(SUITE-TestFiltering-seed#[4D1EBAC1E185F817]-worker) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=30000&connTimeout=30000&retry=true
[junit4] 2> 432193 INFO
(SUITE-TestFiltering-seed#[4D1EBAC1E185F817]-worker) [ ] o.a.s.l.LogWatcher
SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 432193 INFO
(SUITE-TestFiltering-seed#[4D1EBAC1E185F817]-worker) [ ] o.a.s.l.LogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 432193 INFO
(SUITE-TestFiltering-seed#[4D1EBAC1E185F817]-worker) [ ]
o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for
authorization module.
[junit4] 2> 432193 INFO
(SUITE-TestFiltering-seed#[4D1EBAC1E185F817]-worker) [ ]
o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 432194 INFO
(SUITE-TestFiltering-seed#[4D1EBAC1E185F817]-worker) [ ] o.a.s.c.SolrCore
Created CoreDescriptor: {name=collection1, config=solrconfig.xml,
transient=false, schema=schema_latest.xml, loadOnStartup=true,
configSetProperties=configsetprops.json, instanceDir=collection1,
collection=collection1,
absoluteInstDir=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/,
dataDir=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.search.TestFiltering_4D1EBAC1E185F817-001/init-core-data-001,
shard=shard1}
[junit4] 2> 432194 INFO (coreLoadExecutor-1240-thread-1) [ ]
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
'/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/'
[junit4] 2> 432195 INFO (coreLoadExecutor-1240-thread-1) [ ]
o.a.s.c.SolrResourceLoader Adding
'file:/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/classes/'
to classloader
[junit4] 2> 432195 INFO (coreLoadExecutor-1240-thread-1) [ ]
o.a.s.c.SolrResourceLoader Adding
'file:/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/README'
to classloader
[junit4] 2> 432213 INFO (coreLoadExecutor-1240-thread-1) [ ]
o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 432222 INFO (coreLoadExecutor-1240-thread-1) [ ]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0
[junit4] 2> 432247 INFO (coreLoadExecutor-1240-thread-1) [ ]
o.a.s.c.Config Loaded SolrConfig: solrconfig.xml
[junit4] 2> 432247 INFO (coreLoadExecutor-1240-thread-1) [ ]
o.a.s.s.IndexSchema Reading Solr Schema from
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/conf/schema_latest.xml
[junit4] 2> 432252 INFO (coreLoadExecutor-1240-thread-1) [ ]
o.a.s.s.IndexSchema [collection1] Schema name=example
[junit4] 2> 432306 WARN (coreLoadExecutor-1240-thread-1) [ ]
o.a.s.s.SpatialRecursivePrefixTreeFieldType units parameter is deprecated,
please use distanceUnits instead for field types with class
SpatialRecursivePrefixTreeFieldType
[junit4] 2> 432308 INFO (coreLoadExecutor-1240-thread-1) [ ]
o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 432318 INFO (coreLoadExecutor-1240-thread-1) [ ]
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 432319 INFO (coreLoadExecutor-1240-thread-1) [ ]
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 432321 INFO (coreLoadExecutor-1240-thread-1) [ ]
o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default
properties: Can't find resource 'configsetprops.json' in classpath or
'/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/conf'
[junit4] 2> 432321 INFO (coreLoadExecutor-1240-thread-1) [ ]
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from
instancedir
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/
[junit4] 2> 432321 INFO (coreLoadExecutor-1240-thread-1) [
x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 432321 INFO (coreLoadExecutor-1240-thread-1) [
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/],
dataDir=[null]
[junit4] 2> 432321 INFO (coreLoadExecutor-1240-thread-1) [
x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr
mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@1e2ba9
[junit4] 2> 432322 INFO (coreLoadExecutor-1240-thread-1) [
x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.search.TestFiltering_4D1EBAC1E185F817-001/init-core-data-001
[junit4] 2> 432322 INFO (coreLoadExecutor-1240-thread-1) [
x:collection1] o.a.s.c.SolrCore New index directory detected: old=null
new=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.search.TestFiltering_4D1EBAC1E185F817-001/init-core-data-001/index/
[junit4] 2> 432322 WARN (coreLoadExecutor-1240-thread-1) [
x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory
'/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.search.TestFiltering_4D1EBAC1E185F817-001/init-core-data-001/index'
doesn't exist. Creating new index...
[junit4] 2> 432322 INFO (coreLoadExecutor-1240-thread-1) [
x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.search.TestFiltering_4D1EBAC1E185F817-001/init-core-data-001/index
[junit4] 2> 432322 INFO (coreLoadExecutor-1240-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=35, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=1.0]
[junit4] 2> 432323 INFO (coreLoadExecutor-1240-thread-1) [
x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1781040
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1d4b5fa),segFN=segments_1,generation=1}
[junit4] 2> 432323 INFO (coreLoadExecutor-1240-thread-1) [
x:collection1] o.a.s.c.SolrCore newest commit generation = 1
[junit4] 2> 432323 INFO
(OldIndexDirectoryCleanupThreadForCore-collection1) [ x:collection1]
o.a.s.c.SolrCore Looking for old index directories to cleanup for core
collection1 in
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.search.TestFiltering_4D1EBAC1E185F817-001/init-core-data-001/
[junit4] 2> 432328 INFO (coreLoadExecutor-1240-thread-1) [
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 432328 INFO (coreLoadExecutor-1240-thread-1) [
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 432328 INFO (coreLoadExecutor-1240-thread-1) [
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating
updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 432328 INFO (coreLoadExecutor-1240-thread-1) [
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"dedupe-allfields"
[junit4] 2> 432328 INFO (coreLoadExecutor-1240-thread-1) [
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 432328 INFO (coreLoadExecutor-1240-thread-1) [
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 432328 INFO (coreLoadExecutor-1240-thread-1) [
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating
updateRequestProcessorChain "uniq-fields"
[junit4] 2> 432328 INFO (coreLoadExecutor-1240-thread-1) [
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4] 2> 432329 INFO (coreLoadExecutor-1240-thread-1) [
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 432329 INFO (coreLoadExecutor-1240-thread-1) [
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 432329 INFO (coreLoadExecutor-1240-thread-1) [
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 432329 INFO (coreLoadExecutor-1240-thread-1) [
x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as
default, creating implicit default
[junit4] 2> 432330 INFO (coreLoadExecutor-1240-thread-1) [
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 432331 INFO (coreLoadExecutor-1240-thread-1) [
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 432332 INFO (coreLoadExecutor-1240-thread-1) [
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 432333 INFO (coreLoadExecutor-1240-thread-1) [
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 432339 INFO (coreLoadExecutor-1240-thread-1) [
x:collection1] o.a.s.c.PluginBag requestHandler : 'lazy' created with
startup=lazy
[junit4] 2> 432342 INFO (coreLoadExecutor-1240-thread-1) [
x:collection1] o.a.s.c.RequestHandlers 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> 432342 WARN (coreLoadExecutor-1240-thread-1) [
x:collection1] o.a.s.c.SolrCore solrconfig.xml uses deprecated
<admin/gettableFiles>, Please update your config to use the
ShowFileRequestHandler.
[junit4] 2> 432343 INFO (coreLoadExecutor-1240-thread-1) [
x:collection1] o.a.s.c.SolrCore Using default statsCache cache:
org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 432343 INFO (coreLoadExecutor-1240-thread-1) [
x:collection1] o.a.s.c.SolrCore Hard AutoCommit: disabled
[junit4] 2> 432343 INFO (coreLoadExecutor-1240-thread-1) [
x:collection1] o.a.s.c.SolrCore Soft AutoCommit: disabled
[junit4] 2> 432343 INFO (coreLoadExecutor-1240-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=17, maxMergeAtOnceExplicit=14, maxMergedSegmentMB=20.654296875,
floorSegmentMB=1.4375, forceMergeDeletesPctAllowed=13.74633062858655,
segmentsPerTier=26.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
[junit4] 2> 432344 INFO (coreLoadExecutor-1240-thread-1) [
x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1781040
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1d4b5fa),segFN=segments_1,generation=1}
[junit4] 2> 432344 INFO (coreLoadExecutor-1240-thread-1) [
x:collection1] o.a.s.c.SolrCore newest commit generation = 1
[junit4] 2> 432344 INFO (coreLoadExecutor-1240-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@abc65a[collection1]
main
[junit4] 2> 432344 INFO (coreLoadExecutor-1240-thread-1) [
x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs:
{storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
[junit4] 2> 432344 INFO (coreLoadExecutor-1240-thread-1) [
x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using
InMemoryStorage
[junit4] 2> 432344 INFO (coreLoadExecutor-1240-thread-1) [
x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
[junit4] 2> 432344 INFO (coreLoadExecutor-1240-thread-1) [
x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 432384 INFO (coreLoadExecutor-1240-thread-1) [
x:collection1] o.a.s.s.DirectSolrSpellChecker init:
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 432585 INFO (coreLoadExecutor-1240-thread-1) [
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 432585 INFO
(searcherExecutor-1241-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 432586 INFO
(searcherExecutor-1241-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 432586 INFO
(searcherExecutor-1241-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 432586 INFO
(searcherExecutor-1241-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker:
multipleFields
[junit4] 2> 432586 INFO
(searcherExecutor-1241-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 432586 INFO
(searcherExecutor-1241-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 432587 INFO
(searcherExecutor-1241-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 432587 INFO (coreLoadExecutor-1240-thread-1) [
x:collection1] o.a.s.c.CoreContainer registering core: collection1
[junit4] 2> 432587 INFO
(searcherExecutor-1241-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 432587 INFO
(searcherExecutor-1241-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 432588 INFO
(SUITE-TestFiltering-seed#[4D1EBAC1E185F817]-worker) [ ]
o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 432588 INFO
(searcherExecutor-1241-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@abc65a[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 432592 INFO
(TEST-TestFiltering.testCaching-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testCaching
[junit4] 2> 432592 INFO
(TEST-TestFiltering.testCaching-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.c.SolrCore [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 432592 INFO
(TEST-TestFiltering.testCaching-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={}
{deleteByQuery=*:*} 0 0
[junit4] 2> 432596 INFO
(TEST-TestFiltering.testCaching-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={}
{add=[4]} 0 1
[junit4] 2> 432597 INFO
(TEST-TestFiltering.testCaching-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={}
{add=[1]} 0 0
[junit4] 2> 432598 INFO
(TEST-TestFiltering.testCaching-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={}
{add=[3]} 0 0
[junit4] 2> 432599 INFO
(TEST-TestFiltering.testCaching-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={}
{add=[2]} 0 0
[junit4] 2> 432599 INFO
(TEST-TestFiltering.testCaching-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.UpdateHandler start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 432602 INFO
(TEST-TestFiltering.testCaching-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1781040
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1d4b5fa),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1781040
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1d4b5fa),segFN=segments_2,generation=2}
[junit4] 2> 432602 INFO
(TEST-TestFiltering.testCaching-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.c.SolrCore newest commit generation = 2
[junit4] 2> 432604 INFO
(TEST-TestFiltering.testCaching-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.s.SolrIndexSearcher Opening Searcher@1264334[collection1] main
[junit4] 2> 432604 INFO
(TEST-TestFiltering.testCaching-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.UpdateHandler end_commit_flush
[junit4] 2> 432607 INFO (searcherExecutor-1241-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@1264334[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):c4)))}
[junit4] 2> 432607 INFO
(TEST-TestFiltering.testCaching-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={}
{commit=} 0 7
[junit4] 2> 432608 INFO
(TEST-TestFiltering.testCaching-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&fq={!frange+l%3D2+u%3D3+cache%3Dfalse+cost%3D100}val_i&wt=xml}
hits=2 status=0 QTime=0
[junit4] 2> 432609 INFO
(TEST-TestFiltering.testCaching-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&fq={!frange+l%3D2+u%3D3+cache%3Dfalse+cost%3D100}val_i&wt=xml}
hits=2 status=0 QTime=0
[junit4] 2> 432610 INFO
(TEST-TestFiltering.testCaching-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&fq={!frange+l%3D2+u%3D4}val_i&wt=xml} hits=3 status=0 QTime=0
[junit4] 2> 432611 INFO
(TEST-TestFiltering.testCaching-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&fq={!frange+l%3D2+u%3D5+cache%3Dfalse}val_i&wt=xml} hits=3
status=0 QTime=0
[junit4] 2> 432611 INFO
(TEST-TestFiltering.testCaching-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&facet.field=id&fq={!frange+l%3D2+u%3D6+cache%3Dfalse+cost%3D100}val_i&facet=true&wt=xml}
hits=3 status=0 QTime=0
[junit4] 2> 432612 INFO
(TEST-TestFiltering.testCaching-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&facet.field=id&fq={!frange+l%3D2+u%3D6+cache%3Dfalse+cost%3D100}val_i&facet=true&wt=xml}
hits=3 status=0 QTime=0
[junit4] 2> 432613 INFO
(TEST-TestFiltering.testCaching-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&facet.field=id&fq={!frange+l%3D2+u%3D7}val_i&facet=true&wt=xml}
hits=3 status=0 QTime=0
[junit4] 2> 432613 INFO
(TEST-TestFiltering.testCaching-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&facet.field=id&fq={!frange+l%3D2+u%3D8+cache%3Dfalse}val_i&facet=true&wt=xml}
hits=3 status=0 QTime=0
[junit4] 2> 432614 INFO
(TEST-TestFiltering.testCaching-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q={!cache%3Dfalse}*:*&fl=val_i&start=2&sort=val_i+asc&rows=1&wt=xml}
hits=4 status=0 QTime=0
[junit4] 2> 432614 INFO
(TEST-TestFiltering.testCaching-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending testCaching
[junit4] 2> 432616 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testRandomFiltering
[junit4] 2> 432616 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.c.SolrCore [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 432617 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={}
{deleteByQuery=*:*} 0 0
[junit4] 2> 432622 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[0]} 0 4
[junit4] 2> 432623 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[1]} 0 0
[junit4] 2> 432623 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[2]} 0 0
[junit4] 2> 432624 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[3]} 0 0
[junit4] 2> 432624 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[3]} 0 0
[junit4] 2> 432624 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[4]} 0 0
[junit4] 2> 432625 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[5]} 0 0
[junit4] 2> 432625 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[6]} 0 0
[junit4] 2> 432625 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[6]} 0 0
[junit4] 2> 432626 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[7]} 0 0
[junit4] 2> 432627 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[8]} 0 0
[junit4] 2> 432627 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[9]} 0 0
[junit4] 2> 432627 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.UpdateHandler start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 432630 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1781040
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1d4b5fa),segFN=segments_2,generation=2}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1781040
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1d4b5fa),segFN=segments_3,generation=3}
[junit4] 2> 432630 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.c.SolrCore newest commit generation = 3
[junit4] 2> 432631 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.s.SolrIndexSearcher Opening Searcher@122e70d[collection1] main
[junit4] 2> 432631 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.UpdateHandler end_commit_flush
[junit4] 2> 432635 INFO (searcherExecutor-1241-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@122e70d[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(6.0.0):c12/2:delGen=1)))}
[junit4] 2> 432635 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={}
{commit=} 0 7
[junit4] 2> 432636 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[10]} 0 0
[junit4] 2> 432637 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[11]} 0 0
[junit4] 2> 432637 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[12]} 0 0
[junit4] 2> 432637 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.UpdateHandler start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 432640 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1781040
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1d4b5fa),segFN=segments_3,generation=3}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1781040
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1d4b5fa),segFN=segments_4,generation=4}
[junit4] 2> 432640 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.c.SolrCore newest commit generation = 4
[junit4] 2> 432641 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.s.SolrIndexSearcher Opening Searcher@2a574d[collection1] main
[junit4] 2> 432641 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.UpdateHandler end_commit_flush
[junit4] 2> 432644 INFO (searcherExecutor-1241-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@2a574d[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(6.0.0):c12/2:delGen=1)
Uninverting(_2(6.0.0):c3)))}
[junit4] 2> 432645 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={}
{commit=} 0 7
[junit4] 2> 432646 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[13]} 0 0
[junit4] 2> 432646 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[14]} 0 0
[junit4] 2> 432647 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[15]} 0 0
[junit4] 2> 432647 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[15]} 0 0
[junit4] 2> 432647 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[16]} 0 0
[junit4] 2> 432647 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[17]} 0 0
[junit4] 2> 432648 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[18]} 0 0
[junit4] 2> 432648 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.UpdateHandler start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 432651 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1781040
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1d4b5fa),segFN=segments_4,generation=4}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1781040
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1d4b5fa),segFN=segments_5,generation=5}
[junit4] 2> 432651 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.c.SolrCore newest commit generation = 5
[junit4] 2> 432652 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.s.SolrIndexSearcher Opening Searcher@1dde725[collection1] main
[junit4] 2> 432652 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.UpdateHandler end_commit_flush
[junit4] 2> 432656 INFO (searcherExecutor-1241-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@1dde725[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(6.0.0):c12/2:delGen=1)
Uninverting(_2(6.0.0):c3) Uninverting(_3(6.0.0):c7/1:delGen=1)))}
[junit4] 2> 432657 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={}
{commit=} 0 9
[junit4] 2> 432658 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[19]} 0 0
[junit4] 2> 432659 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[20]} 0 0
[junit4] 2> 432659 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[21]} 0 0
[junit4] 2> 432659 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[22]} 0 0
[junit4] 2> 432660 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[22]} 0 0
[junit4] 2> 432660 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[23]} 0 0
[junit4] 2> 432660 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[24]} 0 0
[junit4] 2> 432661 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[25]} 0 0
[junit4] 2> 432661 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[26]} 0 0
[junit4] 2> 432662 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[27]} 0 0
[junit4] 2> 432662 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[28]} 0 0
[junit4] 2> 432662 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[29]} 0 0
[junit4] 2> 432663 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[30]} 0 0
[junit4] 2> 432663 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[30]} 0 0
[junit4] 2> 432663 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[31]} 0 0
[junit4] 2> 432664 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[32]} 0 0
[junit4] 2> 432664 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[33]} 0 0
[junit4] 2> 432664 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[34]} 0 0
[junit4] 2> 432664 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[34]} 0 0
[junit4] 2> 432665 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[35]} 0 0
[junit4] 2> 432665 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[36]} 0 0
[junit4] 2> 432666 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[37]} 0 0
[junit4] 2> 432666 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[38]} 0 0
[junit4] 2> 432666 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[38]} 0 0
[junit4] 2> 432667 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[39]} 0 0
[junit4] 2> 432667 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[40]} 0 0
[junit4] 2> 432667 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[41]} 0 0
[junit4] 2> 432667 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[42]} 0 0
[junit4] 2> 432668 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[43]} 0 0
[junit4] 2> 432668 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[44]} 0 0
[junit4] 2> 432668 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[44]} 0 0
[junit4] 2> 432669 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[45]} 0 0
[junit4] 2> 432669 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[46]} 0 0
[junit4] 2> 432669 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[47]} 0 0
[junit4] 2> 432669 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[48]} 0 0
[junit4] 2> 432670 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[49]} 0 0
[junit4] 2> 432670 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[50]} 0 0
[junit4] 2> 432670 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[51]} 0 0
[junit4] 2> 432671 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[51]} 0 0
[junit4] 2> 432671 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[52]} 0 0
[junit4] 2> 432671 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[53]} 0 0
[junit4] 2> 432672 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[54]} 0 0
[junit4] 2> 432672 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[55]} 0 0
[junit4] 2> 432672 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[56]} 0 0
[junit4] 2> 432672 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[56]} 0 0
[junit4] 2> 432673 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[57]} 0 0
[junit4] 2> 432673 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[58]} 0 0
[junit4] 2> 432674 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[59]} 0 0
[junit4] 2> 432674 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[60]} 0 0
[junit4] 2> 432674 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[61]} 0 0
[junit4] 2> 432675 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[62]} 0 0
[junit4] 2> 432675 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[63]} 0 0
[junit4] 2> 432675 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[64]} 0 0
[junit4] 2> 432675 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[65]} 0 0
[junit4] 2> 432676 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[65]} 0 0
[junit4] 2> 432676 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.UpdateHandler start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 432681 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1781040
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1d4b5fa),segFN=segments_5,generation=5}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1781040
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1d4b5fa),segFN=segments_6,generation=6}
[junit4] 2> 432681 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.c.SolrCore newest commit generation = 6
[junit4] 2> 432682 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.s.SolrIndexSearcher Opening Searcher@172a683[collection1] main
[junit4] 2> 432682 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.UpdateHandler end_commit_flush
[junit4] 2> 432687 INFO (searcherExecutor-1241-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@172a683[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(6.0.0):c12/2:delGen=1)
Uninverting(_2(6.0.0):c3) Uninverting(_3(6.0.0):c7/1:delGen=1)
Uninverting(_4(6.0.0):c55/8:delGen=1)))}
[junit4] 2> 432688 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={}
{commit=} 0 11
[junit4] 2> 432689 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[66]} 0 0
[junit4] 2> 432689 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.UpdateHandler start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 432692 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1781040
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1d4b5fa),segFN=segments_6,generation=6}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1781040
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1d4b5fa),segFN=segments_7,generation=7}
[junit4] 2> 432692 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.c.SolrCore newest commit generation = 7
[junit4] 2> 432693 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.s.SolrIndexSearcher Opening Searcher@1767d43[collection1] main
[junit4] 2> 432693 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.UpdateHandler end_commit_flush
[junit4] 2> 432698 INFO (searcherExecutor-1241-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@1767d43[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(6.0.0):c12/2:delGen=1)
Uninverting(_2(6.0.0):c3) Uninverting(_3(6.0.0):c7/1:delGen=1)
Uninverting(_4(6.0.0):c55/8:delGen=1) Uninverting(_5(6.0.0):c1)))}
[junit4] 2> 432699 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={}
{commit=} 0 9
[junit4] 2> 432700 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[67]} 0 0
[junit4] 2> 432700 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[68]} 0 0
[junit4] 2> 432700 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[69]} 0 0
[junit4] 2> 432701 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[70]} 0 0
[junit4] 2> 432701 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[71]} 0 0
[junit4] 2> 432701 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[72]} 0 0
[junit4] 2> 432702 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.UpdateHandler start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 432705 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1781040
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1d4b5fa),segFN=segments_7,generation=7}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1781040
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1d4b5fa),segFN=segments_8,generation=8}
[junit4] 2> 432705 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.c.SolrCore newest commit generation = 8
[junit4] 2> 432706 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.s.SolrIndexSearcher Opening Searcher@df4622[collection1] main
[junit4] 2> 432706 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.UpdateHandler end_commit_flush
[junit4] 2> 432711 INFO (searcherExecutor-1241-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@df4622[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(6.0.0):c12/2:delGen=1)
Uninverting(_2(6.0.0):c3) Uninverting(_3(6.0.0):c7/1:delGen=1)
Uninverting(_4(6.0.0):c55/8:delGen=1) Uninverting(_5(6.0.0):c1)
Uninverting(_6(6.0.0):c6)))}
[junit4] 2> 432712 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={}
{commit=} 0 10
[junit4] 2> 432714 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[73]} 0 0
[junit4] 2> 432714 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[74]} 0 0
[junit4] 2> 432714 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[75]} 0 0
[junit4] 2> 432715 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[75]} 0 0
[junit4] 2> 432715 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[76]} 0 0
[junit4] 2> 432715 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.UpdateHandler start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 432718 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1781040
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1d4b5fa),segFN=segments_8,generation=8}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1781040
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1d4b5fa),segFN=segments_9,generation=9}
[junit4] 2> 432718 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.c.SolrCore newest commit generation = 9
[junit4] 2> 432719 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.s.SolrIndexSearcher Opening Searcher@10199ed[collection1] main
[junit4] 2> 432719 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.UpdateHandler end_commit_flush
[junit4] 2> 432723 INFO (searcherExecutor-1241-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@10199ed[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(6.0.0):c12/2:delGen=1)
Uninverting(_2(6.0.0):c3) Uninverting(_3(6.0.0):c7/1:delGen=1)
Uninverting(_4(6.0.0):c55/8:delGen=1) Uninverting(_5(6.0.0):c1)
Uninverting(_6(6.0.0):c6) Uninverting(_7(6.0.0):c5/1:delGen=1)))}
[junit4] 2> 432724 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={}
{commit=} 0 8
[junit4] 2> 432725 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[77]} 0 0
[junit4] 2> 432725 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={wt=json&indent=true} {add=[78]} 0 0
[junit4] 2> 432725 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.UpdateHandler start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 432729 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1781040
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1d4b5fa),segFN=segments_9,generation=9}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1781040
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1d4b5fa),segFN=segments_a,generation=10}
[junit4] 2> 432729 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.c.SolrCore newest commit generation = 10
[junit4] 2> 432729 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.s.SolrIndexSearcher Opening Searcher@12e0d49[collection1] main
[junit4] 2> 432729 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.UpdateHandler end_commit_flush
[junit4] 2> 432732 INFO (searcherExecutor-1241-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@12e0d49[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(6.0.0):c12/2:delGen=1)
Uninverting(_2(6.0.0):c3) Uninverting(_3(6.0.0):c7/1:delGen=1)
Uninverting(_4(6.0.0):c55/8:delGen=1) Uninverting(_5(6.0.0):c1)
Uninverting(_6(6.0.0):c6) Uninverting(_7(6.0.0):c5/1:delGen=1)
Uninverting(_8(6.0.0):c2)))}
[junit4] 2> 432733 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={}
{commit=} 0 7
[junit4] 2> 432734 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.UpdateHandler start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 432734 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.UpdateHandler No uncommitted changes. Skipping IW.commit.
[junit4] 2> 432734 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.c.SolrCore SolrIndexSearcher has not changed - not re-opening:
org.apache.solr.search.SolrIndexSearcher
[junit4] 2> 432734 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.UpdateHandler end_commit_flush
[junit4] 2> 432734 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={}
{commit=} 0 0
[junit4] 2> 432735 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&wt=xml}
hits=79 status=0 QTime=0
[junit4] 2> 432755 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q={!cache%3Dtrue}+val_i:0+val_i:1+val_i:3+val_i:5+val_i:6+val_i:7+val_i:8+val_i:9+val_i:11+val_i:12+val_i:13+val_i:15+val_i:17+val_i:21+val_i:25+val_i:26+val_i:27+val_i:29+val_i:30+val_i:35+val_i:36+val_i:37+val_i:39+val_i:40+val_i:42+val_i:44+val_i:49+val_i:50+val_i:54+val_i:55+val_i:58+val_i:61+val_i:62+val_i:64+val_i:66+val_i:67+val_i:68+val_i:69+val_i:71+val_i:75+val_i:76&fq=-_query_:"{!frange+v%3Dval_i+l%3D64+u%3D78}"&fq={!+cache%3Dfalse+cost%3D126}-_query_:"val_i:[00040+TO+00079}"&fq={!+cache%3Dtrue+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D37+u%3D78}"&wt=xml}
hits=21 status=0 QTime=19
[junit4] 2> 432759 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q={!frange+v%3Dval_i+l%3D64+u%3D128}&fq=id:RAND838220489+OR+val_i:{00031+TO+00092}&fq={!+cache%3Dtrue+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D5+u%3D78}"&wt=xml}
hits=0 status=0 QTime=2
[junit4] 2> 432772 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery}+-val_i:0+-val_i:1+-val_i:2+-val_i:4+-val_i:7+-val_i:9+-val_i:14+-val_i:17+-val_i:18+-val_i:20+-val_i:21+-val_i:23+-val_i:24+-val_i:25+-val_i:26+-val_i:30+-val_i:31+-val_i:32+-val_i:34+-val_i:35+-val_i:37+-val_i:42+-val_i:45+-val_i:48+-val_i:52+-val_i:53+-val_i:58+-val_i:59+-val_i:68+-val_i:69+-val_i:70+-val_i:75+-val_i:78&q={!+cost%3D11}-_query_:"val_i:[00025+TO+00079}"&fq={!cache%3Dfalse}+val_i:0+val_i:8+val_i:10+val_i:11+val_i:13+val_i:15+val_i:16+val_i:18+val_i:20+val_i:22+val_i:24+val_i:28+val_i:29+val_i:30+val_i:32+val_i:34+val_i:35+val_i:38+val_i:39+val_i:41+val_i:42+val_i:43+val_i:45+val_i:47+val_i:49+val_i:50+val_i:51+val_i:52+val_i:53+val_i:61+val_i:62+val_i:64+val_i:68+val_i:69+val_i:70+val_i:74+val_i:77&facet=true&wt=xml}
hits=11 status=0 QTime=12
[junit4] 2> 432783 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery}-_query_:"{!frange+v%3Dval_i+l%3D54+u%3D78}"&q={!cache%3Dfalse}+-val_i:1+-val_i:2+-val_i:3+-val_i:4+-val_i:10+-val_i:11+-val_i:13+-val_i:15+-val_i:16+-val_i:18+-val_i:19+-val_i:20+-val_i:21+-val_i:22+-val_i:23+-val_i:24+-val_i:26+-val_i:29+-val_i:33+-val_i:34+-val_i:36+-val_i:37+-val_i:38+-val_i:40+-val_i:41+-val_i:44+-val_i:47+-val_i:48+-val_i:49+-val_i:51+-val_i:52+-val_i:55+-val_i:56+-val_i:57+-val_i:59+-val_i:60+-val_i:65+-val_i:66+-val_i:67+-val_i:68+-val_i:70+-val_i:71+-val_i:75+-val_i:76+-val_i:78&fq=-_query_:"{!frange+v%3Dval_i+l%3D22+u%3D78}"&fq=val_i:{00066+TO+00088]&fq=+-val_i:2+-val_i:4+-val_i:6+-val_i:7+-val_i:8+-val_i:9+-val_i:10+-val_i:11+-val_i:12+-val_i:13+-val_i:16+-val_i:19+-val_i:21+-val_i:22+-val_i:23+-val_i:25+-val_i:28+-val_i:29+-val_i:30+-val_i:34+-val_i:36+-val_i:37+-val_i:38+-val_i:46+-val_i:47+-val_i:49+-val_i:50+-val_i:51+-val_i:52+-val_i:55+-val_i:56+-val_i:57+-val_i:58+-val_i:59+-val_i:60+-val_i:64+-val_i:67+-val_i:68+-val_i:69+-val_i:71+-val_i:72+-val_i:73+-val_i:75+-val_i:77&facet=true&wt=xml}
hits=0 status=0 QTime=10
[junit4] 2> 432788 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=val_s:[00021+TO+00095]&fq={!frange+v%3Dval_i+l%3D53+u%3D122}&fq={!+cache%3Dtrue+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D33+u%3D78}"&fq={!frange+v%3Dval_i+l%3D30+u%3D54+cache%3Dfalse+cost%3D20}&fq={!+cache%3Dtrue+tag%3Dt}val_i:{00037+TO+00101]+AND+val_i:[00038+TO+00102}&wt=xml}
hits=0 status=0 QTime=4
[junit4] 2> 432793 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery+cache%3Dfalse+cost%3D188}+val_i:0+val_i:4+val_i:5+val_i:7+val_i:9+val_i:10+val_i:13+val_i:15+val_i:16+val_i:18+val_i:19+val_i:20+val_i:21+val_i:22+val_i:23+val_i:24+val_i:25+val_i:26+val_i:27+val_i:28+val_i:29+val_i:33+val_i:34+val_i:40+val_i:43+val_i:45+val_i:48+val_i:49+val_i:51+val_i:52+val_i:53+val_i:54+val_i:55+val_i:57+val_i:62+val_i:63+val_i:64+val_i:67+val_i:68+val_i:70+val_i:72+val_i:74+val_i:76+val_i:78&q={!frange+v%3Dval_i+l%3D60+u%3D84+cache%3Dfalse}&fq={!frange+v%3Dval_i+l%3D31+u%3D95+cost%3D176+tag%3Dt}&fq={!frange+v%3Dval_i+l%3D0+u%3D53}&facet=true&wt=xml}
hits=0 status=0 QTime=4
[junit4] 2> 432794 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q={!+cache%3Dtrue+tag%3Dt}val_i:{00060+TO+00112]&wt=xml} hits=18
status=0 QTime=1
[junit4] 2> 432798 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery+cache%3Dfalse+cost%3D72}+val_i:1+val_i:2+val_i:3+val_i:5+val_i:8+val_i:9+val_i:14+val_i:15+val_i:17+val_i:19+val_i:20+val_i:23+val_i:24+val_i:26+val_i:27+val_i:29+val_i:30+val_i:31+val_i:33+val_i:34+val_i:39+val_i:41+val_i:43+val_i:46+val_i:48+val_i:49+val_i:53+val_i:57+val_i:60+val_i:63+val_i:66+val_i:67+val_i:69+val_i:70+val_i:73+val_i:75+val_i:77&q={!+cache%3Dfalse+cost%3D197+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D62+u%3D78}"&facet=true&wt=xml}
hits=62 status=0 QTime=3
[junit4] 2> 432816 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery+frange+v%3Dval_i+l%3D67+u%3D116}&q={!cache%3Dfalse+cost%3D47}+-val_i:2+-val_i:4+-val_i:6+-val_i:7+-val_i:8+-val_i:11+-val_i:13+-val_i:14+-val_i:15+-val_i:16+-val_i:17+-val_i:19+-val_i:20+-val_i:24+-val_i:28+-val_i:29+-val_i:30+-val_i:33+-val_i:35+-val_i:36+-val_i:40+-val_i:41+-val_i:42+-val_i:43+-val_i:44+-val_i:45+-val_i:46+-val_i:47+-val_i:48+-val_i:49+-val_i:50+-val_i:51+-val_i:53+-val_i:56+-val_i:58+-val_i:59+-val_i:65+-val_i:67+-val_i:68+-val_i:69+-val_i:70+-val_i:71+-val_i:75+-val_i:77&fq={!frange+v%3Dval_i+l%3D70+u%3D87+cache%3Dfalse}&fq={!+cache%3Dfalse+tag%3Dt}-_query_:"val_i:[00036+TO+00078]"&fq={!cache%3Dtrue+tag%3Dt}+-val_i:2+-val_i:3+-val_i:7+-val_i:8+-val_i:9+-val_i:10+-val_i:11+-val_i:13+-val_i:14+-val_i:15+-val_i:18+-val_i:19+-val_i:23+-val_i:25+-val_i:26+-val_i:27+-val_i:28+-val_i:33+-val_i:36+-val_i:37+-val_i:40+-val_i:42+-val_i:44+-val_i:46+-val_i:47+-val_i:48+-val_i:49+-val_i:50+-val_i:51+-val_i:52+-val_i:53+-val_i:62+-val_i:63+-val_i:65+-val_i:68+-val_i:69+-val_i:74&fq={!cache%3Dfalse+cost%3D199}+val_i:0+val_i:1+val_i:6+val_i:7+val_i:8+val_i:9+val_i:10+val_i:12+val_i:15+val_i:18+val_i:21+val_i:22+val_i:23+val_i:24+val_i:26+val_i:29+val_i:30+val_i:32+val_i:33+val_i:35+val_i:37+val_i:38+val_i:39+val_i:40+val_i:43+val_i:44+val_i:45+val_i:46+val_i:49+val_i:50+val_i:51+val_i:53+val_i:54+val_i:56+val_i:57+val_i:59+val_i:60+val_i:62+val_i:65+val_i:67+val_i:68+val_i:70+val_i:72+val_i:73+val_i:75+val_i:77&facet=true&wt=xml}
hits=0 status=0 QTime=17
[junit4] 2> 432840 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery}val_i:[00002+TO+00053]+OR+id:RAND381067611&q={!cache%3Dtrue+tag%3Dt}+val_i:1+val_i:2+val_i:4+val_i:8+val_i:9+val_i:11+val_i:14+val_i:18+val_i:20+val_i:21+val_i:22+val_i:23+val_i:24+val_i:25+val_i:28+val_i:29+val_i:32+val_i:37+val_i:38+val_i:41+val_i:45+val_i:46+val_i:49+val_i:53+val_i:54+val_i:55+val_i:58+val_i:62+val_i:63+val_i:66+val_i:68+val_i:69+val_i:71+val_i:72+val_i:73+val_i:74+val_i:75+val_i:76+val_i:78&fq=-_query_:"{!frange+v%3Dval_i+l%3D58+u%3D78}"&fq={!cache%3Dfalse+tag%3Dt}+val_i:0+val_i:1+val_i:2+val_i:3+val_i:5+val_i:7+val_i:9+val_i:14+val_i:19+val_i:23+val_i:25+val_i:29+val_i:30+val_i:33+val_i:34+val_i:36+val_i:40+val_i:41+val_i:42+val_i:45+val_i:49+val_i:52+val_i:56+val_i:61+val_i:62+val_i:64+val_i:65+val_i:66+val_i:67+val_i:71+val_i:72+val_i:76+val_i:78&fq={!frange+v%3Dval_i+l%3D0+u%3D68}&facet=true&wt=xml}
hits=10 status=0 QTime=23
[junit4] 2> 432847 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery++cache%3Dfalse}-_query_:"val_s:[00065+TO+00079}"&q={!cache%3Dtrue}+-val_i:2+-val_i:4+-val_i:6+-val_i:8+-val_i:9+-val_i:10+-val_i:13+-val_i:18+-val_i:20+-val_i:23+-val_i:26+-val_i:28+-val_i:30+-val_i:31+-val_i:34+-val_i:38+-val_i:39+-val_i:41+-val_i:42+-val_i:46+-val_i:47+-val_i:48+-val_i:49+-val_i:52+-val_i:55+-val_i:58+-val_i:60+-val_i:64+-val_i:65+-val_i:66+-val_i:67+-val_i:69+-val_i:71+-val_i:73+-val_i:75&fq={!}val_i:{00017+TO+00078}&facet=true&wt=xml}
hits=32 status=0 QTime=5
[junit4] 2> 432852 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery+}-_query_:"val_i:{00066+TO+00079}"&q={!+cache%3Dtrue+tag%3Dt}-_query_:"val_i:{00013+TO+00079}"&fq={!+tag%3Dt}-_query_:"val_i:[00017+TO+00078]"&fq={!+cache%3Dfalse+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D40+u%3D78}"&facet=true&wt=xml}
hits=14 status=0 QTime=4
[junit4] 2> 432859 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q={!cache%3Dfalse+cost%3D44+tag%3Dt}+val_i:0+val_i:1+val_i:4+val_i:6+val_i:7+val_i:10+val_i:12+val_i:13+val_i:15+val_i:20+val_i:21+val_i:22+val_i:26+val_i:27+val_i:30+val_i:31+val_i:33+val_i:34+val_i:36+val_i:37+val_i:38+val_i:41+val_i:43+val_i:46+val_i:48+val_i:50+val_i:51+val_i:54+val_i:59+val_i:60+val_i:61+val_i:64+val_i:65+val_i:68+val_i:70+val_i:71+val_i:72+val_i:73+val_i:75+val_i:76+val_i:78&fq={!cache%3Dfalse}+-val_i:1+-val_i:3+-val_i:5+-val_i:8+-val_i:11+-val_i:13+-val_i:16+-val_i:17+-val_i:19+-val_i:25+-val_i:26+-val_i:27+-val_i:28+-val_i:31+-val_i:36+-val_i:37+-val_i:42+-val_i:43+-val_i:45+-val_i:46+-val_i:47+-val_i:48+-val_i:49+-val_i:50+-val_i:52+-val_i:53+-val_i:54+-val_i:56+-val_i:57+-val_i:59+-val_i:60+-val_i:61+-val_i:62+-val_i:63+-val_i:66+-val_i:67+-val_i:68+-val_i:69+-val_i:70+-val_i:71+-val_i:72+-val_i:78&fq={!+cache%3Dfalse+cost%3D145}-_query_:"{!frange+v%3Dval_i+l%3D48+u%3D78}"&wt=xml}
hits=15 status=0 QTime=6
[junit4] 2> 432865 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery++cache%3Dfalse+cost%3D70}val_s:[00033+TO+00093]&q={!+cache%3Dtrue+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D38+u%3D78}"&fq={!+cache%3Dtrue+tag%3Dt}val_s:[00060+TO+00107]+OR+val_s:{00059+TO+00108}&fq=val_i:[00055+TO+00104}&fq={!frange+v%3Dval_i+l%3D28+u%3D98+cache%3Dtrue+tag%3Dt}&fq={!+cache%3Dfalse}-_query_:"val_s:{00060+TO+00078]"&facet=true&wt=xml}
hits=0 status=0 QTime=4
[junit4] 2> 432879 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery+cache%3Dfalse}+val_i:1+val_i:2+val_i:4+val_i:5+val_i:6+val_i:7+val_i:10+val_i:11+val_i:13+val_i:14+val_i:15+val_i:16+val_i:17+val_i:22+val_i:23+val_i:24+val_i:25+val_i:26+val_i:27+val_i:28+val_i:29+val_i:31+val_i:32+val_i:35+val_i:37+val_i:38+val_i:40+val_i:42+val_i:43+val_i:44+val_i:46+val_i:48+val_i:49+val_i:52+val_i:54+val_i:55+val_i:56+val_i:57+val_i:61+val_i:62+val_i:63+val_i:64+val_i:67+val_i:68+val_i:69+val_i:70+val_i:71+val_i:73&q={!+cache%3Dtrue+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D77+u%3D78}"&fq={!cache%3Dfalse}+val_i:2+val_i:3+val_i:6+val_i:8+val_i:12+val_i:13+val_i:14+val_i:15+val_i:17+val_i:18+val_i:20+val_i:22+val_i:23+val_i:24+val_i:27+val_i:29+val_i:30+val_i:34+val_i:35+val_i:38+val_i:42+val_i:44+val_i:45+val_i:46+val_i:48+val_i:50+val_i:51+val_i:56+val_i:57+val_i:58+val_i:59+val_i:61+val_i:62+val_i:63+val_i:64+val_i:65+val_i:67+val_i:68+val_i:69+val_i:71+val_i:72+val_i:73+val_i:74+val_i:75+val_i:78&fq={!cache%3Dfalse+tag%3Dt}+val_i:0+val_i:4+val_i:5+val_i:6+val_i:10+val_i:16+val_i:21+val_i:30+val_i:31+val_i:33+val_i:35+val_i:36+val_i:37+val_i:41+val_i:43+val_i:46+val_i:47+val_i:49+val_i:52+val_i:53+val_i:57+val_i:58+val_i:60+val_i:63+val_i:64+val_i:65+val_i:66+val_i:69+val_i:70+val_i:74+val_i:75+val_i:78&fq={!cache%3Dfalse+cost%3D127+tag%3Dt}+val_i:0+val_i:2+val_i:8+val_i:9+val_i:15+val_i:16+val_i:18+val_i:19+val_i:21+val_i:22+val_i:26+val_i:27+val_i:29+val_i:31+val_i:33+val_i:34+val_i:37+val_i:38+val_i:40+val_i:48+val_i:50+val_i:51+val_i:54+val_i:55+val_i:58+val_i:59+val_i:64+val_i:66+val_i:67+val_i:69+val_i:73+val_i:74+val_i:75+val_i:76+val_i:78&fq=-_query_:"val_s:[00044+TO+00078]"&facet=true&wt=xml}
hits=0 status=0 QTime=13
[junit4] 2> 432886 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery++cache%3Dfalse+cost%3D29}val_i:{00077+TO+00079}+OR+val_i:[00078+TO+00078]&q={!frange+v%3Dval_i+l%3D49+u%3D80+cache%3Dfalse}&fq={!cache%3Dtrue+tag%3Dt}+-val_i:0+-val_i:1+-val_i:3+-val_i:7+-val_i:9+-val_i:10+-val_i:11+-val_i:12+-val_i:14+-val_i:15+-val_i:18+-val_i:19+-val_i:21+-val_i:22+-val_i:24+-val_i:30+-val_i:33+-val_i:36+-val_i:41+-val_i:42+-val_i:43+-val_i:47+-val_i:49+-val_i:50+-val_i:51+-val_i:52+-val_i:53+-val_i:56+-val_i:58+-val_i:59+-val_i:61+-val_i:63+-val_i:64+-val_i:65+-val_i:67+-val_i:70+-val_i:72+-val_i:73+-val_i:74+-val_i:77+-val_i:78&fq=val_s:{00026+TO+00075}&fq={!+cost%3D70}-_query_:"val_s:{00003+TO+00079}"&fq={!+cache%3Dfalse+tag%3Dt}-_query_:"val_i:[00030+TO+00079}"&facet=true&wt=xml}
hits=0 status=0 QTime=6
[junit4] 2> 432891 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery+cache%3Dfalse}+val_i:1+val_i:3+val_i:7+val_i:13+val_i:15+val_i:16+val_i:18+val_i:19+val_i:21+val_i:22+val_i:23+val_i:25+val_i:26+val_i:27+val_i:30+val_i:33+val_i:35+val_i:36+val_i:40+val_i:41+val_i:44+val_i:45+val_i:46+val_i:49+val_i:51+val_i:53+val_i:54+val_i:55+val_i:60+val_i:64+val_i:65+val_i:68+val_i:70+val_i:71+val_i:72+val_i:74+val_i:75+val_i:76+val_i:77+val_i:78&q={!+cache%3Dfalse+cost%3D19+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D76+u%3D81}"&fq={!+cost%3D17+tag%3Dt}val_s:[00067+TO+00104}+OR+val_s:{00066+TO+00103]&facet=true&wt=xml}
hits=9 status=0 QTime=4
[junit4] 2> 432902 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q={!frange+v%3Dval_i+l%3D5+u%3D59+cache%3Dtrue+tag%3Dt}&group.main=true&fq={!+cache%3Dfalse+tag%3Dt}-_query_:"val_s:{00073+TO+00078]"&fq=+val_i:0+val_i:5+val_i:7+val_i:8+val_i:10+val_i:13+val_i:14+val_i:16+val_i:18+val_i:22+val_i:25+val_i:30+val_i:32+val_i:34+val_i:37+val_i:38+val_i:39+val_i:41+val_i:42+val_i:47+val_i:51+val_i:52+val_i:53+val_i:55+val_i:56+val_i:57+val_i:58+val_i:64+val_i:65+val_i:67+val_i:68+val_i:69+val_i:74+val_i:75+val_i:76&fq={!frange+v%3Dval_i+l%3D56+u%3D127+tag%3Dt}&fq={!frange+v%3Dval_i+l%3D65+u%3D92+cache%3Dfalse+cost%3D187+tag%3Dt}&wt=xml&group.field=id&group=true}
hits=0 status=0 QTime=10
[junit4] 2> 432906 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery}-_query_:"{!frange+v%3Dval_i+l%3D35+u%3D78}"&q={!frange+v%3Dval_i+l%3D49+u%3D119}&fq={!cache%3Dfalse+cost%3D108}+-val_i:2+-val_i:3+-val_i:5+-val_i:7+-val_i:8+-val_i:9+-val_i:13+-val_i:15+-val_i:16+-val_i:19+-val_i:21+-val_i:23+-val_i:31+-val_i:32+-val_i:33+-val_i:35+-val_i:37+-val_i:38+-val_i:39+-val_i:40+-val_i:42+-val_i:43+-val_i:44+-val_i:45+-val_i:48+-val_i:51+-val_i:52+-val_i:53+-val_i:54+-val_i:55+-val_i:58+-val_i:61+-val_i:66+-val_i:67+-val_i:71+-val_i:72+-val_i:74+-val_i:75+-val_i:78&fq={!+cache%3Dfalse+cost%3D188}-_query_:"{!frange+v%3Dval_i+l%3D43+u%3D78}"&facet=true&wt=xml}
hits=0 status=0 QTime=3
[junit4] 2> 432915 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery+cache%3Dtrue}+val_i:0+val_i:1+val_i:3+val_i:6+val_i:13+val_i:14+val_i:19+val_i:21+val_i:23+val_i:24+val_i:25+val_i:26+val_i:27+val_i:28+val_i:30+val_i:34+val_i:35+val_i:36+val_i:37+val_i:39+val_i:41+val_i:43+val_i:44+val_i:45+val_i:47+val_i:48+val_i:51+val_i:52+val_i:56+val_i:57+val_i:58+val_i:59+val_i:60+val_i:62+val_i:69+val_i:71+val_i:76+val_i:77+val_i:78&q={!+cache%3Dfalse}-_query_:"val_s:[00073+TO+00079}"&fq={!+cache%3Dfalse+tag%3Dt}-_query_:"val_s:{00043+TO+00078]"&fq={!cache%3Dfalse+cost%3D128}+val_i:1+val_i:3+val_i:4+val_i:5+val_i:10+val_i:19+val_i:20+val_i:21+val_i:22+val_i:23+val_i:24+val_i:27+val_i:28+val_i:31+val_i:33+val_i:37+val_i:38+val_i:40+val_i:41+val_i:45+val_i:46+val_i:50+val_i:51+val_i:54+val_i:58+val_i:61+val_i:62+val_i:72+val_i:76+val_i:77&fq={!+cache%3Dfalse}-_query_:"val_i:[00077+TO+00080]"&facet=true&wt=xml}
hits=19 status=0 QTime=8
[junit4] 2> 432923 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery}-_query_:"{!frange+v%3Dval_i+l%3D42+u%3D78}"&q={!cache%3Dtrue+tag%3Dt}+-val_i:0+-val_i:1+-val_i:2+-val_i:3+-val_i:4+-val_i:6+-val_i:9+-val_i:10+-val_i:14+-val_i:15+-val_i:16+-val_i:17+-val_i:19+-val_i:20+-val_i:21+-val_i:22+-val_i:23+-val_i:24+-val_i:25+-val_i:28+-val_i:30+-val_i:31+-val_i:32+-val_i:34+-val_i:35+-val_i:36+-val_i:37+-val_i:38+-val_i:40+-val_i:41+-val_i:43+-val_i:46+-val_i:48+-val_i:51+-val_i:52+-val_i:54+-val_i:56+-val_i:58+-val_i:60+-val_i:63+-val_i:66+-val_i:69+-val_i:73+-val_i:75+-val_i:76&fq={!cache%3Dtrue}+val_i:1+val_i:6+val_i:11+val_i:13+val_i:14+val_i:15+val_i:16+val_i:18+val_i:19+val_i:20+val_i:22+val_i:23+val_i:24+val_i:29+val_i:32+val_i:41+val_i:43+val_i:44+val_i:45+val_i:46+val_i:48+val_i:51+val_i:52+val_i:53+val_i:58+val_i:60+val_i:61+val_i:62+val_i:63+val_i:70+val_i:71+val_i:72+val_i:73+val_i:75&facet=true&wt=xml}
hits=12 status=0 QTime=7
[junit4] 2> 432930 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[4D1EBAC1E185F817]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery++cache%3Dfalse+cost%3D62}val_i:{00056+TO+00069]+OR+id:RAND1811134257&q={!cache%3Dtrue+tag%3Dt}+val_i:0+val_i:1+val_i:2+val_i:3+val_i:4+val_i:5+val_i:6+val_i:9+val_i:10+val_i:11+val_i:12+val_i:15+val_i:16+val_i:17+val_i:18+val_i:19+val_i:23+val_i:24+val_i:26+val_i:27+val_i:28+val_i:32+val_i:33+val_i:34+val_i:36+val_i:38+val_i:39+val_i:40+val_i:46+val_i:47+val_i:50+val_i:51+val_i:52+val_i:53+val_i:55+val_i:56+val_i:57+val_i:61+val_i:63+val_i:71+val_i:7
[...truncated too long message...]
va:241)
[junit4] 2> at
org.apache.solr.cloud.ElectionContext.cancelElection(ElectionContext.java:85)
[junit4] 2> at
org.apache.solr.cloud.ShardLeaderElectionContextBase.cancelElection(ElectionContext.java:166)
[junit4] 2> at
org.apache.solr.cloud.ShardLeaderElectionContext.cancelElection(ElectionContext.java:267)
[junit4] 2> at
org.apache.solr.cloud.ShardLeaderElectionContext.runLeaderProcess(ElectionContext.java:449)
[junit4] 2> at
org.apache.solr.cloud.LeaderElector.runIamLeaderProcess(LeaderElector.java:197)
[junit4] 2> at
org.apache.solr.cloud.LeaderElector.checkIfIamLeader(LeaderElector.java:157)
[junit4] 2> at
org.apache.solr.cloud.LeaderElector.access$200(LeaderElector.java:58)
[junit4] 2> at
org.apache.solr.cloud.LeaderElector$ElectionWatcher.process(LeaderElector.java:388)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient$3$1.run(SolrZkClient.java:269)
[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
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1.run(ExecutorUtil.java:231)
[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> 1538846 INFO
(TEST-SolrCloudExampleTest.testLoadDocsIntoGettingStartedCollection-seed#[4D1EBAC1E185F817])
[ ] o.e.j.s.ServerConnector Stopped
ServerConnector@52fd8e{HTTP/1.1}{127.0.0.1:0}
[junit4] 2> 1538846 INFO
(TEST-SolrCloudExampleTest.testLoadDocsIntoGettingStartedCollection-seed#[4D1EBAC1E185F817])
[ ] o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@ba5aeb{/,null,UNAVAILABLE}
[junit4] 2> 1538848 INFO
(TEST-SolrCloudExampleTest.testLoadDocsIntoGettingStartedCollection-seed#[4D1EBAC1E185F817])
[n:127.0.0.1:59370_ c:collection1 s:shard1 r:core_node4 x:collection1]
o.a.s.c.ZkTestServer connecting to 127.0.0.1:34223 34223
[junit4] 2> 1538957 INFO (Thread-4731) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:34223 34223
[junit4] 2> 1538958 WARN (Thread-4731) [ ] o.a.s.c.ZkTestServer Watch
limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 9 /solr/aliases.json
[junit4] 2> 8 /solr/configs/gettingstarted/managed-schema
[junit4] 2> 8 /solr/configs/gettingstarted
[junit4] 2> 5 /solr/security.json
[junit4] 2> 5 /solr/configs/conf1
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 9 /solr/clusterstate.json
[junit4] 2> 4 /solr/collections/collection1/state.json
[junit4] 2> 4 /solr/collections/gettingstarted/state.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 9 /solr/live_nodes
[junit4] 2> 9 /solr/collections
[junit4] 2> 4 /solr/overseer/queue
[junit4] 2> 4 /solr/overseer/collection-queue-work
[junit4] 2>
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=SolrCloudExampleTest
-Dtests.method=testLoadDocsIntoGettingStartedCollection
-Dtests.seed=4D1EBAC1E185F817 -Dtests.multiplier=3 -Dtests.slow=true
-Dtests.locale=lv_LV -Dtests.timezone=America/North_Dakota/New_Salem
-Dtests.asserts=true -Dtests.file.encoding=US-ASCII
[junit4] FAILURE 42.1s J2 |
SolrCloudExampleTest.testLoadDocsIntoGettingStartedCollection <<<
[junit4] > Throwable #1: java.lang.AssertionError: Delete action failed!
[junit4] > at
__randomizedtesting.SeedInfo.seed([4D1EBAC1E185F817:5E7D88AED0EA41B1]:0)
[junit4] > at
org.apache.solr.cloud.SolrCloudExampleTest.doTestDeleteAction(SolrCloudExampleTest.java:169)
[junit4] > at
org.apache.solr.cloud.SolrCloudExampleTest.testLoadDocsIntoGettingStartedCollection(SolrCloudExampleTest.java:145)
[junit4] > at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:963)
[junit4] > at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:938)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 1538972 INFO
(SUITE-SolrCloudExampleTest-seed#[4D1EBAC1E185F817]-worker) [n:127.0.0.1:59370_
c:collection1 s:shard1 r:core_node4 x:collection1] o.a.s.SolrTestCaseJ4
###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at:
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.SolrCloudExampleTest_4D1EBAC1E185F817-001
[junit4] 2> Oct 08, 2015 6:24:13 PM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 1 leaked
thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene53): {},
docValues:{}, sim=RandomSimilarityProvider(queryNorm=true,coord=yes): {},
locale=lv_LV, timezone=America/North_Dakota/New_Salem
[junit4] 2> NOTE: Linux 3.19.0-30-generic i386/Oracle Corporation 1.8.0_60
(32-bit)/cpus=12,threads=1,free=162831264,total=536870912
[junit4] 2> NOTE: All tests run in this JVM: [LeaderElectionTest,
HdfsLockFactoryTest, PrimitiveFieldTypeTest, RuleEngineTest, TestConfigSetsAPI,
TestManagedSynonymFilterFactory, HighlighterConfigTest,
IgnoreCommitOptimizeUpdateProcessorFactoryTest, TestCursorMarkWithoutUniqueKey,
TestFastLRUCache, SuggesterWFSTTest, SampleTest,
TestManagedSchemaDynamicFieldResource, TestGroupingSearch, JavabinLoaderTest,
SuggesterTSTTest, NoCacheHeaderTest, CoreAdminRequestStatusTest,
TestCollapseQParserPlugin, AssignTest, FullSolrCloudDistribCmdsTest,
TestJsonRequest, HdfsDirectoryFactoryTest, TestMiniSolrCloudCluster,
TestTolerantSearch, SpatialHeatmapFacetsTest, TestConfigSetsAPIExclusivity,
TestBulkSchemaAPI, TestCollationField, TestPostingsSolrHighlighter,
QueryParsingTest, TestDefaultStatsCache, SSLMigrationTest, DocValuesMultiTest,
OverseerTest, SystemInfoHandlerTest, AsyncMigrateRouteKeyTest,
TestSortByMinMaxFunction, TermVectorComponentDistributedTest,
TestPerFieldSimilarity, TestConfigReload, TestWriterPerf, SearchHandlerTest,
RAMDirectoryFactoryTest, TestDynamicLoading, ExplicitHLLTest,
UnloadDistributedZkTest, TestIndexSearcher, TestReload, BadIndexSchemaTest,
SegmentsInfoRequestHandlerTest, ResponseHeaderTest,
DocExpirationUpdateProcessorFactoryTest, UUIDFieldTest,
DirectUpdateHandlerTest, TestRuleBasedAuthorizationPlugin, DeleteReplicaTest,
TestHighFrequencyDictionaryFactory, OverseerCollectionConfigSetProcessorTest,
TestStressReorder, CloudMLTQParserTest, PluginInfoTest,
BinaryUpdateRequestHandlerTest, TestStressRecovery, TestFastWriter,
TestExactSharedStatsCache, TestSolrQueryParserResource, TestCharFilters,
UpdateParamsTest, HdfsRecoverLeaseTest, HdfsThreadLeakTest, TestCryptoKeys,
OverseerTaskQueueTest, SpatialRPTFieldTypeTest, RegexBoostProcessorTest,
TestRecovery, TestSQLHandler, StatsComponentTest, TestCustomDocTransformer,
StatelessScriptUpdateProcessorFactoryTest, TestCloudPivotFacet,
HdfsRecoveryZkTest, SolrCoreCheckLockOnStartupTest,
TestDefaultSimilarityFactory, SimpleFacetsTest, TestDistribDocBasedVersion,
TestSolrIndexConfig, TestElisionMultitermQuery, ChaosMonkeySafeLeaderTest,
BasicDistributedZk2Test, CollectionsAPIDistributedZkTest, TestZkChroot,
ZkCLITest, ShardRoutingCustomTest, AutoCommitTest, TestStressVersions,
TestRangeQuery, SpellCheckComponentTest, TestLazyCores,
ShowFileRequestHandlerTest, CurrencyFieldXmlFileTest, SolrIndexSplitterTest,
TestCoreDiscovery, TestExtendedDismaxParser, SuggesterFSTTest,
SolrRequestParserTest, TestFoldingMultitermQuery, DocValuesTest,
SpatialFilterTest, PolyFieldTest, TestWordDelimiterFilterFactory,
SortByFunctionTest, CacheHeaderTest, LukeRequestHandlerTest,
TestReversedWildcardFilterFactory, FileBasedSpellCheckerTest,
TestValueSourceCache, TermVectorComponentTest, FieldAnalysisRequestHandlerTest,
SolrPluginUtilsTest, UpdateRequestProcessorFactoryTest, JSONWriterTest,
JsonLoaderTest, TestPHPSerializedResponseWriter, CSVRequestHandlerTest,
TestComponentsName, TestLFUCache, TestSimpleTrackingShardHandler,
AsyncCallRequestStatusResponseTest, CdcrReplicationDistributedZkTest,
CdcrRequestHandlerTest, CollectionsAPIAsyncDistributedZkTest,
ConnectionManagerTest, DistributedQueueTest, LeaderFailoverAfterPartitionTest,
MultiThreadedOCPTest, SolrCloudExampleTest]
[junit4] Completed [429/547] on J2 in 42.67s, 1 test, 1 failure <<< FAILURES!
[...truncated 383 lines...]
BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:775: The following
error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:719: The following
error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:59: The following
error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build.xml:233: The
following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/common-build.xml:516: The
following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:1432:
The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:987:
There were test failures: 547 suites (8 ignored), 2148 tests, 2 failures, 72
ignored (36 assumptions) [seed: 4D1EBAC1E185F817]
Total time: 51 minutes 43 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
[WARNINGS] Skipping publisher since build result is FAILURE
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]
