Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-Solr-Tests-8.x/3178/

2 tests failed.
FAILED:  org.apache.solr.util.TestCircuitBreaker.testResponseWithCBTiming

Error Message:
Exception during query

Stack Trace:
java.lang.RuntimeException: Exception during query
        at 
__randomizedtesting.SeedInfo.seed([1FCB477FA65B0BB9:F717EA9D55B31199]:0)
        at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:1024)
        at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:984)
        at 
org.apache.solr.util.TestCircuitBreaker.testResponseWithCBTiming(TestCircuitBreaker.java:245)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at org.junit.rules.RunRules.evaluate(RunRules.java:20)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at org.junit.rules.RunRules.evaluate(RunRules.java:20)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at org.junit.rules.RunRules.evaluate(RunRules.java:20)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at org.junit.rules.RunRules.evaluate(RunRules.java:20)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.lang.Thread.run(Thread.java:748)
Caused by: org.apache.solr.common.SolrException: Circuit Breakers tripped 
Memory Circuit Breaker triggered as JVM heap usage values are greater than 
allocated threshold.Seen JVM heap memory usage 468047304 and allocated 
threshold 396361728

        at 
org.apache.solr.handler.component.SearchHandler.handleRequestBody(SearchHandler.java:321)
        at 
org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:216)
        at org.apache.solr.core.SolrCore.execute(SolrCore.java:2637)
        at org.apache.solr.util.TestHarness.query(TestHarness.java:346)
        at org.apache.solr.util.TestHarness.query(TestHarness.java:328)
        at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:998)
        ... 45 more


FAILED:  org.apache.solr.search.TestFiltering.testRandomFiltering

Error Message:
should have unwrapped

Stack Trace:
java.lang.AssertionError: should have unwrapped
        at 
__randomizedtesting.SeedInfo.seed([1FCB477FA65B0BB9:A8E4BA437C4BB0]:0)
        at 
org.apache.solr.search.SolrIndexSearcher.getAndCacheDocSet(SolrIndexSearcher.java:862)
        at 
org.apache.solr.search.SolrIndexSearcher.getDocSet(SolrIndexSearcher.java:824)
        at 
org.apache.solr.search.SolrIndexSearcher.getDocListC(SolrIndexSearcher.java:1367)
        at 
org.apache.solr.search.SolrIndexSearcher.search(SolrIndexSearcher.java:596)
        at 
org.apache.solr.handler.component.QueryComponent.doProcessUngroupedSearch(QueryComponent.java:1511)
        at 
org.apache.solr.handler.component.QueryComponent.process(QueryComponent.java:390)
        at 
org.apache.solr.handler.component.SearchHandler.handleRequestBody(SearchHandler.java:368)
        at 
org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:216)
        at org.apache.solr.core.SolrCore.execute(SolrCore.java:2637)
        at org.apache.solr.util.TestHarness.query(TestHarness.java:346)
        at org.apache.solr.util.TestHarness.query(TestHarness.java:328)
        at org.apache.solr.SolrTestCaseJ4.assertJQ(SolrTestCaseJ4.java:1090)
        at org.apache.solr.SolrTestCaseJ4.assertJQ(SolrTestCaseJ4.java:1059)
        at 
org.apache.solr.search.TestFiltering.testRandomFiltering(TestFiltering.java:488)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at org.junit.rules.RunRules.evaluate(RunRules.java:20)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at org.junit.rules.RunRules.evaluate(RunRules.java:20)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at org.junit.rules.RunRules.evaluate(RunRules.java:20)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at org.junit.rules.RunRules.evaluate(RunRules.java:20)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.lang.Thread.run(Thread.java:748)




Build Log:
[...truncated 13623 lines...]
   [junit4] Suite: org.apache.solr.search.TestFiltering
   [junit4]   2> 242901 INFO  
