lucene-builds mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Apache Jenkins Server <jenk...@builds.apache.org>
Subject [JENKINS] Lucene » Lucene-Solr-repro - Build # 386 - Still Unstable!
Date Mon, 09 Nov 2020 18:20:38 GMT
Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-Solr-repro/386/

[...truncated 31 lines...]
[repro] Jenkins log URL: https://ci-builds.apache.org/job/Lucene/job/Lucene-Solr-Tests-8.x/745//consoleText

[repro] Revision: 91ef1c0fe8854db04e42b9095437b3186ff8038e

[repro] Repro line:  ant test  -Dtestcase=TestCircuitBreaker -Dtests.method=testResponseWithCBTiming -Dtests.seed=BF8D3AA3C41FF310 -Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=is-IS -Dtests.timezone=Pacific/Samoa -Dtests.asserts=true -Dtests.file.encoding=UTF-8

[repro] Repro line:  ant test  -Dtestcase=TestRandomDVFaceting -Dtests.method=testRandomFaceting -Dtests.seed=BF8D3AA3C41FF310 -Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=mt-MT -Dtests.timezone=Pacific/Truk -Dtests.asserts=true -Dtests.file.encoding=UTF-8

[repro] git rev-parse --abbrev-ref HEAD
[repro] git rev-parse HEAD
[repro] Initial local git branch/revision: ec9a659845973a0dd0ee7c04e0075db818ed118d
[repro] JUnit rest result XML files will be moved to: ./repro-reports
[repro] git fetch
[repro] git checkout 91ef1c0fe8854db04e42b9095437b3186ff8038e

[...truncated 2 lines...]
[repro] git merge --ff-only

[...truncated 1 lines...]
[repro] ant clean

[...truncated 6 lines...]
[repro] Test suites by module:
[repro]    solr/core
[repro]       TestCircuitBreaker
[repro]       TestRandomDVFaceting
[repro] ant compile-test

