Build:
https://ci-builds.apache.org/job/Lucene/job/Lucene-Solr-NightlyTests-8.x/412/
2 tests failed.
FAILED: org.apache.solr.search.TestFiltering.testRandomFiltering
Error Message:
Test abandoned because suite timeout was reached.
Stack Trace:
java.lang.Exception: Test abandoned because suite timeout was reached.
at __randomizedtesting.SeedInfo.seed([941028414E3EFF6C]:0)
FAILED: junit.framework.TestSuite.org.apache.solr.search.TestFiltering
Error Message:
Suite timeout exceeded (>= 7200000 msec).
Stack Trace:
java.lang.Exception: Suite timeout exceeded (>= 7200000 msec).
at __randomizedtesting.SeedInfo.seed([941028414E3EFF6C]:0)
Build Log:
[...truncated 16555 lines...]
[junit4] Suite: org.apache.solr.search.TestFiltering
[junit4] 2> 4376848 INFO
(SUITE-TestFiltering-seed#[941028414E3EFF6C]-worker) [ ] o.a.s.SolrTestCase
Setting 'solr.default.confdir' system property to test-framework derived value
of
'/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/server/solr/configsets/_default/conf'
[junit4] 2> 4376849 INFO
(SUITE-TestFiltering-seed#[941028414E3EFF6C]-worker) [ ]
o.a.s.SolrTestCaseJ4 Created dataDir:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J2/temp/solr.search.TestFiltering_941028414E3EFF6C-001/data-dir-178-001
[junit4] 2> 4376849 WARN
(SUITE-TestFiltering-seed#[941028414E3EFF6C]-worker) [ ]
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=4 numCloses=4
[junit4] 2> 4376849 INFO
(SUITE-TestFiltering-seed#[941028414E3EFF6C]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 4376851 INFO
(SUITE-TestFiltering-seed#[941028414E3EFF6C]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via:
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 4376851 INFO
(SUITE-TestFiltering-seed#[941028414E3EFF6C]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 4376851 INFO
(SUITE-TestFiltering-seed#[941028414E3EFF6C]-worker) [ ]
o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 4376858 INFO
(SUITE-TestFiltering-seed#[941028414E3EFF6C]-worker) [ ]
o.a.s.c.SolrResourceLoader Added 2 libs to classloader, from paths:
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1/lib,
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 4376875 INFO
(SUITE-TestFiltering-seed#[941028414E3EFF6C]-worker) [ ] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 8.11.0
[junit4] 2> 4376875 WARN
(SUITE-TestFiltering-seed#[941028414E3EFF6C]-worker) [ ] o.a.s.c.SolrConfig
solrconfig.xml: <boolTofilterOptimizer> is currently not implemented and has no
effect.
[junit4] 2> 4376875 WARN
(SUITE-TestFiltering-seed#[941028414E3EFF6C]-worker) [ ] o.a.s.c.SolrConfig
solrconfig.xml: <jmx> is no longer supported, use solr.xml:/metrics/reporter
section instead
[junit4] 2> 4376878 INFO
(SUITE-TestFiltering-seed#[941028414E3EFF6C]-worker) [ ]
o.a.s.s.IndexSchema Schema name=example
[junit4] 2> 4376881 INFO
(SUITE-TestFiltering-seed#[941028414E3EFF6C]-worker) [ ]
o.a.s.s.IndexSchema Loaded schema example/1.6 with uniqueid field id
[junit4] 2> 4377178 WARN
(SUITE-TestFiltering-seed#[941028414E3EFF6C]-worker) [ ]
o.a.s.c.CoreContainer Unable to create
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/userfiles].
Features requiring this directory may fail.
[junit4] 2> => java.security.AccessControlException: access
denied ("java.io.FilePermission"
"/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/userfiles"
"write")
[junit4] 2> at
java.security.AccessControlContext.checkPermission(AccessControlContext.java:472)
[junit4] 2> java.security.AccessControlException: access denied
("java.io.FilePermission"
"/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/userfiles"
"write")
[junit4] 2> at
java.security.AccessControlContext.checkPermission(AccessControlContext.java:472)
~[?:1.8.0_291]
[junit4] 2> at
java.security.AccessController.checkPermission(AccessController.java:886)
~[?:1.8.0_291]
[junit4] 2> at
java.lang.SecurityManager.checkPermission(SecurityManager.java:549)
~[?:1.8.0_291]
[junit4] 2> at
java.lang.SecurityManager.checkWrite(SecurityManager.java:979) ~[?:1.8.0_291]
[junit4] 2> at sun.nio.fs.UnixPath.checkWrite(UnixPath.java:801)
~[?:?]
[junit4] 2> at
sun.nio.fs.UnixFileSystemProvider.createDirectory(UnixFileSystemProvider.java:376)
~[?:?]
[junit4] 2> at java.nio.file.Files.createDirectory(Files.java:674)
~[?:1.8.0_291]
[junit4] 2> at
java.nio.file.Files.createAndCheckIsDirectory(Files.java:781) ~[?:1.8.0_291]
[junit4] 2> at
java.nio.file.Files.createDirectories(Files.java:727) ~[?:1.8.0_291]
[junit4] 2> at
org.apache.solr.core.CoreContainer.<init>(CoreContainer.java:378) [java/:?]
[junit4] 2> at
org.apache.solr.core.CoreContainer.<init>(CoreContainer.java:343) [java/:?]
[junit4] 2> at
org.apache.solr.util.TestHarness.<init>(TestHarness.java:183) [java/:?]
[junit4] 2> at
org.apache.solr.util.TestHarness.<init>(TestHarness.java:156) [java/:?]
[junit4] 2> at
org.apache.solr.util.TestHarness.<init>(TestHarness.java:162) [java/:?]
[junit4] 2> at
org.apache.solr.util.TestHarness.<init>(TestHarness.java:112) [java/:?]
[junit4] 2> at
org.apache.solr.SolrTestCaseJ4.createCore(SolrTestCaseJ4.java:813) [java/:?]
[junit4] 2> at
org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:803) [java/:?]
[junit4] 2> at
org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:664) [java/:?]
[junit4] 2> at
org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:653) [java/:?]
[junit4] 2> at
org.apache.solr.search.TestFiltering.beforeTests(TestFiltering.java:45)
[test/:?]
[junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native
Method) ~[?:1.8.0_291]
[junit4] 2> at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
~[?:1.8.0_291]
[junit4] 2> at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
~[?:1.8.0_291]
[junit4] 2> at java.lang.reflect.Method.invoke(Method.java:498)
~[?:1.8.0_291]
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:878)
[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at org.junit.rules.RunRules.evaluate(RunRules.java:20)
[junit-4.13.1.jar:4.13.1]
[junit4] 2> at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[java/:?]
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
[java/:?]
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
[java/:?]
[junit4] 2> at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
[java/:?]
[junit4] 2> at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
[java/:?]
[junit4] 2> at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
[java/:?]
[junit4] 2> at org.junit.rules.RunRules.evaluate(RunRules.java:20)
[junit-4.13.1.jar:4.13.1]
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at java.lang.Thread.run(Thread.java:748) [?:1.8.0_291]
[junit4] 2> 4377180 WARN
(SUITE-TestFiltering-seed#[941028414E3EFF6C]-worker) [ ]
o.a.s.f.DistribPackageStore Unable to create
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/filestore]
directory in SOLR_HOME
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/core/src/test-files/solr].
Features requiring this directory may fail.
[junit4] 2> => java.security.AccessControlException: access
denied ("java.io.FilePermission"
"/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/filestore"
"write")
[junit4] 2> at
java.security.AccessControlContext.checkPermission(AccessControlContext.java:472)
[junit4] 2> java.security.AccessControlException: access denied
("java.io.FilePermission"
"/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/filestore"
"write")
[junit4] 2> at
java.security.AccessControlContext.checkPermission(AccessControlContext.java:472)
~[?:1.8.0_291]
[junit4] 2> at
java.security.AccessController.checkPermission(AccessController.java:886)
~[?:1.8.0_291]
[junit4] 2> at
java.lang.SecurityManager.checkPermission(SecurityManager.java:549)
~[?:1.8.0_291]
[junit4] 2> at
java.lang.SecurityManager.checkWrite(SecurityManager.java:979) ~[?:1.8.0_291]
[junit4] 2> at java.io.File.mkdir(File.java:1348) ~[?:1.8.0_291]
[junit4] 2> at java.io.File.mkdirs(File.java:1380) ~[?:1.8.0_291]
[junit4] 2> at
org.apache.solr.filestore.DistribPackageStore.ensurePackageStoreDir(DistribPackageStore.java:561)
[java/:?]
[junit4] 2> at
org.apache.solr.filestore.DistribPackageStore.<init>(DistribPackageStore.java:81)
[java/:?]
[junit4] 2> at
org.apache.solr.filestore.PackageStoreAPI.<init>(PackageStoreAPI.java:78)
[java/:?]
[junit4] 2> at
org.apache.solr.core.CoreContainer.load(CoreContainer.java:679) [java/:?]
[junit4] 2> at
org.apache.solr.util.TestHarness.<init>(TestHarness.java:184) [java/:?]
[junit4] 2> at
org.apache.solr.util.TestHarness.<init>(TestHarness.java:156) [java/:?]
[junit4] 2> at
org.apache.solr.util.TestHarness.<init>(TestHarness.java:162) [java/:?]
[junit4] 2> at
org.apache.solr.util.TestHarness.<init>(TestHarness.java:112) [java/:?]
[junit4] 2> at
org.apache.solr.SolrTestCaseJ4.createCore(SolrTestCaseJ4.java:813) [java/:?]
[junit4] 2> at
org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:803) [java/:?]
[junit4] 2> at
org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:664) [java/:?]
[junit4] 2> at
org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:653) [java/:?]
[junit4] 2> at
org.apache.solr.search.TestFiltering.beforeTests(TestFiltering.java:45)
[test/:?]
[junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native
Method) ~[?:1.8.0_291]
[junit4] 2> at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
~[?:1.8.0_291]
[junit4] 2> at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
~[?:1.8.0_291]
[junit4] 2> at java.lang.reflect.Method.invoke(Method.java:498)
~[?:1.8.0_291]
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:878)
[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at org.junit.rules.RunRules.evaluate(RunRules.java:20)
[junit-4.13.1.jar:4.13.1]
[junit4] 2> at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[java/:?]
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
[java/:?]
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
[java/:?]
[junit4] 2> at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
[java/:?]
[junit4] 2> at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
[java/:?]
[junit4] 2> at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
[java/:?]
[junit4] 2> at org.junit.rules.RunRules.evaluate(RunRules.java:20)
[junit-4.13.1.jar:4.13.1]
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at java.lang.Thread.run(Thread.java:748) [?:1.8.0_291]
[junit4] 2> 4377181 INFO
(SUITE-TestFiltering-seed#[941028414E3EFF6C]-worker) [ ]
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 4377181 WARN
(SUITE-TestFiltering-seed#[941028414E3EFF6C]-worker) [ ]
o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport
since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 4377182 WARN
(SUITE-TestFiltering-seed#[941028414E3EFF6C]-worker) [ ] o.e.j.u.s.S.config
Trusting all certificates configured for
Client@4522196b[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 4377182 WARN
(SUITE-TestFiltering-seed#[941028414E3EFF6C]-worker) [ ] o.e.j.u.s.S.config
No Client EndPointIdentificationAlgorithm configured for
Client@4522196b[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 4377186 WARN
(SUITE-TestFiltering-seed#[941028414E3EFF6C]-worker) [ ]
o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport
since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 4377190 WARN
(SUITE-TestFiltering-seed#[941028414E3EFF6C]-worker) [ ] o.e.j.u.s.S.config
Trusting all certificates configured for
Client@6d9918c6[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 4377190 WARN
(SUITE-TestFiltering-seed#[941028414E3EFF6C]-worker) [ ] o.e.j.u.s.S.config
No Client EndPointIdentificationAlgorithm configured for
Client@6d9918c6[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 4377191 WARN
(SUITE-TestFiltering-seed#[941028414E3EFF6C]-worker) [ ]
o.a.s.c.CoreContainer Not all security plugins configured!
authentication=disabled authorization=disabled. Solr is only as secure as you
make it. Consider configuring authentication/authorization before exposing Solr
to users internal or external. See https://s.apache.org/solrsecurity for more
info
[junit4] 2> 4377223 INFO
(SUITE-TestFiltering-seed#[941028414E3EFF6C]-worker) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@58e6ca2
[junit4] 2> 4377230 INFO
(SUITE-TestFiltering-seed#[941028414E3EFF6C]-worker) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@58e6ca2
[junit4] 2> 4377230 INFO
(SUITE-TestFiltering-seed#[941028414E3EFF6C]-worker) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@58e6ca2
[junit4] 2> 4377232 INFO (coreLoadExecutor-15995-thread-1) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient core cache for max
2147483647 cores with initial capacity of 1024
[junit4] 2> 4377241 INFO (coreLoadExecutor-15995-thread-1) [
x:collection1 ] o.a.s.c.SolrResourceLoader Added 2 libs to classloader, from
paths:
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1/lib,
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 4377267 INFO (coreLoadExecutor-15995-thread-1) [
x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.11.0
[junit4] 2> 4377267 WARN (coreLoadExecutor-15995-thread-1) [
x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <boolTofilterOptimizer> is
currently not implemented and has no effect.
[junit4] 2> 4377268 WARN (coreLoadExecutor-15995-thread-1) [
x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <jmx> is no longer
supported, use solr.xml:/metrics/reporter section instead
[junit4] 2> 4377270 INFO (coreLoadExecutor-15995-thread-1) [
x:collection1 ] o.a.s.s.IndexSchema Schema name=example
[junit4] 2> 4377273 INFO (coreLoadExecutor-15995-thread-1) [
x:collection1 ] o.a.s.s.IndexSchema Loaded schema example/1.6 with uniqueid
field id
[junit4] 2> 4377281 INFO (coreLoadExecutor-15995-thread-1) [
x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using
configuration from instancedir
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1,
trusted=true
[junit4] 2> 4377282 INFO (coreLoadExecutor-15995-thread-1) [
x:collection1 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.core.collection1' (registry 'solr.core.collection1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@58e6ca2
[junit4] 2> 4377282 INFO (coreLoadExecutor-15995-thread-1) [
x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1],
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J2/temp/solr.search.TestFiltering_941028414E3EFF6C-001/data-dir-178-001/]
[junit4] 2> 4377283 INFO (coreLoadExecutor-15995-thread-1) [
x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy:
minMergeSize=0, mergeFactor=10, maxMergeSize=828494060,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.1]
[junit4] 2> 4377342 INFO (coreLoadExecutor-15995-thread-1) [
x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 4377342 INFO (coreLoadExecutor-15995-thread-1) [
x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 4377343 INFO (coreLoadExecutor-15995-thread-1) [
x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=5, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=0.3759765625,
noCFSRatio=0.3805283097344102]
[junit4] 2> 4377345 INFO (coreLoadExecutor-15995-thread-1) [
x:collection1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 4377448 INFO (coreLoadExecutor-15995-thread-1) [
x:collection1 ] o.a.s.s.DirectSolrSpellChecker init:
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 4377540 INFO (coreLoadExecutor-15995-thread-1) [
x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 4377540 INFO
(searcherExecutor-15997-thread-1-processing-x:collection1) [ x:collection1 ]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 4377541 INFO
(searcherExecutor-15997-thread-1-processing-x:collection1) [ x:collection1 ]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 4377541 INFO
(searcherExecutor-15997-thread-1-processing-x:collection1) [ x:collection1 ]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 4377541 INFO
(searcherExecutor-15997-thread-1-processing-x:collection1) [ x:collection1 ]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker:
multipleFields
[junit4] 2> 4377541 INFO
(searcherExecutor-15997-thread-1-processing-x:collection1) [ x:collection1 ]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 4377541 INFO
(searcherExecutor-15997-thread-1-processing-x:collection1) [ x:collection1 ]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 4377541 INFO
(searcherExecutor-15997-thread-1-processing-x:collection1) [ x:collection1 ]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 4377543 INFO
(SUITE-TestFiltering-seed#[941028414E3EFF6C]-worker) [ ]
o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 4377547 INFO
(searcherExecutor-15997-thread-1-processing-x:collection1) [ x:collection1 ]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 4377547 INFO
(searcherExecutor-15997-thread-1-processing-x:collection1) [ x:collection1 ]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 4377548 INFO
(searcherExecutor-15997-thread-1-processing-x:collection1) [ x:collection1 ]
o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 4377555 INFO
(TEST-TestFiltering.testHossssSanity-seed#[941028414E3EFF6C]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testHossssSanity
[junit4] 2> 4377555 INFO
(TEST-TestFiltering.testHossssSanity-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 4377556 INFO
(TEST-TestFiltering.testHossssSanity-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}{deleteByQuery=*:*}
0 0
[junit4] 2> 4377557 INFO
(TEST-TestFiltering.testHossssSanity-seed#[941028414E3EFF6C]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[0]} 0 0
[junit4] 2> 4377559 INFO
(TEST-TestFiltering.testHossssSanity-seed#[941028414E3EFF6C]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[1]} 0 0
[junit4] 2> 4377560 INFO
(TEST-TestFiltering.testHossssSanity-seed#[941028414E3EFF6C]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[2]} 0 0
[junit4] 2> 4377560 INFO
(TEST-TestFiltering.testHossssSanity-seed#[941028414E3EFF6C]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[3]} 0 0
[junit4] 2> 4377560 INFO
(TEST-TestFiltering.testHossssSanity-seed#[941028414E3EFF6C]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[4]} 0 0
[junit4] 2> 4377561 INFO
(TEST-TestFiltering.testHossssSanity-seed#[941028414E3EFF6C]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[5]} 0 0
[junit4] 2> 4377561 INFO
(TEST-TestFiltering.testHossssSanity-seed#[941028414E3EFF6C]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[6]} 0 0
[junit4] 2> 4377561 INFO
(TEST-TestFiltering.testHossssSanity-seed#[941028414E3EFF6C]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[7]} 0 0
[junit4] 2> 4377561 INFO
(TEST-TestFiltering.testHossssSanity-seed#[941028414E3EFF6C]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[8]} 0 0
[junit4] 2> 4377562 INFO
(TEST-TestFiltering.testHossssSanity-seed#[941028414E3EFF6C]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[9]} 0 0
[junit4] 2> 4377580 INFO
(searcherExecutor-15997-thread-1-processing-x:collection1) [ x:collection1 ]
o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 4377581 INFO
(TEST-TestFiltering.testHossssSanity-seed#[941028414E3EFF6C]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{commit=} 0 18
[junit4] 2> 4377581 INFO
(TEST-TestFiltering.testHossssSanity-seed#[941028414E3EFF6C]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&wt=xml}
hits=10 status=0 QTime=0
[junit4] 2> 4377582 INFO
(TEST-TestFiltering.testHossssSanity-seed#[941028414E3EFF6C]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q={!frange+v%3Dval_i+l%3D0+u%3D1}&fq={!frange+v%3Dval_i+l%3D0+u%3D1}&fq={!frange+v%3Dval_i+l%3D0+u%3D1}&fq=-_query_:"{!frange+v%3Dval_i+l%3D1+u%3D1}"&fq=-_query_:"{!frange+v%3Dval_i+l%3D1+u%3D1}"}
hits=1 status=0 QTime=0
[junit4] 2> 4377583 INFO
(TEST-TestFiltering.testHossssSanity-seed#[941028414E3EFF6C]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q={!frange+v%3Dval_i+l%3D0+u%3D1}&fq={!frange+v%3Dval_i+l%3D1+u%3D1}&fq={!frange+v%3Dval_i+l%3D0+u%3D1}&fq=-_query_:"{!frange+v%3Dval_i+l%3D1+u%3D1}"&fq=-_query_:"{!frange+v%3Dval_i+l%3D0+u%3D1}"}
hits=0 status=0 QTime=0
[junit4] 2> 4377583 INFO
(TEST-TestFiltering.testHossssSanity-seed#[941028414E3EFF6C]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{commit=} 0 0
[junit4] 2> 4377584 INFO
(TEST-TestFiltering.testHossssSanity-seed#[941028414E3EFF6C]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q={!frange+v%3Dval_i+l%3D0+u%3D1}&fq={!frange+v%3Dval_i+l%3D1+u%3D1}&fq={!frange+v%3Dval_i+l%3D0+u%3D1}&fq=-_query_:"{!frange+v%3Dval_i+l%3D1+u%3D1}"&fq=-_query_:"{!frange+v%3Dval_i+l%3D0+u%3D1}"}
hits=0 status=0 QTime=0
[junit4] 2> 4377584 INFO
(TEST-TestFiltering.testHossssSanity-seed#[941028414E3EFF6C]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q={!frange+v%3Dval_i+l%3D0+u%3D1}&fq={!frange+v%3Dval_i+l%3D0+u%3D1}&fq={!frange+v%3Dval_i+l%3D0+u%3D1}&fq=-_query_:"{!frange+v%3Dval_i+l%3D1+u%3D1}"&fq=-_query_:"{!frange+v%3Dval_i+l%3D1+u%3D1}"}
hits=1 status=0 QTime=0
[junit4] 2> 4377585 INFO
(TEST-TestFiltering.testHossssSanity-seed#[941028414E3EFF6C]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending testHossssSanity
[junit4] 2> 4377591 INFO
(TEST-TestFiltering.testLiveDocsSharing-seed#[941028414E3EFF6C]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testLiveDocsSharing
[junit4] 2> 4377591 INFO
(TEST-TestFiltering.testLiveDocsSharing-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 4377591 INFO
(TEST-TestFiltering.testLiveDocsSharing-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}{deleteByQuery=*:*}
0 0
[junit4] 2> 4377592 INFO
(TEST-TestFiltering.testLiveDocsSharing-seed#[941028414E3EFF6C]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[0]} 0 0
[junit4] 2> 4377593 INFO
(TEST-TestFiltering.testLiveDocsSharing-seed#[941028414E3EFF6C]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[0]} 0 0
[junit4] 2> 4377593 INFO
(TEST-TestFiltering.testLiveDocsSharing-seed#[941028414E3EFF6C]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[1]} 0 0
[junit4] 2> 4377593 INFO
(TEST-TestFiltering.testLiveDocsSharing-seed#[941028414E3EFF6C]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[2]} 0 0
[junit4] 2> 4377593 INFO
(TEST-TestFiltering.testLiveDocsSharing-seed#[941028414E3EFF6C]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[3]} 0 0
[junit4] 2> 4377594 INFO
(TEST-TestFiltering.testLiveDocsSharing-seed#[941028414E3EFF6C]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[4]} 0 0
[junit4] 2> 4377594 INFO
(TEST-TestFiltering.testLiveDocsSharing-seed#[941028414E3EFF6C]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[5]} 0 0
[junit4] 2> 4377594 INFO
(TEST-TestFiltering.testLiveDocsSharing-seed#[941028414E3EFF6C]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[5]} 0 0
[junit4] 2> 4377594 INFO
(TEST-TestFiltering.testLiveDocsSharing-seed#[941028414E3EFF6C]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[6]} 0 0
[junit4] 2> 4377595 INFO
(TEST-TestFiltering.testLiveDocsSharing-seed#[941028414E3EFF6C]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[7]} 0 0
[junit4] 2> 4377595 INFO
(TEST-TestFiltering.testLiveDocsSharing-seed#[941028414E3EFF6C]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[8]} 0 0
[junit4] 2> 4377595 INFO
(TEST-TestFiltering.testLiveDocsSharing-seed#[941028414E3EFF6C]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[9]} 0 0
[junit4] 2> 4377595 INFO
(TEST-TestFiltering.testLiveDocsSharing-seed#[941028414E3EFF6C]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[10]} 0 0
[junit4] 2> 4377596 INFO
(TEST-TestFiltering.testLiveDocsSharing-seed#[941028414E3EFF6C]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[10]} 0 0
[junit4] 2> 4377596 INFO
(TEST-TestFiltering.testLiveDocsSharing-seed#[941028414E3EFF6C]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[11]} 0 0
[junit4] 2> 4377596 INFO
(TEST-TestFiltering.testLiveDocsSharing-seed#[941028414E3EFF6C]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[12]} 0 0
[junit4] 2> 4377596 INFO
(TEST-TestFiltering.testLiveDocsSharing-seed#[941028414E3EFF6C]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[13]} 0 0
[junit4] 2> 4377597 INFO
(TEST-TestFiltering.testLiveDocsSharing-seed#[941028414E3EFF6C]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[14]} 0 0
[junit4] 2> 4377597 INFO
(TEST-TestFiltering.testLiveDocsSharing-seed#[941028414E3EFF6C]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[15]} 0 0
[junit4] 2> 4377597 INFO
(TEST-TestFiltering.testLiveDocsSharing-seed#[941028414E3EFF6C]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[15]} 0 0
[junit4] 2> 4377597 INFO
(TEST-TestFiltering.testLiveDocsSharing-seed#[941028414E3EFF6C]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[16]} 0 0
[junit4] 2> 4377598 INFO
(TEST-TestFiltering.testLiveDocsSharing-seed#[941028414E3EFF6C]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[17]} 0 0
[junit4] 2> 4377602 INFO
(TEST-TestFiltering.testLiveDocsSharing-seed#[941028414E3EFF6C]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[18]} 0 3
[junit4] 2> 4377602 INFO
(TEST-TestFiltering.testLiveDocsSharing-seed#[941028414E3EFF6C]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[19]} 0 0
[junit4] 2> 4377614 INFO
(searcherExecutor-15997-thread-1-processing-x:collection1) [ x:collection1 ]
o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 4377615 INFO
(TEST-TestFiltering.testLiveDocsSharing-seed#[941028414E3EFF6C]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{commit=} 0 12
[junit4] 2> 4377622 INFO
(TEST-TestFiltering.testLiveDocsSharing-seed#[941028414E3EFF6C]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending testLiveDocsSharing
[junit4] 2> 4377628 INFO
(TEST-TestFiltering.testCaching-seed#[941028414E3EFF6C]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testCaching
[junit4] 2> 4377629 INFO
(TEST-TestFiltering.testCaching-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 4377629 INFO
(TEST-TestFiltering.testCaching-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}{deleteByQuery=*:*}
0 0
[junit4] 2> 4377630 INFO
(TEST-TestFiltering.testCaching-seed#[941028414E3EFF6C]) [ x:collection1 ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{add=[4]} 0 0
[junit4] 2> 4377630 INFO
(TEST-TestFiltering.testCaching-seed#[941028414E3EFF6C]) [ x:collection1 ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{add=[1]} 0 0
[junit4] 2> 4377630 INFO
(TEST-TestFiltering.testCaching-seed#[941028414E3EFF6C]) [ x:collection1 ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{add=[3]} 0 0
[junit4] 2> 4377630 INFO
(TEST-TestFiltering.testCaching-seed#[941028414E3EFF6C]) [ x:collection1 ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{add=[2]} 0 0
[junit4] 2> 4377643 INFO
(searcherExecutor-15997-thread-1-processing-x:collection1) [ x:collection1 ]
o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 4377643 INFO
(TEST-TestFiltering.testCaching-seed#[941028414E3EFF6C]) [ x:collection1 ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{commit=} 0 12
[junit4] 2> 4377645 INFO
(TEST-TestFiltering.testCaching-seed#[941028414E3EFF6C]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&fq={!frange+l%3D2+u%3D3+cache%3Dfalse}val_i&wt=xml} hits=2
status=0 QTime=0
[junit4] 2> 4377645 INFO
(TEST-TestFiltering.testCaching-seed#[941028414E3EFF6C]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&fq={!frange+l%3D2+u%3D3+cache%3Dfalse}val_i&wt=xml} hits=2
status=0 QTime=0
[junit4] 2> 4377645 INFO
(TEST-TestFiltering.testCaching-seed#[941028414E3EFF6C]) [ ]
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> 4377646 INFO
(TEST-TestFiltering.testCaching-seed#[941028414E3EFF6C]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&fq={!frange+l%3D2+u%3D4+cost%3D0}val_i&wt=xml} hits=3 status=0
QTime=0
[junit4] 2> 4377646 INFO
(TEST-TestFiltering.testCaching-seed#[941028414E3EFF6C]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&fq={!frange+l%3D2+u%3D4+cost%3D999}val_i&wt=xml} hits=3 status=0
QTime=0
[junit4] 2> 4377646 INFO
(TEST-TestFiltering.testCaching-seed#[941028414E3EFF6C]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&fq={!frange+l%3D2+u%3D5+cache%3Dfalse+cost%3D0}val_i&wt=xml}
hits=3 status=0 QTime=0
[junit4] 2> 4377647 INFO
(TEST-TestFiltering.testCaching-seed#[941028414E3EFF6C]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&facet.field=id&fq={!frange+l%3D2+u%3D6+cache%3Dfalse}val_i&facet=true&wt=xml}
hits=3 status=0 QTime=0
[junit4] 2> 4377648 INFO
(TEST-TestFiltering.testCaching-seed#[941028414E3EFF6C]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&facet.field=id&fq={!frange+l%3D2+u%3D6+cache%3Dfalse}val_i&facet=true&wt=xml}
hits=3 status=0 QTime=0
[junit4] 2> 4377648 INFO
(TEST-TestFiltering.testCaching-seed#[941028414E3EFF6C]) [ ]
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> 4377648 INFO
(TEST-TestFiltering.testCaching-seed#[941028414E3EFF6C]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&facet.field=id&fq={!frange+l%3D2+u%3D7+cost%3D0}val_i&facet=true&wt=xml}
hits=3 status=0 QTime=0
[junit4] 2> 4377649 INFO
(TEST-TestFiltering.testCaching-seed#[941028414E3EFF6C]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&facet.field=id&fq={!frange+l%3D2+u%3D7+cost%3D999}val_i&facet=true&wt=xml}
hits=3 status=0 QTime=0
[junit4] 2> 4377649 INFO
(TEST-TestFiltering.testCaching-seed#[941028414E3EFF6C]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&facet.field=id&fq={!frange+l%3D2+u%3D8+cache%3Dfalse+cost%3D0}val_i&facet=true&wt=xml}
hits=3 status=0 QTime=0
[junit4] 2> 4377649 INFO
(TEST-TestFiltering.testCaching-seed#[941028414E3EFF6C]) [ ]
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> 4377650 INFO
(TEST-TestFiltering.testCaching-seed#[941028414E3EFF6C]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending testCaching
[junit4] 2> 4377657 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testRandomFiltering
[junit4] 2> 4377657 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 4377657 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}{deleteByQuery=*:*}
0 0
[junit4] 2> 4377658 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[0]} 0 0
[junit4] 2> 4377658 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[0]} 0 0
[junit4] 2> 4377659 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[1]} 0 0
[junit4] 2> 4377659 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[2]} 0 0
[junit4] 2> 4377659 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[3]} 0 0
[junit4] 2> 4377659 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[4]} 0 0
[junit4] 2> 4377659 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[4]} 0 0
[junit4] 2> 4377659 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[5]} 0 0
[junit4] 2> 4377659 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[6]} 0 0
[junit4] 2> 4377659 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[7]} 0 0
[junit4] 2> 4377660 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[8]} 0 0
[junit4] 2> 4377660 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[9]} 0 0
[junit4] 2> 4377660 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[9]} 0 0
[junit4] 2> 4377677 INFO
(searcherExecutor-15997-thread-1-processing-x:collection1) [ x:collection1 ]
o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 4377678 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{commit=} 0 17
[junit4] 2> 4377679 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[10]} 0 0
[junit4] 2> 4377679 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[10]} 0 0
[junit4] 2> 4377691 INFO
(searcherExecutor-15997-thread-1-processing-x:collection1) [ x:collection1 ]
o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 4377691 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{commit=} 0 12
[junit4] 2> 4377692 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[11]} 0 0
[junit4] 2> 4377692 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[12]} 0 0
[junit4] 2> 4377692 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[13]} 0 0
[junit4] 2> 4377692 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[14]} 0 0
[junit4] 2> 4377693 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[15]} 0 0
[junit4] 2> 4377693 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[15]} 0 0
[junit4] 2> 4377693 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[16]} 0 0
[junit4] 2> 4377693 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[17]} 0 0
[junit4] 2> 4377693 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[18]} 0 0
[junit4] 2> 4377693 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[19]} 0 0
[junit4] 2> 4377693 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[20]} 0 0
[junit4] 2> 4377693 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[21]} 0 0
[junit4] 2> 4377694 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[22]} 0 0
[junit4] 2> 4377694 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[23]} 0 0
[junit4] 2> 4377694 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[24]} 0 0
[junit4] 2> 4377694 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[24]} 0 0
[junit4] 2> 4377694 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[25]} 0 0
[junit4] 2> 4377694 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[26]} 0 0
[junit4] 2> 4377694 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[27]} 0 0
[junit4] 2> 4377695 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[28]} 0 0
[junit4] 2> 4377695 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[29]} 0 0
[junit4] 2> 4377695 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[30]} 0 0
[junit4] 2> 4377695 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[31]} 0 0
[junit4] 2> 4377695 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[32]} 0 0
[junit4] 2> 4377695 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[33]} 0 0
[junit4] 2> 4377695 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[33]} 0 0
[junit4] 2> 4377707 INFO
(searcherExecutor-15997-thread-1-processing-x:collection1) [ x:collection1 ]
o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 4377707 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{commit=} 0 11
[junit4] 2> 4377708 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[34]} 0 0
[junit4] 2> 4377708 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[35]} 0 0
[junit4] 2> 4377709 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[36]} 0 0
[junit4] 2> 4377709 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[36]} 0 0
[junit4] 2> 4377709 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[37]} 0 0
[junit4] 2> 4377709 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[38]} 0 0
[junit4] 2> 4377709 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[39]} 0 0
[junit4] 2> 4377727 INFO
(searcherExecutor-15997-thread-1-processing-x:collection1) [ x:collection1 ]
o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 1 ms
[junit4] 2> 4377728 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{commit=} 0 18
[junit4] 2> 4377729 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[40]} 0 0
[junit4] 2> 4377729 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[41]} 0 0
[junit4] 2> 4377729 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[42]} 0 0
[junit4] 2> 4377729 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[43]} 0 0
[junit4] 2> 4377729 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[43]} 0 0
[junit4] 2> 4377729 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[44]} 0 0
[junit4] 2> 4377730 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[45]} 0 0
[junit4] 2> 4377730 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[46]} 0 0
[junit4] 2> 4377730 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[47]} 0 0
[junit4] 2> 4377730 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[48]} 0 0
[junit4] 2> 4377730 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[49]} 0 0
[junit4] 2> 4377730 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[50]} 0 0
[junit4] 2> 4377730 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[51]} 0 0
[junit4] 2> 4377730 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[51]} 0 0
[junit4] 2> 4377731 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[52]} 0 0
[junit4] 2> 4377731 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[53]} 0 0
[junit4] 2> 4377731 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[54]} 0 0
[junit4] 2> 4377731 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[55]} 0 0
[junit4] 2> 4377731 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[56]} 0 0
[junit4] 2> 4377731 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[57]} 0 0
[junit4] 2> 4377731 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[58]} 0 0
[junit4] 2> 4377731 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[59]} 0 0
[junit4] 2> 4377731 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[59]} 0 0
[junit4] 2> 4377732 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[60]} 0 0
[junit4] 2> 4377732 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[61]} 0 0
[junit4] 2> 4377732 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[62]} 0 0
[junit4] 2> 4377732 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[62]} 0 0
[junit4] 2> 4377732 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[63]} 0 0
[junit4] 2> 4377732 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[64]} 0 0
[junit4] 2> 4377732 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[65]} 0 0
[junit4] 2> 4377732 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[65]} 0 0
[junit4] 2> 4377751 INFO
(searcherExecutor-15997-thread-1-processing-x:collection1) [ x:collection1 ]
o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 4377751 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{commit=} 0 18
[junit4] 2> 4377752 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[66]} 0 0
[junit4] 2> 4377752 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[67]} 0 0
[junit4] 2> 4377753 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[68]} 0 0
[junit4] 2> 4377753 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[69]} 0 0
[junit4] 2> 4377753 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[70]} 0 0
[junit4] 2> 4377753 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[71]} 0 0
[junit4] 2> 4377753 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[72]} 0 0
[junit4] 2> 4377753 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[73]} 0 0
[junit4] 2> 4377766 INFO
(searcherExecutor-15997-thread-1-processing-x:collection1) [ x:collection1 ]
o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 4377766 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{commit=} 0 13
[junit4] 2> 4377767 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&wt=xml}
hits=74 status=0 QTime=0
[junit4] 2> 4377769 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q={!+cache%3Dtrue+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D12+u%3D73}"&fq={!cache%3Dtrue}+val_i:0+val_i:1+val_i:2+val_i:3+val_i:4+val_i:6+val_i:13+val_i:15+val_i:20+val_i:21+val_i:22+val_i:23+val_i:27+val_i:28+val_i:31+val_i:32+val_i:33+val_i:34+val_i:38+val_i:43+val_i:47+val_i:50+val_i:51+val_i:53+val_i:57+val_i:58+val_i:61+val_i:63+val_i:65+val_i:67+val_i:68+val_i:69+val_i:71+val_i:72+val_i:73&fq={!}val_s:{00055+TO+00126]&fq={!frange+v%3Dval_i+l%3D9+u%3D30}&fq={!+cost%3D193}-_query_:"{!frange+v%3Dval_i+l%3D48+u%3D73}"&wt=xml}
hits=0 status=0 QTime=1
[junit4] 2> 4377770 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q={!+cache%3Dtrue+tag%3Dt}val_i:[00027+TO+00074]&fq={!+cost%3D123+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D10+u%3D73}"&fq=-_query_:"{!frange+v%3Dval_i+l%3D67+u%3D73}"&fq={!frange+v%3Dval_i+l%3D47+u%3D86}&wt=xml}
hits=0 status=0 QTime=0
[junit4] 2> 4377772 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
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:2+-val_i:3+-val_i:6+-val_i:9+-val_i:10+-val_i:11+-val_i:16+-val_i:18+-val_i:20+-val_i:21+-val_i:25+-val_i:27+-val_i:28+-val_i:29+-val_i:30+-val_i:31+-val_i:34+-val_i:35+-val_i:36+-val_i:37+-val_i:39+-val_i:41+-val_i:42+-val_i:43+-val_i:44+-val_i:45+-val_i:47+-val_i:48+-val_i:50+-val_i:52+-val_i:57+-val_i:58+-val_i:61+-val_i:62+-val_i:63+-val_i:69+-val_i:70+-val_i:71+-val_i:72&q={!frange+v%3Dval_i+l%3D48+u%3D76+cache%3Dfalse}&fq={!cache%3Dtrue+tag%3Dt}+val_i:1+val_i:2+val_i:3+val_i:4+val_i:5+val_i:6+val_i:7+val_i:11+val_i:16+val_i:18+val_i:22+val_i:26+val_i:27+val_i:29+val_i:30+val_i:31+val_i:32+val_i:34+val_i:35+val_i:36+val_i:39+val_i:43+val_i:44+val_i:46+val_i:47+val_i:48+val_i:49+val_i:50+val_i:51+val_i:54+val_i:55+val_i:56+val_i:58+val_i:59+val_i:64+val_i:66+val_i:67+val_i:69+val_i:70+val_i:71+val_i:73&facet=true&wt=xml}
hits=16 status=0 QTime=2
[junit4] 2> 4377776 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q={!cache%3Dtrue+tag%3Dt}+val_i:0+val_i:1+val_i:2+val_i:3+val_i:5+val_i:8+val_i:9+val_i:12+val_i:13+val_i:19+val_i:21+val_i:26+val_i:27+val_i:28+val_i:30+val_i:31+val_i:32+val_i:34+val_i:36+val_i:38+val_i:42+val_i:43+val_i:45+val_i:46+val_i:47+val_i:51+val_i:53+val_i:54+val_i:56+val_i:57+val_i:61+val_i:62+val_i:66+val_i:67+val_i:68+val_i:70+val_i:72&fq={!cache%3Dfalse+cost%3D17+tag%3Dt}+-val_i:2+-val_i:4+-val_i:7+-val_i:8+-val_i:10+-val_i:11+-val_i:13+-val_i:16+-val_i:17+-val_i:19+-val_i:22+-val_i:24+-val_i:25+-val_i:28+-val_i:29+-val_i:30+-val_i:33+-val_i:34+-val_i:35+-val_i:39+-val_i:40+-val_i:46+-val_i:49+-val_i:50+-val_i:52+-val_i:55+-val_i:57+-val_i:61+-val_i:62+-val_i:64+-val_i:65+-val_i:66+-val_i:67+-val_i:70+-val_i:72&fq={!frange+v%3Dval_i+l%3D12+u%3D50+tag%3Dt}&fq={!cache%3Dtrue}+val_i:0+val_i:2+val_i:3+val_i:5+val_i:7+val_i:8+val_i:11+val_i:13+val_i:14+val_i:18+val_i:19+val_i:22+val_i:26+val_i:27+val_i:31+val_i:33+val_i:34+val_i:38+val_i:39+val_i:40+val_i:44+val_i:47+val_i:49+val_i:51+val_i:52+val_i:53+val_i:55+val_i:58+val_i:61+val_i:62+val_i:63+val_i:68+val_i:70+val_i:71+val_i:73&fq={!}-_query_:"val_s:[00030+TO+00074}"&wt=xml}
hits=2 status=0 QTime=3
[junit4] 2> 4377779 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
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%3D192}-_query_:"val_i:[00026+TO+00074}"&q={!+cache%3Dtrue+tag%3Dt}val_i:{00005+TO+00079]+OR+val_i:[00006+TO+00080}&fq={!cache%3Dtrue+tag%3Dt}+-val_i:0+-val_i:1+-val_i:2+-val_i:3+-val_i:5+-val_i:7+-val_i:8+-val_i:9+-val_i:18+-val_i:19+-val_i:21+-val_i:23+-val_i:25+-val_i:26+-val_i:28+-val_i:32+-val_i:33+-val_i:38+-val_i:40+-val_i:41+-val_i:42+-val_i:43+-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:54+-val_i:55+-val_i:56+-val_i:58+-val_i:62+-val_i:66+-val_i:67+-val_i:68+-val_i:72+-val_i:73&fq={!+cost%3D178}-_query_:"{!frange+v%3Dval_i+l%3D15+u%3D73}"&fq={!+cache%3Dfalse}-_query_:"{!frange+v%3Dval_i+l%3D72+u%3D78}"&fq={!cache%3Dfalse+cost%3D175}+val_i:0+val_i:1+val_i:2+val_i:4+val_i:7+val_i:9+val_i:12+val_i:13+val_i:14+val_i:15+val_i:18+val_i:21+val_i:23+val_i:24+val_i:26+val_i:28+val_i:32+val_i:35+val_i:38+val_i:41+val_i:42+val_i:44+val_i:46+val_i:47+val_i:49+val_i:50+val_i:52+val_i:53+val_i:54+val_i:55+val_i:61+val_i:62+val_i:64+val_i:65+val_i:67+val_i:68+val_i:71&facet=true&wt=xml}
hits=3 status=0 QTime=2
[junit4] 2> 4377781 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q={!cache%3Dfalse+cost%3D57}+val_i:0+val_i:1+val_i:3+val_i:5+val_i:6+val_i:7+val_i:10+val_i:11+val_i:14+val_i:17+val_i:20+val_i:22+val_i:24+val_i:25+val_i:30+val_i:33+val_i:34+val_i:36+val_i:37+val_i:39+val_i:40+val_i:41+val_i:42+val_i:46+val_i:52+val_i:53+val_i:54+val_i:55+val_i:56+val_i:57+val_i:59+val_i:60+val_i:61+val_i:62+val_i:63+val_i:64+val_i:65+val_i:66+val_i:70+val_i:71+val_i:72+val_i:73&fq={!cache%3Dfalse+cost%3D102+tag%3Dt}+val_i:1+val_i:2+val_i:5+val_i:6+val_i:11+val_i:13+val_i:14+val_i:15+val_i:20+val_i:23+val_i:24+val_i:27+val_i:28+val_i:29+val_i:32+val_i:33+val_i:36+val_i:37+val_i:38+val_i:40+val_i:42+val_i:43+val_i:45+val_i:46+val_i:48+val_i:51+val_i:52+val_i:54+val_i:55+val_i:56+val_i:59+val_i:61+val_i:62+val_i:65+val_i:66+val_i:69+val_i:70+val_i:71+val_i:72&wt=xml}
hits=25 status=0 QTime=1
[junit4] 2> 4377782 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q={!cache%3Dfalse+cost%3D84+tag%3Dt}+-val_i:2+-val_i:3+-val_i:5+-val_i:6+-val_i:7+-val_i:8+-val_i:11+-val_i:13+-val_i:15+-val_i:17+-val_i:19+-val_i:20+-val_i:21+-val_i:22+-val_i:23+-val_i:24+-val_i:28+-val_i:29+-val_i:31+-val_i:32+-val_i:34+-val_i:37+-val_i:39+-val_i:42+-val_i:43+-val_i:47+-val_i:50+-val_i:53+-val_i:54+-val_i:55+-val_i:56+-val_i:57+-val_i:59+-val_i:62+-val_i:64+-val_i:65+-val_i:67+-val_i:68+-val_i:70&wt=xml}
hits=35 status=0 QTime=1
[junit4] 2> 4377791 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q={!cache%3Dtrue+tag%3Dt}+val_i:0+val_i:2+val_i:13+val_i:14+val_i:15+val_i:16+val_i:17+val_i:21+val_i:22+val_i:24+val_i:27+val_i:28+val_i:30+val_i:31+val_i:32+val_i:36+val_i:38+val_i:39+val_i:40+val_i:41+val_i:42+val_i:43+val_i:44+val_i:45+val_i:47+val_i:48+val_i:49+val_i:50+val_i:54+val_i:55+val_i:56+val_i:58+val_i:59+val_i:61+val_i:62+val_i:63+val_i:66+val_i:69+val_i:70+val_i:71&fq=-_query_:"{!frange+v%3Dval_i+l%3D5+u%3D73}"&fq={!+tag%3Dt}val_i:[00073+TO+00074}+AND+val_i:{00072+TO+00073]&fq={!cache%3Dtrue+tag%3Dt}+val_i:3+val_i:10+val_i:11+val_i:13+val_i:15+val_i:17+val_i:19+val_i:22+val_i:26+val_i:31+val_i:34+val_i:35+val_i:39+val_i:41+val_i:42+val_i:44+val_i:45+val_i:47+val_i:49+val_i:50+val_i:52+val_i:55+val_i:57+val_i:58+val_i:59+val_i:61+val_i:62+val_i:64+val_i:66+val_i:67+val_i:68+val_i:70+val_i:73&fq={!cache%3Dtrue+tag%3Dt}+val_i:1+val_i:4+val_i:7+val_i:8+val_i:9+val_i:10+val_i:18+val_i:20+val_i:23+val_i:24+val_i:30+val_i:31+val_i:33+val_i:36+val_i:39+val_i:40+val_i:43+val_i:44+val_i:45+val_i:47+val_i:50+val_i:52+val_i:53+val_i:56+val_i:57+val_i:59+val_i:60+val_i:64+val_i:68+val_i:72&wt=xml}
hits=0 status=0 QTime=8
[junit4] 2> 4377804 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
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%3D20+u%3D73}"&q={!frange+v%3Dval_i+l%3D5+u%3D27}&group.main=true&group.cache.percent=100&fq={!cache%3Dtrue+tag%3Dt}+val_i:0+val_i:3+val_i:5+val_i:6+val_i:8+val_i:9+val_i:10+val_i:11+val_i:16+val_i:17+val_i:21+val_i:23+val_i:24+val_i:27+val_i:28+val_i:36+val_i:37+val_i:38+val_i:39+val_i:40+val_i:42+val_i:45+val_i:46+val_i:47+val_i:50+val_i:51+val_i:52+val_i:56+val_i:57+val_i:59+val_i:60+val_i:62+val_i:63+val_i:65+val_i:66+val_i:67+val_i:68+val_i:69+val_i:70+val_i:73&fq={!+tag%3Dt}-_query_:"val_i:[00023+TO+00073]"&fq={!cache%3Dfalse}+val_i:1+val_i:2+val_i:3+val_i:4+val_i:7+val_i:12+val_i:13+val_i:15+val_i:16+val_i:21+val_i:23+val_i:27+val_i:33+val_i:34+val_i:37+val_i:38+val_i:39+val_i:41+val_i:42+val_i:44+val_i:45+val_i:46+val_i:47+val_i:51+val_i:53+val_i:55+val_i:58+val_i:59+val_i:60+val_i:61+val_i:64+val_i:66+val_i:67+val_i:68+val_i:69+val_i:71&fq={!cache%3Dfalse}+val_i:0+val_i:1+val_i:2+val_i:3+val_i:4+val_i:5+val_i:8+val_i:9+val_i:14+val_i:15+val_i:16+val_i:17+val_i:18+val_i:19+val_i:21+val_i:22+val_i:25+val_i:26+val_i:27+val_i:30+val_i:32+val_i:33+val_i:34+val_i:35+val_i:36+val_i:37+val_i:41+val_i:42+val_i:46+val_i:47+val_i:50+val_i:51+val_i:52+val_i:53+val_i:54+val_i:57+val_i:58+val_i:59+val_i:60+val_i:63+val_i:64+val_i:65+val_i:66+val_i:67+val_i:71&facet=true&wt=xml&group.field=id&group=true}
hits=2 status=0 QTime=13
[junit4] 2> 4377806 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q={!cache%3Dtrue}+val_i:3+val_i:4+val_i:8+val_i:9+val_i:11+val_i:12+val_i:13+val_i:14+val_i:16+val_i:17+val_i:18+val_i:19+val_i:22+val_i:23+val_i:25+val_i:26+val_i:27+val_i:28+val_i:31+val_i:32+val_i:34+val_i:35+val_i:36+val_i:38+val_i:39+val_i:40+val_i:44+val_i:45+val_i:47+val_i:49+val_i:54+val_i:55+val_i:56+val_i:59+val_i:61+val_i:67+val_i:68+val_i:70+val_i:73&fq={!+cost%3D113}-_query_:"{!frange+v%3Dval_i+l%3D23+u%3D73}"&fq={!frange+v%3Dval_i+l%3D38+u%3D84+cache%3Dtrue+tag%3Dt}&fq={!cache%3Dfalse+cost%3D36+tag%3Dt}+val_i:2+val_i:4+val_i:5+val_i:8+val_i:9+val_i:10+val_i:12+val_i:15+val_i:16+val_i:17+val_i:18+val_i:19+val_i:20+val_i:21+val_i:23+val_i:27+val_i:29+val_i:32+val_i:35+val_i:37+val_i:40+val_i:43+val_i:44+val_i:46+val_i:54+val_i:55+val_i:56+val_i:59+val_i:64+val_i:66+val_i:67+val_i:68+val_i:70+val_i:72&wt=xml}
hits=0 status=0 QTime=1
[junit4] 2> 4377808 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q={!frange+v%3Dval_i+l%3D39+u%3D102+cache%3Dfalse+tag%3Dt}&fq={!cache%3Dtrue}+val_i:2+val_i:3+val_i:5+val_i:7+val_i:8+val_i:11+val_i:12+val_i:14+val_i:16+val_i:18+val_i:23+val_i:24+val_i:26+val_i:28+val_i:31+val_i:32+val_i:34+val_i:36+val_i:38+val_i:39+val_i:42+val_i:45+val_i:48+val_i:50+val_i:55+val_i:56+val_i:57+val_i:58+val_i:59+val_i:62+val_i:63+val_i:64+val_i:65+val_i:66+val_i:69+val_i:70+val_i:71&fq={!+cache%3Dfalse+tag%3Dt}val_i:[00024+TO+00091]&fq=-_query_:"{!frange+v%3Dval_i+l%3D23+u%3D73}"&fq={!cache%3Dtrue+tag%3Dt}+-val_i:0+-val_i:3+-val_i:4+-val_i:5+-val_i:12+-val_i:17+-val_i:18+-val_i:21+-val_i:22+-val_i:23+-val_i:28+-val_i:29+-val_i:31+-val_i:33+-val_i:34+-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:51+-val_i:57+-val_i:60+-val_i:61+-val_i:64+-val_i:65+-val_i:66+-val_i:67+-val_i:68+-val_i:70+-val_i:71+-val_i:73&wt=xml}
hits=0 status=0 QTime=1
[junit4] 2> 4377810 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
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%3D63+u%3D84+cost%3D134}&q={!cache%3Dtrue+tag%3Dt}+-val_i:0+-val_i:1+-val_i:2+-val_i:5+-val_i:7+-val_i:9+-val_i:10+-val_i:11+-val_i:12+-val_i:16+-val_i:19+-val_i:21+-val_i:23+-val_i:24+-val_i:26+-val_i:28+-val_i:30+-val_i:31+-val_i:34+-val_i:35+-val_i:38+-val_i:39+-val_i:42+-val_i:44+-val_i:45+-val_i:46+-val_i:47+-val_i:49+-val_i:50+-val_i:51+-val_i:54+-val_i:55+-val_i:60+-val_i:61+-val_i:64+-val_i:67+-val_i:68+-val_i:69+-val_i:70+-val_i:72&fq={!cache%3Dtrue+tag%3Dt}+val_i:0+val_i:1+val_i:2+val_i:3+val_i:5+val_i:6+val_i:9+val_i:11+val_i:12+val_i:14+val_i:19+val_i:20+val_i:21+val_i:23+val_i:24+val_i:27+val_i:28+val_i:30+val_i:33+val_i:37+val_i:39+val_i:40+val_i:41+val_i:42+val_i:43+val_i:44+val_i:45+val_i:46+val_i:50+val_i:51+val_i:53+val_i:54+val_i:55+val_i:56+val_i:57+val_i:64+val_i:66+val_i:67+val_i:70+val_i:72&fq=+val_i:0+val_i:4+val_i:5+val_i:9+val_i:11+val_i:16+val_i:17+val_i:21+val_i:22+val_i:23+val_i:25+val_i:26+val_i:27+val_i:28+val_i:29+val_i:32+val_i:36+val_i:38+val_i:41+val_i:44+val_i:45+val_i:46+val_i:47+val_i:48+val_i:49+val_i:54+val_i:55+val_i:57+val_i:58+val_i:60+val_i:61+val_i:64+val_i:69+val_i:70+val_i:71+val_i:72+val_i:73&fq={!frange+v%3Dval_i+l%3D22+u%3D60+cache%3Dfalse+cost%3D121}&fq={!cache%3Dfalse+cost%3D109}+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:11+val_i:12+val_i:13+val_i:16+val_i:18+val_i:19+val_i:22+val_i:24+val_i:26+val_i:28+val_i:30+val_i:34+val_i:36+val_i:37+val_i:38+val_i:44+val_i:45+val_i:46+val_i:49+val_i:50+val_i:52+val_i:53+val_i:54+val_i:56+val_i:57+val_i:60+val_i:61+val_i:69+val_i:70+val_i:72+val_i:73&facet=true&wt=xml}
hits=1 status=0 QTime=2
[junit4] 2> 4377813 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q={!cache%3Dfalse}+-val_i:0+-val_i:2+-val_i:3+-val_i:4+-val_i:7+-val_i:8+-val_i:9+-val_i:10+-val_i:11+-val_i:14+-val_i:15+-val_i:16+-val_i:19+-val_i:23+-val_i:27+-val_i:29+-val_i:30+-val_i:31+-val_i:32+-val_i:33+-val_i:38+-val_i:40+-val_i:41+-val_i:42+-val_i:43+-val_i:44+-val_i:47+-val_i:49+-val_i:50+-val_i:51+-val_i:52+-val_i:53+-val_i:54+-val_i:55+-val_i:57+-val_i:63+-val_i:64+-val_i:66+-val_i:67+-val_i:69+-val_i:72&fq={!cache%3Dfalse+tag%3Dt}+val_i:1+val_i:2+val_i:3+val_i:5+val_i:11+val_i:12+val_i:13+val_i:14+val_i:15+val_i:17+val_i:18+val_i:20+val_i:21+val_i:22+val_i:27+val_i:29+val_i:31+val_i:32+val_i:36+val_i:38+val_i:39+val_i:41+val_i:49+val_i:50+val_i:56+val_i:57+val_i:58+val_i:59+val_i:60+val_i:63+val_i:64+val_i:65+val_i:66+val_i:67+val_i:68+val_i:69+val_i:71+val_i:72&fq={!cache%3Dfalse+cost%3D192}+val_i:2+val_i:3+val_i:5+val_i:6+val_i:10+val_i:11+val_i:12+val_i:13+val_i:15+val_i:17+val_i:18+val_i:19+val_i:22+val_i:29+val_i:30+val_i:35+val_i:36+val_i:37+val_i:40+val_i:42+val_i:43+val_i:44+val_i:46+val_i:47+val_i:49+val_i:54+val_i:55+val_i:57+val_i:60+val_i:62+val_i:63+val_i:64+val_i:65+val_i:66+val_i:67+val_i:70+val_i:73&fq={!+cache%3Dfalse}val_i:{00007+TO+00078}+OR+val_i:[00008+TO+00077]&wt=xml}
hits=8 status=0 QTime=1
[junit4] 2> 4377815 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q={!cache%3Dtrue+tag%3Dt}+-val_i:2+-val_i:4+-val_i:6+-val_i:7+-val_i:8+-val_i:11+-val_i:14+-val_i:15+-val_i:16+-val_i:18+-val_i:21+-val_i:22+-val_i:24+-val_i:25+-val_i:26+-val_i:30+-val_i:31+-val_i:32+-val_i:33+-val_i:34+-val_i:38+-val_i:41+-val_i:42+-val_i:44+-val_i:48+-val_i:49+-val_i:52+-val_i:53+-val_i:54+-val_i:55+-val_i:56+-val_i:58+-val_i:61+-val_i:62+-val_i:64+-val_i:66+-val_i:67+-val_i:70+-val_i:72+-val_i:73&group.main=true&group.cache.percent=100&fq={!+cache%3Dtrue+tag%3Dt}id:RAND1938553725+OR+val_i:{00024+TO+00071}&fq={!+cache%3Dfalse+cost%3D149+tag%3Dt}val_s:{00069+TO+00120]+AND+val_s:[00070+TO+00121}&fq={!+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D48+u%3D73}"&fq={!cache%3Dfalse}+val_i:2+val_i:4+val_i:5+val_i:6+val_i:9+val_i:11+val_i:14+val_i:18+val_i:19+val_i:21+val_i:22+val_i:23+val_i:24+val_i:26+val_i:27+val_i:28+val_i:30+val_i:32+val_i:33+val_i:36+val_i:37+val_i:48+val_i:49+val_i:50+val_i:54+val_i:56+val_i:57+val_i:59+val_i:60+val_i:64+val_i:68+val_i:69+val_i:70+val_i:72&wt=xml&group.field=id&group=true}
hits=0 status=0 QTime=1
[junit4] 2> 4377817 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q={!cache%3Dtrue+tag%3Dt}+-val_i:1+-val_i:3+-val_i:4+-val_i:5+-val_i:7+-val_i:8+-val_i:9+-val_i:11+-val_i:12+-val_i:13+-val_i:15+-val_i:16+-val_i:19+-val_i:27+-val_i:28+-val_i:29+-val_i:31+-val_i:32+-val_i:34+-val_i:37+-val_i:38+-val_i:39+-val_i:41+-val_i:42+-val_i:44+-val_i:45+-val_i:46+-val_i:48+-val_i:50+-val_i:52+-val_i:54+-val_i:57+-val_i:58+-val_i:60+-val_i:62+-val_i:63+-val_i:64+-val_i:70+-val_i:71&group.main=true&group.cache.percent=100&fq=-_query_:"val_s:[00045+TO+00073]"&wt=xml&group.field=id&group=true}
hits=20 status=0 QTime=1
[junit4] 2> 4377820 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q={!cache%3Dtrue}+val_i:0+val_i:2+val_i:4+val_i:5+val_i:6+val_i:9+val_i:10+val_i:12+val_i:13+val_i:14+val_i:16+val_i:17+val_i:18+val_i:19+val_i:20+val_i:25+val_i:26+val_i:32+val_i:35+val_i:37+val_i:40+val_i:41+val_i:42+val_i:48+val_i:49+val_i:50+val_i:54+val_i:58+val_i:59+val_i:62+val_i:63+val_i:64+val_i:70+val_i:73&fq={!cache%3Dfalse+cost%3D196+tag%3Dt}+-val_i:0+-val_i:1+-val_i:3+-val_i:4+-val_i:7+-val_i:8+-val_i:9+-val_i:10+-val_i:11+-val_i:12+-val_i:13+-val_i:14+-val_i:18+-val_i:19+-val_i:21+-val_i:23+-val_i:25+-val_i:28+-val_i:30+-val_i:31+-val_i:32+-val_i:33+-val_i:36+-val_i:37+-val_i:38+-val_i:42+-val_i:44+-val_i:46+-val_i:47+-val_i:51+-val_i:52+-val_i:55+-val_i:56+-val_i:57+-val_i:58+-val_i:59+-val_i:61+-val_i:63+-val_i:64+-val_i:65+-val_i:67+-val_i:68+-val_i:69+-val_i:70+-val_i:72+-val_i:73&wt=xml}
hits=15 status=0 QTime=3
[junit4] 2> 4377834 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=+-val_i:0+-val_i:2+-val_i:3+-val_i:4+-val_i:6+-val_i:7+-val_i:11+-val_i:12+-val_i:14+-val_i:17+-val_i:18+-val_i:19+-val_i:26+-val_i:27+-val_i:28+-val_i:29+-val_i:31+-val_i:33+-val_i:34+-val_i:36+-val_i:39+-val_i:40+-val_i:42+-val_i:43+-val_i:44+-val_i:47+-val_i:48+-val_i:51+-val_i:53+-val_i:54+-val_i:57+-val_i:58+-val_i:60+-val_i:61+-val_i:63+-val_i:64+-val_i:65+-val_i:67+-val_i:68+-val_i:71&fq={!cache%3Dfalse+cost%3D171}+-val_i:0+-val_i:3+-val_i:4+-val_i:8+-val_i:10+-val_i:13+-val_i:14+-val_i:15+-val_i:17+-val_i:18+-val_i:19+-val_i:20+-val_i:23+-val_i:24+-val_i:28+-val_i:29+-val_i:30+-val_i:33+-val_i:34+-val_i:41+-val_i:43+-val_i:45+-val_i:46+-val_i:48+-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:60+-val_i:61+-val_i:62+-val_i:64+-val_i:67+-val_i:68+-val_i:70+-val_i:71&fq={!cache%3Dtrue+tag%3Dt}+-val_i:0+-val_i:1+-val_i:4+-val_i:5+-val_i:6+-val_i:7+-val_i:11+-val_i:14+-val_i:15+-val_i:16+-val_i:17+-val_i:21+-val_i:23+-val_i:25+-val_i:27+-val_i:29+-val_i:30+-val_i:32+-val_i:35+-val_i:36+-val_i:39+-val_i:41+-val_i:47+-val_i:49+-val_i:52+-val_i:63+-val_i:65+-val_i:67+-val_i:68+-val_i:69+-val_i:73&wt=xml}
hits=7 status=0 QTime=13
[junit4] 2> 4377838 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
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_s:{00053+TO+00073]"&q={!frange+v%3Dval_i+l%3D22+u%3D72+cache%3Dtrue+tag%3Dt}&fq={!cache%3Dfalse+cost%3D69+tag%3Dt}+val_i:5+val_i:7+val_i:8+val_i:10+val_i:12+val_i:13+val_i:14+val_i:16+val_i:18+val_i:21+val_i:23+val_i:24+val_i:27+val_i:28+val_i:29+val_i:30+val_i:31+val_i:32+val_i:33+val_i:38+val_i:39+val_i:40+val_i:41+val_i:42+val_i:48+val_i:58+val_i:59+val_i:62+val_i:64+val_i:66+val_i:67+val_i:69+val_i:72+val_i:73&fq=-_query_:"{!frange+v%3Dval_i+l%3D22+u%3D73}"&fq={!cache%3Dfalse}+-val_i:0+-val_i:1+-val_i:4+-val_i:5+-val_i:7+-val_i:10+-val_i:11+-val_i:12+-val_i:13+-val_i:14+-val_i:15+-val_i:16+-val_i:20+-val_i:25+-val_i:26+-val_i:28+-val_i:29+-val_i:30+-val_i:31+-val_i:34+-val_i:35+-val_i:38+-val_i:39+-val_i:42+-val_i:43+-val_i:45+-val_i:48+-val_i:49+-val_i:50+-val_i:51+-val_i:52+-val_i:54+-val_i:55+-val_i:56+-val_i:57+-val_i:59+-val_i:61+-val_i:63+-val_i:65+-val_i:66+-val_i:67+-val_i:69+-val_i:71&facet=true&wt=xml}
hits=0 status=0 QTime=3
[junit4] 2> 4377840 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
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%3D64+u%3D73}"&q={!cache%3Dfalse+cost%3D9+tag%3Dt}+val_i:1+val_i:2+val_i:3+val_i:6+val_i:9+val_i:10+val_i:12+val_i:13+val_i:19+val_i:20+val_i:26+val_i:29+val_i:30+val_i:32+val_i:36+val_i:37+val_i:40+val_i:42+val_i:46+val_i:49+val_i:51+val_i:52+val_i:54+val_i:55+val_i:56+val_i:58+val_i:59+val_i:61+val_i:63+val_i:66+val_i:67+val_i:68+val_i:69+val_i:70+val_i:73&fq={!cache%3Dtrue}+-val_i:1+-val_i:3+-val_i:8+-val_i:11+-val_i:12+-val_i:13+-val_i:18+-val_i:19+-val_i:20+-val_i:22+-val_i:23+-val_i:24+-val_i:27+-val_i:29+-val_i:30+-val_i:32+-val_i:33+-val_i:39+-val_i:42+-val_i:43+-val_i:44+-val_i:46+-val_i:47+-val_i:48+-val_i:50+-val_i:55+-val_i:56+-val_i:57+-val_i:59+-val_i:62+-val_i:63+-val_i:72+-val_i:73&fq={!frange+v%3Dval_i+l%3D72+u%3D100+cache%3Dtrue+tag%3Dt}&facet=true&wt=xml}
hits=0 status=0 QTime=2
[junit4] 2> 4377841 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q={!}-_query_:"val_i:[00021+TO+00074}"&fq={!+cost%3D159+tag%3Dt}-_query_:"val_s:[00043+TO+00074}"&wt=xml}
hits=21 status=0 QTime=0
[junit4] 2> 4377844 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
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:2+val_i:3+val_i:4+val_i:5+val_i:8+val_i:11+val_i:12+val_i:14+val_i:15+val_i:16+val_i:17+val_i:19+val_i:20+val_i:21+val_i:24+val_i:25+val_i:26+val_i:29+val_i:30+val_i:31+val_i:36+val_i:41+val_i:42+val_i:43+val_i:45+val_i:50+val_i:51+val_i:52+val_i:54+val_i:55+val_i:58+val_i:60+val_i:65+val_i:66+val_i:67+val_i:69+val_i:70+val_i:71+val_i:72+val_i:73&q={!cache%3Dfalse+cost%3D13}+val_i:0+val_i:4+val_i:5+val_i:6+val_i:8+val_i:12+val_i:13+val_i:14+val_i:16+val_i:20+val_i:22+val_i:23+val_i:24+val_i:26+val_i:28+val_i:29+val_i:30+val_i:33+val_i:34+val_i:36+val_i:37+val_i:39+val_i:41+val_i:46+val_i:47+val_i:50+val_i:54+val_i:55+val_i:56+val_i:58+val_i:59+val_i:63+val_i:65+val_i:67+val_i:70+val_i:71+val_i:72&facet=true&wt=xml}
hits=37 status=0 QTime=2
[junit4] 2> 4377849 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery}*:*+AND+val_i:[00050+TO+00102]&q={!cache%3Dtrue+tag%3Dt}+-val_i:0+-val_i:2+-val_i:4+-val_i:7+-val_i:9+-val_i:10+-val_i:11+-val_i:13+-val_i:14+-val_i:15+-val_i:19+-val_i:21+-val_i:24+-val_i:28+-val_i:29+-val_i:30+-val_i:33+-val_i:34+-val_i:35+-val_i:36+-val_i:39+-val_i:45+-val_i:48+-val_i:50+-val_i:53+-val_i:55+-val_i:57+-val_i:58+-val_i:60+-val_i:65+-val_i:66+-val_i:67+-val_i:69+-val_i:70+-val_i:71&fq=-_query_:"{!frange+v%3Dval_i+l%3D25+u%3D73}"&fq=-_query_:"{!frange+v%3Dval_i+l%3D34+u%3D73}"&fq={!cache%3Dfalse}+-val_i:3+-val_i:4+-val_i:7+-val_i:8+-val_i:10+-val_i:11+-val_i:12+-val_i:16+-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:31+-val_i:32+-val_i:33+-val_i:34+-val_i:36+-val_i:37+-val_i:39+-val_i:40+-val_i:41+-val_i:42+-val_i:46+-val_i:49+-val_i:50+-val_i:53+-val_i:54+-val_i:55+-val_i:59+-val_i:61+-val_i:62+-val_i:65+-val_i:71+-val_i:72+-val_i:73&facet=true&wt=xml}
hits=6 status=0 QTime=4
[junit4] 2> 4377851 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
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:0+-val_i:2+-val_i:4+-val_i:5+-val_i:9+-val_i:10+-val_i:13+-val_i:17+-val_i:18+-val_i:20+-val_i:22+-val_i:23+-val_i:29+-val_i:30+-val_i:31+-val_i:32+-val_i:33+-val_i:36+-val_i:38+-val_i:40+-val_i:41+-val_i:44+-val_i:50+-val_i:52+-val_i:53+-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:65+-val_i:66+-val_i:67+-val_i:70+-val_i:71+-val_i:72&q=-_query_:"{!frange+v%3Dval_i+l%3D7+u%3D73}"&fq={!cache%3Dtrue}+-val_i:4+-val_i:5+-val_i:6+-val_i:7+-val_i:9+-val_i:11+-val_i:12+-val_i:16+-val_i:17+-val_i:19+-val_i:21+-val_i:22+-val_i:23+-val_i:25+-val_i:26+-val_i:28+-val_i:29+-val_i:36+-val_i:37+-val_i:42+-val_i:45+-val_i:47+-val_i:49+-val_i:50+-val_i:53+-val_i:56+-val_i:58+-val_i:59+-val_i:61+-val_i:66+-val_i:70&fq={!frange+v%3Dval_i+l%3D48+u%3D85+cache%3Dtrue+tag%3Dt}&facet=true&wt=xml}
hits=0 status=0 QTime=1
[junit4] 2> 4377852 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[941028414E3EFF6C]) [ ]
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:3+-val_i:4+-val_i:5+-val_i:7+-val_i:9+-val_i:11+-val_i:17+-val_i:19+-val_i:20+-val_i:23+-val_i:25+-val_i:28+-val_i:34+-val_i:35+-val_i:36+-val_i:39+-val_i:44+-val_i:51+-val_i:52+-val_i:53+-val_
[...truncated too long message...]
2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 6) Thread[id=214646, name=h2sc-15992-thread-1,
state=RUNNABLE, group=TGRP-TestFiltering]
[junit4] 2> at sun.nio.ch.EPollArrayWrapper.epollWait(Native
Method)
[junit4] 2> at
sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:269)
[junit4] 2> at
sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93)
[junit4] 2> at
sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
[junit4] 2> at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:97)
[junit4] 2> at
sun.nio.ch.SelectorImpl.select(SelectorImpl.java:101)
[junit4] 2> at
org.eclipse.jetty.io.ManagedSelector.nioSelect(ManagedSelector.java:183)
[junit4] 2> at
org.eclipse.jetty.io.ManagedSelector.select(ManagedSelector.java:190)
[junit4] 2> at
org.eclipse.jetty.io.ManagedSelector$SelectorProducer.select(ManagedSelector.java:606)
[junit4] 2> at
org.eclipse.jetty.io.ManagedSelector$SelectorProducer.produce(ManagedSelector.java:543)
[junit4] 2> at
org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produceTask(EatWhatYouKill.java:360)
[junit4] 2> at
org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:184)
[junit4] 2> at
org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.tryProduce(EatWhatYouKill.java:171)
[junit4] 2> at
org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produce(EatWhatYouKill.java:135)
[junit4] 2> at
org.eclipse.jetty.io.ManagedSelector$$Lambda$103/1319282351.run(Unknown Source)
[junit4] 2> at
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:218)
[junit4] 2> at
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$$Lambda$62/1315339641.run(Unknown
Source)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 7) Thread[id=214642, name=h2sc-15990-thread-1,
state=RUNNABLE, group=TGRP-TestFiltering]
[junit4] 2> at sun.nio.ch.EPollArrayWrapper.epollWait(Native
Method)
[junit4] 2> at
sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:269)
[junit4] 2> at
sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93)
[junit4] 2> at
sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
[junit4] 2> at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:97)
[junit4] 2> at
sun.nio.ch.SelectorImpl.select(SelectorImpl.java:101)
[junit4] 2> at
org.eclipse.jetty.io.ManagedSelector.nioSelect(ManagedSelector.java:183)
[junit4] 2> at
org.eclipse.jetty.io.ManagedSelector.select(ManagedSelector.java:190)
[junit4] 2> at
org.eclipse.jetty.io.ManagedSelector$SelectorProducer.select(ManagedSelector.java:606)
[junit4] 2> at
org.eclipse.jetty.io.ManagedSelector$SelectorProducer.produce(ManagedSelector.java:543)
[junit4] 2> at
org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produceTask(EatWhatYouKill.java:360)
[junit4] 2> at
org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:184)
[junit4] 2> at
org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.tryProduce(EatWhatYouKill.java:171)
[junit4] 2> at
org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produce(EatWhatYouKill.java:135)
[junit4] 2> at
org.eclipse.jetty.io.ManagedSelector$$Lambda$103/1319282351.run(Unknown Source)
[junit4] 2> at
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:218)
[junit4] 2> at
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$$Lambda$62/1315339641.run(Unknown
Source)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> NOTE: test params are:
codec=DummyCompressingStoredFieldsData(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=DUMMY,
chunkSize=1563, maxDocsPerChunk=9, blockShift=7),
termVectorsFormat=CompressingTermVectorsFormat(compressionMode=DUMMY,
chunkSize=1563, maxDocsPerChunk=9, blockSize=7)),
sim=Asserting(RandomSimilarity(queryNorm=false): {}), locale=sr-Latn-ME,
timezone=Asia/Dhaka
[junit4] 2> NOTE: Linux 4.15.0-147-generic amd64/Oracle Corporation
1.8.0_291 (64-bit)/cpus=4,threads=10,free=140115600,total=535298048
[junit4] 2> NOTE: All tests run in this JVM: [BlockJoinFacetDistribTest,
UninvertDocValuesMergePolicyTest, AutoscalingHistoryHandlerTest,
OpenExchangeRatesOrgProviderTest, FacetPivotSmallTest, ClusterStateUpdateTest,
TestSubQueryTransformerCrossCore, TestCustomSort, SecurityConfHandlerTest,
MigrateRouteKeyTest, TestManagedSchemaAPI, AnalysisErrorHandlingTest,
ForceLeaderTest, TestBackupRepositoryFactory, TestTolerantSearch,
SuggesterTest, TestNamedUpdateProcessors, TestIncrementalCoreBackup,
AddSchemaFieldsUpdateProcessorFactoryTest, OverseerStatusTest, TestConfig,
FieldMutatingUpdateProcessorTest, BasicAuthStandaloneTest,
TestRebalanceLeaders, TestSchemaField, PluginInfoTest, MBeansHandlerTest,
TestSchemaDesignerConfigSetHelper, TestCollectionAPIs, BasicDistributedZk2Test,
TestSearchPerf, SolrIndexMetricsTest, ZkDynamicConfigTest, ZkStateWriterTest,
TestRandomDVFaceting, HighlighterConfigTest, TestCloudJSONFacetSKG,
TestSchemaVersionResource, SolrCloudExampleTest,
ByteBuffersDirectoryFactoryTest, GraphQueryTest, TestTestInjection,
TestFastOutputStream, RestartWhileUpdatingTest, TestBinaryField, DocValuesTest,
TestConfigSets, BooleanFieldTest, TestCollectionAPI, TestLazyCores,
ClassificationUpdateProcessorFactoryTest, NodeMutatorTest,
TestOnReconnectListenerSupport, HdfsThreadLeakTest, PingRequestHandlerTest,
TestReplicaProperties, FuzzySearchTest, ConjunctionSolrSpellCheckerTest,
TestPseudoReturnFields, HdfsBasicDistributedZkTest, TestShortCircuitedRequests,
ChaosMonkeyNothingIsSafeWithPullReplicasTest, TestPostingsSolrHighlighter,
NoCacheHeaderTest, SuggestComponentContextFilterQueryTest, ActionThrottleTest,
TestLMJelinekMercerSimilarityFactory, TestLegacyTerms,
SubstringBytesRefFilterTest, TestChildDocTransformer,
TestStressIncrementalBackup, TestFieldCacheSortRandom, TestRemoteStreaming,
NestedAtomicUpdateTest, TestPivotHelperCode,
VMParamsZkACLAndCredentialsProvidersTest, TriggerEventQueueTest,
HttpTriggerListenerTest, TestSimUtils, CdcrVersionReplicationTest,
V2CollectionBackupsAPIMappingTest, SolrMetricsIntegrationTest,
TestStressUserVersions, AsyncCallRequestStatusResponseTest,
TestCloudInspectUtil, TestCustomStream, V2StandaloneTest,
TestSimNodeLostTrigger, TestTextField, TestFieldTypeResource, TestDistribIDF,
TestScoreJoinQPScore, AggValueSourceTest, TestImplicitCoreProperties,
IndexSizeEstimatorTest, IndexSchemaTest, TermsComponentTest,
DistributedQueryElevationComponentTest, TestCursorMarkWithoutUniqueKey,
LeaderVoteWaitTimeoutTest, SchemaVersionSpecificBehaviorTest,
QueryEqualityTest, TestGraphMLResponseWriter, TestWordDelimiterFilterFactory,
SearchRateTriggerTest, TestDocTermOrdsUninvertLimit,
JWTVerificationkeyResolverTest, SearchHandlerTest, TestPullReplicaWithAuth,
TestLeaderElectionWithEmptyReplica, TestMaxScoreQueryParser,
TestSimComputePlanAction, TestAuthorizationFramework, DeleteShardTest,
TestManagedSynonymFilterFactory, TestCSVLoader, MetricTriggerIntegrationTest,
MetricTriggerTest, NodeAddedTriggerIntegrationTest, NodeAddedTriggerTest,
NodeLostTriggerTest, ScheduledMaintenanceTriggerTest,
BaseCdcrDistributedZkTest, CdcrBidirectionalTest, CdcrBootstrapTest,
HdfsNNFailoverTest, HdfsRecoverLeaseTest, HdfsWriteToMultipleCollectionsTest,
StressHdfsTest, TestConfigOverlay, TestCoreContainer, TestMergePolicyConfig,
TestMinimalConfig, TestNRTOpen, TestReloadAndDeleteDocs, TestSolrConfigHandler,
TestSolrCloudSnapshots, TestReplicationHandlerBackup,
TestReplicationHandlerDiskOverFlow, TestSQLHandler,
XmlUpdateRequestHandlerTest, CoreAdminOperationTest,
CoreAdminRequestStatusTest, ShowFileRequestHandlerTest,
ZookeeperStatusHandlerFailureTest, CloudReplicaSourceTest,
CustomHighlightComponentTest, DebugComponentTest,
DistributedDebugComponentTest, DistributedExpandComponentTest,
DistributedFacetPivotLongTailTest, DistributedMLTComponentTest,
TestDistributedStatsComponentCardinality, TestCollationField,
TestManagedSchemaThreadSafety, UUIDFieldTest, AnalyticsMergeStrategyTest,
RankQueryTest, SignificantTermsQParserPluginTest, SortSpecParsingTest,
TestAddFieldRealTimeGet, TestCaffeineCache, TestFastLRUCache,
TestFilteredDocIdSet, TestFiltering]
[junit4] 2> NOTE: download the large Jenkins line-docs file by running
'ant get-jenkins-line-docs' in the lucene directory.
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestFiltering
-Dtests.seed=941028414E3EFF6C -Dtests.multiplier=2 -Dtests.nightly=true
-Dtests.slow=true
-Dtests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/test-data/enwiki.random.lines.txt
-Dtests.locale=sr-Latn-ME -Dtests.timezone=Asia/Dhaka -Dtests.asserts=true
-Dtests.file.encoding=ISO-8859-1
[junit4] ERROR 0.00s J2 | TestFiltering (suite) <<<
[junit4] > Throwable #1: java.lang.Exception: Suite timeout exceeded (>=
7200000 msec).
[junit4] > at
__randomizedtesting.SeedInfo.seed([941028414E3EFF6C]:0)
[junit4] Completed [947/947 (1!)] on J2 in 7212.86s, 4 tests, 2 errors <<<
FAILURES!
[...truncated 54224 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