(SUITE-TestFiltering-seed#[1FCB477FA65B0BB9]-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-Tests-8.x/solr/server/solr/configsets/_default/conf'
   [junit4]   2> 242901 INFO  
(SUITE-TestFiltering-seed#[1FCB477FA65B0BB9]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Created dataDir: 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.search.TestFiltering_1FCB477FA65B0BB9-001/data-dir-31-001
   [junit4]   2> 242901 WARN  
(SUITE-TestFiltering-seed#[1FCB477FA65B0BB9]-worker) [     ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=39 numCloses=39
   [junit4]   2> 242901 INFO  
(SUITE-TestFiltering-seed#[1FCB477FA65B0BB9]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 242905 INFO  
(SUITE-TestFiltering-seed#[1FCB477FA65B0BB9]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via: 
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
   [junit4]   2> 242905 INFO  
(SUITE-TestFiltering-seed#[1FCB477FA65B0BB9]-worker) [     ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 242906 INFO  
(SUITE-TestFiltering-seed#[1FCB477FA65B0BB9]-worker) [     ] 
o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 242917 INFO  
(SUITE-TestFiltering-seed#[1FCB477FA65B0BB9]-worker) [     ] 
o.a.s.c.SolrResourceLoader Added 2 libs to classloader, from paths: 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1/lib,
 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 242938 INFO  
(SUITE-TestFiltering-seed#[1FCB477FA65B0BB9]-worker) [     ] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 8.11.0
   [junit4]   2> 242938 WARN  
(SUITE-TestFiltering-seed#[1FCB477FA65B0BB9]-worker) [     ] o.a.s.c.SolrConfig 
solrconfig.xml: <boolTofilterOptimizer> is currently not implemented and has no 
effect.
   [junit4]   2> 242938 WARN  
(SUITE-TestFiltering-seed#[1FCB477FA65B0BB9]-worker) [     ] o.a.s.c.SolrConfig 
solrconfig.xml: <jmx> is no longer supported, use solr.xml:/metrics/reporter 
section instead
   [junit4]   2> 242941 INFO  
(SUITE-TestFiltering-seed#[1FCB477FA65B0BB9]-worker) [     ] 
o.a.s.s.IndexSchema Schema name=example
   [junit4]   2> 242945 INFO  
(SUITE-TestFiltering-seed#[1FCB477FA65B0BB9]-worker) [     ] 
o.a.s.s.IndexSchema Loaded schema example/1.6 with uniqueid field id
   [junit4]   2> 243694 WARN  
(SUITE-TestFiltering-seed#[1FCB477FA65B0BB9]-worker) [     ] 
o.a.s.c.CoreContainer Unable to create 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/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-Tests-8.x/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-Tests-8.x/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> 243695 WARN  
(SUITE-TestFiltering-seed#[1FCB477FA65B0BB9]-worker) [     ] 
o.a.s.f.DistribPackageStore Unable to create 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/filestore]
 directory in SOLR_HOME 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/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-Tests-8.x/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-Tests-8.x/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> 243697 INFO  
(SUITE-TestFiltering-seed#[1FCB477FA65B0BB9]-worker) [     ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 243699 WARN  
(SUITE-TestFiltering-seed#[1FCB477FA65B0BB9]-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> 243701 WARN  
(SUITE-TestFiltering-seed#[1FCB477FA65B0BB9]-worker) [     ] o.e.j.u.s.S.config 
Trusting all certificates configured for 
Client@6b1d500c[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 243701 WARN  
(SUITE-TestFiltering-seed#[1FCB477FA65B0BB9]-worker) [     ] o.e.j.u.s.S.config 
No Client EndPointIdentificationAlgorithm configured for 
Client@6b1d500c[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 243704 WARN  
(SUITE-TestFiltering-seed#[1FCB477FA65B0BB9]-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> 243705 WARN  
(SUITE-TestFiltering-seed#[1FCB477FA65B0BB9]-worker) [     ] o.e.j.u.s.S.config 
Trusting all certificates configured for 
Client@60a4d492[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 243705 WARN  
(SUITE-TestFiltering-seed#[1FCB477FA65B0BB9]-worker) [     ] o.e.j.u.s.S.config 
No Client EndPointIdentificationAlgorithm configured for 
Client@60a4d492[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 243707 WARN  
(SUITE-TestFiltering-seed#[1FCB477FA65B0BB9]-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> 243764 INFO  
(SUITE-TestFiltering-seed#[1FCB477FA65B0BB9]-worker) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@55d5a632
   [junit4]   2> 243775 INFO  
(SUITE-TestFiltering-seed#[1FCB477FA65B0BB9]-worker) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@55d5a632
   [junit4]   2> 243775 INFO  
(SUITE-TestFiltering-seed#[1FCB477FA65B0BB9]-worker) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@55d5a632
   [junit4]   2> 243778 INFO  (coreLoadExecutor-2013-thread-1) [     ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient core cache for max 
2147483647 cores with initial capacity of 1024
   [junit4]   2> 243790 INFO  (coreLoadExecutor-2013-thread-1) [    
x:collection1 ] o.a.s.c.SolrResourceLoader Added 2 libs to classloader, from 
paths: 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1/lib,
 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 243818 INFO  (coreLoadExecutor-2013-thread-1) [    
x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.11.0
   [junit4]   2> 243819 WARN  (coreLoadExecutor-2013-thread-1) [    
x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <boolTofilterOptimizer> is 
currently not implemented and has no effect.
   [junit4]   2> 243819 WARN  (coreLoadExecutor-2013-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> 243822 INFO  (coreLoadExecutor-2013-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema Schema name=example
   [junit4]   2> 243825 INFO  (coreLoadExecutor-2013-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema Loaded schema example/1.6 with uniqueid 
field id
   [junit4]   2> 243835 INFO  (coreLoadExecutor-2013-thread-1) [    
x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from instancedir 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1,
 trusted=true
   [junit4]   2> 243836 INFO  (coreLoadExecutor-2013-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@55d5a632
   [junit4]   2> 243836 INFO  (coreLoadExecutor-2013-thread-1) [    
x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.search.TestFiltering_1FCB477FA65B0BB9-001/data-dir-31-001/]
   [junit4]   2> 243837 INFO  (coreLoadExecutor-2013-thread-1) [    
x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=22, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.7514797614363371]
   [junit4]   2> 243898 INFO  (coreLoadExecutor-2013-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 243898 INFO  (coreLoadExecutor-2013-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 243899 INFO  (coreLoadExecutor-2013-thread-1) [    
x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=22, maxMergeAtOnceExplicit=17, maxMergedSegmentMB=74.041015625, 
floorSegmentMB=1.548828125, forceMergeDeletesPctAllowed=28.536732636964032, 
segmentsPerTier=39.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.8590480305679078, deletesPctAllowed=40.022252243194345
   [junit4]   2> 243900 INFO  (coreLoadExecutor-2013-thread-1) [    
x:collection1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 243914 INFO  (coreLoadExecutor-2013-thread-1) [    
x:collection1 ] o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 243958 INFO  (coreLoadExecutor-2013-thread-1) [    
x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 243958 INFO  
(searcherExecutor-2015-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 243958 INFO  
(searcherExecutor-2015-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 243958 INFO  
(searcherExecutor-2015-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 243958 INFO  
(searcherExecutor-2015-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 243959 INFO  
(searcherExecutor-2015-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 243959 INFO  
(searcherExecutor-2015-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 243959 INFO  
(searcherExecutor-2015-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 243959 INFO  
(searcherExecutor-2015-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 243959 INFO  
(searcherExecutor-2015-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 243960 INFO  
(SUITE-TestFiltering-seed#[1FCB477FA65B0BB9]-worker) [     ] 
o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 243960 INFO  
(searcherExecutor-2015-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 243964 INFO  
(TEST-TestFiltering.testCaching-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.SolrTestCaseJ4 ###Starting testCaching
   [junit4]   2> 243964 INFO  
(TEST-TestFiltering.testCaching-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.u.DirectUpdateHandler2 [collection1]  REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 243965 INFO  
(TEST-TestFiltering.testCaching-seed#[1FCB477FA65B0BB9]) [     ] 
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> 243966 INFO  
(TEST-TestFiltering.testCaching-seed#[1FCB477FA65B0BB9]) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[4]} 0 0
   [junit4]   2> 243969 INFO  
(TEST-TestFiltering.testCaching-seed#[1FCB477FA65B0BB9]) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[1]} 0 0
   [junit4]   2> 243969 INFO  
(TEST-TestFiltering.testCaching-seed#[1FCB477FA65B0BB9]) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[3]} 0 0
   [junit4]   2> 243969 INFO  
(TEST-TestFiltering.testCaching-seed#[1FCB477FA65B0BB9]) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[2]} 0 0
   [junit4]   2> 243979 INFO  
(searcherExecutor-2015-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 243979 INFO  
(TEST-TestFiltering.testCaching-seed#[1FCB477FA65B0BB9]) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{commit=} 0 9
   [junit4]   2> 243982 INFO  
(TEST-TestFiltering.testCaching-seed#[1FCB477FA65B0BB9]) [     ] 
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=1
   [junit4]   2> 243982 INFO  
(TEST-TestFiltering.testCaching-seed#[1FCB477FA65B0BB9]) [     ] 
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> 243983 INFO  
(TEST-TestFiltering.testCaching-seed#[1FCB477FA65B0BB9]) [     ] 
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> 243983 INFO  
(TEST-TestFiltering.testCaching-seed#[1FCB477FA65B0BB9]) [     ] 
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> 243983 INFO  
(TEST-TestFiltering.testCaching-seed#[1FCB477FA65B0BB9]) [     ] 
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> 243986 INFO  
(TEST-TestFiltering.testCaching-seed#[1FCB477FA65B0BB9]) [     ] 
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=3
   [junit4]   2> 244004 INFO  
(TEST-TestFiltering.testCaching-seed#[1FCB477FA65B0BB9]) [     ] 
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=18
   [junit4]   2> 244005 INFO  
(TEST-TestFiltering.testCaching-seed#[1FCB477FA65B0BB9]) [     ] 
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> 244008 INFO  
(TEST-TestFiltering.testCaching-seed#[1FCB477FA65B0BB9]) [     ] 
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> 244008 INFO  
(TEST-TestFiltering.testCaching-seed#[1FCB477FA65B0BB9]) [     ] 
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> 244009 INFO  
(TEST-TestFiltering.testCaching-seed#[1FCB477FA65B0BB9]) [     ] 
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> 244009 INFO  
(TEST-TestFiltering.testCaching-seed#[1FCB477FA65B0BB9]) [     ] 
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> 244010 INFO  
(TEST-TestFiltering.testCaching-seed#[1FCB477FA65B0BB9]) [     ] 
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> 244011 INFO  
(TEST-TestFiltering.testCaching-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.SolrTestCaseJ4 ###Ending testCaching
   [junit4]   2> 244017 INFO  
(TEST-TestFiltering.testLiveDocsSharing-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.SolrTestCaseJ4 ###Starting testLiveDocsSharing
   [junit4]   2> 244017 INFO  
(TEST-TestFiltering.testLiveDocsSharing-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.u.DirectUpdateHandler2 [collection1]  REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 244017 INFO  
(TEST-TestFiltering.testLiveDocsSharing-seed#[1FCB477FA65B0BB9]) [     ] 
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> 244018 INFO  
(TEST-TestFiltering.testLiveDocsSharing-seed#[1FCB477FA65B0BB9]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[0]} 0 0
   [junit4]   2> 244018 INFO  
(TEST-TestFiltering.testLiveDocsSharing-seed#[1FCB477FA65B0BB9]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[0]} 0 0
   [junit4]   2> 244019 INFO  
(TEST-TestFiltering.testLiveDocsSharing-seed#[1FCB477FA65B0BB9]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[1]} 0 0
   [junit4]   2> 244019 INFO  
(TEST-TestFiltering.testLiveDocsSharing-seed#[1FCB477FA65B0BB9]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[2]} 0 0
   [junit4]   2> 244020 INFO  
(TEST-TestFiltering.testLiveDocsSharing-seed#[1FCB477FA65B0BB9]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[3]} 0 0
   [junit4]   2> 244020 INFO  
(TEST-TestFiltering.testLiveDocsSharing-seed#[1FCB477FA65B0BB9]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[4]} 0 0
   [junit4]   2> 244020 INFO  
(TEST-TestFiltering.testLiveDocsSharing-seed#[1FCB477FA65B0BB9]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[5]} 0 0
   [junit4]   2> 244021 INFO  
(TEST-TestFiltering.testLiveDocsSharing-seed#[1FCB477FA65B0BB9]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[5]} 0 0
   [junit4]   2> 244021 INFO  
(TEST-TestFiltering.testLiveDocsSharing-seed#[1FCB477FA65B0BB9]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[6]} 0 0
   [junit4]   2> 244021 INFO  
(TEST-TestFiltering.testLiveDocsSharing-seed#[1FCB477FA65B0BB9]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[7]} 0 0
   [junit4]   2> 244022 INFO  
(TEST-TestFiltering.testLiveDocsSharing-seed#[1FCB477FA65B0BB9]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[8]} 0 0
   [junit4]   2> 244022 INFO  
(TEST-TestFiltering.testLiveDocsSharing-seed#[1FCB477FA65B0BB9]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[9]} 0 0
   [junit4]   2> 244022 INFO  
(TEST-TestFiltering.testLiveDocsSharing-seed#[1FCB477FA65B0BB9]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[10]} 0 0
   [junit4]   2> 244022 INFO  
(TEST-TestFiltering.testLiveDocsSharing-seed#[1FCB477FA65B0BB9]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[10]} 0 0
   [junit4]   2> 244023 INFO  
(TEST-TestFiltering.testLiveDocsSharing-seed#[1FCB477FA65B0BB9]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[11]} 0 0
   [junit4]   2> 244023 INFO  
(TEST-TestFiltering.testLiveDocsSharing-seed#[1FCB477FA65B0BB9]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[12]} 0 0
   [junit4]   2> 244023 INFO  
(TEST-TestFiltering.testLiveDocsSharing-seed#[1FCB477FA65B0BB9]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[13]} 0 0
   [junit4]   2> 244024 INFO  
(TEST-TestFiltering.testLiveDocsSharing-seed#[1FCB477FA65B0BB9]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[14]} 0 0
   [junit4]   2> 244024 INFO  
(TEST-TestFiltering.testLiveDocsSharing-seed#[1FCB477FA65B0BB9]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[15]} 0 0
   [junit4]   2> 244024 INFO  
(TEST-TestFiltering.testLiveDocsSharing-seed#[1FCB477FA65B0BB9]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[15]} 0 0
   [junit4]   2> 244025 INFO  
(TEST-TestFiltering.testLiveDocsSharing-seed#[1FCB477FA65B0BB9]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[16]} 0 0
   [junit4]   2> 244025 INFO  
(TEST-TestFiltering.testLiveDocsSharing-seed#[1FCB477FA65B0BB9]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[17]} 0 0
   [junit4]   2> 244025 INFO  
(TEST-TestFiltering.testLiveDocsSharing-seed#[1FCB477FA65B0BB9]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[18]} 0 0
   [junit4]   2> 244025 INFO  
(TEST-TestFiltering.testLiveDocsSharing-seed#[1FCB477FA65B0BB9]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[19]} 0 0
   [junit4]   2> 244034 INFO  
(searcherExecutor-2015-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 244035 INFO  
(TEST-TestFiltering.testLiveDocsSharing-seed#[1FCB477FA65B0BB9]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{commit=} 0 9
   [junit4]   2> 244044 INFO  
(TEST-TestFiltering.testLiveDocsSharing-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.SolrTestCaseJ4 ###Ending testLiveDocsSharing
   [junit4]   2> 244055 INFO  
(TEST-TestFiltering.testHossssSanity-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.SolrTestCaseJ4 ###Starting testHossssSanity
   [junit4]   2> 244055 INFO  
(TEST-TestFiltering.testHossssSanity-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.u.DirectUpdateHandler2 [collection1]  REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 244055 INFO  
(TEST-TestFiltering.testHossssSanity-seed#[1FCB477FA65B0BB9]) [     ] 
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> 244056 INFO  
(TEST-TestFiltering.testHossssSanity-seed#[1FCB477FA65B0BB9]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[0]} 0 0
   [junit4]   2> 244056 INFO  
(TEST-TestFiltering.testHossssSanity-seed#[1FCB477FA65B0BB9]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[1]} 0 0
   [junit4]   2> 244057 INFO  
(TEST-TestFiltering.testHossssSanity-seed#[1FCB477FA65B0BB9]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[2]} 0 0
   [junit4]   2> 244057 INFO  
(TEST-TestFiltering.testHossssSanity-seed#[1FCB477FA65B0BB9]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[3]} 0 0
   [junit4]   2> 244057 INFO  
(TEST-TestFiltering.testHossssSanity-seed#[1FCB477FA65B0BB9]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[4]} 0 0
   [junit4]   2> 244057 INFO  
(TEST-TestFiltering.testHossssSanity-seed#[1FCB477FA65B0BB9]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[5]} 0 0
   [junit4]   2> 244058 INFO  
(TEST-TestFiltering.testHossssSanity-seed#[1FCB477FA65B0BB9]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[6]} 0 0
   [junit4]   2> 244058 INFO  
(TEST-TestFiltering.testHossssSanity-seed#[1FCB477FA65B0BB9]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[7]} 0 0
   [junit4]   2> 244058 INFO  
(TEST-TestFiltering.testHossssSanity-seed#[1FCB477FA65B0BB9]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[8]} 0 0
   [junit4]   2> 244058 INFO  
(TEST-TestFiltering.testHossssSanity-seed#[1FCB477FA65B0BB9]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[9]} 0 0
   [junit4]   2> 244070 INFO  
(searcherExecutor-2015-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 1 ms
   [junit4]   2> 244074 INFO  
(TEST-TestFiltering.testHossssSanity-seed#[1FCB477FA65B0BB9]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{commit=} 0 14
   [junit4]   2> 244074 INFO  
(TEST-TestFiltering.testHossssSanity-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=*:*&wt=xml} 
hits=10 status=0 QTime=0
   [junit4]   2> 244077 INFO  
(TEST-TestFiltering.testHossssSanity-seed#[1FCB477FA65B0BB9]) [     ] 
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=2
   [junit4]   2> 244078 INFO  
(TEST-TestFiltering.testHossssSanity-seed#[1FCB477FA65B0BB9]) [     ] 
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> 244078 INFO  
(TEST-TestFiltering.testHossssSanity-seed#[1FCB477FA65B0BB9]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{commit=} 0 0
   [junit4]   2> 244079 INFO  
(TEST-TestFiltering.testHossssSanity-seed#[1FCB477FA65B0BB9]) [     ] 
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> 244079 INFO  
(TEST-TestFiltering.testHossssSanity-seed#[1FCB477FA65B0BB9]) [     ] 
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> 244080 INFO  
(TEST-TestFiltering.testHossssSanity-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.SolrTestCaseJ4 ###Ending testHossssSanity
   [junit4]   2> 244084 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.SolrTestCaseJ4 ###Starting testRandomFiltering
   [junit4]   2> 244084 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.u.DirectUpdateHandler2 [collection1]  REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 244084 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
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> 244085 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[0]} 0 0
   [junit4]   2> 244085 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[0]} 0 0
   [junit4]   2> 244097 INFO  
(searcherExecutor-2015-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 244102 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{commit=} 0 16
   [junit4]   2> 244102 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[1]} 0 0
   [junit4]   2> 244103 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[2]} 0 0
   [junit4]   2> 244103 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[3]} 0 0
   [junit4]   2> 244103 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[3]} 0 0
   [junit4]   2> 244103 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[4]} 0 0
   [junit4]   2> 244103 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[5]} 0 0
   [junit4]   2> 244103 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[6]} 0 0
   [junit4]   2> 244110 INFO  
(searcherExecutor-2015-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 244110 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{commit=} 0 7
   [junit4]   2> 244111 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=*:*&wt=xml} 
hits=7 status=0 QTime=0
   [junit4]   2> 244112 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q={!+cache%3Dfalse}val_i:[00000+TO+00005]&fq={!cache%3Dtrue}+-val_i:1+-val_i:3+-val_i:4+-val_i:5&wt=xml}
 hits=2 status=0 QTime=1
   [junit4]   2> 244114 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q={!cache%3Dfalse+tag%3Dt}+-val_i:5+-val_i:6&fq={!frange+v%3Dval_i+l%3D5+u%3D9+cache%3Dfalse}&fq={!cache%3Dfalse+cost%3D91+tag%3Dt}+-val_i:2+-val_i:5+-val_i:6&fq={!+cache%3Dtrue+tag%3Dt}val_i:[00002+TO+00006]+OR+id:RAND83637585&fq={!+cost%3D54+tag%3Dt}-_query_:"val_s:{00002+TO+00006]"&wt=xml}
 hits=0 status=0 QTime=1
   [junit4]   2> 244117 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
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:6&q={!frange+v%3Dval_i+l%3D2+u%3D7+cache%3Dfalse}&fq={!cache%3Dfalse+cost%3D63+tag%3Dt}+val_i:1+val_i:2+val_i:3+val_i:5&fq={!+cache%3Dtrue+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D3+u%3D6}"&fq={!+cost%3D42+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D6+u%3D7}"&fq=-_query_:"{!frange+v%3Dval_i+l%3D6+u%3D6}"&facet=true&wt=xml}
 hits=1 status=0 QTime=2
   [junit4]   2> 244120 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
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:6&fq={!cache%3Dtrue+tag%3Dt}+-val_i:2+-val_i:4+-val_i:6&fq={!cache%3Dtrue+tag%3Dt}+-val_i:0+-val_i:1+-val_i:4+-val_i:6&fq={!+cost%3D120}val_i:[00004+TO+00007}&wt=xml}
 hits=1 status=0 QTime=3
   [junit4]   2> 244121 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
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%3D50}-id:99999999&q={!+cache%3Dfalse}-_query_:"{!frange+v%3Dval_i+l%3D3+u%3D6}"&fq={!+cache%3Dtrue+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D0+u%3D6}"&facet=true&wt=xml}
 hits=0 status=0 QTime=0
   [junit4]   2> 244122 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
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%3D6+u%3D6}"&q={!cache%3Dfalse}+val_i:0+val_i:3&fq={!frange+v%3Dval_i+l%3D1+u%3D4+cost%3D84+tag%3Dt}&fq={!cache%3Dfalse+tag%3Dt}+-val_i:0+-val_i:2+-val_i:3+-val_i:5+-val_i:6&facet=true&wt=xml}
 hits=0 status=0 QTime=0
   [junit4]   2> 244123 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
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:6&q={!cache%3Dtrue+tag%3Dt}+-val_i:2&fq={!frange+v%3Dval_i+l%3D5+u%3D6+cache%3Dfalse+tag%3Dt}&facet=true&wt=xml}
 hits=2 status=0 QTime=0
   [junit4]   2> 244123 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q={!+cache%3Dfalse}val_s:[00004+TO+00006}&fq={!+cost%3D120+tag%3Dt}-_query_:"val_i:[00001+TO+00006]"&wt=xml}
 hits=0 status=0 QTime=0
   [junit4]   2> 244124 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=-_query_:"val_s:{00002+TO+00007}"&fq={!cache%3Dfalse}+val_i:0+val_i:2+val_i:5+val_i:6&fq={!+cache%3Dtrue+tag%3Dt}-_query_:"val_s:[00000+TO+00006]"&fq={!+cache%3Dfalse+cost%3D12}-_query_:"val_i:{00004+TO+00007}"&fq={!+cache%3Dfalse+cost%3D41}-_query_:"{!frange+v%3Dval_i+l%3D3+u%3D6}"&wt=xml}
 hits=0 status=0 QTime=1
   [junit4]   2> 244126 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
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:4&q={!cache%3Dfalse+cost%3D37+tag%3Dt}+val_i:1+val_i:2+val_i:3+val_i:6&fq={!cache%3Dfalse}+val_i:1+val_i:4&fq={!frange+v%3Dval_i+l%3D4+u%3D9+cache%3Dtrue+tag%3Dt}&fq=val_s:[00004+TO+00010]&facet=true&wt=xml}
 hits=0 status=0 QTime=1
   [junit4]   2> 244126 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q={!+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D0+u%3D6}"&fq={!cache%3Dfalse}+val_i:4&fq={!+cache%3Dtrue+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D0+u%3D6}"&wt=xml}
 hits=0 status=0 QTime=0
   [junit4]   2> 244127 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
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%3D1+u%3D4}&q={!cache%3Dtrue+tag%3Dt}+val_i:0+val_i:1+val_i:3+val_i:4+val_i:5+val_i:6&fq={!+cache%3Dtrue+tag%3Dt}-_query_:"val_s:{00002+TO+00006]"&fq={!+cost%3D195}-_query_:"val_i:[00000+TO+00007}"&facet=true&wt=xml}
 hits=0 status=0 QTime=0
   [junit4]   2> 244129 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
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%3D157}+-val_i:1+-val_i:2+-val_i:5&q={!cache%3Dfalse+tag%3Dt}+val_i:1+val_i:2+val_i:3+val_i:6&fq=val_s:{00000+TO+00006]+AND+val_s:[00001+TO+00007}&fq={!cache%3Dfalse}+val_i:0+val_i:1+val_i:3+val_i:5+val_i:6&fq={!cache%3Dtrue+tag%3Dt}+-val_i:1+-val_i:2+-val_i:3+-val_i:6&facet=true&wt=xml}
 hits=0 status=0 QTime=2
   [junit4]   2> 244130 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
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%3D0+u%3D6}"&q={!frange+v%3Dval_i+l%3D2+u%3D7+cache%3Dfalse+cost%3D40}&facet=true&wt=xml}
 hits=5 status=0 QTime=0
   [junit4]   2> 244130 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=-_query_:"{!frange+v%3Dval_i+l%3D5+u%3D6}"&fq={!frange+v%3Dval_i+l%3D3+u%3D8+cache%3Dfalse+cost%3D59+tag%3Dt}&fq={!+cache%3Dtrue+tag%3Dt}-_query_:"val_s:{00001+TO+00007}"&fq={!+cache%3Dfalse+cost%3D110+tag%3Dt}*:*+AND+val_i:{00005+TO+00007}&fq=val_i:{00005+TO+00007}&wt=xml}
 hits=0 status=0 QTime=0
   [junit4]   2> 244131 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q={!cache%3Dfalse+cost%3D7+tag%3Dt}+val_i:0+val_i:2+val_i:6&fq={!frange+v%3Dval_i+l%3D5+u%3D8+tag%3Dt}&fq={!cache%3Dfalse+cost%3D31+tag%3Dt}+val_i:1+val_i:2+val_i:3+val_i:4&fq={!cache%3Dfalse+cost%3D78+tag%3Dt}+-val_i:1+-val_i:2+-val_i:4+-val_i:6&fq={!+cost%3D79+tag%3Dt}val_i:{00003+TO+00009]&wt=xml}
 hits=0 status=0 QTime=0
   [junit4]   2> 244132 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q={!frange+v%3Dval_i+l%3D2+u%3D5}&fq=+-val_i:1+-val_i:2+-val_i:4+-val_i:5+-val_i:6&wt=xml}
 hits=1 status=0 QTime=0
   [junit4]   2> 244133 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
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:1+-val_i:2+-val_i:3+-val_i:5&q={!frange+v%3Dval_i+l%3D1+u%3D3}&facet=true&wt=xml}
 hits=3 status=0 QTime=0
   [junit4]   2> 244133 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q={!+cache%3Dfalse}-_query_:"{!frange+v%3Dval_i+l%3D1+u%3D6}"&fq=+val_i:0+val_i:1+val_i:2+val_i:3+val_i:5+val_i:6&wt=xml}
 hits=1 status=0 QTime=0
   [junit4]   2> 244134 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
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:1+-val_i:3+-val_i:4&q={!cache%3Dfalse}+val_i:1+val_i:2+val_i:6&fq={!+cache%3Dfalse}-_query_:"{!frange+v%3Dval_i+l%3D1+u%3D6}"&fq={!+cache%3Dtrue+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D5+u%3D6}"&fq={!frange+v%3Dval_i+l%3D5+u%3D10+cache%3Dtrue+tag%3Dt}&fq={!frange+v%3Dval_i+l%3D2+u%3D8}&facet=true&wt=xml}
 hits=0 status=0 QTime=1
   [junit4]   2> 244136 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
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%3D6+u%3D6}"&q=+-val_i:1+-val_i:2&fq=+val_i:0+val_i:1+val_i:2+val_i:4+val_i:6&fq={!frange+v%3Dval_i+l%3D2+u%3D5+cache%3Dfalse}&fq={!frange+v%3Dval_i+l%3D5+u%3D10+cache%3Dtrue+tag%3Dt}&fq={!cache%3Dfalse+tag%3Dt}+-val_i:0+-val_i:3+-val_i:5+-val_i:6&facet=true&wt=xml}
 hits=0 status=0 QTime=1
   [junit4]   2> 244136 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
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:{00001+TO+00009}+AND+val_i:[00002+TO+00008]&q={!cache%3Dfalse}+val_i:2+val_i:3+val_i:4+val_i:6&facet=true&wt=xml}
 hits=4 status=0 QTime=0
   [junit4]   2> 244137 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q={!cache%3Dfalse+cost%3D136}+-val_i:1+-val_i:2+-val_i:3&wt=xml} hits=4 
status=0 QTime=0
   [junit4]   2> 244138 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q={!cache%3Dtrue}+-val_i:0+-val_i:2+-val_i:5+-val_i:6&fq=+val_i:0+val_i:1+val_i:4+val_i:6&fq={!cache%3Dtrue+tag%3Dt}+val_i:0+val_i:1+val_i:2+val_i:4&fq={!cache%3Dtrue}+-val_i:0+-val_i:1+-val_i:3+-val_i:4+-val_i:6&wt=xml}
 hits=0 status=0 QTime=0
   [junit4]   2> 244139 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
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:[00000+TO+00005}&q={!+tag%3Dt}id:RAND969520153+OR+val_i:{00000+TO+00008}&fq={!cache%3Dfalse}+-val_i:0+-val_i:1+-val_i:2+-val_i:3+-val_i:4+-val_i:5&fq={!cache%3Dtrue+tag%3Dt}+-val_i:0+-val_i:1+-val_i:2+-val_i:3&facet=true&wt=xml}
 hits=1 status=0 QTime=1
   [junit4]   2> 244140 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=-_query_:"val_i:{00001+TO+00007}"&fq={!frange+v%3Dval_i+l%3D3+u%3D5+cache%3Dfalse+cost%3D121+tag%3Dt}&fq={!+cache%3Dtrue+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D0+u%3D6}"&fq={!frange+v%3Dval_i+l%3D2+u%3D7}&fq={!frange+v%3Dval_i+l%3D4+u%3D9+cache%3Dfalse+cost%3D177}&wt=xml}
 hits=0 status=0 QTime=0
   [junit4]   2> 244141 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q={!cache%3Dfalse+tag%3Dt}+-val_i:0+-val_i:1+-val_i:2+-val_i:3+-val_i:4+-val_i:5&fq={!+cost%3D19}val_s:{00002+TO+00007]+OR+val_s:[00003+TO+00008}&wt=xml}
 hits=1 status=0 QTime=0
   [junit4]   2> 244141 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery+}-_query_:"val_i:{00000+TO+00007}"&q={!cache%3Dfalse+cost%3D114}+val_i:0+val_i:5&fq={!+cache%3Dfalse}-_query_:"{!frange+v%3Dval_i+l%3D6+u%3D6}"&fq=val_s:[00005+TO+00009]&facet=true&wt=xml}
 hits=1 status=0 QTime=0
   [junit4]   2> 244142 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q={!cache%3Dtrue}+-val_i:1+-val_i:3+-val_i:5&fq={!+cache%3Dtrue+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D4+u%3D6}"&wt=xml}
 hits=2 status=0 QTime=0
   [junit4]   2> 244143 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
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%3D2+u%3D6}&q=-_query_:"val_s:{00000+TO+00006]"&facet=true&wt=xml}
 hits=1 status=0 QTime=0
   [junit4]   2> 244143 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
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_s:[00006+TO+00006]+AND+val_s:{00005+TO+00007}&q={!frange+v%3Dval_i+l%3D5+u%3D9+tag%3Dt}&fq={!+cache%3Dfalse+cost%3D173}-_query_:"val_i:[00000+TO+00006]"&facet=true&wt=xml}
 hits=0 status=0 QTime=0
   [junit4]   2> 244144 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q={!cache%3Dfalse+tag%3Dt}+val_i:0+val_i:1+val_i:3+val_i:4+val_i:5&fq=+-val_i:0+-val_i:2+-val_i:4+-val_i:5&fq={!+cost%3D65+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D3+u%3D6}"&fq={!frange+v%3Dval_i+l%3D0+u%3D3+cost%3D10}&fq={!+cache%3Dtrue+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D5+u%3D6}"&wt=xml}
 hits=1 status=0 QTime=0
   [junit4]   2> 244145 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=-_query_:"val_i:[00004+TO+00006]"&fq={!cache%3Dtrue}+-val_i:0+-val_i:2+-val_i:4+-val_i:6&fq={!+cost%3D59}-_query_:"val_s:[00002+TO+00006]"&fq={!cache%3Dfalse+cost%3D18+tag%3Dt}+-val_i:2+-val_i:3+-val_i:4+-val_i:6&wt=xml}
 hits=1 status=0 QTime=0
   [junit4]   2> 244146 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
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_s:{00002+TO+00007]&q={!+cache%3Dfalse+cost%3D146+tag%3Dt}-_query_:"val_s:[00002+TO+00006]"&fq={!+cache%3Dtrue+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D0+u%3D6}"&fq={!cache%3Dtrue}+-val_i:2+-val_i:4+-val_i:6&fq={!cache%3Dtrue}+val_i:0+val_i:2+val_i:6&fq=+-val_i:2+-val_i:3+-val_i:4+-val_i:5&facet=true&wt=xml}
 hits=0 status=0 QTime=0
   [junit4]   2> 244146 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q={!+cache%3Dfalse+cost%3D84}val_s:{00005+TO+00006]&fq=-_query_:"val_s:[00005+TO+00007}"&wt=xml}
 hits=0 status=0 QTime=0
   [junit4]   2> 244147 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q={!+cache%3Dfalse}val_i:{00005+TO+00006]&fq={!cache%3Dfalse+tag%3Dt}+-val_i:2+-val_i:5&wt=xml}
 hits=1 status=0 QTime=0
   [junit4]   2> 244148 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
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:2+-val_i:6&q={!+cache%3Dfalse+cost%3D70}-_query_:"{!frange+v%3Dval_i+l%3D5+u%3D6}"&fq={!+cache%3Dfalse+cost%3D50+tag%3Dt}-_query_:"val_i:[00001+TO+00007}"&fq={!frange+v%3Dval_i+l%3D6+u%3D6+cache%3Dtrue+tag%3Dt}&fq=-_query_:"val_i:{00001+TO+00007}"&fq={!+cache%3Dfalse+cost%3D9}-_query_:"val_i:{00003+TO+00006]"&facet=true&wt=xml}
 hits=0 status=0 QTime=0
   [junit4]   2> 244148 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
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:4+val_i:5&fq={!}-_query_:"val_s:[00002+TO+00007}"&fq={!cache%3Dtrue+tag%3Dt}+-val_i:0+-val_i:2+-val_i:4+-val_i:5&fq={!cache%3Dtrue+tag%3Dt}+-val_i:4+-val_i:5+-val_i:6&fq={!cache%3Dtrue+tag%3Dt}+val_i:0+val_i:2+val_i:3+val_i:4+val_i:6&wt=xml}
 hits=0 status=0 QTime=0
   [junit4]   2> 244149 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
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%3D5+u%3D10}&q={!+cache%3Dtrue+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D0+u%3D6}"&fq={!cache%3Dtrue+tag%3Dt}+val_i:0+val_i:1+val_i:3+val_i:4+val_i:6&facet=true&wt=xml}
 hits=0 status=0 QTime=0
   [junit4]   2> 244177 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
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%3D138}+val_i:0+val_i:1+val_i:3+val_i:5&q={!cache%3Dtrue+tag%3Dt}+-val_i:1+-val_i:3+-val_i:5&fq={!cache%3Dfalse+cost%3D104+tag%3Dt}+val_i:0+val_i:3+val_i:4+val_i:6&facet=true&wt=xml}
 hits=3 status=0 QTime=28
   [junit4]   2> 244178 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q={!frange+v%3Dval_i+l%3D1+u%3D6}&fq={!+cache%3Dfalse+cost%3D128+tag%3Dt}val_s:{00002+TO+00009}&fq={!cache%3Dfalse}+-val_i:0+-val_i:3+-val_i:4+-val_i:5&fq={!cache%3Dfalse+cost%3D1}+val_i:1+val_i:2+val_i:5&wt=xml}
 hits=0 status=0 QTime=0
   [junit4]   2> 244179 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q={!frange+v%3Dval_i+l%3D4+u%3D6}&wt=xml} hits=3 status=0 QTime=0
   [junit4]   2> 244179 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=+-val_i:5&fq={!cache%3Dfalse+tag%3Dt}+-val_i:0+-val_i:1+-val_i:4+-val_i:5+-val_i:6&fq={!cache%3Dtrue+tag%3Dt}+-val_i:2+-val_i:3+-val_i:4&wt=xml}
 hits=0 status=0 QTime=0
   [junit4]   2> 244180 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q={!frange+v%3Dval_i+l%3D5+u%3D6+cache%3Dtrue+tag%3Dt}&fq={!frange+v%3Dval_i+l%3D4+u%3D9+cost%3D199}&fq={!cache%3Dtrue+tag%3Dt}+val_i:0+val_i:2+val_i:4+val_i:5+val_i:6&fq={!cache%3Dfalse}+val_i:0+val_i:1+val_i:2+val_i:4+val_i:5+val_i:6&fq={!+cache%3Dfalse+cost%3D65}-_query_:"val_s:[00000+TO+00006]"&wt=xml}
 hits=0 status=0 QTime=0
   [junit4]   2> 244181 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q={!+cache%3Dtrue+tag%3Dt}-_query_:"val_i:[00004+TO+00007}"&fq={!+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D6+u%3D7}"&fq={!+cache%3Dfalse+cost%3D141+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D6+u%3D6}"&fq={!+cache%3Dfalse}-_query_:"val_s:{00001+TO+00007}"&fq=-_query_:"{!frange+v%3Dval_i+l%3D0+u%3D6}"&wt=xml}
 hits=0 status=0 QTime=0
   [junit4]   2> 244182 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
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:[00004+TO+00008}&q={!+cache%3Dtrue+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D1+u%3D6}"&facet=true&wt=xml}
 hits=1 status=0 QTime=0
   [junit4]   2> 244183 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
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%3D173}id:RAND-1882968194+OR+val_i:{00004+TO+00011}&q={!frange+v%3Dval_i+l%3D3+u%3D6+cache%3Dtrue+tag%3Dt}&fq={!cache%3Dtrue+tag%3Dt}+val_i:1+val_i:3&fq={!cache%3Dfalse+tag%3Dt}+val_i:0+val_i:2+val_i:4&fq={!cache%3Dtrue+tag%3Dt}+val_i:2+val_i:3+val_i:6&facet=true&wt=xml}
 hits=0 status=0 QTime=0
   [junit4]   2> 244183 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q={!+cache%3Dfalse}-_query_:"{!frange+v%3Dval_i+l%3D5+u%3D6}"&fq={!frange+v%3Dval_i+l%3D3+u%3D8+cache%3Dfalse+cost%3D19}&fq=+-val_i:1+-val_i:2+-val_i:4+-val_i:5&wt=xml}
 hits=1 status=0 QTime=0
   [junit4]   2> 244184 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
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:[00004+TO+00006]"&q={!+cache%3Dtrue+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D6+u%3D7}"&fq={!cache%3Dtrue+tag%3Dt}+val_i:3&facet=true&wt=xml}
 hits=1 status=0 QTime=0
   [junit4]   2> 244184 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery+cache%3Dfalse}+val_i:1+val_i:6&q={!+cache%3Dfalse+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D4+u%3D6}"&fq={!frange+v%3Dval_i+l%3D6+u%3D6+tag%3Dt}&facet=true&wt=xml}
 hits=0 status=0 QTime=0
   [junit4]   2> 244185 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q={!frange+v%3Dval_i+l%3D6+u%3D6+cache%3Dfalse+cost%3D188}&fq={!+cache%3Dfalse+cost%3D69+tag%3Dt}val_i:{00003+TO+00011}+OR+val_i:[00004+TO+00010]&fq={!+cache%3Dfalse+cost%3D41}-_query_:"val_s:[00003+TO+00006]"&wt=xml}
 hits=0 status=0 QTime=0
   [junit4]   2> 244186 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q={!frange+v%3Dval_i+l%3D0+u%3D5+cost%3D11+tag%3Dt}&fq={!cache%3Dtrue+tag%3Dt}+-val_i:0+-val_i:1+-val_i:3+-val_i:5+-val_i:6&fq={!+cache%3Dfalse}*:*+AND+val_s:[00000+TO+00007}&fq={!frange+v%3Dval_i+l%3D1+u%3D7+cache%3Dtrue+tag%3Dt}&fq=-_query_:"{!frange+v%3Dval_i+l%3D3+u%3D6}"&wt=xml}
 hits=1 status=0 QTime=0
   [junit4]   2> 244190 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q={!+cache%3Dtrue+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D3+u%3D6}"&fq={!frange+v%3Dval_i+l%3D6+u%3D6+cost%3D148}&fq={!cache%3Dtrue}+-val_i:0+-val_i:1+-val_i:2+-val_i:3&fq={!cache%3Dtrue}+-val_i:0+-val_i:2+-val_i:5+-val_i:6&wt=xml}
 hits=0 status=0 QTime=4
   [junit4]   2> 244191 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q={!frange+v%3Dval_i+l%3D2+u%3D7}&fq={!+cache%3Dtrue+tag%3Dt}*:*+AND+val_s:[00005+TO+00011]&wt=xml}
 hits=2 status=0 QTime=0
   [junit4]   2> 244191 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q={!+cache%3Dtrue+tag%3Dt}-_query_:"val_s:[00000+TO+00007}"&fq=+-val_i:0+-val_i:2+-val_i:4+-val_i:5+-val_i:6&fq={!+cache%3Dfalse+cost%3D106}-_query_:"{!frange+v%3Dval_i+l%3D4+u%3D6}"&fq={!cache%3Dfalse+tag%3Dt}+val_i:0+val_i:2+val_i:6&wt=xml}
 hits=0 status=0 QTime=0
   [junit4]   2> 244192 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q={!+cache%3Dtrue+tag%3Dt}-_query_:"val_s:[00003+TO+00006]"&fq={!+cache%3Dtrue+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D6+u%3D6}"&fq={!+cache%3Dfalse+tag%3Dt}-_query_:"val_s:[00005+TO+00007}"&fq=val_s:[00005+TO+00011}+OR+id:RAND1822284506&fq={!+cache%3Dfalse+tag%3Dt}val_s:[00003+TO+00009}&wt=xml}
 hits=0 status=0 QTime=0
   [junit4]   2> 244193 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery++cost%3D59}-_query_:"{!frange+v%3Dval_i+l%3D0+u%3D6}"&q={!cache%3Dfalse+cost%3D164}+val_i:0+val_i:1&facet=true&wt=xml}
 hits=2 status=0 QTime=0
   [junit4]   2> 244194 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
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:[00003+TO+00009]&q={!+cache%3Dfalse+cost%3D7}-_query_:"val_s:{00000+TO+00006]"&fq={!frange+v%3Dval_i+l%3D2+u%3D5}&fq={!frange+v%3Dval_i+l%3D5+u%3D11+cost%3D7+tag%3Dt}&facet=true&wt=xml}
 hits=0 status=0 QTime=0
   [junit4]   2> 244194 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery+cache%3Dtrue}+val_i:0+val_i:1+val_i:2+val_i:3+val_i:4+val_i:5&q={!+cache%3Dfalse+cost%3D60}-_query_:"{!frange+v%3Dval_i+l%3D1+u%3D6}"&facet=true&wt=xml}
 hits=1 status=0 QTime=0
   [junit4]   2> 244195 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery++cache%3Dfalse}-_query_:"{!frange+v%3Dval_i+l%3D3+u%3D6}"&q=-_query_:"{!frange+v%3Dval_i+l%3D6+u%3D7}"&fq=val_s:[00002+TO+00004]&fq={!cache%3Dtrue+tag%3Dt}+-val_i:0+-val_i:3&fq={!frange+v%3Dval_i+l%3D5+u%3D9}&fq={!cache%3Dfalse+tag%3Dt}+val_i:2+val_i:3+val_i:4+val_i:6&facet=true&wt=xml}
 hits=0 status=0 QTime=0
   [junit4]   2> 244196 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery++cache%3Dfalse}-_query_:"val_s:[00001+TO+00007}"&q=-_query_:"val_i:{00002+TO+00007}"&facet=true&wt=xml}
 hits=3 status=0 QTime=0
   [junit4]   2> 244196 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q={!frange+v%3Dval_i+l%3D1+u%3D5+cache%3Dfalse+cost%3D190}&fq={!frange+v%3Dval_i+l%3D6+u%3D6+cache%3Dtrue+tag%3Dt}&fq={!+cost%3D110}-_query_:"{!frange+v%3Dval_i+l%3D0+u%3D6}"&fq={!frange+v%3Dval_i+l%3D6+u%3D6+cost%3D49}&fq=val_s:{00005+TO+00006]+OR+id:RAND-1383683677&wt=xml}
 hits=0 status=0 QTime=0
   [junit4]   2> 244197 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q={!+cache%3Dtrue+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D4+u%3D6}"&fq={!+cost%3D86+tag%3Dt}-_query_:"val_s:{00002+TO+00007}"&fq={!cache%3Dfalse}+val_i:2+val_i:4+val_i:5+val_i:6&fq={!}val_s:[00006+TO+00006]+OR+id:RAND-1367660880&fq={!cache%3Dtrue+tag%3Dt}+val_i:1+val_i:5&wt=xml}
 hits=0 status=0 QTime=0
   [junit4]   2> 244198 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
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%3D167}+val_i:1+val_i:2+val_i:6&q={!cache%3Dfalse+cost%3D100}+-val_i:0+-val_i:2+-val_i:3+-val_i:4+-val_i:5+-val_i:6&fq=-_query_:"{!frange+v%3Dval_i+l%3D3+u%3D6}"&facet=true&wt=xml}
 hits=1 status=0 QTime=0
   [junit4]   2> 244199 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q={!+cache%3Dtrue+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D3+u%3D6}"&fq=-_query_:"{!frange+v%3Dval_i+l%3D0+u%3D6}"&fq=+-val_i:0+-val_i:1+-val_i:5&fq=+-val_i:0+-val_i:1+-val_i:2+-val_i:4&wt=xml}
 hits=0 status=0 QTime=0
   [junit4]   2> 244199 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
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_s:[00006+TO+00006]+AND+val_s:{00005+TO+00007}&q={!}-_query_:"val_i:[00006+TO+00007]"&facet=true&wt=xml}
 hits=6 status=0 QTime=0
   [junit4]   2> 244199 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q={!frange+v%3Dval_i+l%3D4+u%3D6+cache%3Dfalse+cost%3D18+tag%3Dt}&wt=xml}
 hits=3 status=0 QTime=0
   [junit4]   2> 244231 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q={!cache%3Dfalse+tag%3Dt}+val_i:0+val_i:1+val_i:2+val_i:4&group.main=true&group.cache.percent=100&fq=-_query_:"{!frange+v%3Dval_i+l%3D5+u%3D6}"&wt=xml&group.field=id&group=true}
 hits=4 status=0 QTime=31
   [junit4]   2> 244233 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
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_s:[00004+TO+00010}&q={!frange+v%3Dval_i+l%3D5+u%3D7+cache%3Dtrue+tag%3Dt}&group.main=true&fq={!+cache%3Dfalse+cost%3D122+tag%3Dt}val_s:[00000+TO+00004}&facet=true&wt=xml&group.field=id&group=true}
 hits=0 status=0 QTime=1
   [junit4]   2> 244233 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q={!frange+v%3Dval_i+l%3D4+u%3D7+cost%3D20}&fq={!+cost%3D153+tag%3Dt}val_i:[00002+TO+00007}&wt=xml}
 hits=3 status=0 QTime=0
   [junit4]   2> 244234 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q={!frange+v%3Dval_i+l%3D3+u%3D7+cost%3D104}&fq={!+cost%3D182}-_query_:"{!frange+v%3Dval_i+l%3D0+u%3D6}"&fq={!frange+v%3Dval_i+l%3D0+u%3D5}&fq={!frange+v%3Dval_i+l%3D4+u%3D9}&wt=xml}
 hits=0 status=0 QTime=0
   [junit4]   2> 244234 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
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:3+-val_i:6&q={!+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D1+u%3D6}"&facet=true&wt=xml}
 hits=1 status=0 QTime=0
   [junit4]   2> 244235 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q={!frange+v%3Dval_i+l%3D4+u%3D6}&fq={!frange+v%3Dval_i+l%3D0+u%3D5+tag%3Dt}&fq={!cache%3Dtrue+tag%3Dt}+-val_i:1+-val_i:2+-val_i:3&fq={!frange+v%3Dval_i+l%3D3+u%3D8}&fq=-_query_:"val_i:{00002+TO+00006]"&wt=xml}
 hits=0 status=0 QTime=0
   [junit4]   2> 244235 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q={!frange+v%3Dval_i+l%3D2+u%3D4}&fq={!frange+v%3Dval_i+l%3D0+u%3D5}&fq={!cache%3Dtrue+tag%3Dt}+-val_i:0+-val_i:1+-val_i:2+-val_i:4&wt=xml}
 hits=1 status=0 QTime=0
   [junit4]   2> 244236 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery++cost%3D191}val_i:{00004+TO+00011]&q={!+cost%3D170}-_query_:"val_s:[00000+TO+00007}"&facet=true&wt=xml}
 hits=0 status=0 QTime=0
   [junit4]   2> 244236 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q={!frange+v%3Dval_i+l%3D4+u%3D8+cache%3Dtrue+tag%3Dt}&wt=xml} hits=3 
status=0 QTime=0
   [junit4]   2> 244237 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q={!cache%3Dfalse+cost%3D33}+val_i:0+val_i:3+val_i:4+val_i:5+val_i:6&fq={!+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D4+u%3D6}"&fq={!cache%3Dfalse}+-val_i:0+-val_i:3+-val_i:4+-val_i:5&fq={!+cache%3Dfalse+cost%3D126}val_s:{00005+TO+00007}&wt=xml}
 hits=0 status=0 QTime=0
   [junit4]   2> 244237 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q={!cache%3Dfalse}+val_i:0+val_i:1+val_i:2+val_i:4&fq={!+cost%3D111+tag%3Dt}-_query_:"val_i:[00006+TO+00008}"&wt=xml}
 hits=4 status=0 QTime=0
   [junit4]   2> 244238 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q={!frange+v%3Dval_i+l%3D1+u%3D4+cost%3D68}&fq={!+cache%3Dfalse+cost%3D11+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D0+u%3D6}"&fq={!cache%3Dfalse}+val_i:2+val_i:3+val_i:5&fq={!}val_i:[00001+TO+00005}&fq={!+cache%3Dtrue+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D1+u%3D6}"&wt=xml}
 hits=0 status=0 QTime=0
   [junit4]   2> 244239 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery++cache%3Dfalse}-_query_:"val_s:[00003+TO+00006]"&q={!+cache%3Dfalse+cost%3D189+tag%3Dt}val_s:{00001+TO+00006]+OR+id:RAND737246403&fq={!frange+v%3Dval_i+l%3D2+u%3D5}&fq={!+cache%3Dfalse+tag%3Dt}val_i:{00004+TO+00007]+AND+val_i:[00005+TO+00008}&facet=true&wt=xml}
 hits=1 status=0 QTime=0
   [junit4]   2> 244240 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
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&fq={!+cache%3Dfalse}-_query_:"val_s:[00001+TO+00007}"&fq={!cache%3Dtrue}+-val_i:1+-val_i:2+-val_i:3+-val_i:4+-val_i:6&fq={!cache%3Dfalse}+val_i:1+val_i:2+val_i:3+val_i:5&wt=xml}
 hits=0 status=0 QTime=0
   [junit4]   2> 244240 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[1FCB477FA65B0BB9]) [     ] 
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:{00003+TO+00006]+AND+val_i:[00004+TO+

[...truncated too long message...]

rs for registry=solr.core.collection1 tag=SolrCore@153e4ca6
   [junit4]   2> 2443818 INFO  (coreCloseExecutor-21954-thread-1) [     ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@44c5d61f: rootName = null, 
domain = solr.core.collection1, service url = null, agent id = null] for 
registry solr.core.collection1/com.codahale.metrics.MetricRegistry@ee9fc89
   [junit4]   2> 2443830 INFO  (coreCloseExecutor-21954-thread-1) [     ] 
o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close()  ... SKIPPED 
(unnecessary).
   [junit4]   2> 2443832 INFO  
(SUITE-TestCircuitBreaker-seed#[1FCB477FA65B0BB9]-worker) [     ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node 
tag=null
   [junit4]   2> 2443832 INFO  
(SUITE-TestCircuitBreaker-seed#[1FCB477FA65B0BB9]-worker) [     ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@6c03670e: rootName = null, 
domain = solr.node, service url = null, agent id = null] for registry 
solr.node/com.codahale.metrics.MetricRegistry@752417c6
   [junit4]   2> 2443838 INFO  
(SUITE-TestCircuitBreaker-seed#[1FCB477FA65B0BB9]-worker) [     ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm 
tag=null
   [junit4]   2> 2443838 INFO  
(SUITE-TestCircuitBreaker-seed#[1FCB477FA65B0BB9]-worker) [     ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@4d469b6: rootName = null, 
domain = solr.jvm, service url = null, agent id = null] for registry 
solr.jvm/com.codahale.metrics.MetricRegistry@47925a87
   [junit4]   2> 2443840 INFO  
(SUITE-TestCircuitBreaker-seed#[1FCB477FA65B0BB9]-worker) [     ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty 
tag=null
   [junit4]   2> 2443841 INFO  
(SUITE-TestCircuitBreaker-seed#[1FCB477FA65B0BB9]-worker) [     ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@6df924c4: rootName = null, 
domain = solr.jetty, service url = null, agent id = null] for registry 
solr.jetty/com.codahale.metrics.MetricRegistry@6627fd
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.util.TestCircuitBreaker_1FCB477FA65B0BB9-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene87): 
{title_stringNoNorms=PostingsFormat(name=Asserting), title_stemmed=FST50, 
multiDefault=PostingsFormat(name=Asserting), inStock_b1=Lucene84, _root_=FST50, 
name=PostingsFormat(name=LuceneVarGapDocFreqInterval), 
id=PostingsFormat(name=LuceneVarGapDocFreqInterval), text=Lucene84, 
title=FST50, title_lettertok=PostingsFormat(name=LuceneVarGapDocFreqInterval)}, 
docValues:{range_facet_l_dv=DocValuesFormat(name=Lucene80), 
range_facet_i_dv=DocValuesFormat(name=Lucene80), 
intDvoDefault=DocValuesFormat(name=Lucene80), 
timestamp=DocValuesFormat(name=Lucene80)}, maxPointsInLeafNode=1282, 
maxMBSortInHeap=7.403205078807229, 
sim=Asserting(RandomSimilarity(queryNorm=true): {}), locale=sr-Latn-ME, 
timezone=America/Bahia
   [junit4]   2> NOTE: Linux 5.4.0-45-generic amd64/Oracle Corporation 
1.8.0_291 (64-bit)/cpus=4,threads=1,free=33873984,total=527433728
   [junit4]   2> NOTE: All tests run in this JVM: [RequiredFieldsTest, 
ZkControllerTest, IgnoreLargeDocumentProcessorFactoryTest, 
CurrencyRangeFacetCloudTest, AutoAddReplicasIntegrationTest, 
SolrCmdDistributorTest, RandomizedTaggerTest, TestCoreDiscovery, 
RAMDirectoryFactoryTest, TestSolrDeletionPolicy1, AnalysisAfterCoreReloadTest, 
TestFieldCacheReopen, TestNestedUpdateProcessor, TestCloudConsistency, 
SecurityHeadersTest, SolrJmxReporterCloudTest, TestCloudPivotFacet, 
RuleEngineTest, TestXmlQParser, HdfsLockFactoryTest, HighlighterTest, 
TestNumericRangeQuery32, TestAnalyzeInfixSuggestions, 
TestBooleanSimilarityFactory, HdfsChaosMonkeySafeLeaderTest, 
PeerSyncWithLeaderAndIndexFingerprintCachingTest, TestUniqueKeyFieldResource, 
TestManagedResource, TestHdfsCloudBackupRestore, TestJsonFacetErrors, 
TestFilteredDocIdSet, ZkCollectionPropsCachingTest, TestContainerPlugin, 
TestCustomDocTransformer, ExecutePlanActionTest, TestSolrQueryParser, 
CollectionReloadTest, DistributedQueryComponentCustomSortTest, 
SystemInfoHandlerTest, TestUnifiedSolrHighlighterWithoutStoredId, 
DirectSolrConnectionTest, DocValuesMissingTest, TestElisionMultitermQuery, 
TestPolicyCloud, TestQueryUtils, JSONWriterTest, TestReloadAndDeleteDocs, 
ShowFileRequestHandlerTest, SignatureUpdateProcessorFactoryTest, 
TestHalfAndHalfDocValues, JsonLoaderTest, TestReRankQParserPlugin, 
TestUninvertingReader, TestHashQParserPlugin, ExternalFileFieldSortTest, 
TestAtomicUpdateErrorCases, TestPKIAuthenticationPlugin, TestSolrCachePerf, 
RouteFieldTest, TestMinimalConfig, TestExpandComponent, BlockCacheTest, 
BasicAuthIntegrationTest, TestWaitForStateWithJettyShutdowns, JvmMetricsTest, 
DaemonStreamApiTest, TestConfigSetImmutable, ScheduledTriggerTest, 
HLLSerializationTest, PreAnalyzedUpdateProcessorTest, HDFSCollectionsAPITest, 
TestNonDefinedSimilarityFactory, PathHierarchyTokenizerFactoryTest, 
TestLuceneMatchVersion, TestHighlightDedupGrouping, TestSimpleQParserPlugin, 
ClusterStateMockUtilTest, BasicZkTest, ShardRoutingCustomTest, 
TestSimDistributedQueue, AliasIntegrationTest, MetricsHistoryIntegrationTest, 
FullSolrCloudDistribCmdsTest, RegexBytesRefFilterTest, 
BaseCdcrDistributedZkTest, CustomHighlightComponentTest, DynamicMapsTest, 
ExitableDirectoryReaderTest, CdcrReplicationHandlerTest, TimeZoneUtilsTest, 
ZkSolrClientTest, DistanceFunctionTest, SuggesterFSTTest, TestXIncludeConfig, 
BigEndianAscendingWordSerializerTest, SolrIndexSearcherTest, 
TestSimpleTrackingShardHandler, OverseerSolrResponseTest, 
SolrShardReporterTest, CheckHdfsIndexTest, SolrCoreCheckLockOnStartupTest, 
RecoveryZkTest, ClassificationUpdateProcessorTest, TestSQLHandler, 
DistributedUpdateProcessorTest, ManagedSchemaDiffTest, 
DistributedFacetPivotSmallAdvancedTest, TestSSLRandomization, TestSimScenario, 
TestCodecSupport, CreateCollectionCleanupTest, DeleteNodeTest, 
TestSchemaResource, BinaryUpdateRequestHandlerTest, UpdateParamsTest, 
TestSolrJacksonAnnotation, LeaderElectionContextKeyTest, EchoParamsTest, 
MinimalSchemaTest, OutputWriterTest, SampleTest, SolrInfoBeanTest, 
SolrTestCaseJ4Test, TestCrossCoreJoin, TestCursorMarkWithoutUniqueKey, 
TestDistributedGrouping, TestDocumentBuilder, TestTrie, 
TestLuceneIndexBackCompat, ChaosMonkeySafeLeaderTest, CleanupOldIndexTest, 
CollectionStateFormat2Test, ConcurrentCreateRoutedAliasTest, DeleteStatusTest, 
DistribDocExpirationUpdateProcessorTest, LeaderFailureAfterFreshStartTest, 
MultiSolrCloudTestCaseTest, MultiThreadedOCPTest, PeerSyncReplicationTest, 
TestConfigSetsAPIExclusivity, TestConfigSetsAPIShareSchema, 
TestDistribDocBasedVersion, TestDynamicFieldNamesIndexCorrectly, TestLockTree, 
TestMiniSolrCloudClusterSSL, TestRandomFlRTGCloud, 
TestSolrCloudWithKerberosAlt, TestStressCloudBlindAtomicUpdates, 
TestTolerantUpdateProcessorCloud, TestTolerantUpdateProcessorRandomCloud, 
TestUtilizeNode, VMParamsZkACLAndCredentialsProvidersTest, ZkShardTermsTest, 
ConcurrentDeleteAndCreateCollectionTest, CustomCollectionTest, 
HdfsCollectionsAPIDistributedZkTest, PurgeGraphTest, 
SimpleCollectionCreateDeleteTest, SplitByPrefixTest, ComputePlanActionTest, 
RestoreTriggerStateTest, CdcrWithNodesRestartsTest, HdfsRecoveryZkTest, 
HdfsRestartWhileUpdatingTest, HdfsSyncSliceTest, HdfsThreadLeakTest, 
HdfsTlogReplayBufferedWhileIndexingTest, HdfsWriteToMultipleCollectionsTest, 
TestClusterStateMutator, BlobRepositoryCloudTest, TestDynamicLoadingUrl, 
TestMergePolicyConfig, TestSolrXml, HdfsBackupRepositoryIntegrationTest, 
TestBlobHandler, TestReplicationHandlerDiskOverFlow, 
TestSolrConfigHandlerConcurrent, TestSystemCollAutoCreate, V2StandaloneTest, 
XsltUpdateRequestHandlerTest, AdminHandlersProxyTest, LukeRequestHandlerTest, 
PropertiesRequestHandlerTest, SecurityConfHandlerTest, 
SegmentsInfoRequestHandlerTest, TestConfigsApi, TestCoreAdminApis, 
ThreadDumpHandlerTest, V2CollectionBackupsAPIMappingTest, ZookeeperReadAPITest, 
ZookeeperStatusHandlerFailureTest, ZookeeperStatusHandlerTest, 
DistributedExpandComponentTest, DistributedMLTComponentTest, 
DistributedSuggestComponentTest, MoreLikeThisComponentTest, 
QueryComponentPartialResultsTest, QueryElevationComponentTest, 
TermVectorComponentTest, TermsComponentTest, SQLWithAuthzEnabledTest, 
TestLegacyTerms, SolrCoreMetricManagerTest, TestIntervalFaceting, 
RankQParserPluginTest, SignificantTermsQParserPluginTest, 
TestCollapseQParserPlugin, TestDocSet, TestGraphTermsQParserPlugin, 
TestLegacyNumericRangeQueryBuilder, TestMultiWordSynonyms, 
TestPseudoReturnFields, TestStressLucene, TestStressUserVersions, 
TestSurroundQueryParser, TestTermsQParserPlugin, TestCloudJSONFacetJoinDomain, 
TestCloudJSONFacetSKGEquiv, AggValueSourceTest, TestFunctionQuery, 
TestOrdValues, TestSortByMinMaxFunction, BlockJoinFacetSimpleTest, 
TestNestedDocsSort, TestScoreJoinQPNoScore, CloudMLTQParserTest, 
TestImpersonationWithHadoopAuth, TestSolrCloudWithHadoopAuthPlugin, 
TestZkAclsWithHadoopAuth, FileBasedSpellCheckerTest, 
SpellingQueryConverterTest, WordBreakSolrSpellCheckerTest, 
TestFreeTextSuggestions, HdfsDirectoryTest, AtomicUpdatesTest, 
CategoryRoutedAliasUpdateProcessorTest, 
ClassificationUpdateProcessorFactoryTest, 
ClassificationUpdateProcessorIntegrationTest, 
IgnoreCommitOptimizeUpdateProcessorFactoryTest, 
ParsingFieldUpdateProcessorsTest, TestCloudDeduplication, 
TestPartialUpdateDeduplication, TimeRoutedAliasUpdateProcessorTest, 
TolerantUpdateProcessorTest, URLClassifyProcessorTest, 
UniqFieldsUpdateProcessorFactoryTest, UpdateRequestProcessorFactoryTest, 
XMLAtomicUpdateMultivalueTest, CircularListTest, DOMUtilTest, 
DateMathParserTest, DistanceUnitsTest, PrimUtilsTest, SimplePostToolTest, 
SolrLogPostToolTest, SolrPluginUtilsTest, TestCircuitBreaker]
   [junit4] Completed [930/947 (2!)] on J0 in 1.01s, 5 tests, 1 error <<< 
FAILURES!

[...truncated 54268 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: builds-unsubscr...@lucene.apache.org
For additional commands, e-mail: builds-h...@lucene.apache.org

Reply via email to