[...truncated 3450 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=10 -Dtests.class="*.TestCircuitBreaker|*.TestRandomDVFaceting" -Dtests.showOutput=onerror  -Dtests.seed=BF8D3AA3C41FF310 -Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=is-IS -Dtests.timezone=Pacific/Samoa -Dtests.asserts=true -Dtests.file.encoding=UTF-8

[...truncated 21328 lines...]
   [junit4]   2> 43541 ERROR (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.TestRandomDVFaceting ERROR: mismatch facet response: mismatch: 'b'!='a' @ facet_counts/facet_fields/small_s/[2]
   [junit4]   2>  expected ={
   [junit4]   2>   "response":{"numFound":12,"start":0,"numFoundExact":true,"docs":[]
   [junit4]   2>   },
   [junit4]   2>   "facet_counts":{
   [junit4]   2>     "facet_queries":{},
   [junit4]   2>     "facet_fields":{
   [junit4]   2>       "small_s":[
   [junit4]   2>         "c",4,
   [junit4]   2>         "b",2,
   [junit4]   2>         "d",0]},
   [junit4]   2>     "facet_ranges":{},
   [junit4]   2>     "facet_intervals":{},
   [junit4]   2>     "facet_heatmaps":{}}}
   [junit4]   2> 
   [junit4]   2>  response = {
   [junit4]   2>   "response":{"numFound":12,"start":0,"numFoundExact":true,"docs":[]
   [junit4]   2>   },
   [junit4]   2>   "facet_counts":{
   [junit4]   2>     "facet_queries":{},
   [junit4]   2>     "facet_fields":{
   [junit4]   2>       "small_s":[
   [junit4]   2>         "c",4,
   [junit4]   2>         "a",1,
   [junit4]   2>         "b",1,
   [junit4]   2>         "d",0]},
   [junit4]   2>     "facet_ranges":{},
   [junit4]   2>     "facet_intervals":{},
   [junit4]   2>     "facet_heatmaps":{}}}
   [junit4]   2> 
   [junit4]   2>  request = facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.field=small_s&facet.method=uif
   [junit4]   2> 43541 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.SolrTestCaseJ4 ###Ending testRandomFaceting
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestRandomDVFaceting -Dtests.method=testRandomFaceting -Dtests.seed=BF8D3AA3C41FF310 -Dtests.multiplier=2 -Dtests.slow=true -Dtests.badapples=true -Dtests.locale=is-IS -Dtests.timezone=Pacific/Samoa -Dtests.asserts=true -Dtests.file.encoding=UTF-8
   [junit4] FAILURE 27.1s J0 | TestRandomDVFaceting.testRandomFaceting <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: mismatch: 'b'!='a' @ facet_counts/facet_fields/small_s/[2]
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([BF8D3AA3C41FF310:B2E51A7691E63BAF]:0)
   [junit4]    > 	at org.apache.solr.TestRandomDVFaceting.doFacetTests(TestRandomDVFaceting.java:292)
   [junit4]    > 	at org.apache.solr.TestRandomDVFaceting.doFacetTests(TestRandomDVFaceting.java:175)
   [junit4]    > 	at org.apache.solr.TestRandomDVFaceting.testRandomFaceting(TestRandomDVFaceting.java:158)
   [junit4]    > 	at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> 43546 INFO  (SUITE-TestRandomDVFaceting-seed#[BF8D3AA3C41FF310]-worker) [     ] o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> 43546 INFO  (SUITE-TestRandomDVFaceting-seed#[BF8D3AA3C41FF310]-worker) [     ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1985615102
   [junit4]   2> 43546 INFO  (coreCloseExecutor-41-thread-1) [     ] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@1a399483
   [junit4]   2> 43546 INFO  (coreCloseExecutor-41-thread-1) [     ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1 tag=SolrCore@1a399483
   [junit4]   2> 43546 INFO  (coreCloseExecutor-41-thread-1) [     ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@3c5e30bc: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1/com.codahale.metrics.MetricRegistry@1290cca5
   [junit4]   2> 43568 INFO  (coreCloseExecutor-41-thread-1) [     ] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close()  ... SKIPPED (unnecessary).
   [junit4]   2> 43574 INFO  (SUITE-TestRandomDVFaceting-seed#[BF8D3AA3C41FF310]-worker) [     ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node tag=null
   [junit4]   2> 43574 INFO  (SUITE-TestRandomDVFaceting-seed#[BF8D3AA3C41FF310]-worker) [     ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@7f03fbb4: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node/com.codahale.metrics.MetricRegistry@6797f5d
   [junit4]   2> 43579 INFO  (SUITE-TestRandomDVFaceting-seed#[BF8D3AA3C41FF310]-worker) [     ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm tag=null
   [junit4]   2> 43579 INFO  (SUITE-TestRandomDVFaceting-seed#[BF8D3AA3C41FF310]-worker) [     ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@6c241a65: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm/com.codahale.metrics.MetricRegistry@6048fa33
   [junit4]   2> 43580 INFO  (SUITE-TestRandomDVFaceting-seed#[BF8D3AA3C41FF310]-worker) [     ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty tag=null
   [junit4]   2> 43580 INFO  (SUITE-TestRandomDVFaceting-seed#[BF8D3AA3C41FF310]-worker) [     ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@6e9b01ef: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty/com.codahale.metrics.MetricRegistry@1a640e46
   [junit4]   2> NOTE: leaving temporary files on disk at: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-repro/solr/build/solr-core/test/J0/temp/solr.TestRandomDVFaceting_BF8D3AA3C41FF310-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene87): {small3_ss=PostingsFormat(name=Asserting), foo_ds_dv=Lucene84, foo_f_dv=PostingsFormat(name=Direct), small_i=Lucene84, small3_is=Lucene84, small_s=PostingsFormat(name=Asserting), score_f=PostingsFormat(name=Asserting), score_d=Lucene84, id=Lucene84, foo_i=PostingsFormat(name=Direct), foo_fs_dv=PostingsFormat(name=Asserting), foo_l=Lucene84, small4_ss=PostingsFormat(name=LuceneFixedGap), small2_s=PostingsFormat(name=Asserting), small2_i=Lucene84, foo_ls_dv=Lucene84, small2_is=PostingsFormat(name=LuceneFixedGap), foo_ds=PostingsFormat(name=Direct), foo_fs=PostingsFormat(name=LuceneFixedGap), foo_d_dv=PostingsFormat(name=LuceneFixedGap), score_f_dv=PostingsFormat(name=Direct), foo_d=Lucene84, score_d_dv=PostingsFormat(name=LuceneFixedGap), small2_ss=PostingsFormat(name=Direct), foo_f=PostingsFormat(name=Asserting), foo_l_dv=PostingsFormat(name=LuceneFixedGap), foo_ls=PostingsFormat(name=Direct)}, docValues:{small2_s_dv=DocValuesFormat(name=Asserting), score_f_p=DocValuesFormat(name=Asserting), id_dv=DocValuesFormat(name=Asserting), score_d_p=DocValuesFormat(name=Lucene80), small2_is_p=DocValuesFormat(name=Direct), small3_is_dv=DocValuesFormat(name=Lucene80), foo_ds_dv=DocValuesFormat(name=Lucene80), foo_f_dv=DocValuesFormat(name=Lucene80), foo_ds_p=DocValuesFormat(name=Direct), foo_l_p=DocValuesFormat(name=Lucene80), foo_i_p=DocValuesFormat(name=Lucene80), small2_i_dv=DocValuesFormat(name=Lucene80), small4_ss_dv=DocValuesFormat(name=Lucene80), small_s_dv=DocValuesFormat(name=Asserting), foo_i_dv=DocValuesFormat(name=Direct), small2_ss_dv=DocValuesFormat(name=Lucene80), foo_fs_dv=DocValuesFormat(name=Direct), small2_is_dv=DocValuesFormat(name=Direct), small_i_p=DocValuesFormat(name=Asserting), small2_i_p=DocValuesFormat(name=Asserting), small_i_dv=DocValuesFormat(name=Lucene80), small3_is_p=DocValuesFormat(name=Asserting), foo_ls_dv=DocValuesFormat(name=Lucene80), foo_f_p=DocValuesFormat(name=Asserting), foo_ls_p=DocValuesFormat(name=Direct), foo_d_p=DocValuesFormat(name=Lucene80), foo_fs_p=DocValuesFormat(name=Lucene80), score_f_dv=DocValuesFormat(name=Lucene80), foo_d_dv=DocValuesFormat(name=Asserting), score_d_dv=DocValuesFormat(name=Asserting), foo_l_dv=DocValuesFormat(name=Asserting), small3_ss_dv=DocValuesFormat(name=Asserting)}, maxPointsInLeafNode=493, maxMBSortInHeap=5.412564381770178, sim=Asserting(RandomSimilarity(queryNorm=true): {}), locale=is-IS, timezone=Pacific/Samoa
   [junit4]   2> NOTE: Linux 4.15.0-112-generic amd64/Oracle Corporation 1.8.0_252 (64-bit)/cpus=4,threads=1,free=180129160,total=324534272
   [junit4]   2> NOTE: All tests run in this JVM: [TestCircuitBreaker, TestRandomDVFaceting]
   [junit4] Completed [6/10 (1!)] on J0 in 28.00s, 1 test, 1 failure <<< FAILURES!
   [junit4] 
   [junit4] Suite: org.apache.solr.TestRandomDVFaceting
   [junit4]   2> 16411 INFO  (SUITE-TestRandomDVFaceting-seed#[BF8D3AA3C41FF310]-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-repro/solr/server/solr/configsets/_default/conf'
   [junit4]   2> 16411 INFO  (SUITE-TestRandomDVFaceting-seed#[BF8D3AA3C41FF310]-worker) [     ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 16411 INFO  (SUITE-TestRandomDVFaceting-seed#[BF8D3AA3C41FF310]-worker) [     ] o.a.s.SolrTestCaseJ4 Created dataDir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-repro/solr/build/solr-core/test/J2/temp/solr.TestRandomDVFaceting_BF8D3AA3C41FF310-001/data-dir-2-001
   [junit4]   2> 16412 WARN  (SUITE-TestRandomDVFaceting-seed#[BF8D3AA3C41FF310]-worker) [     ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=21 numCloses=21
   [junit4]   2> 16412 INFO  (SUITE-TestRandomDVFaceting-seed#[BF8D3AA3C41FF310]-worker) [     ] o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 16414 INFO  (SUITE-TestRandomDVFaceting-seed#[BF8D3AA3C41FF310]-worker) [     ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
   [junit4]   2> 16415 INFO  (SUITE-TestRandomDVFaceting-seed#[BF8D3AA3C41FF310]-worker) [     ] o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 16427 INFO  (SUITE-TestRandomDVFaceting-seed#[BF8D3AA3C41FF310]-worker) [     ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.8.0
   [junit4]   2> 16440 INFO  (SUITE-TestRandomDVFaceting-seed#[BF8D3AA3C41FF310]-worker) [     ] o.a.s.s.IndexSchema Schema name=test
   [junit4]   2> 16451 INFO  (SUITE-TestRandomDVFaceting-seed#[BF8D3AA3C41FF310]-worker) [     ] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 17383 WARN  (SUITE-TestRandomDVFaceting-seed#[BF8D3AA3C41FF310]-worker) [     ] o.a.s.c.CoreContainer Unable to create [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-repro/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-repro/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-repro/solr/core/src/test-files/solr/userfiles" "write")
   [junit4]   2> 	at java.security.AccessControlContext.checkPermission(AccessControlContext.java:472) ~[?:1.8.0_252]
   [junit4]   2> 	at java.security.AccessController.checkPermission(AccessController.java:886) ~[?:1.8.0_252]
   [junit4]   2> 	at java.lang.SecurityManager.checkPermission(SecurityManager.java:549) ~[?:1.8.0_252]
   [junit4]   2> 	at java.lang.SecurityManager.checkWrite(SecurityManager.java:979) ~[?:1.8.0_252]
   [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_252]
   [junit4]   2> 	at java.nio.file.Files.createAndCheckIsDirectory(Files.java:781) ~[?:1.8.0_252]
   [junit4]   2> 	at java.nio.file.Files.createDirectories(Files.java:727) ~[?:1.8.0_252]
   [junit4]   2> 	at org.apache.solr.core.CoreContainer.<init>(CoreContainer.java:371) [java/:?]
   [junit4]   2> 	at org.apache.solr.core.CoreContainer.<init>(CoreContainer.java:336) [java/:?]
   [junit4]   2> 	at org.apache.solr.util.TestHarness.<init>(TestHarness.java:170) [java/:?]
   [junit4]   2> 	at org.apache.solr.util.TestHarness.<init>(TestHarness.java:143) [java/:?]
   [junit4]   2> 	at org.apache.solr.util.TestHarness.<init>(TestHarness.java:149) [java/:?]
   [junit4]   2> 	at org.apache.solr.util.TestHarness.<init>(TestHarness.java:112) [java/:?]
   [junit4]   2> 	at org.apache.solr.SolrTestCaseJ4.createCore(SolrTestCaseJ4.java:806) [java/:?]
   [junit4]   2> 	at org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:796) [java/:?]
   [junit4]   2> 	at org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:657) [java/:?]
   [junit4]   2> 	at org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:646) [java/:?]
   [junit4]   2> 	at org.apache.solr.TestRandomDVFaceting.beforeTests(TestRandomDVFaceting.java:55) [test/:?]
   [junit4]   2> 	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[?:1.8.0_252]
   [junit4]   2> 	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[?:1.8.0_252]
   [junit4]   2> 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[?:1.8.0_252]
   [junit4]   2> 	at java.lang.reflect.Method.invoke(Method.java:498) ~[?:1.8.0_252]
   [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_252]
   [junit4]   2> 17390 WARN  (SUITE-TestRandomDVFaceting-seed#[BF8D3AA3C41FF310]-worker) [     ] o.a.s.f.DistribPackageStore Unable to create [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-repro/solr/core/src/test-files/solr/filestore] directory in SOLR_HOME [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-repro/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-repro/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-repro/solr/core/src/test-files/solr/filestore" "write")
   [junit4]   2> 	at java.security.AccessControlContext.checkPermission(AccessControlContext.java:472) ~[?:1.8.0_252]
   [junit4]   2> 	at java.security.AccessController.checkPermission(AccessController.java:886) ~[?:1.8.0_252]
   [junit4]   2> 	at java.lang.SecurityManager.checkPermission(SecurityManager.java:549) ~[?:1.8.0_252]
   [junit4]   2> 	at java.lang.SecurityManager.checkWrite(SecurityManager.java:979) ~[?:1.8.0_252]
   [junit4]   2> 	at java.io.File.mkdir(File.java:1311) ~[?:1.8.0_252]
   [junit4]   2> 	at java.io.File.mkdirs(File.java:1343) ~[?:1.8.0_252]
   [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:672) [java/:?]
   [junit4]   2> 	at org.apache.solr.util.TestHarness.<init>(TestHarness.java:171) [java/:?]
   [junit4]   2> 	at org.apache.solr.util.TestHarness.<init>(TestHarness.java:143) [java/:?]
   [junit4]   2> 	at org.apache.solr.util.TestHarness.<init>(TestHarness.java:149) [java/:?]
   [junit4]   2> 	at org.apache.solr.util.TestHarness.<init>(TestHarness.java:112) [java/:?]
   [junit4]   2> 	at org.apache.solr.SolrTestCaseJ4.createCore(SolrTestCaseJ4.java:806) [java/:?]
   [junit4]   2> 	at org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:796) [java/:?]
   [junit4]   2> 	at org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:657) [java/:?]
   [junit4]   2> 	at org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:646) [java/:?]
   [junit4]   2> 	at org.apache.solr.TestRandomDVFaceting.beforeTests(TestRandomDVFaceting.java:55) [test/:?]
   [junit4]   2> 	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[?:1.8.0_252]
   [junit4]   2> 	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[?:1.8.0_252]
   [junit4]   2> 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[?:1.8.0_252]
   [junit4]   2> 	at java.lang.reflect.Method.invoke(Method.java:498) ~[?:1.8.0_252]
   [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_252]
   [junit4]   2> 17391 INFO  (SUITE-TestRandomDVFaceting-seed#[BF8D3AA3C41FF310]-worker) [     ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 17410 WARN  (SUITE-TestRandomDVFaceting-seed#[BF8D3AA3C41FF310]-worker) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@3badf5ab[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 17411 WARN  (SUITE-TestRandomDVFaceting-seed#[BF8D3AA3C41FF310]-worker) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@3badf5ab[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 17433 WARN  (SUITE-TestRandomDVFaceting-seed#[BF8D3AA3C41FF310]-worker) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@38233455[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 17433 WARN  (SUITE-TestRandomDVFaceting-seed#[BF8D3AA3C41FF310]-worker) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@38233455[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 17434 WARN  (SUITE-TestRandomDVFaceting-seed#[BF8D3AA3C41FF310]-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> 17549 INFO  (SUITE-TestRandomDVFaceting-seed#[BF8D3AA3C41FF310]-worker) [     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@21935cf6
   [junit4]   2> 17549 INFO  (SUITE-TestRandomDVFaceting-seed#[BF8D3AA3C41FF310]-worker) [     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@21935cf6
   [junit4]   2> 17550 INFO  (SUITE-TestRandomDVFaceting-seed#[BF8D3AA3C41FF310]-worker) [     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@21935cf6
   [junit4]   2> 17557 INFO  (coreLoadExecutor-34-thread-1) [     ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
   [junit4]   2> 17570 INFO  (coreLoadExecutor-34-thread-1) [    x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.8.0
   [junit4]   2> 17588 INFO  (coreLoadExecutor-34-thread-1) [    x:collection1 ] o.a.s.s.IndexSchema Schema name=test
   [junit4]   2> 17596 INFO  (coreLoadExecutor-34-thread-1) [    x:collection1 ] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 17596 INFO  (coreLoadExecutor-34-thread-1) [    x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-repro/solr/core/src/test-files/solr/collection1, trusted=true
   [junit4]   2> 17597 INFO  (coreLoadExecutor-34-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@21935cf6
   [junit4]   2> 17597 INFO  (coreLoadExecutor-34-thread-1) [    x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-repro/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-repro/solr/build/solr-core/test/J2/temp/solr.TestRandomDVFaceting_BF8D3AA3C41FF310-001/data-dir-2-001/]
   [junit4]   2> 17601 INFO  (coreLoadExecutor-34-thread-1) [    x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=19, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.8825333199574229]
   [junit4]   2> 17649 INFO  (coreLoadExecutor-34-thread-1) [    x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 17649 INFO  (coreLoadExecutor-34-thread-1) [    x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 17650 INFO  (coreLoadExecutor-34-thread-1) [    x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=10, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
   [junit4]   2> 17651 WARN  (coreLoadExecutor-34-thread-1) [    x:collection1 ] o.a.s.r.ManagedResourceStorage Cannot write to config directory /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-repro/solr/core/src/test-files/solr/collection1/conf ; switching to use InMemory storage instead.
   [junit4]   2> 17652 INFO  (coreLoadExecutor-34-thread-1) [    x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 17654 INFO  (SUITE-TestRandomDVFaceting-seed#[BF8D3AA3C41FF310]-worker) [     ] o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 17659 INFO  (searcherExecutor-36-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 17664 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.SolrTestCaseJ4 ###Starting testRandomFaceting
   [junit4]   2> 17963 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.u.DirectUpdateHandler2 [collection1]  REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 17964 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] 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 12
   [junit4]   2> 17970 INFO  (searcherExecutor-36-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 17973 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 8
   [junit4]   2> 17993 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=*:*&indent=true&fl=id&sort=_docid_+asc&rows=0&wt=json} hits=0 status=0 QTime=14
   [junit4]   2> 18019 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.offset=9&facet.limit=38&facet.sort=index&facet.field=id&facet.method=enum} hits=0 status=0 QTime=24
   [junit4]   2> 18026 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.offset=9&facet.limit=38&facet.sort=index&facet.field=id&facet.method=fc} hits=0 status=0 QTime=6
   [junit4]   2> 18032 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.offset=9&facet.limit=38&facet.sort=index&facet.field=id&facet.method=fcs} hits=0 status=0 QTime=5
   [junit4]   2> 18034 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.offset=9&facet.limit=38&facet.sort=index&facet.field={!key%3Did}id_dv} hits=0 status=0 QTime=2
   [junit4]   2> 18035 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.offset=9&facet.limit=38&facet.sort=index&facet.field=id&facet.method=uif} hits=0 status=0 QTime=0
   [junit4]   2> 18040 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.offset=23&facet.sort=count&facet.mincount=1&facet.field=score_f&facet.method=enum} hits=0 status=0 QTime=1
   [junit4]   2> 18055 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.offset=23&facet.sort=count&facet.mincount=1&facet.field=score_f&facet.method=fc} hits=0 status=0 QTime=13
   [junit4]   2> 18056 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.offset=23&facet.sort=count&facet.mincount=1&facet.field=score_f&facet.method=fcs} hits=0 status=0 QTime=0
   [junit4]   2> 18056 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.offset=23&facet.sort=count&facet.mincount=1&facet.field={!key%3Dscore_f}score_f_dv} hits=0 status=0 QTime=0
   [junit4]   2> 18135 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.offset=23&facet.sort=count&facet.mincount=1&facet.field=score_f&facet.method=uif} hits=0 status=0 QTime=78
   [junit4]   2> 18136 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.offset=23&facet.sort=count&facet.mincount=1&facet.field={!key%3Dscore_f}score_f_p&facet.method=uif} hits=0 status=0 QTime=0
   [junit4]   2> 18140 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.limit=51&facet.sort=count&facet.mincount=3&facet.field=score_d&facet.method=enum} hits=0 status=0 QTime=2
   [junit4]   2> 18144 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.limit=51&facet.sort=count&facet.mincount=3&facet.field=score_d&facet.method=fc} hits=0 status=0 QTime=3
   [junit4]   2> 18144 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.limit=51&facet.sort=count&facet.mincount=3&facet.field=score_d&facet.method=fcs} hits=0 status=0 QTime=0
   [junit4]   2> 18145 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.limit=51&facet.sort=count&facet.mincount=3&facet.field={!key%3Dscore_d}score_d_dv} hits=0 status=0 QTime=0
   [junit4]   2> 18146 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.limit=51&facet.sort=count&facet.mincount=3&facet.field=score_d&facet.method=uif} hits=0 status=0 QTime=1
   [junit4]   2> 18147 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.limit=51&facet.sort=count&facet.mincount=3&facet.field={!key%3Dscore_d}score_d_p&facet.method=uif} hits=0 status=0 QTime=0
   [junit4]   2> 18148 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.limit=100&facet.sort=count&facet.mincount=4&facet.field=foo_i&facet.method=enum} hits=0 status=0 QTime=0
   [junit4]   2> 18150 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.limit=100&facet.sort=count&facet.mincount=4&facet.field=foo_i&facet.method=fc} hits=0 status=0 QTime=2
   [junit4]   2> 18151 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.limit=100&facet.sort=count&facet.mincount=4&facet.field=foo_i&facet.method=fcs} hits=0 status=0 QTime=0
   [junit4]   2> 18152 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.limit=100&facet.sort=count&facet.mincount=4&facet.field={!key%3Dfoo_i}foo_i_dv} hits=0 status=0 QTime=0
   [junit4]   2> 18153 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.limit=100&facet.sort=count&facet.mincount=4&facet.field=foo_i&facet.method=uif} hits=0 status=0 QTime=0
   [junit4]   2> 18153 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.limit=100&facet.sort=count&facet.mincount=4&facet.field={!key%3Dfoo_i}foo_i_p&facet.method=uif} hits=0 status=0 QTime=0
   [junit4]   2> 18154 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.offset=9&facet.sort=count&facet.mincount=4&facet.field=foo_l&facet.method=enum} hits=0 status=0 QTime=0
   [junit4]   2> 18157 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.offset=9&facet.sort=count&facet.mincount=4&facet.field=foo_l&facet.method=fc} hits=0 status=0 QTime=3
   [junit4]   2> 18158 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.offset=9&facet.sort=count&facet.mincount=4&facet.field=foo_l&facet.method=fcs} hits=0 status=0 QTime=0
   [junit4]   2> 18158 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.offset=9&facet.sort=count&facet.mincount=4&facet.field={!key%3Dfoo_l}foo_l_dv} hits=0 status=0 QTime=0
   [junit4]   2> 18159 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.offset=9&facet.sort=count&facet.mincount=4&facet.field=foo_l&facet.method=uif} hits=0 status=0 QTime=0
   [junit4]   2> 18159 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.offset=9&facet.sort=count&facet.mincount=4&facet.field={!key%3Dfoo_l}foo_l_p&facet.method=uif} hits=0 status=0 QTime=0
   [junit4]   2> 18160 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.field=small_s&facet.method=enum} hits=0 status=0 QTime=0
   [junit4]   2> 18160 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.field=small_s&facet.method=fc} hits=0 status=0 QTime=0
   [junit4]   2> 18160 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.field=small_s&facet.method=fcs} hits=0 status=0 QTime=0
   [junit4]   2> 18161 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.field={!key%3Dsmall_s}small_s_dv} hits=0 status=0 QTime=0
   [junit4]   2> 18161 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.field=small_s&facet.method=uif} hits=0 status=0 QTime=0
   [junit4]   2> 18164 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=index&facet.missing=true&facet.field=small2_s&facet.method=enum} hits=0 status=0 QTime=3
   [junit4]   2> 18165 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=index&facet.missing=true&facet.field=small2_s&facet.method=fc} hits=0 status=0 QTime=0
   [junit4]   2> 18166 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=index&facet.missing=true&facet.field=small2_s&facet.method=fcs} hits=0 status=0 QTime=0
   [junit4]   2> 18167 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=index&facet.missing=true&facet.field={!key%3Dsmall2_s}small2_s_dv} hits=0 status=0 QTime=0
   [junit4]   2> 18167 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=index&facet.missing=true&facet.field=small2_s&facet.method=uif} hits=0 status=0 QTime=0
   [junit4]   2> 18170 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.field=small2_ss&facet.method=enum} hits=0 status=0 QTime=0
   [junit4]   2> 18170 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.field=small2_ss&facet.method=fc} hits=0 status=0 QTime=0
   [junit4]   2> 18171 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.field=small2_ss&facet.method=fcs} hits=0 status=0 QTime=0
   [junit4]   2> 18171 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.field={!key%3Dsmall2_ss}small2_ss_dv} hits=0 status=0 QTime=0
   [junit4]   2> 18172 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.field=small2_ss&facet.method=uif} hits=0 status=0 QTime=0
   [junit4]   2> 18172 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.field=small3_ss&facet.method=enum} hits=0 status=0 QTime=0
   [junit4]   2> 18173 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.field=small3_ss&facet.method=fc} hits=0 status=0 QTime=0
   [junit4]   2> 18173 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.field=small3_ss&facet.method=fcs} hits=0 status=0 QTime=0
   [junit4]   2> 18173 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.field={!key%3Dsmall3_ss}small3_ss_dv} hits=0 status=0 QTime=0
   [junit4]   2> 18173 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.field=small3_ss&facet.method=uif} hits=0 status=0 QTime=0
   [junit4]   2> 18174 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=index&facet.field=small4_ss&facet.method=enum} hits=0 status=0 QTime=0
   [junit4]   2> 18175 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=index&facet.field=small4_ss&facet.method=fc} hits=0 status=0 QTime=0
   [junit4]   2> 18175 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=index&facet.field=small4_ss&facet.method=fcs} hits=0 status=0 QTime=0
   [junit4]   2> 18176 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=index&facet.field={!key%3Dsmall4_ss}small4_ss_dv} hits=0 status=0 QTime=0
   [junit4]   2> 18176 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=index&facet.field=small4_ss&facet.method=uif} hits=0 status=0 QTime=0
   [junit4]   2> 18177 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=count&facet.mincount=4&facet.field=small_i&facet.method=enum} hits=0 status=0 QTime=0
   [junit4]   2> 18177 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=count&facet.mincount=4&facet.field=small_i&facet.method=fc} hits=0 status=0 QTime=0
   [junit4]   2> 18177 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=count&facet.mincount=4&facet.field=small_i&facet.method=fcs} hits=0 status=0 QTime=0
   [junit4]   2> 18179 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=count&facet.mincount=4&facet.field={!key%3Dsmall_i}small_i_dv} hits=0 status=0 QTime=0
   [junit4]   2> 18179 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=count&facet.mincount=4&facet.field=small_i&facet.method=uif} hits=0 status=0 QTime=0
   [junit4]   2> 18180 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=count&facet.mincount=4&facet.field={!key%3Dsmall_i}small_i_p&facet.method=uif} hits=0 status=0 QTime=0
   [junit4]   2> 18182 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=count&facet.mincount=3&facet.field=small2_i&facet.method=enum} hits=0 status=0 QTime=0
   [junit4]   2> 18182 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=count&facet.mincount=3&facet.field=small2_i&facet.method=fc} hits=0 status=0 QTime=0
   [junit4]   2> 18183 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=count&facet.mincount=3&facet.field=small2_i&facet.method=fcs} hits=0 status=0 QTime=0
   [junit4]   2> 18183 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=count&facet.mincount=3&facet.field={!key%3Dsmall2_i}small2_i_dv} hits=0 status=0 QTime=0
   [junit4]   2> 18183 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=count&facet.mincount=3&facet.field=small2_i&facet.method=uif} hits=0 status=0 QTime=0
   [junit4]   2> 18184 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=count&facet.mincount=3&facet.field={!key%3Dsmall2_i}small2_i_p&facet.method=uif} hits=0 status=0 QTime=0
   [junit4]   2> 18184 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=count&facet.field=small2_is&facet.method=enum} hits=0 status=0 QTime=0
   [junit4]   2> 18184 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=count&facet.field=small2_is&facet.method=fc} hits=0 status=0 QTime=0
   [junit4]   2> 18185 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=count&facet.field=small2_is&facet.method=fcs} hits=0 status=0 QTime=0
   [junit4]   2> 18185 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=count&facet.field={!key%3Dsmall2_is}small2_is_dv} hits=0 status=0 QTime=0
   [junit4]   2> 18185 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=count&facet.field=small2_is&facet.method=uif} hits=0 status=0 QTime=0
   [junit4]   2> 18186 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=index&facet.field=small3_is&facet.method=enum} hits=0 status=0 QTime=0
   [junit4]   2> 18186 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=index&facet.field=small3_is&facet.method=fc} hits=0 status=0 QTime=0
   [junit4]   2> 18187 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=index&facet.field=small3_is&facet.method=fcs} hits=0 status=0 QTime=0
   [junit4]   2> 18187 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=index&facet.field={!key%3Dsmall3_is}small3_is_dv} hits=0 status=0 QTime=0
   [junit4]   2> 18188 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=index&facet.field=small3_is&facet.method=uif} hits=0 status=0 QTime=0
   [junit4]   2> 18192 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.offset=0&facet.missing=true&facet.field=foo_fs&facet.method=enum} hits=0 status=0 QTime=3
   [junit4]   2> 18192 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.offset=0&facet.missing=true&facet.field=foo_fs&facet.method=fc} hits=0 status=0 QTime=0
   [junit4]   2> 18193 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.offset=0&facet.missing=true&facet.field=foo_fs&facet.method=fcs} hits=0 status=0 QTime=0
   [junit4]   2> 18194 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.offset=0&facet.missing=true&facet.field={!key%3Dfoo_fs}foo_fs_dv} hits=0 status=0 QTime=0
   [junit4]   2> 18194 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.offset=0&facet.missing=true&facet.field=foo_fs&facet.method=uif} hits=0 status=0 QTime=0
   [junit4]   2> 18195 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.limit=36&facet.sort=count&facet.mincount=3&facet.field=foo_f&facet.method=enum} hits=0 status=0 QTime=0
   [junit4]   2> 18196 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.limit=36&facet.sort=count&facet.mincount=3&facet.field=foo_f&facet.method=fc} hits=0 status=0 QTime=0
   [junit4]   2> 18196 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.limit=36&facet.sort=count&facet.mincount=3&facet.field=foo_f&facet.method=fcs} hits=0 status=0 QTime=0
   [junit4]   2> 18196 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.limit=36&facet.sort=count&facet.mincount=3&facet.field={!key%3Dfoo_f}foo_f_dv} hits=0 status=0 QTime=0
   [junit4]   2> 18197 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.limit=36&facet.sort=count&facet.mincount=3&facet.field=foo_f&facet.method=uif} hits=0 status=0 QTime=0
   [junit4]   2> 18198 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.limit=36&facet.sort=count&facet.mincount=3&facet.field={!key%3Dfoo_f}foo_f_p&facet.method=uif} hits=0 status=0 QTime=0
   [junit4]   2> 18199 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.offset=19&facet.field=foo_ds&facet.method=enum} hits=0 status=0 QTime=0
   [junit4]   2> 18204 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.offset=19&facet.field=foo_ds&facet.method=fc} hits=0 status=0 QTime=0
   [junit4]   2> 18205 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.offset=19&facet.field=foo_ds&facet.method=fcs} hits=0 status=0 QTime=0
   [junit4]   2> 18205 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.offset=19&facet.field={!key%3Dfoo_ds}foo_ds_dv} hits=0 status=0 QTime=0
   [junit4]   2> 18205 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.offset=19&facet.field=foo_ds&facet.method=uif} hits=0 status=0 QTime=0
   [junit4]   2> 18206 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=count&facet.mincount=3&facet.field=foo_d&facet.method=enum} hits=0 status=0 QTime=0
   [junit4]   2> 18206 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=count&facet.mincount=3&facet.field=foo_d&facet.method=fc} hits=0 status=0 QTime=0
   [junit4]   2> 18207 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=count&facet.mincount=3&facet.field=foo_d&facet.method=fcs} hits=0 status=0 QTime=0
   [junit4]   2> 18207 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=count&facet.mincount=3&facet.field={!key%3Dfoo_d}foo_d_dv} hits=0 status=0 QTime=0
   [junit4]   2> 18207 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=count&facet.mincount=3&facet.field=foo_d&facet.method=uif} hits=0 status=0 QTime=0
   [junit4]   2> 18208 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=count&facet.mincount=3&facet.field={!key%3Dfoo_d}foo_d_p&facet.method=uif} hits=0 status=0 QTime=1
   [junit4]   2> 18210 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.offset=0&facet.sort=index&facet.field=foo_ls&facet.method=enum} hits=0 status=0 QTime=0
   [junit4]   2> 18216 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.offset=0&facet.sort=index&facet.field=foo_ls&facet.method=fc} hits=0 status=0 QTime=4
   [junit4]   2> 18216 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.offset=0&facet.sort=index&facet.field=foo_ls&facet.method=fcs} hits=0 status=0 QTime=0
   [junit4]   2> 18217 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.offset=0&facet.sort=index&facet.field={!key%3Dfoo_ls}foo_ls_dv} hits=0 status=0 QTime=0
   [junit4]   2> 18217 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.offset=0&facet.sort=index&facet.field=foo_ls&facet.method=uif} hits=0 status=0 QTime=0
   [junit4]   2> 18217 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=count&facet.mincount=5&facet.field=missing_i&facet.method=enum} hits=0 status=0 QTime=0
   [junit4]   2> 18218 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=count&facet.mincount=5&facet.field=missing_i&facet.method=fc} hits=0 status=0 QTime=0
   [junit4]   2> 18218 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=count&facet.mincount=5&facet.field=missing_i&facet.method=fcs} hits=0 status=0 QTime=0
   [junit4]   2> 18218 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=count&facet.mincount=5&facet.field={!key%3Dmissing_i}missing_i_dv} hits=0 status=0 QTime=0
   [junit4]   2> 18218 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=count&facet.mincount=5&facet.field=missing_i&facet.method=uif} hits=0 status=0 QTime=0
   [junit4]   2> 18219 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=count&facet.mincount=5&facet.field={!key%3Dmissing_i}missing_i_p&facet.method=uif} hits=0 status=0 QTime=0
   [junit4]   2> 18219 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=count&facet.mincount=3&facet.field=missing_is&facet.method=enum} hits=0 status=0 QTime=0
   [junit4]   2> 18219 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=count&facet.mincount=3&facet.field=missing_is&facet.method=fc} hits=0 status=0 QTime=0
   [junit4]   2> 18220 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=count&facet.mincount=3&facet.field=missing_is&facet.method=fcs} hits=0 status=0 QTime=0
   [junit4]   2> 18220 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=count&facet.mincount=3&facet.field={!key%3Dmissing_is}missing_is_dv} hits=0 status=0 QTime=0
   [junit4]   2> 18227 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.s.f.UnInvertedField UnInverted multi-valued field {field=missing_is,memSize=4320,tindexSize=32,time=0,phase1=0,nTerms=0,bigTerms=0,termInstances=0,uses=0}
   [junit4]   2> 18230 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=count&facet.mincount=3&facet.field=missing_is&facet.method=uif} hits=0 status=0 QTime=9
   [junit4]   2> 18231 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=count&facet.mincount=3&facet.field={!key%3Dmissing_is}missing_is_p&facet.method=uif} hits=0 status=0 QTime=0
   [junit4]   2> 18231 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=count&facet.field=missing_s&facet.method=enum} hits=0 status=0 QTime=0
   [junit4]   2> 18232 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=count&facet.field=missing_s&facet.method=fc} hits=0 status=0 QTime=0
   [junit4]   2> 18232 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=count&facet.field=missing_s&facet.method=fcs} hits=0 status=0 QTime=0
   [junit4]   2> 18233 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=count&facet.field={!key%3Dmissing_s}missing_s_dv} hits=0 status=0 QTime=0
   [junit4]   2> 18234 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=count&facet.field=missing_s&facet.method=uif} hits=0 status=0 QTime=0
   [junit4]   2> 18236 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.field=missing_ss&facet.method=enum} hits=0 status=0 QTime=2
   [junit4]   2> 18238 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.field=missing_ss&facet.method=fc} hits=0 status=0 QTime=1
   [junit4]   2> 18239 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.field=missing_ss&facet.method=fcs} hits=0 status=0 QTime=0
   [junit4]   2> 18240 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.field={!key%3Dmissing_ss}missing_ss_dv} hits=0 status=0 QTime=0
   [junit4]   2> 18241 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.field=missing_ss&facet.method=uif} hits=0 status=0 QTime=0
   [junit4]   2> 18280 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={wt=json&indent=true}{add=[AGQS]} 0 38
   [junit4]   2> 18288 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={wt=json&indent=true}{add=[YDHQ]} 0 5
   [junit4]   2> 18293 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={wt=json&indent=true}{add=[EZCJ]} 0 3
   [junit4]   2> 18303 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={wt=json&indent=true}{add=[GSHC]} 0 4
   [junit4]   2> 18307 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={wt=json&indent=true}{add=[GSHC]} 0 3
   [junit4]   2> 18307 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={wt=json&indent=true}{add=[BUKT]} 0 0
   [junit4]   2> 18308 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={wt=json&indent=true}{add=[NIGU]} 0 0
   [junit4]   2> 18309 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={wt=json&indent=true}{add=[GQIL]} 0 0
   [junit4]   2> 18310 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={wt=json&indent=true}{add=[OTBQ]} 0 0
   [junit4]   2> 18311 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={wt=json&indent=true}{add=[BQLY]} 0 0
   [junit4]   2> 18668 INFO  (searcherExecutor-36-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 18669 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 357
   [junit4]   2> 18675 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={wt=json&indent=true}{add=[TLJS]} 0 3
   [junit4]   2> 18677 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={wt=json&indent=true}{add=[TLJS]} 0 1
   [junit4]   2> 18683 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={wt=json&indent=true}{add=[FPBN]} 0 4
   [junit4]   2> 18690 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={wt=json&indent=true}{add=[REMC]} 0 6
   [junit4]   2> 18738 INFO  (searcherExecutor-36-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 18740 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 49
   [junit4]   2> 18743 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={wt=json&indent=true}{add=[ORGL]} 0 1
   [junit4]   2> 18744 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={wt=json&indent=true}{add=[TUJY]} 0 0
   [junit4]   2> 18744 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={wt=json&indent=true}{add=[MXQB]} 0 0
   [junit4]   2> 18745 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={wt=json&indent=true}{add=[NCPJ]} 0 0
   [junit4]   2> 18803 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={wt=json&indent=true}{add=[APBT]} 0 0
   [junit4]   2> 18803 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={wt=json&indent=true}{add=[ERBB]} 0 0
   [junit4]   2> 18911 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={wt=json&indent=true}{add=[TJMR]} 0 108
   [junit4]   2> 18913 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={wt=json&indent=true}{add=[CKTD]} 0 1
   [junit4]   2> 18956 INFO  (searcherExecutor-36-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 18957 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 43
   [junit4]   2> 18963 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={wt=json&indent=true}{add=[RYLH]} 0 5
   [junit4]   2> 18980 INFO  (searcherExecutor-36-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 18981 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 17
   [junit4]   2> 18995 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=*:*&indent=true&fl=id&sort=_docid_+asc&rows=42&wt=json} hits=21 status=0 QTime=14
   [junit4]   2> 19002 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{deleteByQuery=id:(YDHQ )} 0 3
   [junit4]   2> 19012 INFO  (searcherExecutor-36-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 19013 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 10
   [junit4]   2> 19024 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.mincount=2&facet.field=id&facet.method=enum} hits=20 status=0 QTime=8
   [junit4]   2> 19048 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.mincount=2&facet.field=id&facet.method=fc} hits=20 status=0 QTime=23
   [junit4]   2> 19055 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.mincount=2&facet.field=id&facet.method=fcs} hits=20 status=0 QTime=7
   [junit4]   2> 19074 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.mincount=2&facet.field={!key%3Did}id_dv} hits=20 status=0 QTime=19
   [junit4]   2> 19082 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.mincount=2&facet.field=id&facet.method=uif} hits=20 status=0 QTime=8
   [junit4]   2> 19089 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=count&facet.mincount=1&facet.field=score_f&facet.method=enum} hits=20 status=0 QTime=6
   [junit4]   2> 19103 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=count&facet.mincount=1&facet.field=score_f&facet.method=fc} hits=20 status=0 QTime=14
   [junit4]   2> 19104 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=count&facet.mincount=1&facet.field=score_f&facet.method=fcs} hits=20 status=0 QTime=0
   [junit4]   2> 19105 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=count&facet.mincount=1&facet.field={!key%3Dscore_f}score_f_dv} hits=20 status=0 QTime=0
   [junit4]   2> 19105 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=count&facet.mincount=1&facet.field=score_f&facet.method=uif} hits=20 status=0 QTime=0
   [junit4]   2> 19106 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=count&facet.mincount=1&facet.field={!key%3Dscore_f}score_f_p&facet.method=uif} hits=20 status=0 QTime=0
   [junit4]   2> 19107 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=count&facet.mincount=4&facet.field=score_d&facet.method=enum} hits=20 status=0 QTime=0
   [junit4]   2> 19107 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=count&facet.mincount=4&facet.field=score_d&facet.method=fc} hits=20 status=0 QTime=0
   [junit4]   2> 19108 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=count&facet.mincount=4&facet.field=score_d&facet.method=fcs} hits=20 status=0 QTime=0
   [junit4]   2> 19108 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=count&facet.mincount=4&facet.field={!key%3Dscore_d}score_d_dv} hits=20 status=0 QTime=0
   [junit4]   2> 19108 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=count&facet.mincount=4&facet.field=score_d&facet.method=uif} hits=20 status=0 QTime=0
   [junit4]   2> 19109 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=count&facet.mincount=4&facet.field={!key%3Dscore_d}score_d_p&facet.method=uif} hits=20 status=0 QTime=0
   [junit4]   2> 19109 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.offset=0&facet.sort=count&facet.mincount=4&facet.field=foo_i&facet.method=enum} hits=20 status=0 QTime=0
   [junit4]   2> 19110 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.offset=0&facet.sort=count&facet.mincount=4&facet.field=foo_i&facet.method=fc} hits=20 status=0 QTime=1
   [junit4]   2> 19111 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.offset=0&facet.sort=count&facet.mincount=4&facet.field=foo_i&facet.method=fcs} hits=20 status=0 QTime=0
   [junit4]   2> 19112 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.offset=0&facet.sort=count&facet.mincount=4&facet.field={!key%3Dfoo_i}foo_i_dv} hits=20 status=0 QTime=0
   [junit4]   2> 19112 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.offset=0&facet.sort=count&facet.mincount=4&facet.field=foo_i&facet.method=uif} hits=20 status=0 QTime=0
   [junit4]   2> 19113 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.offset=0&facet.sort=count&facet.mincount=4&facet.field={!key%3Dfoo_i}foo_i_p&facet.method=uif} hits=20 status=0 QTime=0
   [junit4]   2> 19113 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.limit=100&facet.sort=count&facet.mincount=4&facet.field=foo_l&facet.method=enum} hits=20 status=0 QTime=0
   [junit4]   2> 19114 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.limit=100&facet.sort=count&facet.mincount=4&facet.field=foo_l&facet.method=fc} hits=20 status=0 QTime=0
   [junit4]   2> 19114 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.limit=100&facet.sort=count&facet.mincount=4&facet.field=foo_l&facet.method=fcs} hits=20 status=0 QTime=0
   [junit4]   2> 19115 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.limit=100&facet.sort=count&facet.mincount=4&facet.field={!key%3Dfoo_l}foo_l_dv} hits=20 status=0 QTime=0
   [junit4]   2> 19115 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.limit=100&facet.sort=count&facet.mincount=4&facet.field=foo_l&facet.method=uif} hits=20 status=0 QTime=0
   [junit4]   2> 19115 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[BF8D3AA3C41FF310]) [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.limit=100&facet.sort=count&facet.mincount=4&facet.field={!key%3Dfoo_l}foo_l_p&facet.method=uif} hits=20 status=0 QTime=0
   [junit4]   2> 19116 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting

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

   [junit4]   2>         "c",1,
   [junit4]   2>         "d",1]},
   [junit4]   2>     "facet_ranges":{},
   [junit4]   2>     "facet_intervals":{},
   [junit4]   2>     "facet_heatmaps":{}}}
   [junit4]   2> 
   [junit4]   2>  request = facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=count&facet.field=small2_s&facet.method=uif
   [junit4]   2> 22975 INFO  (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[3C1482A918CE99B0]) [     ] o.a.s.SolrTestCaseJ4 ###Ending testRandomFaceting
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestRandomDVFaceting -Dtests.method=testRandomFaceting -Dtests.seed=3C1482A918CE99B0 -Dtests.multiplier=2 -Dtests.slow=true -Dtests.badapples=true -Dtests.locale=mt-MT -Dtests.timezone=Pacific/Truk -Dtests.asserts=true -Dtests.file.encoding=UTF-8
   [junit4] FAILURE 1.23s J3 | TestRandomDVFaceting.testRandomFaceting <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: mismatch: 'b'!='c' @ facet_counts/facet_fields/small2_s/[2]
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([3C1482A918CE99B0:317CA27C4D37510F]:0)
   [junit4]    > 	at org.apache.solr.TestRandomDVFaceting.doFacetTests(TestRandomDVFaceting.java:292)
   [junit4]    > 	at org.apache.solr.TestRandomDVFaceting.doFacetTests(TestRandomDVFaceting.java:175)
   [junit4]    > 	at org.apache.solr.TestRandomDVFaceting.testRandomFaceting(TestRandomDVFaceting.java:158)
   [junit4]    > 	at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> 22976 INFO  (SUITE-TestRandomDVFaceting-seed#[3C1482A918CE99B0]-worker) [     ] o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> 22976 INFO  (SUITE-TestRandomDVFaceting-seed#[3C1482A918CE99B0]-worker) [     ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=177678317
   [junit4]   2> 22976 INFO  (coreCloseExecutor-39-thread-1) [     ] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@777c484a
   [junit4]   2> 22976 INFO  (coreCloseExecutor-39-thread-1) [     ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1 tag=SolrCore@777c484a
   [junit4]   2> 22976 INFO  (coreCloseExecutor-39-thread-1) [     ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1296f665: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1/com.codahale.metrics.MetricRegistry@20084c76
   [junit4]   2> 22989 INFO  (coreCloseExecutor-39-thread-1) [     ] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close()  ... SKIPPED (unnecessary).
   [junit4]   2> 22990 INFO  (SUITE-TestRandomDVFaceting-seed#[3C1482A918CE99B0]-worker) [     ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node tag=null
   [junit4]   2> 22990 INFO  (SUITE-TestRandomDVFaceting-seed#[3C1482A918CE99B0]-worker) [     ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@60242304: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node/com.codahale.metrics.MetricRegistry@7fd85c18
   [junit4]   2> 22995 INFO  (SUITE-TestRandomDVFaceting-seed#[3C1482A918CE99B0]-worker) [     ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm tag=null
   [junit4]   2> 22995 INFO  (SUITE-TestRandomDVFaceting-seed#[3C1482A918CE99B0]-worker) [     ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1370d178: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm/com.codahale.metrics.MetricRegistry@77ea616e
   [junit4]   2> 22995 INFO  (SUITE-TestRandomDVFaceting-seed#[3C1482A918CE99B0]-worker) [     ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty tag=null
   [junit4]   2> 22995 INFO  (SUITE-TestRandomDVFaceting-seed#[3C1482A918CE99B0]-worker) [     ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@659e601e: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty/com.codahale.metrics.MetricRegistry@24d36e49
   [junit4]   2> NOTE: leaving temporary files on disk at: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-repro/solr/build/solr-core/test/J3/temp/solr.TestRandomDVFaceting_3C1482A918CE99B0-002
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene87): {small3_ss=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)), foo_ds_dv=PostingsFormat(name=Asserting), foo_f_dv=PostingsFormat(name=LuceneVarGapDocFreqInterval), small_i=PostingsFormat(name=Asserting), small3_is=PostingsFormat(name=Asserting), small_s=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)), score_f=PostingsFormat(name=Asserting), score_d=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)), id=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)), foo_i=PostingsFormat(name=LuceneVarGapDocFreqInterval), foo_fs_dv=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)), foo_l=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)), small4_ss=PostingsFormat(name=LuceneVarGapDocFreqInterval), small2_s=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)), small2_i=PostingsFormat(name=Asserting), foo_ls_dv=PostingsFormat(name=Asserting), small2_is=PostingsFormat(name=LuceneVarGapDocFreqInterval), foo_ds=FST50, foo_fs=PostingsFormat(name=LuceneVarGapDocFreqInterval), score_f_dv=PostingsFormat(name=LuceneVarGapDocFreqInterval), foo_d_dv=FST50, score_d_dv=FST50, foo_d=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)), small2_ss=FST50, foo_f=PostingsFormat(name=Asserting), foo_l_dv=FST50, foo_ls=FST50}, docValues:{small2_s_dv=DocValuesFormat(name=Lucene80), score_f_p=DocValuesFormat(name=Direct), id_dv=DocValuesFormat(name=Direct), score_d_p=DocValuesFormat(name=Lucene80), small2_is_p=DocValuesFormat(name=Lucene80), small3_is_dv=DocValuesFormat(name=Direct), foo_ds_dv=DocValuesFormat(name=Asserting), foo_f_dv=DocValuesFormat(name=Lucene80), foo_ds_p=DocValuesFormat(name=Asserting), foo_l_p=DocValuesFormat(name=Direct), foo_i_p=DocValuesFormat(name=Asserting), small2_i_dv=DocValuesFormat(name=Direct), small4_ss_dv=DocValuesFormat(name=Lucene80), small_s_dv=DocValuesFormat(name=Direct), foo_i_dv=DocValuesFormat(name=Asserting), small2_ss_dv=DocValuesFormat(name=Asserting), foo_fs_dv=DocValuesFormat(name=Lucene80), small2_is_dv=DocValuesFormat(name=Lucene80), small_i_p=DocValuesFormat(name=Lucene80), small2_i_p=DocValuesFormat(name=Direct), small_i_dv=DocValuesFormat(name=Lucene80), small3_is_p=DocValuesFormat(name=Lucene80), foo_ls_dv=DocValuesFormat(name=Asserting), foo_f_p=DocValuesFormat(name=Lucene80), foo_ls_p=DocValuesFormat(name=Asserting), foo_d_p=DocValuesFormat(name=Direct), foo_fs_p=DocValuesFormat(name=Lucene80), score_f_dv=DocValuesFormat(name=Lucene80), foo_d_dv=DocValuesFormat(name=Direct), score_d_dv=DocValuesFormat(name=Direct), foo_l_dv=DocValuesFormat(name=Direct), small3_ss_dv=DocValuesFormat(name=Lucene80)}, maxPointsInLeafNode=453, maxMBSortInHeap=6.6023126874132325, sim=Asserting(RandomSimilarity(queryNorm=true): {}), locale=mt-MT, timezone=Pacific/Truk
   [junit4]   2> NOTE: Linux 4.15.0-112-generic amd64/Oracle Corporation 1.8.0_252 (64-bit)/cpus=4,threads=1,free=217591328,total=370147328
   [junit4]   2> NOTE: All tests run in this JVM: [TestRandomDVFaceting, TestRandomDVFaceting]
   [junit4] Completed [5/5 (5!)] on J3 in 3.89s, 1 test, 1 failure <<< FAILURES!
   [junit4] 
   [junit4] 
   [junit4] Tests with failures [seed: 3C1482A918CE99B0]:
   [junit4]   - org.apache.solr.TestRandomDVFaceting.testRandomFaceting
   [junit4]   - org.apache.solr.TestRandomDVFaceting.testRandomFaceting
   [junit4]   - org.apache.solr.TestRandomDVFaceting.testRandomFaceting
   [junit4]   - org.apache.solr.TestRandomDVFaceting.testRandomFaceting
   [junit4]   - org.apache.solr.TestRandomDVFaceting.testRandomFaceting
   [junit4] 
   [junit4] 
   [junit4] JVM J0:     0.74 ..    20.57 =    19.82s
   [junit4] JVM J1:     0.74 ..    20.97 =    20.23s
   [junit4] JVM J2:     0.74 ..    20.25 =    19.51s
   [junit4] JVM J3:     0.75 ..    24.17 =    23.42s
   [junit4] Execution time total: 24 seconds
   [junit4] Tests summary: 5 suites, 5 tests, 5 failures

