Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-Solr-Tests-8.x/3187/
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([3196D1817ED3D012:2EF572449BF4901B]: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 13579 lines...]
[junit4] Suite: org.apache.solr.search.TestFiltering
[junit4] 2> 141421 INFO
(SUITE-TestFiltering-seed#[3196D1817ED3D012]-worker) [ ] o.a.s.SolrTestCase
Setting 'solr.default.confdir' system property to test-framework derived value
of
'/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/server/solr/configsets/_default/conf'
[junit4] 2> 141421 INFO
(SUITE-TestFiltering-seed#[3196D1817ED3D012]-worker) [ ]
o.a.s.SolrTestCaseJ4 Created dataDir:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.search.TestFiltering_3196D1817ED3D012-001/data-dir-12-001
[junit4] 2> 141422 WARN
(SUITE-TestFiltering-seed#[3196D1817ED3D012]-worker) [ ]
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=9 numCloses=9
[junit4] 2> 141422 INFO
(SUITE-TestFiltering-seed#[3196D1817ED3D012]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 141424 INFO
(SUITE-TestFiltering-seed#[3196D1817ED3D012]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via:
@org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
[junit4] 2> 141424 INFO
(SUITE-TestFiltering-seed#[3196D1817ED3D012]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 141424 INFO
(SUITE-TestFiltering-seed#[3196D1817ED3D012]-worker) [ ]
o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 141431 INFO
(SUITE-TestFiltering-seed#[3196D1817ED3D012]-worker) [ ]
o.a.s.c.SolrResourceLoader Added 2 libs to classloader, from paths:
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1/lib,
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 141447 INFO
(SUITE-TestFiltering-seed#[3196D1817ED3D012]-worker) [ ] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 8.11.0
[junit4] 2> 141447 WARN
(SUITE-TestFiltering-seed#[3196D1817ED3D012]-worker) [ ] o.a.s.c.SolrConfig
solrconfig.xml: <boolTofilterOptimizer> is currently not implemented and has no
effect.
[junit4] 2> 141447 WARN
(SUITE-TestFiltering-seed#[3196D1817ED3D012]-worker) [ ] o.a.s.c.SolrConfig
solrconfig.xml: <jmx> is no longer supported, use solr.xml:/metrics/reporter
section instead
[junit4] 2> 141450 INFO
(SUITE-TestFiltering-seed#[3196D1817ED3D012]-worker) [ ]
o.a.s.s.IndexSchema Schema name=example
[junit4] 2> 141458 INFO
(SUITE-TestFiltering-seed#[3196D1817ED3D012]-worker) [ ]
o.a.s.s.IndexSchema Loaded schema example/1.6 with uniqueid field id
[junit4] 2> 142930 WARN
(SUITE-TestFiltering-seed#[3196D1817ED3D012]-worker) [ ]
o.a.s.c.CoreContainer Unable to create
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/userfiles].
Features requiring this directory may fail.
[junit4] 2> => java.security.AccessControlException: access
denied ("java.io.FilePermission"
"/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/userfiles"
"write")
[junit4] 2> at
java.security.AccessControlContext.checkPermission(AccessControlContext.java:472)
[junit4] 2> java.security.AccessControlException: access denied
("java.io.FilePermission"
"/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/userfiles"
"write")
[junit4] 2> at
java.security.AccessControlContext.checkPermission(AccessControlContext.java:472)
~[?:1.8.0_291]
[junit4] 2> at
java.security.AccessController.checkPermission(AccessController.java:886)
~[?:1.8.0_291]
[junit4] 2> at
java.lang.SecurityManager.checkPermission(SecurityManager.java:549)
~[?:1.8.0_291]
[junit4] 2> at
java.lang.SecurityManager.checkWrite(SecurityManager.java:979) ~[?:1.8.0_291]
[junit4] 2> at sun.nio.fs.UnixPath.checkWrite(UnixPath.java:801)
~[?:?]
[junit4] 2> at
sun.nio.fs.UnixFileSystemProvider.createDirectory(UnixFileSystemProvider.java:376)
~[?:?]
[junit4] 2> at java.nio.file.Files.createDirectory(Files.java:674)
~[?:1.8.0_291]
[junit4] 2> at
java.nio.file.Files.createAndCheckIsDirectory(Files.java:781) ~[?:1.8.0_291]
[junit4] 2> at
java.nio.file.Files.createDirectories(Files.java:727) ~[?:1.8.0_291]
[junit4] 2> at
org.apache.solr.core.CoreContainer.<init>(CoreContainer.java:378) [java/:?]
[junit4] 2> at
org.apache.solr.core.CoreContainer.<init>(CoreContainer.java:343) [java/:?]
[junit4] 2> at
org.apache.solr.util.TestHarness.<init>(TestHarness.java:183) [java/:?]
[junit4] 2> at
org.apache.solr.util.TestHarness.<init>(TestHarness.java:156) [java/:?]
[junit4] 2> at
org.apache.solr.util.TestHarness.<init>(TestHarness.java:162) [java/:?]
[junit4] 2> at
org.apache.solr.util.TestHarness.<init>(TestHarness.java:112) [java/:?]
[junit4] 2> at
org.apache.solr.SolrTestCaseJ4.createCore(SolrTestCaseJ4.java:813) [java/:?]
[junit4] 2> at
org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:803) [java/:?]
[junit4] 2> at
org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:664) [java/:?]
[junit4] 2> at
org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:653) [java/:?]
[junit4] 2> at
org.apache.solr.search.TestFiltering.beforeTests(TestFiltering.java:45)
[test/:?]
[junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native
Method) ~[?:1.8.0_291]
[junit4] 2> at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
~[?:1.8.0_291]
[junit4] 2> at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
~[?:1.8.0_291]
[junit4] 2> at java.lang.reflect.Method.invoke(Method.java:498)
~[?:1.8.0_291]
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:878)
[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at org.junit.rules.RunRules.evaluate(RunRules.java:20)
[junit-4.13.1.jar:4.13.1]
[junit4] 2> at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[java/:?]
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
[java/:?]
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
[java/:?]
[junit4] 2> at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
[java/:?]
[junit4] 2> at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
[java/:?]
[junit4] 2> at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
[java/:?]
[junit4] 2> at org.junit.rules.RunRules.evaluate(RunRules.java:20)
[junit-4.13.1.jar:4.13.1]
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at java.lang.Thread.run(Thread.java:748) [?:1.8.0_291]
[junit4] 2> 142931 WARN
(SUITE-TestFiltering-seed#[3196D1817ED3D012]-worker) [ ]
o.a.s.f.DistribPackageStore Unable to create
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/filestore]
directory in SOLR_HOME
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr].
Features requiring this directory may fail.
[junit4] 2> => java.security.AccessControlException: access
denied ("java.io.FilePermission"
"/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/filestore"
"write")
[junit4] 2> at
java.security.AccessControlContext.checkPermission(AccessControlContext.java:472)
[junit4] 2> java.security.AccessControlException: access denied
("java.io.FilePermission"
"/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/filestore"
"write")
[junit4] 2> at
java.security.AccessControlContext.checkPermission(AccessControlContext.java:472)
~[?:1.8.0_291]
[junit4] 2> at
java.security.AccessController.checkPermission(AccessController.java:886)
~[?:1.8.0_291]
[junit4] 2> at
java.lang.SecurityManager.checkPermission(SecurityManager.java:549)
~[?:1.8.0_291]
[junit4] 2> at
java.lang.SecurityManager.checkWrite(SecurityManager.java:979) ~[?:1.8.0_291]
[junit4] 2> at java.io.File.mkdir(File.java:1348) ~[?:1.8.0_291]
[junit4] 2> at java.io.File.mkdirs(File.java:1380) ~[?:1.8.0_291]
[junit4] 2> at
org.apache.solr.filestore.DistribPackageStore.ensurePackageStoreDir(DistribPackageStore.java:561)
[java/:?]
[junit4] 2> at
org.apache.solr.filestore.DistribPackageStore.<init>(DistribPackageStore.java:81)
[java/:?]
[junit4] 2> at
org.apache.solr.filestore.PackageStoreAPI.<init>(PackageStoreAPI.java:78)
[java/:?]
[junit4] 2> at
org.apache.solr.core.CoreContainer.load(CoreContainer.java:679) [java/:?]
[junit4] 2> at
org.apache.solr.util.TestHarness.<init>(TestHarness.java:184) [java/:?]
[junit4] 2> at
org.apache.solr.util.TestHarness.<init>(TestHarness.java:156) [java/:?]
[junit4] 2> at
org.apache.solr.util.TestHarness.<init>(TestHarness.java:162) [java/:?]
[junit4] 2> at
org.apache.solr.util.TestHarness.<init>(TestHarness.java:112) [java/:?]
[junit4] 2> at
org.apache.solr.SolrTestCaseJ4.createCore(SolrTestCaseJ4.java:813) [java/:?]
[junit4] 2> at
org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:803) [java/:?]
[junit4] 2> at
org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:664) [java/:?]
[junit4] 2> at
org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:653) [java/:?]
[junit4] 2> at
org.apache.solr.search.TestFiltering.beforeTests(TestFiltering.java:45)
[test/:?]
[junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native
Method) ~[?:1.8.0_291]
[junit4] 2> at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
~[?:1.8.0_291]
[junit4] 2> at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
~[?:1.8.0_291]
[junit4] 2> at java.lang.reflect.Method.invoke(Method.java:498)
~[?:1.8.0_291]
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:878)
[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at org.junit.rules.RunRules.evaluate(RunRules.java:20)
[junit-4.13.1.jar:4.13.1]
[junit4] 2> at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[java/:?]
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
[java/:?]
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
[java/:?]
[junit4] 2> at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
[java/:?]
[junit4] 2> at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
[java/:?]
[junit4] 2> at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
[java/:?]
[junit4] 2> at org.junit.rules.RunRules.evaluate(RunRules.java:20)
[junit-4.13.1.jar:4.13.1]
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at java.lang.Thread.run(Thread.java:748) [?:1.8.0_291]
[junit4] 2> 142933 INFO
(SUITE-TestFiltering-seed#[3196D1817ED3D012]-worker) [ ]
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 142933 WARN
(SUITE-TestFiltering-seed#[3196D1817ED3D012]-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> 142940 WARN
(SUITE-TestFiltering-seed#[3196D1817ED3D012]-worker) [ ] o.e.j.u.s.S.config
Trusting all certificates configured for
Client@3d6f6df5[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 142940 WARN
(SUITE-TestFiltering-seed#[3196D1817ED3D012]-worker) [ ] o.e.j.u.s.S.config
No Client EndPointIdentificationAlgorithm configured for
Client@3d6f6df5[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 142944 WARN
(SUITE-TestFiltering-seed#[3196D1817ED3D012]-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> 143000 WARN
(SUITE-TestFiltering-seed#[3196D1817ED3D012]-worker) [ ] o.e.j.u.s.S.config
Trusting all certificates configured for
Client@32a00a6f[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 143000 WARN
(SUITE-TestFiltering-seed#[3196D1817ED3D012]-worker) [ ] o.e.j.u.s.S.config
No Client EndPointIdentificationAlgorithm configured for
Client@32a00a6f[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 143001 WARN
(SUITE-TestFiltering-seed#[3196D1817ED3D012]-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> 143032 INFO
(SUITE-TestFiltering-seed#[3196D1817ED3D012]-worker) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3ff39a66
[junit4] 2> 143039 INFO
(SUITE-TestFiltering-seed#[3196D1817ED3D012]-worker) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3ff39a66
[junit4] 2> 143039 INFO
(SUITE-TestFiltering-seed#[3196D1817ED3D012]-worker) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3ff39a66
[junit4] 2> 143040 INFO (coreLoadExecutor-930-thread-1) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient core cache for max
2147483647 cores with initial capacity of 1024
[junit4] 2> 143049 INFO (coreLoadExecutor-930-thread-1) [
x:collection1 ] o.a.s.c.SolrResourceLoader Added 2 libs to classloader, from
paths:
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1/lib,
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 143079 INFO (coreLoadExecutor-930-thread-1) [
x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.11.0
[junit4] 2> 143079 WARN (coreLoadExecutor-930-thread-1) [
x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <boolTofilterOptimizer> is
currently not implemented and has no effect.
[junit4] 2> 143080 WARN (coreLoadExecutor-930-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> 143082 INFO (coreLoadExecutor-930-thread-1) [
x:collection1 ] o.a.s.s.IndexSchema Schema name=example
[junit4] 2> 143092 INFO (coreLoadExecutor-930-thread-1) [
x:collection1 ] o.a.s.s.IndexSchema Loaded schema example/1.6 with uniqueid
field id
[junit4] 2> 143101 INFO (coreLoadExecutor-930-thread-1) [
x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using
configuration from instancedir
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1,
trusted=true
[junit4] 2> 143102 INFO (coreLoadExecutor-930-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@3ff39a66
[junit4] 2> 143102 INFO (coreLoadExecutor-930-thread-1) [
x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1],
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.search.TestFiltering_3196D1817ED3D012-001/data-dir-12-001/]
[junit4] 2> 143103 INFO (coreLoadExecutor-930-thread-1) [
x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=26, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.0]
[junit4] 2> 143163 INFO (coreLoadExecutor-930-thread-1) [
x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 143163 INFO (coreLoadExecutor-930-thread-1) [
x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 143164 INFO (coreLoadExecutor-930-thread-1) [
x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=37, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=1.0]
[junit4] 2> 143166 INFO (coreLoadExecutor-930-thread-1) [
x:collection1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 143174 INFO (coreLoadExecutor-930-thread-1) [
x:collection1 ] o.a.s.s.DirectSolrSpellChecker init:
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 143198 INFO (coreLoadExecutor-930-thread-1) [
x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 143200 INFO
(searcherExecutor-932-thread-1-processing-x:collection1) [ x:collection1 ]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 143200 INFO
(searcherExecutor-932-thread-1-processing-x:collection1) [ x:collection1 ]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 143200 INFO
(searcherExecutor-932-thread-1-processing-x:collection1) [ x:collection1 ]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 143200 INFO
(searcherExecutor-932-thread-1-processing-x:collection1) [ x:collection1 ]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker:
multipleFields
[junit4] 2> 143200 INFO
(searcherExecutor-932-thread-1-processing-x:collection1) [ x:collection1 ]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 143200 INFO
(searcherExecutor-932-thread-1-processing-x:collection1) [ x:collection1 ]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 143200 INFO
(searcherExecutor-932-thread-1-processing-x:collection1) [ x:collection1 ]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 143200 INFO
(SUITE-TestFiltering-seed#[3196D1817ED3D012]-worker) [ ]
o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 143200 INFO
(searcherExecutor-932-thread-1-processing-x:collection1) [ x:collection1 ]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 143201 INFO
(searcherExecutor-932-thread-1-processing-x:collection1) [ x:collection1 ]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 143202 INFO
(searcherExecutor-932-thread-1-processing-x:collection1) [ x:collection1 ]
o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 143206 INFO
(TEST-TestFiltering.testHossssSanity-seed#[3196D1817ED3D012]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testHossssSanity
[junit4] 2> 143206 INFO
(TEST-TestFiltering.testHossssSanity-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 143206 INFO
(TEST-TestFiltering.testHossssSanity-seed#[3196D1817ED3D012]) [ ]
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> 143207 INFO
(TEST-TestFiltering.testHossssSanity-seed#[3196D1817ED3D012]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[0]} 0 0
[junit4] 2> 143210 INFO
(TEST-TestFiltering.testHossssSanity-seed#[3196D1817ED3D012]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[1]} 0 0
[junit4] 2> 143210 INFO
(TEST-TestFiltering.testHossssSanity-seed#[3196D1817ED3D012]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[2]} 0 0
[junit4] 2> 143210 INFO
(TEST-TestFiltering.testHossssSanity-seed#[3196D1817ED3D012]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[3]} 0 0
[junit4] 2> 143210 INFO
(TEST-TestFiltering.testHossssSanity-seed#[3196D1817ED3D012]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[4]} 0 0
[junit4] 2> 143211 INFO
(TEST-TestFiltering.testHossssSanity-seed#[3196D1817ED3D012]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[5]} 0 0
[junit4] 2> 143211 INFO
(TEST-TestFiltering.testHossssSanity-seed#[3196D1817ED3D012]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[6]} 0 0
[junit4] 2> 143211 INFO
(TEST-TestFiltering.testHossssSanity-seed#[3196D1817ED3D012]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[7]} 0 0
[junit4] 2> 143211 INFO
(TEST-TestFiltering.testHossssSanity-seed#[3196D1817ED3D012]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[8]} 0 0
[junit4] 2> 143211 INFO
(TEST-TestFiltering.testHossssSanity-seed#[3196D1817ED3D012]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[9]} 0 0
[junit4] 2> 143221 INFO
(searcherExecutor-932-thread-1-processing-x:collection1) [ x:collection1 ]
o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 143222 INFO
(TEST-TestFiltering.testHossssSanity-seed#[3196D1817ED3D012]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{commit=} 0 9
[junit4] 2> 143222 INFO
(TEST-TestFiltering.testHossssSanity-seed#[3196D1817ED3D012]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&wt=xml}
hits=10 status=0 QTime=0
[junit4] 2> 143234 INFO
(TEST-TestFiltering.testHossssSanity-seed#[3196D1817ED3D012]) [ ]
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=9
[junit4] 2> 143235 INFO
(TEST-TestFiltering.testHossssSanity-seed#[3196D1817ED3D012]) [ ]
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> 143235 INFO
(TEST-TestFiltering.testHossssSanity-seed#[3196D1817ED3D012]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{commit=} 0 0
[junit4] 2> 143236 INFO
(TEST-TestFiltering.testHossssSanity-seed#[3196D1817ED3D012]) [ ]
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> 143236 INFO
(TEST-TestFiltering.testHossssSanity-seed#[3196D1817ED3D012]) [ ]
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> 143237 INFO
(TEST-TestFiltering.testHossssSanity-seed#[3196D1817ED3D012]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending testHossssSanity
[junit4] 2> 143241 INFO
(TEST-TestFiltering.testLiveDocsSharing-seed#[3196D1817ED3D012]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testLiveDocsSharing
[junit4] 2> 143241 INFO
(TEST-TestFiltering.testLiveDocsSharing-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 143241 INFO
(TEST-TestFiltering.testLiveDocsSharing-seed#[3196D1817ED3D012]) [ ]
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> 143241 INFO
(TEST-TestFiltering.testLiveDocsSharing-seed#[3196D1817ED3D012]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[0]} 0 0
[junit4] 2> 143242 INFO
(TEST-TestFiltering.testLiveDocsSharing-seed#[3196D1817ED3D012]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[0]} 0 0
[junit4] 2> 143242 INFO
(TEST-TestFiltering.testLiveDocsSharing-seed#[3196D1817ED3D012]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[1]} 0 0
[junit4] 2> 143242 INFO
(TEST-TestFiltering.testLiveDocsSharing-seed#[3196D1817ED3D012]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[2]} 0 0
[junit4] 2> 143242 INFO
(TEST-TestFiltering.testLiveDocsSharing-seed#[3196D1817ED3D012]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[3]} 0 0
[junit4] 2> 143242 INFO
(TEST-TestFiltering.testLiveDocsSharing-seed#[3196D1817ED3D012]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[4]} 0 0
[junit4] 2> 143243 INFO
(TEST-TestFiltering.testLiveDocsSharing-seed#[3196D1817ED3D012]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[5]} 0 0
[junit4] 2> 143243 INFO
(TEST-TestFiltering.testLiveDocsSharing-seed#[3196D1817ED3D012]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[5]} 0 0
[junit4] 2> 143243 INFO
(TEST-TestFiltering.testLiveDocsSharing-seed#[3196D1817ED3D012]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[6]} 0 0
[junit4] 2> 143243 INFO
(TEST-TestFiltering.testLiveDocsSharing-seed#[3196D1817ED3D012]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[7]} 0 0
[junit4] 2> 143244 INFO
(TEST-TestFiltering.testLiveDocsSharing-seed#[3196D1817ED3D012]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[8]} 0 0
[junit4] 2> 143244 INFO
(TEST-TestFiltering.testLiveDocsSharing-seed#[3196D1817ED3D012]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[9]} 0 0
[junit4] 2> 143244 INFO
(TEST-TestFiltering.testLiveDocsSharing-seed#[3196D1817ED3D012]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[10]} 0 0
[junit4] 2> 143244 INFO
(TEST-TestFiltering.testLiveDocsSharing-seed#[3196D1817ED3D012]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[10]} 0 0
[junit4] 2> 143245 INFO
(TEST-TestFiltering.testLiveDocsSharing-seed#[3196D1817ED3D012]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[11]} 0 0
[junit4] 2> 143245 INFO
(TEST-TestFiltering.testLiveDocsSharing-seed#[3196D1817ED3D012]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[12]} 0 0
[junit4] 2> 143245 INFO
(TEST-TestFiltering.testLiveDocsSharing-seed#[3196D1817ED3D012]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[13]} 0 0
[junit4] 2> 143245 INFO
(TEST-TestFiltering.testLiveDocsSharing-seed#[3196D1817ED3D012]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[14]} 0 0
[junit4] 2> 143246 INFO
(TEST-TestFiltering.testLiveDocsSharing-seed#[3196D1817ED3D012]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[15]} 0 0
[junit4] 2> 143246 INFO
(TEST-TestFiltering.testLiveDocsSharing-seed#[3196D1817ED3D012]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[15]} 0 0
[junit4] 2> 143246 INFO
(TEST-TestFiltering.testLiveDocsSharing-seed#[3196D1817ED3D012]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[16]} 0 0
[junit4] 2> 143246 INFO
(TEST-TestFiltering.testLiveDocsSharing-seed#[3196D1817ED3D012]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[17]} 0 0
[junit4] 2> 143246 INFO
(TEST-TestFiltering.testLiveDocsSharing-seed#[3196D1817ED3D012]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[18]} 0 0
[junit4] 2> 143247 INFO
(TEST-TestFiltering.testLiveDocsSharing-seed#[3196D1817ED3D012]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[19]} 0 0
[junit4] 2> 143262 INFO
(searcherExecutor-932-thread-1-processing-x:collection1) [ x:collection1 ]
o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 143263 INFO
(TEST-TestFiltering.testLiveDocsSharing-seed#[3196D1817ED3D012]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{commit=} 0 16
[junit4] 2> 143282 INFO
(TEST-TestFiltering.testLiveDocsSharing-seed#[3196D1817ED3D012]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending testLiveDocsSharing
[junit4] 2> 143285 INFO
(TEST-TestFiltering.testCaching-seed#[3196D1817ED3D012]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testCaching
[junit4] 2> 143285 INFO
(TEST-TestFiltering.testCaching-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 143286 INFO
(TEST-TestFiltering.testCaching-seed#[3196D1817ED3D012]) [ ]
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> 143286 INFO
(TEST-TestFiltering.testCaching-seed#[3196D1817ED3D012]) [ x:collection1 ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{add=[4]} 0 0
[junit4] 2> 143286 INFO
(TEST-TestFiltering.testCaching-seed#[3196D1817ED3D012]) [ x:collection1 ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{add=[1]} 0 0
[junit4] 2> 143286 INFO
(TEST-TestFiltering.testCaching-seed#[3196D1817ED3D012]) [ x:collection1 ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{add=[3]} 0 0
[junit4] 2> 143287 INFO
(TEST-TestFiltering.testCaching-seed#[3196D1817ED3D012]) [ x:collection1 ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{add=[2]} 0 0
[junit4] 2> 143293 INFO
(searcherExecutor-932-thread-1-processing-x:collection1) [ x:collection1 ]
o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 143295 INFO
(TEST-TestFiltering.testCaching-seed#[3196D1817ED3D012]) [ x:collection1 ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{commit=} 0 7
[junit4] 2> 143296 INFO
(TEST-TestFiltering.testCaching-seed#[3196D1817ED3D012]) [ ]
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> 143296 INFO
(TEST-TestFiltering.testCaching-seed#[3196D1817ED3D012]) [ ]
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> 143297 INFO
(TEST-TestFiltering.testCaching-seed#[3196D1817ED3D012]) [ ]
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> 143297 INFO
(TEST-TestFiltering.testCaching-seed#[3196D1817ED3D012]) [ ]
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> 143297 INFO
(TEST-TestFiltering.testCaching-seed#[3196D1817ED3D012]) [ ]
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> 143300 INFO
(TEST-TestFiltering.testCaching-seed#[3196D1817ED3D012]) [ ]
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=2
[junit4] 2> 143310 INFO
(TEST-TestFiltering.testCaching-seed#[3196D1817ED3D012]) [ ]
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=10
[junit4] 2> 143311 INFO
(TEST-TestFiltering.testCaching-seed#[3196D1817ED3D012]) [ ]
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> 143311 INFO
(TEST-TestFiltering.testCaching-seed#[3196D1817ED3D012]) [ ]
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> 143311 INFO
(TEST-TestFiltering.testCaching-seed#[3196D1817ED3D012]) [ ]
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> 143312 INFO
(TEST-TestFiltering.testCaching-seed#[3196D1817ED3D012]) [ ]
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> 143312 INFO
(TEST-TestFiltering.testCaching-seed#[3196D1817ED3D012]) [ ]
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> 143313 INFO
(TEST-TestFiltering.testCaching-seed#[3196D1817ED3D012]) [ ]
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> 143313 INFO
(TEST-TestFiltering.testCaching-seed#[3196D1817ED3D012]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending testCaching
[junit4] 2> 143317 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testRandomFiltering
[junit4] 2> 143317 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 143317 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
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> 143318 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[0]} 0 0
[junit4] 2> 143318 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[1]} 0 0
[junit4] 2> 143318 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[2]} 0 0
[junit4] 2> 143318 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[3]} 0 0
[junit4] 2> 143318 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[3]} 0 0
[junit4] 2> 143318 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[4]} 0 0
[junit4] 2> 143319 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[5]} 0 0
[junit4] 2> 143319 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[6]} 0 0
[junit4] 2> 143319 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[7]} 0 0
[junit4] 2> 143319 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[8]} 0 0
[junit4] 2> 143319 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[9]} 0 0
[junit4] 2> 143319 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[9]} 0 0
[junit4] 2> 143319 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[10]} 0 0
[junit4] 2> 143319 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[10]} 0 0
[junit4] 2> 143319 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[11]} 0 0
[junit4] 2> 143319 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[12]} 0 0
[junit4] 2> 143319 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[13]} 0 0
[junit4] 2> 143320 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[14]} 0 0
[junit4] 2> 143320 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[15]} 0 0
[junit4] 2> 143320 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[16]} 0 0
[junit4] 2> 143320 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[17]} 0 0
[junit4] 2> 143320 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[18]} 0 0
[junit4] 2> 143320 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[19]} 0 0
[junit4] 2> 143320 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[20]} 0 0
[junit4] 2> 143320 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[21]} 0 0
[junit4] 2> 143320 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[21]} 0 0
[junit4] 2> 143320 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[22]} 0 0
[junit4] 2> 143321 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[23]} 0 0
[junit4] 2> 143321 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[24]} 0 0
[junit4] 2> 143321 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[24]} 0 0
[junit4] 2> 143321 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[25]} 0 0
[junit4] 2> 143321 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[26]} 0 0
[junit4] 2> 143321 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[26]} 0 0
[junit4] 2> 143321 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[27]} 0 0
[junit4] 2> 143321 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[28]} 0 0
[junit4] 2> 143321 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[29]} 0 0
[junit4] 2> 143321 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[30]} 0 0
[junit4] 2> 143321 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[30]} 0 0
[junit4] 2> 143328 INFO
(searcherExecutor-932-thread-1-processing-x:collection1) [ x:collection1 ]
o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 143329 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{commit=} 0 7
[junit4] 2> 143330 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[31]} 0 0
[junit4] 2> 143330 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[32]} 0 0
[junit4] 2> 143330 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[33]} 0 0
[junit4] 2> 143330 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[34]} 0 0
[junit4] 2> 143330 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[35]} 0 0
[junit4] 2> 143330 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[36]} 0 0
[junit4] 2> 143330 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[37]} 0 0
[junit4] 2> 143330 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[38]} 0 0
[junit4] 2> 143331 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[38]} 0 0
[junit4] 2> 143331 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[39]} 0 0
[junit4] 2> 143331 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[40]} 0 0
[junit4] 2> 143331 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[41]} 0 0
[junit4] 2> 143337 INFO
(searcherExecutor-932-thread-1-processing-x:collection1) [ x:collection1 ]
o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 143337 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{commit=} 0 6
[junit4] 2> 143338 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[42]} 0 0
[junit4] 2> 143338 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[42]} 0 0
[junit4] 2> 143338 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[43]} 0 0
[junit4] 2> 143338 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[44]} 0 0
[junit4] 2> 143338 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[44]} 0 0
[junit4] 2> 143338 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[45]} 0 0
[junit4] 2> 143338 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[46]} 0 0
[junit4] 2> 143339 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[47]} 0 0
[junit4] 2> 143339 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[48]} 0 0
[junit4] 2> 143345 INFO
(searcherExecutor-932-thread-1-processing-x:collection1) [ x:collection1 ]
o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 143345 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{commit=} 0 6
[junit4] 2> 143346 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[49]} 0 0
[junit4] 2> 143346 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[50]} 0 0
[junit4] 2> 143346 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[50]} 0 0
[junit4] 2> 143346 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[51]} 0 0
[junit4] 2> 143346 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[52]} 0 0
[junit4] 2> 143346 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[53]} 0 0
[junit4] 2> 143346 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[54]} 0 0
[junit4] 2> 143346 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[55]} 0 0
[junit4] 2> 143347 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[56]} 0 0
[junit4] 2> 143347 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[57]} 0 0
[junit4] 2> 143353 INFO
(searcherExecutor-932-thread-1-processing-x:collection1) [ x:collection1 ]
o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 143353 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{commit=} 0 6
[junit4] 2> 143354 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[58]} 0 0
[junit4] 2> 143354 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[58]} 0 0
[junit4] 2> 143354 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[59]} 0 0
[junit4] 2> 143354 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[59]} 0 0
[junit4] 2> 143354 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[60]} 0 0
[junit4] 2> 143354 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[61]} 0 0
[junit4] 2> 143354 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[62]} 0 0
[junit4] 2> 143354 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[63]} 0 0
[junit4] 2> 143355 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[64]} 0 0
[junit4] 2> 143355 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[64]} 0 0
[junit4] 2> 143355 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[65]} 0 0
[junit4] 2> 143355 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[66]} 0 0
[junit4] 2> 143355 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[67]} 0 0
[junit4] 2> 143355 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[68]} 0 0
[junit4] 2> 143355 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[68]} 0 0
[junit4] 2> 143355 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[69]} 0 0
[junit4] 2> 143355 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[69]} 0 0
[junit4] 2> 143355 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[70]} 0 0
[junit4] 2> 143355 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[71]} 0 0
[junit4] 2> 143356 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[71]} 0 0
[junit4] 2> 143356 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[72]} 0 0
[junit4] 2> 143356 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[72]} 0 0
[junit4] 2> 143356 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[73]} 0 0
[junit4] 2> 143356 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={wt=json&indent=true}{add=[73]} 0 0
[junit4] 2> 143364 INFO
(searcherExecutor-932-thread-1-processing-x:collection1) [ x:collection1 ]
o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 2 ms
[junit4] 2> 143365 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{commit=} 0 8
[junit4] 2> 143365 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&wt=xml}
hits=74 status=0 QTime=0
[junit4] 2> 143385 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q={!+cost%3D191+tag%3Dt}val_s:{00067+TO+00093]+AND+val_s:[00068+TO+00094}&fq={!cache%3Dtrue}+-val_i:1+-val_i:7+-val_i:8+-val_i:14+-val_i:15+-val_i:16+-val_i:18+-val_i:19+-val_i:22+-val_i:23+-val_i:27+-val_i:29+-val_i:33+-val_i:34+-val_i:35+-val_i:36+-val_i:37+-val_i:39+-val_i:41+-val_i:42+-val_i:43+-val_i:44+-val_i:45+-val_i:46+-val_i:49+-val_i:53+-val_i:54+-val_i:57+-val_i:58+-val_i:59+-val_i:61+-val_i:64+-val_i:65+-val_i:66+-val_i:70+-val_i:72+-val_i:73&wt=xml}
hits=3 status=0 QTime=19
[junit4] 2> 143391 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
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%3D72+u%3D111}&q={!frange+v%3Dval_i+l%3D16+u%3D68+cache%3Dtrue+tag%3Dt}&fq={!cache%3Dfalse}+val_i:0+val_i:2+val_i:3+val_i:4+val_i:5+val_i:9+val_i:10+val_i:11+val_i:12+val_i:13+val_i:15+val_i:16+val_i:17+val_i:19+val_i:21+val_i:22+val_i:26+val_i:28+val_i:29+val_i:30+val_i:31+val_i:34+val_i:36+val_i:41+val_i:42+val_i:44+val_i:48+val_i:49+val_i:52+val_i:55+val_i:57+val_i:64+val_i:65+val_i:66+val_i:67+val_i:68+val_i:71+val_i:72&fq={!+cache%3Dfalse+cost%3D9+tag%3Dt}-_query_:"val_i:[00038+TO+00073]"&fq={!+cache%3Dfalse}val_i:[00050+TO+00090}&facet=true&wt=xml}
hits=0 status=0 QTime=5
[junit4] 2> 143399 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery}+-val_i:1+-val_i:6+-val_i:7+-val_i:8+-val_i:9+-val_i:12+-val_i:13+-val_i:14+-val_i:16+-val_i:17+-val_i:18+-val_i:19+-val_i:20+-val_i:21+-val_i:23+-val_i:25+-val_i:28+-val_i:30+-val_i:31+-val_i:32+-val_i:34+-val_i:37+-val_i:38+-val_i:40+-val_i:42+-val_i:49+-val_i:51+-val_i:53+-val_i:55+-val_i:56+-val_i:57+-val_i:58+-val_i:62+-val_i:63+-val_i:64+-val_i:66+-val_i:67+-val_i:70+-val_i:72&q=val_i:{00014+TO+00045}+OR+id:RAND-2059607809&fq={!cache%3Dfalse+cost%3D194}+-val_i:1+-val_i:4+-val_i:7+-val_i:8+-val_i:12+-val_i:13+-val_i:14+-val_i:15+-val_i:19+-val_i:20+-val_i:21+-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:37+-val_i:39+-val_i:40+-val_i:42+-val_i:43+-val_i:44+-val_i:45+-val_i:46+-val_i:47+-val_i:51+-val_i:54+-val_i:56+-val_i:57+-val_i:60+-val_i:63+-val_i:66+-val_i:69+-val_i:71&fq={!frange+v%3Dval_i+l%3D62+u%3D114+cache%3Dtrue+tag%3Dt}&fq={!cache%3Dfalse+tag%3Dt}+val_i:0+val_i:2+val_i:4+val_i:6+val_i:7+val_i:11+val_i:13+val_i:14+val_i:15+val_i:16+val_i:19+val_i:22+val_i:23+val_i:24+val_i:25+val_i:26+val_i:27+val_i:32+val_i:38+val_i:42+val_i:43+val_i:49+val_i:51+val_i:55+val_i:58+val_i:62+val_i:63+val_i:64+val_i:65+val_i:66+val_i:69+val_i:71+val_i:72+val_i:73&fq={!+cache%3Dtrue+tag%3Dt}-_query_:"val_i:{00040+TO+00073]"&facet=true&wt=xml}
hits=0 status=0 QTime=7
[junit4] 2> 143402 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q={!cache%3Dfalse}+val_i:0+val_i:1+val_i:5+val_i:6+val_i:7+val_i:10+val_i:11+val_i:12+val_i:15+val_i:17+val_i:20+val_i:24+val_i:29+val_i:31+val_i:32+val_i:33+val_i:37+val_i:40+val_i:44+val_i:47+val_i:48+val_i:52+val_i:53+val_i:54+val_i:55+val_i:58+val_i:59+val_i:63+val_i:69+val_i:71+val_i:72&fq={!cache%3Dfalse+cost%3D76+tag%3Dt}+val_i:0+val_i:3+val_i:7+val_i:10+val_i:11+val_i:13+val_i:14+val_i:15+val_i:16+val_i:20+val_i:21+val_i:22+val_i:23+val_i:24+val_i:25+val_i:28+val_i:30+val_i:32+val_i:35+val_i:37+val_i:40+val_i:43+val_i:45+val_i:46+val_i:50+val_i:51+val_i:52+val_i:54+val_i:55+val_i:56+val_i:57+val_i:59+val_i:60+val_i:61+val_i:62+val_i:63+val_i:64+val_i:65+val_i:68+val_i:71&fq=-_query_:"val_i:[00000+TO+00073]"&wt=xml}
hits=0 status=0 QTime=3
[junit4] 2> 143408 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
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%3D31}+val_i:1+val_i:2+val_i:6+val_i:8+val_i:10+val_i:12+val_i:13+val_i:18+val_i:19+val_i:21+val_i:23+val_i:28+val_i:29+val_i:33+val_i:34+val_i:37+val_i:40+val_i:46+val_i:47+val_i:48+val_i:50+val_i:51+val_i:52+val_i:53+val_i:58+val_i:60+val_i:61+val_i:62+val_i:63+val_i:65+val_i:70+val_i:71+val_i:73&q={!+cache%3Dfalse+cost%3D104}-_query_:"val_s:[00023+TO+00073]"&fq={!+cost%3D9+tag%3Dt}val_i:{00045+TO+00092}+AND+val_i:[00046+TO+00091]&fq={!frange+v%3Dval_i+l%3D54+u%3D98}&fq={!+cache%3Dtrue+tag%3Dt}-_query_:"val_i:[00044+TO+00073]"&fq={!cache%3Dfalse}+-val_i:3+-val_i:7+-val_i:13+-val_i:15+-val_i:17+-val_i:18+-val_i:25+-val_i:26+-val_i:27+-val_i:31+-val_i:36+-val_i:38+-val_i:39+-val_i:40+-val_i:42+-val_i:43+-val_i:44+-val_i:46+-val_i:48+-val_i:49+-val_i:51+-val_i:52+-val_i:53+-val_i:54+-val_i:57+-val_i:58+-val_i:59+-val_i:63+-val_i:65+-val_i:67+-val_i:72&facet=true&wt=xml}
hits=0 status=0 QTime=5
[junit4] 2> 143409 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q={!frange+v%3Dval_i+l%3D56+u%3D110+cost%3D146}&fq={!+cost%3D57+tag%3Dt}-_query_:"val_s:[00056+TO+00073]"&fq={!+cache%3Dfalse}val_s:[00044+TO+00067]+OR+id:RAND1772049501&wt=xml}
hits=0 status=0 QTime=1
[junit4] 2> 143427 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery}-_query_:"val_s:[00029+TO+00073]"&q={!cache%3Dfalse+cost%3D22}+-val_i:0+-val_i:2+-val_i:3+-val_i:4+-val_i:5+-val_i:7+-val_i:9+-val_i:10+-val_i:12+-val_i:15+-val_i:16+-val_i:17+-val_i:18+-val_i:19+-val_i:20+-val_i:24+-val_i:27+-val_i:29+-val_i:30+-val_i:33+-val_i:36+-val_i:39+-val_i:41+-val_i:42+-val_i:44+-val_i:45+-val_i:46+-val_i:48+-val_i:49+-val_i:51+-val_i:53+-val_i:55+-val_i:57+-val_i:59+-val_i:61+-val_i:64+-val_i:68+-val_i:70+-val_i:72+-val_i:73&fq={!cache%3Dfalse+tag%3Dt}+val_i:3+val_i:5+val_i:9+val_i:10+val_i:11+val_i:12+val_i:13+val_i:14+val_i:15+val_i:16+val_i:18+val_i:20+val_i:22+val_i:23+val_i:25+val_i:27+val_i:33+val_i:36+val_i:41+val_i:42+val_i:48+val_i:51+val_i:52+val_i:53+val_i:57+val_i:60+val_i:63+val_i:68&fq={!cache%3Dfalse+cost%3D174}+-val_i:0+-val_i:3+-val_i:4+-val_i:5+-val_i:8+-val_i:9+-val_i:10+-val_i:11+-val_i:17+-val_i:18+-val_i:20+-val_i:24+-val_i:26+-val_i:28+-val_i:30+-val_i:31+-val_i:32+-val_i:33+-val_i:39+-val_i:40+-val_i:41+-val_i:42+-val_i:45+-val_i:48+-val_i:49+-val_i:50+-val_i:54+-val_i:55+-val_i:56+-val_i:59+-val_i:60+-val_i:62+-val_i:63+-val_i:64+-val_i:72&fq={!+cache%3Dtrue+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D2+u%3D73}"&fq={!cache%3Dfalse+tag%3Dt}+val_i:0+val_i:3+val_i:4+val_i:8+val_i:9+val_i:11+val_i:13+val_i:14+val_i:15+val_i:16+val_i:17+val_i:19+val_i:22+val_i:26+val_i:31+val_i:32+val_i:33+val_i:34+val_i:37+val_i:39+val_i:42+val_i:46+val_i:47+val_i:49+val_i:50+val_i:51+val_i:53+val_i:54+val_i:56+val_i:57+val_i:60+val_i:62+val_i:63+val_i:64+val_i:65+val_i:66+val_i:67+val_i:68+val_i:69+val_i:70+val_i:71+val_i:73&facet=true&wt=xml}
hits=0 status=0 QTime=17
[junit4] 2> 143428 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q={!frange+v%3Dval_i+l%3D19+u%3D58+cache%3Dfalse+cost%3D193+tag%3Dt}&fq={!frange+v%3Dval_i+l%3D41+u%3D90+tag%3Dt}&wt=xml}
hits=18 status=0 QTime=0
[junit4] 2> 143431 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q={!+cache%3Dfalse+cost%3D188+tag%3Dt}val_s:[00027+TO+00087]+OR+val_s:{00026+TO+00088}&fq={!cache%3Dfalse+cost%3D189+tag%3Dt}+val_i:0+val_i:1+val_i:3+val_i:5+val_i:8+val_i:9+val_i:11+val_i:13+val_i:14+val_i:15+val_i:20+val_i:24+val_i:26+val_i:27+val_i:29+val_i:30+val_i:34+val_i:35+val_i:38+val_i:40+val_i:41+val_i:42+val_i:43+val_i:44+val_i:46+val_i:48+val_i:50+val_i:52+val_i:53+val_i:55+val_i:56+val_i:57+val_i:61+val_i:62+val_i:63+val_i:64+val_i:67+val_i:68+val_i:69+val_i:73&fq=val_s:[00031+TO+00096}&wt=xml}
hits=24 status=0 QTime=2
[junit4] 2> 143432 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q={!+cache%3Dtrue+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D9+u%3D73}"&fq={!+cost%3D25}val_s:{00064+TO+00096]+OR+val_s:[00065+TO+00097}&wt=xml}
hits=0 status=0 QTime=0
[junit4] 2> 143435 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery+cache%3Dfalse}+-val_i:1+-val_i:3+-val_i:4+-val_i:5+-val_i:6+-val_i:7+-val_i:10+-val_i:11+-val_i:12+-val_i:14+-val_i:15+-val_i:16+-val_i:22+-val_i:25+-val_i:26+-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+-val_i:49+-val_i:61+-val_i:62+-val_i:65+-val_i:66+-val_i:70+-val_i:71+-val_i:72+-val_i:73&q={!cache%3Dfalse+cost%3D127}+-val_i:0+-val_i:1+-val_i:2+-val_i:4+-val_i:7+-val_i:8+-val_i:9+-val_i:10+-val_i:12+-val_i:13+-val_i:15+-val_i:16+-val_i:17+-val_i:25+-val_i:26+-val_i:28+-val_i:29+-val_i:30+-val_i:31+-val_i:33+-val_i:34+-val_i:38+-val_i:41+-val_i:43+-val_i:45+-val_i:46+-val_i:47+-val_i:50+-val_i:54+-val_i:55+-val_i:56+-val_i:59+-val_i:62+-val_i:64+-val_i:65+-val_i:67+-val_i:68+-val_i:71+-val_i:72+-val_i:73&fq=+val_i:0+val_i:3+val_i:4+val_i:7+val_i:13+val_i:14+val_i:17+val_i:19+val_i:20+val_i:21+val_i:22+val_i:24+val_i:26+val_i:27+val_i:28+val_i:40+val_i:41+val_i:44+val_i:46+val_i:47+val_i:48+val_i:50+val_i:51+val_i:52+val_i:54+val_i:58+val_i:61+val_i:63+val_i:68+val_i:70+val_i:71+val_i:72+val_i:73&facet=true&wt=xml}
hits=17 status=0 QTime=3
[junit4] 2> 143438 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q={!cache%3Dtrue+tag%3Dt}+val_i:0+val_i:2+val_i:4+val_i:9+val_i:10+val_i:13+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:30+val_i:31+val_i:32+val_i:33+val_i:34+val_i:35+val_i:37+val_i:39+val_i:41+val_i:43+val_i:44+val_i:45+val_i:47+val_i:48+val_i:51+val_i:54+val_i:56+val_i:57+val_i:58+val_i:61+val_i:62+val_i:64+val_i:66+val_i:69+val_i:70+val_i:72&fq=val_i:{00025+TO+00091]+OR+id:RAND2075080017&fq={!+cache%3Dtrue+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D45+u%3D73}"&wt=xml}
hits=11 status=0 QTime=2
[junit4] 2> 143443 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
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:7+-val_i:9+-val_i:11+-val_i:12+-val_i:13+-val_i:14+-val_i:15+-val_i:24+-val_i:26+-val_i:28+-val_i:30+-val_i:31+-val_i:32+-val_i:33+-val_i:34+-val_i:37+-val_i:38+-val_i:41+-val_i:43+-val_i:44+-val_i:46+-val_i:48+-val_i:49+-val_i:50+-val_i:52+-val_i:55+-val_i:56+-val_i:57+-val_i:59+-val_i:60+-val_i:66+-val_i:67+-val_i:68+-val_i:71&q=+-val_i:2+-val_i:3+-val_i:9+-val_i:10+-val_i:14+-val_i:15+-val_i:16+-val_i:17+-val_i:18+-val_i:22+-val_i:26+-val_i:27+-val_i:29+-val_i:31+-val_i:33+-val_i:37+-val_i:39+-val_i:47+-val_i:53+-val_i:57+-val_i:59+-val_i:60+-val_i:62+-val_i:65+-val_i:67+-val_i:69+-val_i:70+-val_i:73&fq={!cache%3Dtrue}+-val_i:0+-val_i:2+-val_i:4+-val_i:7+-val_i:8+-val_i:10+-val_i:11+-val_i:12+-val_i:17+-val_i:19+-val_i:23+-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:42+-val_i:43+-val_i:44+-val_i:47+-val_i:51+-val_i:53+-val_i:54+-val_i:55+-val_i:59+-val_i:62+-val_i:63+-val_i:65+-val_i:66+-val_i:67+-val_i:69+-val_i:70+-val_i:72+-val_i:73&fq={!cache%3Dtrue+tag%3Dt}+val_i:2+val_i:4+val_i:5+val_i:6+val_i:7+val_i:9+val_i:11+val_i:15+val_i:18+val_i:19+val_i:22+val_i:26+val_i:29+val_i:30+val_i:31+val_i:36+val_i:40+val_i:41+val_i:43+val_i:45+val_i:52+val_i:55+val_i:57+val_i:58+val_i:59+val_i:60+val_i:61+val_i:62+val_i:63+val_i:64+val_i:65+val_i:66+val_i:67+val_i:70+val_i:71+val_i:72+val_i:73&fq={!cache%3Dtrue+tag%3Dt}+val_i:0+val_i:3+val_i:4+val_i:11+val_i:15+val_i:16+val_i:18+val_i:19+val_i:20+val_i:21+val_i:22+val_i:23+val_i:24+val_i:25+val_i:32+val_i:33+val_i:34+val_i:35+val_i:36+val_i:37+val_i:40+val_i:41+val_i:43+val_i:44+val_i:45+val_i:46+val_i:47+val_i:48+val_i:50+val_i:53+val_i:55+val_i:58+val_i:59+val_i:60+val_i:63+val_i:64+val_i:66+val_i:67+val_i:71+val_i:72+val_i:73&fq={!+cache%3Dtrue+tag%3Dt}-_query_:"val_i:{00037+TO+00074}"&facet=true&wt=xml}
hits=0 status=0 QTime=4
[junit4] 2> 143447 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
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:3+-val_i:5+-val_i:6+-val_i:8+-val_i:10+-val_i:11+-val_i:12+-val_i:14+-val_i:17+-val_i:20+-val_i:21+-val_i:22+-val_i:24+-val_i:25+-val_i:27+-val_i:28+-val_i:30+-val_i:35+-val_i:36+-val_i:37+-val_i:38+-val_i:40+-val_i:42+-val_i:43+-val_i:48+-val_i:49+-val_i:50+-val_i:52+-val_i:55+-val_i:56+-val_i:57+-val_i:58+-val_i:60+-val_i:65+-val_i:66+-val_i:67+-val_i:68+-val_i:70+-val_i:71+-val_i:72&q={!cache%3Dfalse}+val_i:0+val_i:2+val_i:5+val_i:6+val_i:9+val_i:11+val_i:13+val_i:14+val_i:15+val_i:18+val_i:19+val_i:21+val_i:22+val_i:27+val_i:28+val_i:29+val_i:31+val_i:32+val_i:37+val_i:38+val_i:39+val_i:40+val_i:43+val_i:47+val_i:50+val_i:51+val_i:55+val_i:59+val_i:60+val_i:61+val_i:62+val_i:66+val_i:67+val_i:73&fq={!frange+v%3Dval_i+l%3D33+u%3D72+cost%3D55+tag%3Dt}&facet=true&wt=xml}
hits=15 status=0 QTime=4
[junit4] 2> 143450 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
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:4+-val_i:5+-val_i:6+-val_i:7+-val_i:8+-val_i:9+-val_i:10+-val_i:12+-val_i:13+-val_i:14+-val_i:16+-val_i:17+-val_i:20+-val_i:23+-val_i:28+-val_i:30+-val_i:33+-val_i:34+-val_i:37+-val_i:39+-val_i:40+-val_i:42+-val_i:44+-val_i:46+-val_i:47+-val_i:48+-val_i:49+-val_i:54+-val_i:56+-val_i:57+-val_i:61+-val_i:64+-val_i:65+-val_i:66+-val_i:71+-val_i:72+-val_i:73&q=-_query_:"{!frange+v%3Dval_i+l%3D51+u%3D73}"&fq={!+cache%3Dtrue+tag%3Dt}-_query_:"val_s:[00051+TO+00073]"&fq={!+cost%3D85}val_i:{00038+TO+00078]+OR+id:RAND1863674412&facet=true&wt=xml}
hits=12 status=0 QTime=2
[junit4] 2> 143483 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
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%3D33}+val_i:2+val_i:3+val_i:4+val_i:6+val_i:8+val_i:9+val_i:10+val_i:11+val_i:14+val_i:16+val_i:21+val_i:23+val_i:25+val_i:27+val_i:28+val_i:31+val_i:32+val_i:38+val_i:39+val_i:41+val_i:44+val_i:47+val_i:48+val_i:53+val_i:58+val_i:60+val_i:63+val_i:65+val_i:66+val_i:69+val_i:72+val_i:73&q={!+cache%3Dfalse}-_query_:"val_i:[00010+TO+00074}"&group.main=true&group.cache.percent=100&facet=true&wt=xml&group.field=id&group=true}
hits=10 status=0 QTime=32
[junit4] 2> 143484 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q={!frange+v%3Dval_i+l%3D44+u%3D100}&fq={!cache%3Dfalse}+val_i:2+val_i:6+val_i:7+val_i:10+val_i:11+val_i:12+val_i:14+val_i:22+val_i:28+val_i:30+val_i:32+val_i:34+val_i:36+val_i:40+val_i:44+val_i:45+val_i:46+val_i:47+val_i:49+val_i:50+val_i:51+val_i:52+val_i:54+val_i:55+val_i:56+val_i:58+val_i:60+val_i:61+val_i:62+val_i:65+val_i:70+val_i:72+val_i:73&fq=id:RAND1758098131+OR+val_i:[00073+TO+00074}&fq={!+cache%3Dfalse+cost%3D119+tag%3Dt}val_s:{00071+TO+00083}&wt=xml}
hits=1 status=0 QTime=1
[junit4] 2> 143485 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
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:[00070+TO+00075]+OR+id:RAND-117738359&q={!+cache%3Dtrue+tag%3Dt}val_i:[00064+TO+00079]&fq=-_query_:"{!frange+v%3Dval_i+l%3D22+u%3D73}"&facet=true&wt=xml}
hits=0 status=0 QTime=0
[junit4] 2> 143488 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q={!cache%3Dfalse+tag%3Dt}+val_i:0+val_i:1+val_i:3+val_i:5+val_i:6+val_i:8+val_i:10+val_i:11+val_i:12+val_i:15+val_i:16+val_i:19+val_i:20+val_i:21+val_i:22+val_i:25+val_i:26+val_i:27+val_i:29+val_i:35+val_i:36+val_i:37+val_i:41+val_i:43+val_i:44+val_i:48+val_i:52+val_i:55+val_i:58+val_i:62+val_i:63+val_i:65+val_i:68+val_i:69+val_i:70+val_i:71+val_i:72+val_i:73&fq={!+cache%3Dfalse+cost%3D143}-_query_:"{!frange+v%3Dval_i+l%3D65+u%3D73}"&fq={!+cache%3Dfalse+cost%3D141}-_query_:"{!frange+v%3Dval_i+l%3D17+u%3D73}"&fq={!frange+v%3Dval_i+l%3D37+u%3D71+cache%3Dfalse+tag%3Dt}&wt=xml}
hits=0 status=0 QTime=2
[junit4] 2> 143491 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q={!cache%3Dfalse+cost%3D21+tag%3Dt}+-val_i:1+-val_i:4+-val_i:5+-val_i:6+-val_i:7+-val_i:9+-val_i:10+-val_i:11+-val_i:14+-val_i:15+-val_i:16+-val_i:20+-val_i:22+-val_i:23+-val_i:24+-val_i:26+-val_i:27+-val_i:30+-val_i:31+-val_i:35+-val_i:36+-val_i:41+-val_i:43+-val_i:45+-val_i:48+-val_i:49+-val_i:52+-val_i:53+-val_i:54+-val_i:55+-val_i:58+-val_i:59+-val_i:63+-val_i:65+-val_i:67+-val_i:69+-val_i:70&fq={!}val_i:[00058+TO+00099}&fq={!+cache%3Dfalse}-_query_:"val_s:{00046+TO+00074}"&fq={!+cache%3Dfalse}-_query_:"{!frange+v%3Dval_i+l%3D60+u%3D73}"&fq={!}val_s:{00071+TO+00126]&wt=xml}
hits=0 status=0 QTime=2
[junit4] 2> 143493 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
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%3D131}val_i:[00070+TO+00106]&q={!cache%3Dfalse+cost%3D84+tag%3Dt}+-val_i:1+-val_i:2+-val_i:4+-val_i:6+-val_i:9+-val_i:11+-val_i:18+-val_i:19+-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:32+-val_i:33+-val_i:34+-val_i:35+-val_i:36+-val_i:38+-val_i:41+-val_i:43+-val_i:44+-val_i:45+-val_i:49+-val_i:50+-val_i:51+-val_i:52+-val_i:55+-val_i:56+-val_i:57+-val_i:58+-val_i:59+-val_i:63+-val_i:64+-val_i:65+-val_i:66+-val_i:67+-val_i:68+-val_i:71+-val_i:72+-val_i:73&fq={!+cost%3D123}-_query_:"val_i:{00036+TO+00074}"&facet=true&wt=xml}
hits=13 status=0 QTime=2
[junit4] 2> 143496 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery}-_query_:"val_s:[00004+TO+00073]"&q={!+tag%3Dt}-_query_:"val_s:[00053+TO+00074}"&group.main=true&fq={!frange+v%3Dval_i+l%3D29+u%3D72+cache%3Dfalse+cost%3D66}&fq={!+cost%3D92}-_query_:"{!frange+v%3Dval_i+l%3D3+u%3D73}"&facet=true&wt=xml&group.field=id&group=true}
hits=0 status=0 QTime=2
[junit4] 2> 143498 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=+-val_i:0+-val_i:1+-val_i:2+-val_i:3+-val_i:4+-val_i:5+-val_i:8+-val_i:12+-val_i:15+-val_i:17+-val_i:19+-val_i:20+-val_i:22+-val_i:24+-val_i:26+-val_i:27+-val_i:29+-val_i:32+-val_i:36+-val_i:37+-val_i:40+-val_i:41+-val_i:42+-val_i:45+-val_i:47+-val_i:48+-val_i:49+-val_i:51+-val_i:53+-val_i:57+-val_i:61+-val_i:62+-val_i:64+-val_i:65+-val_i:66&fq=val_i:{00019+TO+00084]&wt=xml}
hits=30 status=0 QTime=1
[junit4] 2> 143501 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path
[...truncated too long message...]
-val_i:35+-val_i:38+-val_i:39+-val_i:43+-val_i:44+-val_i:45+-val_i:48+-val_i:49+-val_i:52+-val_i:53+-val_i:55+-val_i:56+-val_i:58+-val_i:66+-val_i:67+-val_i:68+-val_i:71&fq={!cache%3Dfalse+cost%3D43}+-val_i:0+-val_i:2+-val_i:3+-val_i:11+-val_i:13+-val_i:18+-val_i:20+-val_i:22+-val_i:23+-val_i:24+-val_i:25+-val_i:28+-val_i:30+-val_i:31+-val_i:32+-val_i:33+-val_i:36+-val_i:40+-val_i:41+-val_i:42+-val_i:43+-val_i:44+-val_i:45+-val_i:46+-val_i:47+-val_i:49+-val_i:50+-val_i:54+-val_i:58+-val_i:60+-val_i:62+-val_i:64+-val_i:65+-val_i:66+-val_i:71+-val_i:73&fq={!frange+v%3Dval_i+l%3D28+u%3D76+cost%3D36+tag%3Dt}&wt=xml}
hits=10 status=0 QTime=2
[junit4] 2> 144905 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
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%3D38}-_query_:"val_s:{00029+TO+00074}"&q=+val_i:1+val_i:2+val_i:3+val_i:4+val_i:8+val_i:9+val_i:11+val_i:13+val_i:17+val_i:18+val_i:19+val_i:23+val_i:27+val_i:31+val_i:32+val_i:33+val_i:34+val_i:36+val_i:37+val_i:40+val_i:41+val_i:42+val_i:43+val_i:50+val_i:52+val_i:53+val_i:54+val_i:55+val_i:57+val_i:62+val_i:63+val_i:64+val_i:65+val_i:66+val_i:67+val_i:70+val_i:71+val_i:72+val_i:73&fq=val_s:{00050+TO+00077}+AND+val_s:[00051+TO+00076]&fq={!cache%3Dfalse}+-val_i:1+-val_i:2+-val_i:4+-val_i:6+-val_i:7+-val_i:8+-val_i:11+-val_i:12+-val_i:13+-val_i:18+-val_i:20+-val_i:23+-val_i:27+-val_i:28+-val_i:29+-val_i:33+-val_i:34+-val_i:36+-val_i:37+-val_i:38+-val_i:39+-val_i:46+-val_i:49+-val_i:50+-val_i:51+-val_i:52+-val_i:54+-val_i:55+-val_i:57+-val_i:58+-val_i:60+-val_i:61+-val_i:65+-val_i:66+-val_i:68+-val_i:69+-val_i:70+-val_i:71+-val_i:73&fq={!cache%3Dfalse}+-val_i:2+-val_i:3+-val_i:4+-val_i:5+-val_i:7+-val_i:9+-val_i:11+-val_i:13+-val_i:16+-val_i:17+-val_i:18+-val_i:19+-val_i:20+-val_i:22+-val_i:27+-val_i:28+-val_i:29+-val_i:31+-val_i:36+-val_i:38+-val_i:40+-val_i:42+-val_i:45+-val_i:48+-val_i:49+-val_i:53+-val_i:54+-val_i:55+-val_i:59+-val_i:60+-val_i:62+-val_i:65+-val_i:67+-val_i:70+-val_i:71&facet=true&wt=xml}
hits=3 status=0 QTime=4
[junit4] 2> 144907 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q={!cache%3Dfalse}+val_i:1+val_i:2+val_i:3+val_i:5+val_i:6+val_i:7+val_i:9+val_i:10+val_i:12+val_i:14+val_i:15+val_i:21+val_i:22+val_i:23+val_i:26+val_i:28+val_i:29+val_i:30+val_i:32+val_i:36+val_i:38+val_i:41+val_i:42+val_i:43+val_i:45+val_i:46+val_i:51+val_i:52+val_i:53+val_i:55+val_i:60+val_i:61+val_i:62+val_i:63+val_i:66+val_i:68+val_i:69+val_i:70+val_i:71+val_i:72+val_i:73&wt=xml}
hits=41 status=0 QTime=1
[junit4] 2> 144909 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery}-_query_:"val_s:[00001+TO+00074}"&q={!cache%3Dtrue+tag%3Dt}+val_i:5+val_i:6+val_i:7+val_i:9+val_i:10+val_i:11+val_i:14+val_i:15+val_i:24+val_i:27+val_i:29+val_i:30+val_i:31+val_i:32+val_i:36+val_i:37+val_i:39+val_i:40+val_i:41+val_i:44+val_i:45+val_i:48+val_i:49+val_i:50+val_i:52+val_i:55+val_i:56+val_i:57+val_i:59+val_i:60+val_i:61+val_i:62+val_i:65+val_i:68+val_i:72+val_i:73&fq=val_s:{00038+TO+00095}&fq={!cache%3Dtrue+tag%3Dt}+val_i:3+val_i:4+val_i:5+val_i:7+val_i:8+val_i:9+val_i:10+val_i:11+val_i:12+val_i:13+val_i:18+val_i:19+val_i:20+val_i:24+val_i:28+val_i:30+val_i:32+val_i:33+val_i:34+val_i:35+val_i:36+val_i:38+val_i:40+val_i:41+val_i:42+val_i:47+val_i:48+val_i:51+val_i:53+val_i:54+val_i:55+val_i:56+val_i:57+val_i:58+val_i:60+val_i:62+val_i:63+val_i:64+val_i:65+val_i:69+val_i:70+val_i:71&fq={!+cache%3Dtrue+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D68+u%3D73}"&facet=true&wt=xml}
hits=9 status=0 QTime=1
[junit4] 2> 144909 ERROR
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.SolrTestCaseJ4 REQUEST FAILED:
facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery++cost%3D162}-_query_:"{!frange+v%3Dval_i+l%3D9+u%3D73}"&q={!+cache%3Dtrue+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D48+u%3D73}"&facet=true&wt=xml
[junit4] 2> 144910 INFO
(TEST-TestFiltering.testRandomFiltering-seed#[3196D1817ED3D012]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending testRandomFiltering
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestFiltering
-Dtests.method=testRandomFiltering -Dtests.seed=3196D1817ED3D012
-Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=hi
-Dtests.timezone=Asia/Brunei -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] FAILURE 1.60s J1 | TestFiltering.testRandomFiltering <<<
[junit4] > Throwable #1: java.lang.AssertionError: should have unwrapped
[junit4] > at
__randomizedtesting.SeedInfo.seed([3196D1817ED3D012:2EF572449BF4901B]:0)
[junit4] > at
org.apache.solr.search.SolrIndexSearcher.getAndCacheDocSet(SolrIndexSearcher.java:862)
[junit4] > at
org.apache.solr.search.SolrIndexSearcher.getDocSet(SolrIndexSearcher.java:824)
[junit4] > at
org.apache.solr.search.SolrIndexSearcher.getDocListC(SolrIndexSearcher.java:1367)
[junit4] > at
org.apache.solr.search.SolrIndexSearcher.search(SolrIndexSearcher.java:596)
[junit4] > at
org.apache.solr.handler.component.QueryComponent.doProcessUngroupedSearch(QueryComponent.java:1511)
[junit4] > at
org.apache.solr.handler.component.QueryComponent.process(QueryComponent.java:390)
[junit4] > at
org.apache.solr.handler.component.SearchHandler.handleRequestBody(SearchHandler.java:368)
[junit4] > at
org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:216)
[junit4] > at
org.apache.solr.core.SolrCore.execute(SolrCore.java:2637)
[junit4] > at
org.apache.solr.util.TestHarness.query(TestHarness.java:346)
[junit4] > at
org.apache.solr.util.TestHarness.query(TestHarness.java:328)
[junit4] > at
org.apache.solr.SolrTestCaseJ4.assertJQ(SolrTestCaseJ4.java:1090)
[junit4] > at
org.apache.solr.SolrTestCaseJ4.assertJQ(SolrTestCaseJ4.java:1059)
[junit4] > at
org.apache.solr.search.TestFiltering.testRandomFiltering(TestFiltering.java:488)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 144912 INFO
(SUITE-TestFiltering-seed#[3196D1817ED3D012]-worker) [ ]
o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> 144912 INFO
(SUITE-TestFiltering-seed#[3196D1817ED3D012]-worker) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=675535228
[junit4] 2> 144912 INFO (coreCloseExecutor-937-thread-1) [ ]
o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@7ba407fb
[junit4] 2> 144912 INFO (coreCloseExecutor-937-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection1 tag=SolrCore@7ba407fb
[junit4] 2> 144912 INFO (coreCloseExecutor-937-thread-1) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@69872cce: rootName = null,
domain = solr.core.collection1, service url = null, agent id = null] for
registry solr.core.collection1/com.codahale.metrics.MetricRegistry@735030cb
[junit4] 2> 144931 INFO (coreCloseExecutor-937-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close() ... SKIPPED
(unnecessary).
[junit4] 2> 144939 INFO
(SUITE-TestFiltering-seed#[3196D1817ED3D012]-worker) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node
tag=null
[junit4] 2> 144939 INFO
(SUITE-TestFiltering-seed#[3196D1817ED3D012]-worker) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@6230ac8b: rootName = null,
domain = solr.node, service url = null, agent id = null] for registry
solr.node/com.codahale.metrics.MetricRegistry@7e8670ff
[junit4] 2> 144945 INFO
(SUITE-TestFiltering-seed#[3196D1817ED3D012]-worker) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm
tag=null
[junit4] 2> 144945 INFO
(SUITE-TestFiltering-seed#[3196D1817ED3D012]-worker) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@68f9279d: rootName = null,
domain = solr.jvm, service url = null, agent id = null] for registry
solr.jvm/com.codahale.metrics.MetricRegistry@c65bee6
[junit4] 2> 144947 INFO
(SUITE-TestFiltering-seed#[3196D1817ED3D012]-worker) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty
tag=null
[junit4] 2> 144947 INFO
(SUITE-TestFiltering-seed#[3196D1817ED3D012]-worker) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@7d9f099a: rootName = null,
domain = solr.jetty, service url = null, agent id = null] for registry
solr.jetty/com.codahale.metrics.MetricRegistry@706a05a4
[junit4] 2> NOTE: leaving temporary files on disk at:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.search.TestFiltering_3196D1817ED3D012-001
[junit4] 2> NOTE: test params are: codec=CheapBastard,
sim=Asserting(RandomSimilarity(queryNorm=false): {}), locale=hi,
timezone=Asia/Brunei
[junit4] 2> NOTE: Linux 5.4.0-45-generic amd64/Oracle Corporation
1.8.0_291 (64-bit)/cpus=4,threads=1,free=270337728,total=497025024
[junit4] 2> NOTE: All tests run in this JVM: [HdfsNNFailoverTest,
TestSolrCloudSnapshots, CurrencyFieldTypeTest, TestStressReorder,
TestSha256AuthenticationProvider, HdfsDirectoryFactoryTest,
ThreadDumpHandlerTest, DistributedIntervalFacetingTest,
CollectionTooManyReplicasTest, TestFuzzyAnalyzedSuggestions, MergeStrategyTest,
TestFiltering]
[junit4] Completed [48/947 (1!)] on J1 in 3.73s, 4 tests, 1 failure <<<
FAILURES!
[...truncated 57240 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: builds-unsubscr...@lucene.apache.org
For additional commands, e-mail: builds-h...@lucene.apache.org
