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

1 tests failed.
FAILED:  org.apache.solr.search.TestFiltering.testRandomFiltering

Error Message:
should have unwrapped

Stack Trace:
java.lang.AssertionError: should have unwrapped
        at 
__randomizedtesting.SeedInfo.seed([857DDB2E3F475E95:9A1E78EBDA601E9C]: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 16057 lines...]
   [junit4] Suite: org.apache.solr.search.TestFiltering
   [junit4]   2> 2296153 INFO  
(SUITE-TestFiltering-seed#[857DDB2E3F475E95]-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-BadApples-Tests-8.x/solr/server/solr/configsets/_default/conf'
   [junit4]   2> 2296153 INFO  
(SUITE-TestFiltering-seed#[857DDB2E3F475E95]-worker) [     ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 2296153 INFO  
(SUITE-TestFiltering-seed#[857DDB2E3F475E95]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Created dataDir: 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.search.TestFiltering_857DDB2E3F475E95-001/data-dir-217-001
   [junit4]   2> 2296153 WARN  
(SUITE-TestFiltering-seed#[857DDB2E3F475E95]-worker) [     ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=7 numCloses=7
   [junit4]   2> 2296153 INFO  
(SUITE-TestFiltering-seed#[857DDB2E3F475E95]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 2296155 INFO  
(SUITE-TestFiltering-seed#[857DDB2E3F475E95]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via: 
@org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
   [junit4]   2> 2296155 INFO  
(SUITE-TestFiltering-seed#[857DDB2E3F475E95]-worker) [     ] 
o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 2296161 INFO  
(SUITE-TestFiltering-seed#[857DDB2E3F475E95]-worker) [     ] 
o.a.s.c.SolrResourceLoader Added 2 libs to classloader, from paths: 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/core/src/test-files/solr/collection1/lib,
 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 2296175 INFO  
(SUITE-TestFiltering-seed#[857DDB2E3F475E95]-worker) [     ] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 8.11.0
   [junit4]   2> 2296176 WARN  
(SUITE-TestFiltering-seed#[857DDB2E3F475E95]-worker) [     ] o.a.s.c.SolrConfig 
solrconfig.xml: <boolTofilterOptimizer> is currently not implemented and has no 
effect.
   [junit4]   2> 2296176 WARN  
(SUITE-TestFiltering-seed#[857DDB2E3F475E95]-worker) [     ] o.a.s.c.SolrConfig 
solrconfig.xml: <jmx> is no longer supported, use solr.xml:/metrics/reporter 
section instead
   [junit4]   2> 2296178 INFO  
(SUITE-TestFiltering-seed#[857DDB2E3F475E95]-worker) [     ] 
o.a.s.s.IndexSchema Schema name=example
   [junit4]   2> 2296180 INFO  
(SUITE-TestFiltering-seed#[857DDB2E3F475E95]-worker) [     ] 
o.a.s.s.IndexSchema Loaded schema example/1.6 with uniqueid field id
   [junit4]   2> 2296799 WARN  
(SUITE-TestFiltering-seed#[857DDB2E3F475E95]-worker) [     ] 
o.a.s.c.CoreContainer Unable to create 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-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-BadApples-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-BadApples-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> 2296800 WARN  
(SUITE-TestFiltering-seed#[857DDB2E3F475E95]-worker) [     ] 
o.a.s.f.DistribPackageStore Unable to create 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/core/src/test-files/solr/filestore]
 directory in SOLR_HOME 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-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-BadApples-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-BadApples-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> 2296801 INFO  
(SUITE-TestFiltering-seed#[857DDB2E3F475E95]-worker) [     ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 2296802 WARN  
(SUITE-TestFiltering-seed#[857DDB2E3F475E95]-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> 2296802 WARN  
(SUITE-TestFiltering-seed#[857DDB2E3F475E95]-worker) [     ] o.e.j.u.s.S.config 
Trusting all certificates configured for 
Client@570dc3aa[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2296802 WARN  
(SUITE-TestFiltering-seed#[857DDB2E3F475E95]-worker) [     ] o.e.j.u.s.S.config 
No Client EndPointIdentificationAlgorithm configured for 
Client@570dc3aa[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2296804 WARN  
(SUITE-TestFiltering-seed#[857DDB2E3F475E95]-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> 2296806 WARN  
(SUITE-TestFiltering-seed#[857DDB2E3F475E95]-worker) [     ] o.e.j.u.s.S.config 
Trusting all certificates configured for 
Client@36b02d76[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2296806 WARN  
(SUITE-TestFiltering-seed#[857DDB2E3F475E95]-worker) [     ] o.e.j.u.s.S.config 
No Client EndPointIdentificationAlgorithm configured for 
Client@36b02d76[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2296807 WARN  
(SUITE-TestFiltering-seed#[857DDB2E3F475E95]-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> 2296832 INFO  
(SUITE-TestFiltering-seed#[857DDB2E3F475E95]-worker) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6ff680cb
   [junit4]   2> 2296839 INFO  
(SUITE-TestFiltering-seed#[857DDB2E3F475E95]-worker) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6ff680cb
   [junit4]   2> 2296839 INFO  
(SUITE-TestFiltering-seed#[857DDB2E3F475E95]-worker) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6ff680cb
   [junit4]   2> 2296840 INFO  (coreLoadExecutor-26576-thread-1) [     ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient core cache for max 
2147483647 cores with initial capacity of 1024
   [junit4]   2> 2296850 INFO  (coreLoadExecutor-26576-thread-1) [    
x:collection1 ] o.a.s.c.SolrResourceLoader Added 2 libs to classloader, from 
paths: 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/core/src/test-files/solr/collection1/lib,
 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 2296875 INFO  (coreLoadExecutor-26576-thread-1) [    
x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.11.0
   [junit4]   2> 2296875 WARN  (coreLoadExecutor-26576-thread-1) [    
x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <boolTofilterOptimizer> is 
currently not implemented and has no effect.
   [junit4]   2> 2296876 WARN  (coreLoadExecutor-26576-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> 2296880 INFO  (coreLoadExecutor-26576-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema Schema name=example
   [junit4]   2> 2296883 INFO  (coreLoadExecutor-26576-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema Loaded schema example/1.6 with uniqueid 
field id
   [junit4]   2> 2296894 INFO  (coreLoadExecutor-26576-thread-1) [    
x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from instancedir 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/core/src/test-files/solr/collection1,
 trusted=true
   [junit4]   2> 2296894 INFO  (coreLoadExecutor-26576-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@6ff680cb
   [junit4]   2> 2296894 INFO  (coreLoadExecutor-26576-thread-1) [    
x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/core/src/test-files/solr/collection1],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.search.TestFiltering_857DDB2E3F475E95-001/data-dir-217-001/]
   [junit4]   2> 2296895 INFO  (coreLoadExecutor-26576-thread-1) [    
x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=47, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.0]
   [junit4]   2> 2296944 INFO  (coreLoadExecutor-26576-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2296944 INFO  (coreLoadExecutor-26576-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2296944 INFO  (coreLoadExecutor-26576-thread-1) [    
x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.MockRandomMergePolicy: 
org.apache.lucene.index.MockRandomMergePolicy@29c0d212
   [junit4]   2> 2296945 INFO  (coreLoadExecutor-26576-thread-1) [    
x:collection1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 2296973 INFO  (coreLoadExecutor-26576-thread-1) [    
x:collection1 ] o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 2297161 INFO  (coreLoadExecutor-26576-thread-1) [    
x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 2297161 INFO  
(searcherExecutor-26578-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 2297161 INFO  
(searcherExecutor-26578-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 2297161 INFO  
(searcherExecutor-26578-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 2297161 INFO  
(searcherExecutor-26578-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 2297162 INFO  
(searcherExecutor-26578-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 2297162 INFO  
(searcherExecutor-26578-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 2297162 INFO  
(searcherExecutor-26578-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 2297162 INFO  
(searcherExecutor-26578-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 2297163 INFO  
(searcherExecutor-26578-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 2297164 INFO  
(searcherExecutor-26578-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 2297165 INFO  
(SUITE-TestFiltering-seed#[857DDB2E3F475E95]-worker) [     ] 
o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 2297169 INFO  
(TEST-TestFiltering.testLiveDocsSharing-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.SolrTestCaseJ4 ###Starting testLiveDocsSharing
   [junit4]   2> 2297169 INFO  
(TEST-TestFiltering.testLiveDocsSharing-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.DirectUpdateHandler2 [collection1]  REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 2297169 INFO  
(TEST-TestFiltering.testLiveDocsSharing-seed#[857DDB2E3F475E95]) [     ] 
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> 2297170 INFO  
(TEST-TestFiltering.testLiveDocsSharing-seed#[857DDB2E3F475E95]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[0]} 0 0
   [junit4]   2> 2297172 INFO  
(TEST-TestFiltering.testLiveDocsSharing-seed#[857DDB2E3F475E95]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[0]} 0 0
   [junit4]   2> 2297172 INFO  
(TEST-TestFiltering.testLiveDocsSharing-seed#[857DDB2E3F475E95]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[1]} 0 0
   [junit4]   2> 2297172 INFO  
(TEST-TestFiltering.testLiveDocsSharing-seed#[857DDB2E3F475E95]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[2]} 0 0
   [junit4]   2> 2297173 INFO  
(TEST-TestFiltering.testLiveDocsSharing-seed#[857DDB2E3F475E95]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[3]} 0 0
   [junit4]   2> 2297173 INFO  
(TEST-TestFiltering.testLiveDocsSharing-seed#[857DDB2E3F475E95]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[4]} 0 0
   [junit4]   2> 2297173 INFO  
(TEST-TestFiltering.testLiveDocsSharing-seed#[857DDB2E3F475E95]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[5]} 0 0
   [junit4]   2> 2297173 INFO  
(TEST-TestFiltering.testLiveDocsSharing-seed#[857DDB2E3F475E95]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[5]} 0 0
   [junit4]   2> 2297173 INFO  
(TEST-TestFiltering.testLiveDocsSharing-seed#[857DDB2E3F475E95]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[6]} 0 0
   [junit4]   2> 2297174 INFO  
(TEST-TestFiltering.testLiveDocsSharing-seed#[857DDB2E3F475E95]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[7]} 0 0
   [junit4]   2> 2297174 INFO  
(TEST-TestFiltering.testLiveDocsSharing-seed#[857DDB2E3F475E95]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[8]} 0 0
   [junit4]   2> 2297174 INFO  
(TEST-TestFiltering.testLiveDocsSharing-seed#[857DDB2E3F475E95]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[9]} 0 0
   [junit4]   2> 2297174 INFO  
(TEST-TestFiltering.testLiveDocsSharing-seed#[857DDB2E3F475E95]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[10]} 0 0
   [junit4]   2> 2297174 INFO  
(TEST-TestFiltering.testLiveDocsSharing-seed#[857DDB2E3F475E95]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[10]} 0 0
   [junit4]   2> 2297175 INFO  
(TEST-TestFiltering.testLiveDocsSharing-seed#[857DDB2E3F475E95]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[11]} 0 0
   [junit4]   2> 2297175 INFO  
(TEST-TestFiltering.testLiveDocsSharing-seed#[857DDB2E3F475E95]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[12]} 0 0
   [junit4]   2> 2297175 INFO  
(TEST-TestFiltering.testLiveDocsSharing-seed#[857DDB2E3F475E95]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[13]} 0 0
   [junit4]   2> 2297175 INFO  
(TEST-TestFiltering.testLiveDocsSharing-seed#[857DDB2E3F475E95]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[14]} 0 0
   [junit4]   2> 2297176 INFO  
(TEST-TestFiltering.testLiveDocsSharing-seed#[857DDB2E3F475E95]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[15]} 0 0
   [junit4]   2> 2297176 INFO  
(TEST-TestFiltering.testLiveDocsSharing-seed#[857DDB2E3F475E95]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[15]} 0 0
   [junit4]   2> 2297176 INFO  
(TEST-TestFiltering.testLiveDocsSharing-seed#[857DDB2E3F475E95]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[16]} 0 0
   [junit4]   2> 2297176 INFO  
(TEST-TestFiltering.testLiveDocsSharing-seed#[857DDB2E3F475E95]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[17]} 0 0
   [junit4]   2> 2297176 INFO  
(TEST-TestFiltering.testLiveDocsSharing-seed#[857DDB2E3F475E95]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[18]} 0 0
   [junit4]   2> 2297177 INFO  
(TEST-TestFiltering.testLiveDocsSharing-seed#[857DDB2E3F475E95]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[19]} 0 0
   [junit4]   2> 2297200 INFO  
(searcherExecutor-26578-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 2297202 INFO  
(TEST-TestFiltering.testLiveDocsSharing-seed#[857DDB2E3F475E95]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{commit=} 0 24
   [junit4]   2> 2297206 INFO  
(TEST-TestFiltering.testLiveDocsSharing-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.SolrTestCaseJ4 ###Ending testLiveDocsSharing
   [junit4]   2> 2297211 INFO  
(TEST-TestFiltering.testCaching-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.SolrTestCaseJ4 ###Starting testCaching
   [junit4]   2> 2297211 INFO  
(TEST-TestFiltering.testCaching-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.DirectUpdateHandler2 [collection1]  REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 2297211 INFO  
(TEST-TestFiltering.testCaching-seed#[857DDB2E3F475E95]) [     ] 
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> 2297212 INFO  
(TEST-TestFiltering.testCaching-seed#[857DDB2E3F475E95]) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[4]} 0 0
   [junit4]   2> 2297212 INFO  
(TEST-TestFiltering.testCaching-seed#[857DDB2E3F475E95]) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[1]} 0 0
   [junit4]   2> 2297212 INFO  
(TEST-TestFiltering.testCaching-seed#[857DDB2E3F475E95]) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[3]} 0 0
   [junit4]   2> 2297212 INFO  
(TEST-TestFiltering.testCaching-seed#[857DDB2E3F475E95]) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[2]} 0 0
   [junit4]   2> 2297218 INFO  
(searcherExecutor-26578-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 2297219 INFO  
(TEST-TestFiltering.testCaching-seed#[857DDB2E3F475E95]) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{commit=} 0 5
   [junit4]   2> 2297219 INFO  
(TEST-TestFiltering.testCaching-seed#[857DDB2E3F475E95]) [     ] 
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> 2297220 INFO  
(TEST-TestFiltering.testCaching-seed#[857DDB2E3F475E95]) [     ] 
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> 2297220 INFO  
(TEST-TestFiltering.testCaching-seed#[857DDB2E3F475E95]) [     ] 
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> 2297220 INFO  
(TEST-TestFiltering.testCaching-seed#[857DDB2E3F475E95]) [     ] 
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> 2297220 INFO  
(TEST-TestFiltering.testCaching-seed#[857DDB2E3F475E95]) [     ] 
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> 2297220 INFO  
(TEST-TestFiltering.testCaching-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&fq={!frange+l%3D2+u%3D5+cache%3Dfalse+cost%3D0}val_i&wt=xml} 
hits=3 status=0 QTime=0
   [junit4]   2> 2297221 INFO  
(TEST-TestFiltering.testCaching-seed#[857DDB2E3F475E95]) [     ] 
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> 2297221 INFO  
(TEST-TestFiltering.testCaching-seed#[857DDB2E3F475E95]) [     ] 
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> 2297221 INFO  
(TEST-TestFiltering.testCaching-seed#[857DDB2E3F475E95]) [     ] 
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> 2297221 INFO  
(TEST-TestFiltering.testCaching-seed#[857DDB2E3F475E95]) [     ] 
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> 2297222 INFO  
(TEST-TestFiltering.testCaching-seed#[857DDB2E3F475E95]) [     ] 
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> 2297222 INFO  
(TEST-TestFiltering.testCaching-seed#[857DDB2E3F475E95]) [     ] 
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> 2297222 INFO  
(TEST-TestFiltering.testCaching-seed#[857DDB2E3F475E95]) [     ] 
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> 2297223 INFO  
(TEST-TestFiltering.testCaching-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.SolrTestCaseJ4 ###Ending testCaching
   [junit4]   2> 2297227 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.SolrTestCaseJ4 ###Starting testRandomFiltering
   [junit4]   2> 2297227 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.DirectUpdateHandler2 [collection1]  REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 2297227 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
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> 2297227 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[0]} 0 0
   [junit4]   2> 2297227 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[1]} 0 0
   [junit4]   2> 2297228 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[2]} 0 0
   [junit4]   2> 2297228 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[3]} 0 0
   [junit4]   2> 2297228 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[4]} 0 0
   [junit4]   2> 2297228 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[5]} 0 0
   [junit4]   2> 2297228 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[6]} 0 0
   [junit4]   2> 2297228 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[7]} 0 0
   [junit4]   2> 2297228 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[8]} 0 0
   [junit4]   2> 2297228 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[8]} 0 0
   [junit4]   2> 2297237 INFO  
(searcherExecutor-26578-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 2297237 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{commit=} 0 8
   [junit4]   2> 2297238 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[9]} 0 0
   [junit4]   2> 2297238 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[9]} 0 0
   [junit4]   2> 2297238 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[10]} 0 0
   [junit4]   2> 2297238 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[11]} 0 0
   [junit4]   2> 2297238 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[11]} 0 0
   [junit4]   2> 2297238 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[12]} 0 0
   [junit4]   2> 2297238 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[12]} 0 0
   [junit4]   2> 2297238 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[13]} 0 0
   [junit4]   2> 2297238 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[14]} 0 0
   [junit4]   2> 2297239 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[14]} 0 0
   [junit4]   2> 2297239 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[15]} 0 0
   [junit4]   2> 2297239 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[16]} 0 0
   [junit4]   2> 2297248 INFO  
(searcherExecutor-26578-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 2297248 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{commit=} 0 9
   [junit4]   2> 2297249 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[17]} 0 0
   [junit4]   2> 2297249 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[18]} 0 0
   [junit4]   2> 2297249 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[18]} 0 0
   [junit4]   2> 2297249 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[19]} 0 0
   [junit4]   2> 2297249 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[19]} 0 0
   [junit4]   2> 2297249 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[20]} 0 0
   [junit4]   2> 2297249 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[21]} 0 0
   [junit4]   2> 2297259 INFO  
(searcherExecutor-26578-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 2 ms
   [junit4]   2> 2297259 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{commit=} 0 9
   [junit4]   2> 2297260 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[22]} 0 0
   [junit4]   2> 2297260 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[22]} 0 0
   [junit4]   2> 2297260 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[23]} 0 0
   [junit4]   2> 2297260 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[24]} 0 0
   [junit4]   2> 2297266 INFO  
(searcherExecutor-26578-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 2297267 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{commit=} 0 6
   [junit4]   2> 2297267 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[25]} 0 0
   [junit4]   2> 2297267 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[26]} 0 0
   [junit4]   2> 2297270 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[27]} 0 0
   [junit4]   2> 2297278 INFO  
(searcherExecutor-26578-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 2297279 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{commit=} 0 8
   [junit4]   2> 2297279 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[28]} 0 0
   [junit4]   2> 2297279 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[29]} 0 0
   [junit4]   2> 2297280 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[30]} 0 0
   [junit4]   2> 2297280 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[31]} 0 0
   [junit4]   2> 2297286 INFO  
(searcherExecutor-26578-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 2297286 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{commit=} 0 6
   [junit4]   2> 2297287 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[32]} 0 0
   [junit4]   2> 2297287 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[33]} 0 0
   [junit4]   2> 2297287 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[34]} 0 0
   [junit4]   2> 2297287 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[35]} 0 0
   [junit4]   2> 2297287 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[36]} 0 0
   [junit4]   2> 2297288 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[37]} 0 0
   [junit4]   2> 2297288 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[37]} 0 0
   [junit4]   2> 2297288 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[38]} 0 0
   [junit4]   2> 2297288 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[39]} 0 0
   [junit4]   2> 2297288 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[40]} 0 0
   [junit4]   2> 2297288 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[40]} 0 0
   [junit4]   2> 2297294 INFO  
(searcherExecutor-26578-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 2297294 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{commit=} 0 6
   [junit4]   2> 2297295 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[41]} 0 0
   [junit4]   2> 2297295 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[41]} 0 0
   [junit4]   2> 2297295 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[42]} 0 0
   [junit4]   2> 2297295 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[43]} 0 0
   [junit4]   2> 2297295 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[43]} 0 0
   [junit4]   2> 2297296 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[44]} 0 0
   [junit4]   2> 2297296 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[45]} 0 0
   [junit4]   2> 2297296 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[46]} 0 0
   [junit4]   2> 2297296 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[46]} 0 0
   [junit4]   2> 2297296 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[47]} 0 0
   [junit4]   2> 2297296 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[48]} 0 0
   [junit4]   2> 2297296 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[49]} 0 0
   [junit4]   2> 2297296 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={wt=json&indent=true}{add=[50]} 0 0
   [junit4]   2> 2297303 INFO  
(searcherExecutor-26578-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 2297303 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{commit=} 0 6
   [junit4]   2> 2297304 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=*:*&wt=xml} 
hits=51 status=0 QTime=0
   [junit4]   2> 2297306 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q={!+cache%3Dtrue+tag%3Dt}val_s:{00024+TO+00056]+OR+val_s:[00025+TO+00057}&fq={!+cache%3Dtrue+tag%3Dt}-_query_:"val_s:{00036+TO+00050]"&fq={!+cache%3Dfalse}-_query_:"val_s:[00039+TO+00051}"&fq={!+cache%3Dfalse+cost%3D102}id:RAND1651048251+OR+val_s:[00005+TO+00051]&wt=xml}
 hits=12 status=0 QTime=1
   [junit4]   2> 2297312 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
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:3+-val_i:4+-val_i:6+-val_i:8+-val_i:9+-val_i:10+-val_i:11+-val_i:13+-val_i:14+-val_i:18+-val_i:23+-val_i:24+-val_i:25+-val_i:26+-val_i:28+-val_i:31+-val_i:32+-val_i:36+-val_i:37+-val_i:39+-val_i:40+-val_i:42+-val_i:43+-val_i:48+-val_i:50&q={!frange+v%3Dval_i+l%3D16+u%3D55+cost%3D115+tag%3Dt}&facet=true&wt=xml}
 hits=35 status=0 QTime=6
   [junit4]   2> 2297318 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
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:5+-val_i:6+-val_i:9+-val_i:11+-val_i:12+-val_i:14+-val_i:16+-val_i:18+-val_i:19+-val_i:20+-val_i:21+-val_i:22+-val_i:23+-val_i:24+-val_i:25+-val_i:26+-val_i:28+-val_i:29+-val_i:30+-val_i:31+-val_i:35+-val_i:39+-val_i:40+-val_i:41+-val_i:42+-val_i:43+-val_i:46+-val_i:47+-val_i:48&q={!+cache%3Dtrue+tag%3Dt}val_s:[00046+TO+00063]+OR+id:RAND235299262&group.main=true&facet=true&wt=xml&group.field=id&group=true}
 hits=5 status=0 QTime=4
   [junit4]   2> 2297319 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q={!cache%3Dtrue+tag%3Dt}+val_i:5+val_i:9+val_i:11+val_i:12+val_i:13+val_i:15+val_i:16+val_i:17+val_i:18+val_i:19+val_i:23+val_i:24+val_i:25+val_i:26+val_i:29+val_i:32+val_i:34+val_i:38+val_i:42+val_i:43+val_i:44+val_i:45+val_i:47+val_i:49&wt=xml}
 hits=24 status=0 QTime=1
   [junit4]   2> 2297323 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:RAND481462582+OR+val_i:[00013+TO+00060]&fq={!cache%3Dfalse}+-val_i:0+-val_i:1+-val_i:2+-val_i:3+-val_i:4+-val_i:7+-val_i:11+-val_i:14+-val_i:21+-val_i:23+-val_i:26+-val_i:30+-val_i:31+-val_i:34+-val_i:35+-val_i:37+-val_i:38+-val_i:40+-val_i:41+-val_i:42+-val_i:46+-val_i:47+-val_i:48+-val_i:49+-val_i:50&fq={!cache%3Dfalse+cost%3D110}+-val_i:1+-val_i:2+-val_i:3+-val_i:4+-val_i:5+-val_i:6+-val_i:7+-val_i:8+-val_i:9+-val_i:11+-val_i:12+-val_i:14+-val_i:16+-val_i:17+-val_i:18+-val_i:19+-val_i:20+-val_i:21+-val_i:22+-val_i:25+-val_i:27+-val_i:29+-val_i:30+-val_i:33+-val_i:36+-val_i:39+-val_i:44+-val_i:45+-val_i:49+-val_i:50&fq={!cache%3Dtrue+tag%3Dt}+val_i:0+val_i:1+val_i:2+val_i:3+val_i:4+val_i:5+val_i:7+val_i:8+val_i:10+val_i:11+val_i:12+val_i:13+val_i:14+val_i:15+val_i:21+val_i:25+val_i:27+val_i:29+val_i:30+val_i:32+val_i:33+val_i:38+val_i:42+val_i:43+val_i:44+val_i:45+val_i:46+val_i:49+val_i:50&wt=xml}
 hits=4 status=0 QTime=3
   [junit4]   2> 2297325 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=+-val_i:2+-val_i:4+-val_i:6+-val_i:7+-val_i:9+-val_i:13+-val_i:16+-val_i:23+-val_i:24+-val_i:26+-val_i:28+-val_i:30+-val_i:31+-val_i:33+-val_i:35+-val_i:38+-val_i:42+-val_i:50&fq={!cache%3Dfalse+cost%3D128}+val_i:2+val_i:5+val_i:9+val_i:13+val_i:15+val_i:16+val_i:19+val_i:21+val_i:22+val_i:24+val_i:25+val_i:26+val_i:29+val_i:30+val_i:31+val_i:32+val_i:35+val_i:38+val_i:40+val_i:41+val_i:42+val_i:43+val_i:44+val_i:48&fq={!+cache%3Dtrue+tag%3Dt}val_i:[00021+TO+00038]+OR+val_i:{00020+TO+00039}&fq={!+cache%3Dfalse+tag%3Dt}val_i:[00011+TO+00043]&wt=xml}
 hits=5 status=0 QTime=1
   [junit4]   2> 2297328 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
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%3D126}+-val_i:1+-val_i:2+-val_i:4+-val_i:7+-val_i:10+-val_i:11+-val_i:12+-val_i:17+-val_i:18+-val_i:19+-val_i:20+-val_i:21+-val_i:23+-val_i:25+-val_i:26+-val_i:27+-val_i:28+-val_i:34+-val_i:35+-val_i:39+-val_i:40+-val_i:43+-val_i:44+-val_i:45+-val_i:46+-val_i:49+-val_i:50&q={!cache%3Dfalse+tag%3Dt}+val_i:1+val_i:2+val_i:6+val_i:7+val_i:8+val_i:9+val_i:11+val_i:14+val_i:15+val_i:16+val_i:17+val_i:18+val_i:20+val_i:23+val_i:26+val_i:29+val_i:33+val_i:34+val_i:38+val_i:40+val_i:43+val_i:45+val_i:46+val_i:50&facet=true&wt=xml}
 hits=24 status=0 QTime=2
   [junit4]   2> 2297370 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery+cache%3Dfalse}+-val_i:0+-val_i:2+-val_i:3+-val_i:4+-val_i:10+-val_i:12+-val_i:13+-val_i:15+-val_i:16+-val_i:19+-val_i:20+-val_i:21+-val_i:22+-val_i:24+-val_i:27+-val_i:28+-val_i:29+-val_i:33+-val_i:35+-val_i:39+-val_i:40+-val_i:41+-val_i:42+-val_i:43+-val_i:44+-val_i:45+-val_i:46+-val_i:47+-val_i:49+-val_i:50&q={!+cache%3Dtrue+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D47+u%3D51}"&fq=-_query_:"{!frange+v%3Dval_i+l%3D41+u%3D50}"&facet=true&wt=xml}
 hits=41 status=0 QTime=41
   [junit4]   2> 2297373 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery}+val_i:0+val_i:1+val_i:2+val_i:3+val_i:5+val_i:6+val_i:8+val_i:10+val_i:11+val_i:12+val_i:14+val_i:21+val_i:23+val_i:26+val_i:27+val_i:30+val_i:32+val_i:34+val_i:36+val_i:38+val_i:42+val_i:43+val_i:45+val_i:47+val_i:48+val_i:50&q={!+cache%3Dtrue+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D23+u%3D50}"&fq={!cache%3Dtrue+tag%3Dt}+-val_i:1+-val_i:6+-val_i:7+-val_i:8+-val_i:9+-val_i:12+-val_i:15+-val_i:16+-val_i:19+-val_i:24+-val_i:25+-val_i:30+-val_i:31+-val_i:34+-val_i:38+-val_i:40+-val_i:43+-val_i:45+-val_i:46+-val_i:47+-val_i:50&facet=true&wt=xml}
 hits=14 status=0 QTime=2
   [junit4]   2> 2297379 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q={!cache%3Dtrue+tag%3Dt}+val_i:1+val_i:4+val_i:5+val_i:8+val_i:9+val_i:11+val_i:20+val_i:21+val_i:24+val_i:25+val_i:26+val_i:27+val_i:28+val_i:31+val_i:33+val_i:35+val_i:36+val_i:38+val_i:39+val_i:40+val_i:42+val_i:43+val_i:44+val_i:47+val_i:48&fq={!cache%3Dfalse}+-val_i:0+-val_i:1+-val_i:3+-val_i:4+-val_i:8+-val_i:9+-val_i:10+-val_i:11+-val_i:12+-val_i:14+-val_i:17+-val_i:19+-val_i:20+-val_i:22+-val_i:23+-val_i:27+-val_i:32+-val_i:34+-val_i:36+-val_i:37+-val_i:39+-val_i:40+-val_i:42+-val_i:43+-val_i:45+-val_i:47+-val_i:49+-val_i:50&fq={!cache%3Dtrue+tag%3Dt}+-val_i:0+-val_i:2+-val_i:3+-val_i:4+-val_i:7+-val_i:9+-val_i:10+-val_i:11+-val_i:12+-val_i:14+-val_i:15+-val_i:19+-val_i:22+-val_i:23+-val_i:25+-val_i:28+-val_i:29+-val_i:30+-val_i:34+-val_i:36+-val_i:37+-val_i:38+-val_i:39+-val_i:43+-val_i:44+-val_i:46+-val_i:49&fq={!frange+v%3Dval_i+l%3D45+u%3D59+tag%3Dt}&wt=xml}
 hits=1 status=0 QTime=5
   [junit4]   2> 2297395 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
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%3D2+u%3D50}"&q={!cache%3Dfalse+cost%3D4}+-val_i:2+-val_i:3+-val_i:4+-val_i:6+-val_i:7+-val_i:8+-val_i:9+-val_i:10+-val_i:19+-val_i:21+-val_i:23+-val_i:25+-val_i:26+-val_i:27+-val_i:30+-val_i:32+-val_i:36+-val_i:37+-val_i:38+-val_i:39+-val_i:41+-val_i:42+-val_i:43+-val_i:44&fq={!cache%3Dfalse}+-val_i:1+-val_i:2+-val_i:3+-val_i:4+-val_i:5+-val_i:7+-val_i:8+-val_i:9+-val_i:12+-val_i:14+-val_i:17+-val_i:18+-val_i:20+-val_i:21+-val_i:23+-val_i:26+-val_i:30+-val_i:32+-val_i:34+-val_i:37+-val_i:38+-val_i:40+-val_i:43+-val_i:44&fq={!+cache%3Dtrue+tag%3Dt}val_s:{00041+TO+00058}+OR+id:RAND1882467298&facet=true&wt=xml}
 hits=6 status=0 QTime=16
   [junit4]   2> 2297397 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
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:2+val_i:6+val_i:7+val_i:8+val_i:10+val_i:11+val_i:15+val_i:18+val_i:20+val_i:21+val_i:26+val_i:28+val_i:29+val_i:30+val_i:31+val_i:34+val_i:37+val_i:40+val_i:41+val_i:46+val_i:47+val_i:49+val_i:50&q=val_i:[00012+TO+00046]&fq={!frange+v%3Dval_i+l%3D12+u%3D47+cache%3Dfalse+cost%3D138}&facet=true&wt=xml}
 hits=35 status=0 QTime=1
   [junit4]   2> 2297403 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
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%3D152}-_query_:"{!frange+v%3Dval_i+l%3D12+u%3D50}"&q={!cache%3Dtrue}+val_i:2+val_i:3+val_i:4+val_i:6+val_i:9+val_i:10+val_i:11+val_i:14+val_i:16+val_i:17+val_i:18+val_i:19+val_i:20+val_i:21+val_i:26+val_i:27+val_i:29+val_i:31+val_i:35+val_i:37+val_i:40+val_i:46+val_i:49+val_i:50&group.main=true&fq={!cache%3Dfalse}+val_i:0+val_i:1+val_i:3+val_i:5+val_i:6+val_i:7+val_i:8+val_i:9+val_i:12+val_i:14+val_i:15+val_i:16+val_i:17+val_i:18+val_i:20+val_i:23+val_i:24+val_i:25+val_i:27+val_i:28+val_i:32+val_i:34+val_i:36+val_i:39+val_i:40+val_i:42+val_i:43+val_i:47+val_i:48+val_i:49&fq={!cache%3Dfalse+cost%3D162}+val_i:0+val_i:1+val_i:2+val_i:4+val_i:9+val_i:10+val_i:11+val_i:14+val_i:17+val_i:19+val_i:20+val_i:21+val_i:23+val_i:26+val_i:27+val_i:29+val_i:34+val_i:35+val_i:39+val_i:40+val_i:41+val_i:44+val_i:46+val_i:48&fq={!frange+v%3Dval_i+l%3D36+u%3D51+cache%3Dfalse}&fq={!cache%3Dtrue}+-val_i:3+-val_i:4+-val_i:6+-val_i:7+-val_i:8+-val_i:9+-val_i:10+-val_i:13+-val_i:14+-val_i:15+-val_i:18+-val_i:20+-val_i:21+-val_i:23+-val_i:24+-val_i:25+-val_i:26+-val_i:27+-val_i:28+-val_i:29+-val_i:30+-val_i:31+-val_i:35+-val_i:37+-val_i:38+-val_i:39+-val_i:41+-val_i:43+-val_i:45+-val_i:46+-val_i:47+-val_i:50&facet=true&wt=xml&group.field=id&group=true}
 hits=1 status=0 QTime=5
   [junit4]   2> 2297404 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q={!+cache%3Dtrue+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D21+u%3D50}"&wt=xml}
 hits=21 status=0 QTime=0
   [junit4]   2> 2297406 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q={!cache%3Dfalse}+val_i:1+val_i:8+val_i:9+val_i:10+val_i:13+val_i:15+val_i:17+val_i:18+val_i:20+val_i:21+val_i:23+val_i:24+val_i:25+val_i:27+val_i:28+val_i:29+val_i:31+val_i:34+val_i:37+val_i:38+val_i:40+val_i:42+val_i:43+val_i:44+val_i:45+val_i:47+val_i:48+val_i:49&fq=-_query_:"{!frange+v%3Dval_i+l%3D11+u%3D50}"&wt=xml}
 hits=4 status=0 QTime=1
   [junit4]   2> 2297406 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
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%3D30+u%3D50}"&q={!frange+v%3Dval_i+l%3D25+u%3D44+tag%3Dt}&fq={!frange+v%3Dval_i+l%3D34+u%3D56+cache%3Dfalse+tag%3Dt}&fq={!frange+v%3Dval_i+l%3D35+u%3D70}&facet=true&wt=xml}
 hits=10 status=0 QTime=0
   [junit4]   2> 2297408 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q={!+cache%3Dfalse+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D15+u%3D50}"&fq={!frange+v%3Dval_i+l%3D48+u%3D74}&fq={!cache%3Dtrue}+val_i:0+val_i:1+val_i:2+val_i:7+val_i:9+val_i:11+val_i:12+val_i:21+val_i:22+val_i:23+val_i:25+val_i:26+val_i:27+val_i:28+val_i:29+val_i:31+val_i:32+val_i:35+val_i:36+val_i:41+val_i:42+val_i:45+val_i:47+val_i:48+val_i:49&fq={!+cost%3D80}-_query_:"val_s:{00033+TO+00050]"&fq={!cache%3Dtrue}+-val_i:1+-val_i:2+-val_i:6+-val_i:8+-val_i:10+-val_i:12+-val_i:13+-val_i:15+-val_i:17+-val_i:18+-val_i:19+-val_i:21+-val_i:22+-val_i:23+-val_i:26+-val_i:27+-val_i:31+-val_i:32+-val_i:33+-val_i:37+-val_i:42+-val_i:44+-val_i:45+-val_i:48&wt=xml}
 hits=0 status=0 QTime=1
   [junit4]   2> 2297409 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
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%3D20+u%3D67}&q={!+cost%3D103}-_query_:"val_i:{00019+TO+00050]"&facet=true&wt=xml}
 hits=20 status=0 QTime=0
   [junit4]   2> 2297410 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q={!cache%3Dfalse+tag%3Dt}+val_i:0+val_i:2+val_i:3+val_i:9+val_i:11+val_i:12+val_i:13+val_i:18+val_i:19+val_i:23+val_i:24+val_i:25+val_i:28+val_i:29+val_i:32+val_i:34+val_i:39+val_i:41+val_i:44+val_i:45+val_i:46+val_i:47+val_i:48&fq=val_i:[00018+TO+00062]&wt=xml}
 hits=16 status=0 QTime=1
   [junit4]   2> 2297412 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q={!cache%3Dtrue+tag%3Dt}+-val_i:4+-val_i:5+-val_i:9+-val_i:11+-val_i:13+-val_i:14+-val_i:16+-val_i:17+-val_i:18+-val_i:19+-val_i:20+-val_i:21+-val_i:24+-val_i:28+-val_i:29+-val_i:31+-val_i:32+-val_i:33+-val_i:34+-val_i:36+-val_i:37+-val_i:38+-val_i:40+-val_i:48+-val_i:49&fq={!frange+v%3Dval_i+l%3D5+u%3D26+cache%3Dtrue+tag%3Dt}&wt=xml}
 hits=10 status=0 QTime=1
   [junit4]   2> 2297415 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
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:4+-val_i:5+-val_i:6+-val_i:8+-val_i:10+-val_i:11+-val_i:12+-val_i:13+-val_i:15+-val_i:16+-val_i:17+-val_i:20+-val_i:24+-val_i:31+-val_i:35+-val_i:36+-val_i:38+-val_i:39+-val_i:40+-val_i:42+-val_i:43+-val_i:44+-val_i:48+-val_i:50&q={!+cache%3Dtrue+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D12+u%3D50}"&fq={!cache%3Dfalse+cost%3D68+tag%3Dt}+-val_i:1+-val_i:2+-val_i:4+-val_i:9+-val_i:12+-val_i:13+-val_i:16+-val_i:19+-val_i:21+-val_i:26+-val_i:30+-val_i:33+-val_i:34+-val_i:36+-val_i:37+-val_i:39+-val_i:41+-val_i:42+-val_i:46+-val_i:47+-val_i:49+-val_i:50&fq={!+cache%3Dfalse}val_i:[00023+TO+00052}+OR+id:RAND622256943&fq={!+cache%3Dtrue+tag%3Dt}-_query_:"val_i:[00043+TO+00051}"&facet=true&wt=xml}
 hits=0 status=0 QTime=2
   [junit4]   2> 2297419 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
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:6+-val_i:7+-val_i:10+-val_i:11+-val_i:12+-val_i:13+-val_i:18+-val_i:21+-val_i:22+-val_i:23+-val_i:26+-val_i:27+-val_i:28+-val_i:31+-val_i:32+-val_i:34+-val_i:35+-val_i:37+-val_i:39+-val_i:44+-val_i:46+-val_i:47+-val_i:48&q={!cache%3Dtrue}+val_i:0+val_i:1+val_i:2+val_i:4+val_i:6+val_i:7+val_i:12+val_i:14+val_i:16+val_i:19+val_i:21+val_i:22+val_i:25+val_i:30+val_i:33+val_i:38+val_i:41+val_i:42+val_i:44+val_i:46+val_i:47+val_i:48+val_i:49+val_i:50&fq={!+cost%3D147+tag%3Dt}-_query_:"val_s:[00045+TO+00051}"&fq=-_query_:"val_s:{00047+TO+00050]"&fq={!cache%3Dfalse+tag%3Dt}+val_i:0+val_i:1+val_i:2+val_i:3+val_i:7+val_i:9+val_i:12+val_i:13+val_i:18+val_i:19+val_i:21+val_i:22+val_i:23+val_i:28+val_i:29+val_i:30+val_i:31+val_i:35+val_i:36+val_i:37+val_i:42+val_i:44&facet=true&wt=xml}
 hits=11 status=0 QTime=4
   [junit4]   2> 2297420 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=-_query_:"val_i:{00028+TO+00051}"&fq={!+cost%3D87+tag%3Dt}id:RAND-2008886605+OR+val_i:[00039+TO+00074]&wt=xml}
 hits=0 status=0 QTime=0
   [junit4]   2> 2297422 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
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%3D18+u%3D67+cache%3Dfalse}&q={!cache%3Dfalse+tag%3Dt}+-val_i:1+-val_i:4+-val_i:5+-val_i:6+-val_i:8+-val_i:9+-val_i:13+-val_i:17+-val_i:19+-val_i:21+-val_i:23+-val_i:25+-val_i:30+-val_i:31+-val_i:37+-val_i:38+-val_i:39+-val_i:42+-val_i:43+-val_i:47+-val_i:48+-val_i:50&fq={!+cost%3D110}-_query_:"{!frange+v%3Dval_i+l%3D49+u%3D53}"&fq={!+cache%3Dtrue+tag%3Dt}val_i:[00049+TO+00093]+OR+val_i:{00048+TO+00094}&facet=true&wt=xml}
 hits=0 status=0 QTime=1
   [junit4]   2> 2297422 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q={!frange+v%3Dval_i+l%3D28+u%3D63+cache%3Dfalse+tag%3Dt}&fq={!cache%3Dtrue+tag%3Dt}+val_i:0+val_i:1+val_i:2+val_i:3+val_i:5+val_i:6+val_i:7+val_i:8+val_i:10+val_i:13+val_i:14+val_i:15+val_i:16+val_i:17+val_i:20+val_i:21+val_i:22+val_i:23+val_i:24+val_i:25+val_i:26+val_i:27+val_i:28+val_i:29+val_i:31+val_i:35+val_i:38+val_i:39+val_i:40+val_i:41+val_i:46+val_i:50&wt=xml}
 hits=10 status=0 QTime=0
   [junit4]   2> 2297424 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=+-val_i:0+-val_i:6+-val_i:7+-val_i:10+-val_i:19+-val_i:24+-val_i:30+-val_i:32+-val_i:34+-val_i:35+-val_i:36+-val_i:37+-val_i:41+-val_i:43+-val_i:44+-val_i:47+-val_i:48+-val_i:49&fq=-_query_:"val_i:{00014+TO+00050]"&wt=xml}
 hits=11 status=0 QTime=1
   [junit4]   2> 2297428 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
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%3D59}+-val_i:4+-val_i:6+-val_i:8+-val_i:15+-val_i:16+-val_i:18+-val_i:19+-val_i:22+-val_i:23+-val_i:24+-val_i:26+-val_i:27+-val_i:28+-val_i:29+-val_i:30+-val_i:31+-val_i:32+-val_i:35+-val_i:36+-val_i:37+-val_i:41+-val_i:43+-val_i:45+-val_i:46+-val_i:47+-val_i:48+-val_i:49&q={!+cache%3Dtrue+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D1+u%3D50}"&group.main=true&group.cache.percent=100&fq={!cache%3Dtrue}+val_i:0+val_i:1+val_i:3+val_i:4+val_i:6+val_i:7+val_i:9+val_i:10+val_i:11+val_i:12+val_i:18+val_i:19+val_i:23+val_i:26+val_i:27+val_i:29+val_i:30+val_i:32+val_i:34+val_i:36+val_i:38+val_i:42+val_i:43+val_i:45+val_i:47&fq={!cache%3Dfalse+tag%3Dt}+-val_i:1+-val_i:2+-val_i:5+-val_i:7+-val_i:8+-val_i:10+-val_i:12+-val_i:13+-val_i:15+-val_i:17+-val_i:19+-val_i:20+-val_i:21+-val_i:22+-val_i:23+-val_i:24+-val_i:28+-val_i:30+-val_i:31+-val_i:38+-val_i:39+-val_i:41+-val_i:42+-val_i:43+-val_i:45+-val_i:46+-val_i:48+-val_i:49+-val_i:50&fq=+val_i:0+val_i:1+val_i:5+val_i:6+val_i:7+val_i:8+val_i:10+val_i:11+val_i:12+val_i:13+val_i:14+val_i:17+val_i:18+val_i:19+val_i:20+val_i:21+val_i:24+val_i:25+val_i:28+val_i:29+val_i:30+val_i:33+val_i:34+val_i:36+val_i:44+val_i:46+val_i:47+val_i:49&facet=true&wt=xml&group.field=id&group=true}
 hits=1 status=0 QTime=4
   [junit4]   2> 2297431 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
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:[00022+TO+00051}"&q=-_query_:"val_i:[00010+TO+00051}"&fq=val_s:[00041+TO+00060}&fq={!+cache%3Dfalse}*:*+AND+val_s:[00014+TO+00047]&fq={!cache%3Dfalse+cost%3D190+tag%3Dt}+-val_i:1+-val_i:2+-val_i:3+-val_i:6+-val_i:7+-val_i:10+-val_i:11+-val_i:12+-val_i:13+-val_i:14+-val_i:16+-val_i:17+-val_i:19+-val_i:21+-val_i:22+-val_i:24+-val_i:25+-val_i:26+-val_i:28+-val_i:30+-val_i:33+-val_i:45+-val_i:50&facet=true&wt=xml}
 hits=0 status=0 QTime=2
   [junit4]   2> 2297432 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
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:{00033+TO+00060}&q=val_i:[00015+TO+00058}&fq={!cache%3Dtrue}+val_i:1+val_i:3+val_i:4+val_i:5+val_i:7+val_i:8+val_i:9+val_i:10+val_i:12+val_i:13+val_i:14+val_i:15+val_i:21+val_i:23+val_i:24+val_i:25+val_i:26+val_i:27+val_i:29+val_i:33+val_i:34+val_i:39+val_i:42+val_i:43+val_i:44+val_i:45+val_i:46+val_i:47+val_i:48+val_i:49&facet=true&wt=xml}
 hits=19 status=0 QTime=0
   [junit4]   2> 2297432 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q={!frange+v%3Dval_i+l%3D29+u%3D78+cache%3Dfalse+tag%3Dt}&fq={!+tag%3Dt}-_query_:"val_i:{00031+TO+00051}"&wt=xml}
 hits=3 status=0 QTime=0
   [junit4]   2> 2297432 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
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%3D47+u%3D49+cache%3Dfalse}&q={!+cache%3Dfalse+cost%3D178+tag%3Dt}-_query_:"val_i:[00041+TO+00051}"&facet=true&wt=xml}
 hits=41 status=0 QTime=0
   [junit4]   2> 2297433 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
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%3D5}+-val_i:0+-val_i:4+-val_i:5+-val_i:8+-val_i:9+-val_i:13+-val_i:15+-val_i:21+-val_i:23+-val_i:24+-val_i:27+-val_i:30+-val_i:31+-val_i:32+-val_i:34+-val_i:35+-val_i:36+-val_i:37+-val_i:38+-val_i:42+-val_i:43+-val_i:44+-val_i:45+-val_i:47+-val_i:48+-val_i:49+-val_i:50&q={!+cache%3Dtrue+tag%3Dt}-_query_:"val_s:{00032+TO+00050]"&fq={!frange+v%3Dval_i+l%3D48+u%3D63}&facet=true&wt=xml}
 hits=0 status=0 QTime=0
   [junit4]   2> 2297435 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
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:1+-val_i:4+-val_i:5+-val_i:6+-val_i:8+-val_i:10+-val_i:11+-val_i:13+-val_i:23+-val_i:24+-val_i:28+-val_i:29+-val_i:30+-val_i:33+-val_i:35+-val_i:38+-val_i:44+-val_i:48&q={!}-_query_:"val_i:{00017+TO+00050]"&facet=true&wt=xml}
 hits=18 status=0 QTime=1
   [junit4]   2> 2297436 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
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%3D25+u%3D50}"&q={!cache%3Dtrue+tag%3Dt}+val_i:5+val_i:11+val_i:15+val_i:19+val_i:20+val_i:21+val_i:22+val_i:26+val_i:33+val_i:34+val_i:35+val_i:36+val_i:37+val_i:38+val_i:42+val_i:47&fq={!cache%3Dfalse+cost%3D169}+val_i:2+val_i:3+val_i:4+val_i:5+val_i:6+val_i:7+val_i:8+val_i:9+val_i:11+val_i:13+val_i:14+val_i:17+val_i:21+val_i:24+val_i:26+val_i:27+val_i:28+val_i:29+val_i:30+val_i:31+val_i:34+val_i:35+val_i:36+val_i:37+val_i:38+val_i:39+val_i:41+val_i:44+val_i:46&facet=true&wt=xml}
 hits=9 status=0 QTime=1
   [junit4]   2> 2297437 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q={!frange+v%3Dval_i+l%3D28+u%3D49+cache%3Dfalse+cost%3D188}&fq={!frange+v%3Dval_i+l%3D28+u%3D57}&fq={!+cache%3Dfalse+cost%3D133}-_query_:"{!frange+v%3Dval_i+l%3D28+u%3D50}"&wt=xml}
 hits=0 status=0 QTime=0
   [junit4]   2> 2297440 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
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:3+-val_i:13+-val_i:14+-val_i:17+-val_i:18+-val_i:19+-val_i:20+-val_i:21+-val_i:22+-val_i:23+-val_i:24+-val_i:25+-val_i:29+-val_i:32+-val_i:34+-val_i:35+-val_i:37+-val_i:38+-val_i:39+-val_i:43+-val_i:45+-val_i:47&q={!cache%3Dtrue+tag%3Dt}+-val_i:0+-val_i:3+-val_i:4+-val_i:7+-val_i:8+-val_i:9+-val_i:11+-val_i:12+-val_i:13+-val_i:19+-val_i:20+-val_i:21+-val_i:25+-val_i:26+-val_i:30+-val_i:37+-val_i:40+-val_i:43+-val_i:44+-val_i:45+-val_i:46+-val_i:48+-val_i:50&fq={!+cost%3D155+tag%3Dt}-_query_:"val_s:{00048+TO+00050]"&facet=true&wt=xml}
 hits=27 status=0 QTime=2
   [junit4]   2> 2297441 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q={!frange+v%3Dval_i+l%3D34+u%3D70+cache%3Dfalse}&fq={!frange+v%3Dval_i+l%3D24+u%3D50+cache%3Dtrue+tag%3Dt}&fq={!+cache%3Dtrue+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D22+u%3D50}"&fq={!cache%3Dfalse+tag%3Dt}+val_i:0+val_i:3+val_i:5+val_i:6+val_i:7+val_i:8+val_i:9+val_i:11+val_i:13+val_i:14+val_i:15+val_i:18+val_i:20+val_i:21+val_i:22+val_i:23+val_i:24+val_i:25+val_i:30+val_i:31+val_i:33+val_i:39+val_i:40+val_i:42+val_i:44+val_i:45+val_i:46+val_i:48&wt=xml}
 hits=0 status=0 QTime=0
   [junit4]   2> 2297441 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q={!+cache%3Dfalse+tag%3Dt}-_query_:"val_s:[00027+TO+00050]"&fq=-_query_:"val_i:{00002+TO+00050]"&wt=xml}
 hits=3 status=0 QTime=0
   [junit4]   2> 2297443 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q={!cache%3Dtrue+tag%3Dt}+-val_i:0+-val_i:4+-val_i:5+-val_i:7+-val_i:8+-val_i:12+-val_i:13+-val_i:14+-val_i:16+-val_i:18+-val_i:19+-val_i:21+-val_i:22+-val_i:27+-val_i:30+-val_i:31+-val_i:32+-val_i:34+-val_i:36+-val_i:38+-val_i:45+-val_i:46+-val_i:48&fq={!+cache%3Dtrue+tag%3Dt}*:*+AND+val_i:[00039+TO+00061]&fq={!cache%3Dtrue+tag%3Dt}+val_i:1+val_i:2+val_i:6+val_i:9+val_i:10+val_i:11+val_i:12+val_i:13+val_i:21+val_i:23+val_i:25+val_i:26+val_i:27+val_i:28+val_i:30+val_i:32+val_i:35+val_i:36+val_i:39+val_i:40+val_i:41+val_i:42+val_i:43+val_i:44+val_i:46+val_i:48+val_i:49+val_i:50&wt=xml}
 hits=8 status=0 QTime=1
   [junit4]   2> 2297447 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q={!frange+v%3Dval_i+l%3D46+u%3D72}&group.main=true&fq={!cache%3Dfalse+cost%3D105}+-val_i:0+-val_i:2+-val_i:3+-val_i:6+-val_i:7+-val_i:8+-val_i:9+-val_i:14+-val_i:16+-val_i:17+-val_i:18+-val_i:19+-val_i:22+-val_i:24+-val_i:26+-val_i:27+-val_i:28+-val_i:29+-val_i:31+-val_i:32+-val_i:33+-val_i:35+-val_i:40+-val_i:41+-val_i:42+-val_i:43&fq={!cache%3Dtrue+tag%3Dt}+val_i:0+val_i:1+val_i:2+val_i:3+val_i:4+val_i:6+val_i:7+val_i:10+val_i:11+val_i:14+val_i:16+val_i:18+val_i:19+val_i:22+val_i:24+val_i:25+val_i:27+val_i:29+val_i:30+val_i:34+val_i:36+val_i:39+val_i:41+val_i:42+val_i:43+val_i:44+val_i:47+val_i:49+val_i:50&wt=xml&group.field=id&group=true}
 hits=3 status=0 QTime=3
   [junit4]   2> 2297447 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q={!frange+v%3Dval_i+l%3D46+u%3D84+cache%3Dtrue+tag%3Dt}&group.main=true&fq=-_query_:"{!frange+v%3Dval_i+l%3D13+u%3D50}"&fq={!cache%3Dfalse+cost%3D75+tag%3Dt}+val_i:1+val_i:3+val_i:4+val_i:5+val_i:7+val_i:9+val_i:11+val_i:12+val_i:14+val_i:15+val_i:16+val_i:20+val_i:21+val_i:23+val_i:24+val_i:25+val_i:26+val_i:27+val_i:30+val_i:32+val_i:33+val_i:35+val_i:36+val_i:38+val_i:39+val_i:41+val_i:44+val_i:45+val_i:47+val_i:48&wt=xml&group.field=id&group=true}
 hits=0 status=0 QTime=0
   [junit4]   2> 2297448 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
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:[00021+TO+00066}&q={!frange+v%3Dval_i+l%3D21+u%3D44+cost%3D47}&fq=-_query_:"{!frange+v%3Dval_i+l%3D41+u%3D50}"&facet=true&wt=xml}
 hits=20 status=0 QTime=0
   [junit4]   2> 2297451 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=+val_i:0+val_i:1+val_i:4+val_i:6+val_i:9+val_i:10+val_i:12+val_i:14+val_i:16+val_i:17+val_i:18+val_i:21+val_i:23+val_i:24+val_i:27+val_i:29+val_i:31+val_i:36+val_i:39+val_i:40+val_i:44+val_i:45+val_i:48+val_i:50&fq=+-val_i:0+-val_i:2+-val_i:3+-val_i:7+-val_i:9+-val_i:11+-val_i:14+-val_i:18+-val_i:21+-val_i:22+-val_i:24+-val_i:25+-val_i:28+-val_i:30+-val_i:33+-val_i:34+-val_i:37+-val_i:38+-val_i:41+-val_i:43+-val_i:44+-val_i:45+-val_i:47+-val_i:49&fq=val_i:{00005+TO+00035]&fq={!+cost%3D186}-_query_:"{!frange+v%3Dval_i+l%3D43+u%3D50}"&wt=xml}
 hits=9 status=0 QTime=2
   [junit4]   2> 2297457 INFO  
(TEST-TestFiltering.testRandomFiltering-seed#[857DDB2E3F475E95]) [     ] 
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%3D40+u%3D66}&q={!+cost%3D3}val_i:{00044+TO+00084]&fq={!cache%3Dfalse+cost%3D98+tag%3Dt}+val_i:0+val_i:2+val_i:8+val_i:10+val_i:11+val_i:13+val_i:15+val_i:17+val_i:18+val_i:21+val_i:23+val_i:24+val_i:25+val_i:27+val_i:28+val_i:30+val_i:32+val_i:33+val_i:35+val_i:38+val_i:39+val_i:45+val_i:47+val_i:48+val_i:49+val_i:50&fq={!cache%3Dfalse+tag%3Dt}+-val_i:4+-val_i:6+-val_i:7+-val_i:10+-val_i:12+-val_i:13+-val_i:14+-val_i:15+-val_i:17+-val_i:19+-val_i:20+-val_i:22+-val_i:23+-val_i:24+-val_i:28+-val_i:29+-val_i:30+-val_i:35+-val_i:36+-val_i:37+-val_i:38+-val_i:40+-val_i:41+-val_i:43+-val_i:44+-val_i:45+-val_i:47+-val_i:49+-val_i:50&fq={!cache%3Dfalse+tag%3Dt}+val_i:0+val_i:1+val_i:6+val_i:8+val_i:9+val_i:11+val_i:13+val_i:14+val_i:15+val_i:17+val_i:18+val_i:19+val_i:20+val_i:23+val_i:24+val_i:25+val_i:26+val_i:27+val_i:

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

quest [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> 2302003 INFO  
(TEST-TestFiltering.testHossssSanity-seed#[857DDB2E3F475E95]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{commit=} 0 0
   [junit4]   2> 2302003 INFO  
(TEST-TestFiltering.testHossssSanity-seed#[857DDB2E3F475E95]) [     ] 
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> 2302003 INFO  
(TEST-TestFiltering.testHossssSanity-seed#[857DDB2E3F475E95]) [     ] 
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> 2302004 INFO  
(TEST-TestFiltering.testHossssSanity-seed#[857DDB2E3F475E95]) [     ] 
o.a.s.SolrTestCaseJ4 ###Ending testHossssSanity
   [junit4]   2> 2302004 INFO  
(SUITE-TestFiltering-seed#[857DDB2E3F475E95]-worker) [     ] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> 2302004 INFO  
(SUITE-TestFiltering-seed#[857DDB2E3F475E95]-worker) [     ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=253173823
   [junit4]   2> 2302005 INFO  (coreCloseExecutor-26583-thread-1) [     ] 
o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@4da5bb47
   [junit4]   2> 2302005 INFO  (coreCloseExecutor-26583-thread-1) [     ] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1 tag=SolrCore@4da5bb47
   [junit4]   2> 2302005 INFO  (coreCloseExecutor-26583-thread-1) [     ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@2bc74545: rootName = null, 
domain = solr.core.collection1, service url = null, agent id = null] for 
registry solr.core.collection1/com.codahale.metrics.MetricRegistry@1e24c6ee
   [junit4]   2> 2302029 INFO  (coreCloseExecutor-26583-thread-1) [     ] 
o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close()  ... SKIPPED 
(unnecessary).
   [junit4]   2> 2302032 INFO  
(SUITE-TestFiltering-seed#[857DDB2E3F475E95]-worker) [     ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node 
tag=null
   [junit4]   2> 2302032 INFO  
(SUITE-TestFiltering-seed#[857DDB2E3F475E95]-worker) [     ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@274c96fd: rootName = null, 
domain = solr.node, service url = null, agent id = null] for registry 
solr.node/com.codahale.metrics.MetricRegistry@7b59b5ee
   [junit4]   2> 2302037 INFO  
(SUITE-TestFiltering-seed#[857DDB2E3F475E95]-worker) [     ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm 
tag=null
   [junit4]   2> 2302037 INFO  
(SUITE-TestFiltering-seed#[857DDB2E3F475E95]-worker) [     ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@7b5bc0a8: rootName = null, 
domain = solr.jvm, service url = null, agent id = null] for registry 
solr.jvm/com.codahale.metrics.MetricRegistry@6d0f80f7
   [junit4]   2> 2302039 INFO  
(SUITE-TestFiltering-seed#[857DDB2E3F475E95]-worker) [     ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty 
tag=null
   [junit4]   2> 2302039 INFO  
(SUITE-TestFiltering-seed#[857DDB2E3F475E95]-worker) [     ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@9474e15: rootName = null, 
domain = solr.jetty, service url = null, agent id = null] for registry 
solr.jetty/com.codahale.metrics.MetricRegistry@730b2da5
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.search.TestFiltering_857DDB2E3F475E95-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene87): 
{_root_=PostingsFormat(name=Direct), 
val_s=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)), 
foo_s=FST50, id=PostingsFormat(name=Asserting)}, 
docValues:{val_i=DocValuesFormat(name=Lucene80)}, maxPointsInLeafNode=1267, 
maxMBSortInHeap=5.650230910721328, 
sim=Asserting(RandomSimilarity(queryNorm=false): {}), locale=sr, 
timezone=America/Shiprock
   [junit4]   2> NOTE: Linux 4.15.0-147-generic amd64/Oracle Corporation 
1.8.0_291 (64-bit)/cpus=4,threads=1,free=226118744,total=532152320
   [junit4]   2> NOTE: All tests run in this JVM: [TestRecovery, 
TestSolrCloudWithKerberosAlt, IndexSizeEstimatorTest, TestRebalanceLeaders, 
TestStressIncrementalBackup, TestFieldTypeResource, ClusterStateUpdateTest, 
DeleteInactiveReplicaTest, GraphQueryTest, ByteBuffersDirectoryFactoryTest, 
DateFieldTest, TestFieldCacheSortRandom, SolrIndexMetricsTest, 
TestEmbeddedSolrServerConstructors, TestOnReconnectListenerSupport, 
QueryEqualityTest, TestAuthorizationFramework, NodeMutatorTest, 
AutoscalingHistoryHandlerTest, HdfsThreadLeakTest, 
TestCursorMarkWithoutUniqueKey, ZkNodePropsTest, TestTestInjection, 
ShardTermsTest, PrimitiveFieldTypeTest, TestRandomDVFaceting, 
TestInPlaceUpdatesStandalone, SolrMetricsIntegrationTest, 
DirectoryFactoriesTest, ScheduledMaintenanceTriggerTest, TestLazyCores, 
TestJsonFacets, QueryComponentPartialResultsTest, 
DistributedFacetPivotWhiteBoxTest, DirectUpdateHandlerTest, 
BasicDistributedZk2Test, TestTolerantSearch, CleanupOldIndexTest, 
HighlighterConfigTest, HdfsBasicDistributedZkTest, TestSimExtremeIndexing, 
UninvertDocValuesMergePolicyTest, SSLMigrationTest, ZkStateWriterTest, 
AsyncCallRequestStatusResponseTest, BadComponentTest, 
TestRandomCollapseQParserPlugin, TestStressLiveNodes, TestCloudRecovery, 
URLClassifyProcessorTest, DebugComponentTest, TestNumericTerms32, 
TestPivotHelperCode, TestManagedSchemaAPI, TestInitQParser, TestBinaryField, 
TestSolr4Spatial, TestCollapseQParserPlugin, TestPseudoReturnFields, 
TestCollectionAPI, TestRemoteStreaming, ActionThrottleTest, 
DistributedQueryElevationComponentTest, OpenExchangeRatesOrgProviderTest, 
RemoteQueryErrorTest, TestStandardQParsers, MigrateRouteKeyTest, 
TestCharFilters, AnalysisErrorHandlingTest, TestSolrFieldCacheBean, 
PingRequestHandlerTest, TestCollectionAPIs, TestTrieFacet, 
CollectionsAPIAsyncDistributedZkTest, AuditLoggerIntegrationTest, 
TestSafeXMLParsing, TestCloudInspectUtil, SQLWithAuthzEnabledTest, 
SuggestComponentContextFilterQueryTest, DefaultValueUpdateProcessorTest, 
StatelessScriptUpdateProcessorFactoryTest, HttpTriggerListenerTest, 
TestPostingsSolrHighlighter, SolrCloudExampleTest, TestDistribIDF, 
HdfsRecoverLeaseTest, MetricsDisabledCloudTest, DistributedFacetPivotLargeTest, 
VMParamsZkACLAndCredentialsProvidersTest, TestDynamicFieldResource, 
TestSchemaField, TestLeaderElectionWithEmptyReplica, TestQuerySenderListener, 
SimpleMLTQParserTest, TestImplicitCoreProperties, TestSuggestSpellingConverter, 
TestCSVLoader, TestChildDocTransformer, TestManagedSynonymFilterFactory, 
V2StandaloneTest, CustomCollectionTest, DocumentAnalysisRequestHandlerTest, 
TestReplicaProperties, XMLAtomicUpdateMultivalueTest, TestTextField, 
NoCacheHeaderTest, TestTolerantUpdateProcessorRandomCloud, 
TestDownShardTolerantSearch, TestSolrIndexConfig, 
DistribJoinFromCollectionTest, AggValueSourceTest, DeleteShardTest, 
TestDocumentBuilder, TestGroupingSearch, TestLuceneMatchVersion, 
TestWordDelimiterFilterFactory, ChaosMonkeyNothingIsSafeTest, 
CollectionStateFormat2Test, CollectionsAPISolrJTest, 
LeaderElectionContextKeyTest, LeaderElectionIntegrationTest, 
LeaderVoteWaitTimeoutTest, OverseerSolrResponseTest, OverseerStatusTest, 
OverseerTest, RecoveryAfterSoftCommitTest, SaslZkACLProviderTest, 
SplitShardTest, SyncSliceTest, TestLeaderElectionZkExpiry, 
TestPullReplicaErrorHandling, TestWithCollection, AutoScalingHandlerTest, 
IndexSizeTriggerSizeEstimationTest, MetricTriggerTest, 
NodeAddedTriggerIntegrationTest, NodeLostTriggerIntegrationTest, 
NodeLostTriggerTest, TestSimClusterStateProvider, TestSimComputePlanAction, 
TestSimNodeAddedTrigger, TestSimNodeLostTrigger, TestSimScenario, TestSimUtils, 
BaseCdcrDistributedZkTest, CdcrBidirectionalTest, CdcrBootstrapTest, 
TestConfigSetProperties, TestConfigSets, TestCorePropertiesReload, 
TestInfoStreamLogging, TestMergePolicyConfig, TestShardHandlerFactory, 
TestSimpleTextCodec, TestSolrXml, TestXIncludeConfig, 
HdfsBackupRepositoryIntegrationTest, TestContainerPlugin, 
PropertiesRequestHandlerTest, SecurityConfHandlerTest, 
ShowFileRequestHandlerTest, StatsReloadRaceTest, 
DistributedSuggestComponentTest, TermVectorComponentDistributedTest, 
TestSchemaDesignerConfigSetHelper, TestLegacyField, TestLegacyFieldReuse, 
TestLegacyNumericUtils, TestLegacyTerms, TestMultiValuedNumericRangeQuery, 
TestNumericRangeQuery32, TestNumericRangeQuery64, SolrJmxReporterCloudTest, 
SolrSlf4jReporterTest, TestMacroExpander, JSONWriterTest, 
TestBinaryResponseWriter, TestGraphMLResponseWriter, TestPushWriter, 
TestRawResponseWriter, TestExplainDocTransformer, 
TestSubQueryTransformerDistrib, TestSchemaSimilarityResource, 
TestSchemaVersionResource, BooleanFieldTest, DocValuesMissingTest, 
DocValuesMultiTest, EnumFieldTest, ExternalFileFieldSortTest, 
IndexSchemaRuntimeFieldTest, IndexSchemaTest, ManagedSchemaRoundRobinCloudTest, 
SchemaVersionSpecificBehaviorTest, UUIDFieldTest, AnalyticsMergeStrategyTest, 
CursorMarkTest, QueryParsingTest, ReturnFieldsTest, SortSpecParsingTest, 
SpatialFilterTest, TestComponentsName, TestExtendedDismaxParser, TestFiltering]
   [junit4] Completed [800/947 (1!)] on J2 in 6.16s, 4 tests, 1 failure <<< 
FAILURES!

[...truncated 54711 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to