BUILD FAILED
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-repro/lucene/common-build.xml:1599: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-repro/lucene/common-build.xml:1126: There were test failures: 5 suites, 5 tests, 5 failures [seed: 3C1482A918CE99B0]

Total time: 25 seconds

[repro] Setting last failure code to 256

[repro] Failures at the tip of branch_8x without a seed:
[repro]   5/5 failed: org.apache.solr.TestRandomDVFaceting
[repro] git checkout ec9a659845973a0dd0ee7c04e0075db818ed118d
Note: checking out 'ec9a659845973a0dd0ee7c04e0075db818ed118d'.

You are in 'detached HEAD' state. You can look around, make experimental
changes and commit them, and you can discard any commits you make in this
state without impacting any branches by performing another checkout.

If you want to create a new branch to retain commits you create, you may
do so (now or later) by using -b with the checkout command again. Example:

  git checkout -b <new-branch-name>

HEAD is now at ec9a6598459 LUCENE-9322: fix minor cosmetic refactoring error in logging string in IndexWriter's infoStream logging. It was always printing 'vector values' for all merging times instead of the other parts of Lucene index ('doc values', 'stored fields', etc.)
[repro] Exiting with code 256
Archiving artifacts
Recording test results
Build step 'Publish JUnit test result report' changed build result to UNSTABLE
Email was triggered for: Unstable (Test Failures)
Sending email for trigger: Unstable (Test Failures)

Mime
View raw message