Build: https://jenkins.thetaphi.de/job/Lucene-Solr-8.x-Linux/960/
Java: 64bit/jdk-11.0.3 -XX:-UseCompressedOops -XX:+UseG1GC

1 tests failed.
FAILED:  org.apache.solr.search.facet.TestJsonFacets.testErrors {p0=STREAM}

Error Message:


Stack Trace:
java.lang.AssertionError
        at 
__randomizedtesting.SeedInfo.seed([D8987511DDB3CC4B:EBF5D885F243398]:0)
        at org.junit.Assert.fail(Assert.java:86)
        at org.junit.Assert.assertTrue(Assert.java:41)
        at org.junit.Assert.assertTrue(Assert.java:52)
        at 
org.apache.solr.search.facet.TestJsonFacets.doTestErrors(TestJsonFacets.java:3163)
        at 
org.apache.solr.search.facet.TestJsonFacets.testErrors(TestJsonFacets.java:3150)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.base/java.lang.reflect.Method.invoke(Method.java:566)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.base/java.lang.Thread.run(Thread.java:834)




Build Log:
[...truncated 14007 lines...]
   [junit4] Suite: org.apache.solr.search.facet.TestJsonFacets
   [junit4]   2> 573133 INFO  
(SUITE-TestJsonFacets-seed#[D8987511DDB3CC4B]-worker) [     ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 573133 INFO  
(SUITE-TestJsonFacets-seed#[D8987511DDB3CC4B]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Created dataDir: 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.search.facet.TestJsonFacets_D8987511DDB3CC4B-001/data-dir-100-001
   [junit4]   2> 573133 WARN  
(SUITE-TestJsonFacets-seed#[D8987511DDB3CC4B]-worker) [     ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=17 numCloses=17
   [junit4]   2> 573133 INFO  
(SUITE-TestJsonFacets-seed#[D8987511DDB3CC4B]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 573134 INFO  
(SUITE-TestJsonFacets-seed#[D8987511DDB3CC4B]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: 
@org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl="None")
   [junit4]   2> 573141 INFO  
(SUITE-TestJsonFacets-seed#[D8987511DDB3CC4B]-worker) [     ] 
o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 573141 INFO  
(SUITE-TestJsonFacets-seed#[D8987511DDB3CC4B]-worker) [     ] 
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: 
[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/lib,
 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 573153 INFO  
(SUITE-TestJsonFacets-seed#[D8987511DDB3CC4B]-worker) [     ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.3.0
   [junit4]   2> 573165 INFO  
(SUITE-TestJsonFacets-seed#[D8987511DDB3CC4B]-worker) [     ] 
o.a.s.s.IndexSchema [null] Schema name=example
   [junit4]   2> 573197 INFO  
(SUITE-TestJsonFacets-seed#[D8987511DDB3CC4B]-worker) [     ] 
o.a.s.s.IndexSchema Loaded schema example/1.6 with uniqueid field id
   [junit4]   2> 573237 INFO  
(SUITE-TestJsonFacets-seed#[D8987511DDB3CC4B]-worker) [     ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
   [junit4]   2> 573238 WARN  
(SUITE-TestJsonFacets-seed#[D8987511DDB3CC4B]-worker) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@7cb0c65[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 573238 WARN  
(SUITE-TestJsonFacets-seed#[D8987511DDB3CC4B]-worker) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@7cb0c65[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 573240 WARN  
(SUITE-TestJsonFacets-seed#[D8987511DDB3CC4B]-worker) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@36ad16e0[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 573240 WARN  
(SUITE-TestJsonFacets-seed#[D8987511DDB3CC4B]-worker) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@36ad16e0[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 573249 INFO  
(SUITE-TestJsonFacets-seed#[D8987511DDB3CC4B]-worker) [     ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 573249 INFO  
(SUITE-TestJsonFacets-seed#[D8987511DDB3CC4B]-worker) [     ] 
o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history 
in memory.
   [junit4]   2> 573257 INFO  
(SUITE-TestJsonFacets-seed#[D8987511DDB3CC4B]-worker) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5fb0778d
   [junit4]   2> 573261 INFO  
(SUITE-TestJsonFacets-seed#[D8987511DDB3CC4B]-worker) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5fb0778d
   [junit4]   2> 573262 INFO  
(SUITE-TestJsonFacets-seed#[D8987511DDB3CC4B]-worker) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5fb0778d
   [junit4]   2> 573263 INFO  (coreLoadExecutor-4514-thread-1) [    
x:collection1 ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, 
from paths: 
[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/lib,
 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 573275 INFO  (coreLoadExecutor-4514-thread-1) [    
x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.3.0
   [junit4]   2> 573288 INFO  (coreLoadExecutor-4514-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema [collection1] Schema name=example
   [junit4]   2> 573319 INFO  (coreLoadExecutor-4514-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema Loaded schema example/1.6 with uniqueid 
field id
   [junit4]   2> 573323 INFO  (coreLoadExecutor-4514-thread-1) [    
x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from instancedir 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1,
 trusted=true
   [junit4]   2> 573323 INFO  (coreLoadExecutor-4514-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@5fb0778d
   [junit4]   2> 573323 INFO  (coreLoadExecutor-4514-thread-1) [    
x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.search.facet.TestJsonFacets_D8987511DDB3CC4B-001/data-dir-100-001/]
   [junit4]   2> 573324 INFO  (coreLoadExecutor-4514-thread-1) [    
x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=20, maxMergeAtOnceExplicit=39, maxMergedSegmentMB=36.189453125, 
floorSegmentMB=1.376953125, forceMergeDeletesPctAllowed=26.143291069956067, 
segmentsPerTier=13.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.4105741823343425, deletesPctAllowed=25.061599473205753
   [junit4]   2> 573325 WARN  (coreLoadExecutor-4514-thread-1) [    
x:collection1 ] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler 
{type = requestHandler,name = /dump,class = DumpRequestHandler,attributes = 
{initParams=a, name=/dump, class=DumpRequestHandler},args = 
{defaults={a=A,b=B}}}
   [junit4]   2> 573346 INFO  (coreLoadExecutor-4514-thread-1) [    
x:collection1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 573346 INFO  (coreLoadExecutor-4514-thread-1) [    
x:collection1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 573353 INFO  (coreLoadExecutor-4514-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 573353 INFO  (coreLoadExecutor-4514-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 573353 INFO  (coreLoadExecutor-4514-thread-1) [    
x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=16, maxMergeAtOnceExplicit=39, maxMergedSegmentMB=86.2236328125, 
floorSegmentMB=1.486328125, forceMergeDeletesPctAllowed=12.527092357664408, 
segmentsPerTier=14.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.7612272982392201, deletesPctAllowed=47.37578688703414
   [junit4]   2> 573354 INFO  (coreLoadExecutor-4514-thread-1) [    
x:collection1 ] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@e0894c7[collection1] main]
   [junit4]   2> 573354 WARN  (coreLoadExecutor-4514-thread-1) [    
x:collection1 ] o.a.s.r.ManagedResourceStorage Cannot write to config directory 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/conf;
 switching to use InMemory storage instead.
   [junit4]   2> 573354 INFO  (coreLoadExecutor-4514-thread-1) [    
x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 573354 INFO  (coreLoadExecutor-4514-thread-1) [    
x:collection1 ] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1640786907183972352
   [junit4]   2> 573356 INFO  
(searcherExecutor-4515-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@e0894c7[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 573356 INFO  
(SUITE-TestJsonFacets-seed#[D8987511DDB3CC4B]-worker) [     ] 
o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 573359 INFO  
(TEST-TestJsonFacets.testErrors-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.SolrTestCaseJ4 ###Starting testErrors {p0=ENUM}
   [junit4]   2> 573360 INFO  
(TEST-TestJsonFacets.testErrors-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{deleteByQuery=*:* (-1640786907189215232)} 0 1
   [junit4]   2> 573365 INFO  
(TEST-TestJsonFacets.testErrors-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 573365 INFO  
(TEST-TestJsonFacets.testErrors-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={ignore_exception=true&q=*:*&json.facet={f:{type:ignore_exception_aaa,+field:bbbbbb}}&wt=json&indent=true}
 status=400 QTime=3
   [junit4]   2> 573365 INFO  
(TEST-TestJsonFacets.testErrors-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.SolrTestCaseJ4 ###Ending testErrors {p0=ENUM}
   [junit4]   2> 573368 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.SolrTestCaseJ4 ###Starting testOverrequest {p0=ENUM}
   [junit4]   2> 573377 WARN  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
   [junit4]   2> 573377 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
   [junit4]   2> 573377 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 573377 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.e.j.s.Server jetty-9.4.19.v20190610; built: 2019-06-10T16:30:51.723Z; git: 
afcf563148970e98786327af5e07c261fda175d3; jvm 11.0.3+7
   [junit4]   2> 573412 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 573412 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 573412 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 573412 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@5e4d62a1{/solr,null,AVAILABLE}
   [junit4]   2> 573413 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.e.j.s.AbstractConnector Started ServerConnector@7a8c0fa6{HTTP/1.1,[http/1.1, 
h2c]}{127.0.0.1:42691}
   [junit4]   2> 573413 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.e.j.s.Server Started @573442ms
   [junit4]   2> 573413 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {schema=schema_latest.xml, 
hostContext=/solr, solrconfig=solrconfig-tlog.xml, hostPort=42691}
   [junit4]   2> 573413 ERROR 
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 573413 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 573413 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.3.0
   [junit4]   2> 573413 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 573413 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 573413 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2019-08-02T20:05:32.136424Z
   [junit4]   2> 573413 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.search.facet.TestJsonFacets_D8987511DDB3CC4B-001/s0-001/solr.xml
   [junit4]   2> 573415 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay 
is ignored
   [junit4]   2> 573415 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 573416 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@5fb0778d, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 573462 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
   [junit4]   2> 573462 WARN  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@2d1d7afe[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 573462 WARN  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@2d1d7afe[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 573464 WARN  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@df4f522[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 573464 WARN  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@df4f522[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 573476 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 573476 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history 
in memory.
   [junit4]   2> 573490 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5fb0778d
   [junit4]   2> 573498 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5fb0778d
   [junit4]   2> 573498 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5fb0778d
   [junit4]   2> 573500 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.search.facet.TestJsonFacets_D8987511DDB3CC4B-001/s0-001/.
   [junit4]   2> 573500 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 573504 INFO  (coreLoadExecutor-4528-thread-1) [    
x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.3.0
   [junit4]   2> 573514 INFO  (coreLoadExecutor-4528-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema [collection1] Schema name=example
   [junit4]   2> 573549 INFO  (coreLoadExecutor-4528-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema Loaded schema example/1.6 with uniqueid 
field id
   [junit4]   2> 573554 INFO  (coreLoadExecutor-4528-thread-1) [    
x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from instancedir 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.search.facet.TestJsonFacets_D8987511DDB3CC4B-001/s0-001/./collection1,
 trusted=true
   [junit4]   2> 573554 INFO  (coreLoadExecutor-4528-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@5fb0778d
   [junit4]   2> 573555 INFO  (coreLoadExecutor-4528-thread-1) [    
x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.search.facet.TestJsonFacets_D8987511DDB3CC4B-001/s0-001/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.search.facet.TestJsonFacets_D8987511DDB3CC4B-001/s0-001/./collection1/data/]
   [junit4]   2> 573556 INFO  (coreLoadExecutor-4528-thread-1) [    
x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=20, maxMergeAtOnceExplicit=39, maxMergedSegmentMB=36.189453125, 
floorSegmentMB=1.376953125, forceMergeDeletesPctAllowed=26.143291069956067, 
segmentsPerTier=13.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.4105741823343425, deletesPctAllowed=25.061599473205753
   [junit4]   2> 573557 WARN  (coreLoadExecutor-4528-thread-1) [    
x:collection1 ] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler 
{type = requestHandler,name = /dump,class = DumpRequestHandler,attributes = 
{initParams=a, name=/dump, class=DumpRequestHandler},args = 
{defaults={a=A,b=B}}}
   [junit4]   2> 573584 INFO  (coreLoadExecutor-4528-thread-1) [    
x:collection1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 573584 INFO  (coreLoadExecutor-4528-thread-1) [    
x:collection1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 573585 INFO  (coreLoadExecutor-4528-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 573585 INFO  (coreLoadExecutor-4528-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 573585 INFO  (coreLoadExecutor-4528-thread-1) [    
x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=16, maxMergeAtOnceExplicit=39, maxMergedSegmentMB=86.2236328125, 
floorSegmentMB=1.486328125, forceMergeDeletesPctAllowed=12.527092357664408, 
segmentsPerTier=14.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.7612272982392201, deletesPctAllowed=47.37578688703414
   [junit4]   2> 573586 INFO  (coreLoadExecutor-4528-thread-1) [    
x:collection1 ] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@133a088f[collection1] main]
   [junit4]   2> 573586 INFO  (coreLoadExecutor-4528-thread-1) [    
x:collection1 ] o.a.s.r.ManagedResourceStorage File-based storage initialized 
to use dir: 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.search.facet.TestJsonFacets_D8987511DDB3CC4B-001/s0-001/collection1/conf
   [junit4]   2> 573586 INFO  (coreLoadExecutor-4528-thread-1) [    
x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 573586 INFO  (coreLoadExecutor-4528-thread-1) [    
x:collection1 ] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1640786907427241984
   [junit4]   2> 573588 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.SolrTestCaseHS ===> Started solr server port=42691 
home=/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.search.facet.TestJsonFacets_D8987511DDB3CC4B-001/s0-001
   [junit4]   2> 573589 INFO  
(searcherExecutor-4529-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@133a088f[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 573593 WARN  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
   [junit4]   2> 573593 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
   [junit4]   2> 573593 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 573593 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.e.j.s.Server jetty-9.4.19.v20190610; built: 2019-06-10T16:30:51.723Z; git: 
afcf563148970e98786327af5e07c261fda175d3; jvm 11.0.3+7
   [junit4]   2> 573596 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 573596 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 573596 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 573596 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@1af1d395{/solr,null,AVAILABLE}
   [junit4]   2> 573596 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.e.j.s.AbstractConnector Started ServerConnector@1cc4f923{HTTP/1.1,[http/1.1, 
h2c]}{127.0.0.1:40467}
   [junit4]   2> 573596 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.e.j.s.Server Started @573625ms
   [junit4]   2> 573596 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {schema=schema_latest.xml, 
hostContext=/solr, solrconfig=solrconfig-tlog.xml, hostPort=40467}
   [junit4]   2> 573597 ERROR 
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 573597 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 573597 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.3.0
   [junit4]   2> 573597 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 573597 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 573597 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2019-08-02T20:05:32.320172Z
   [junit4]   2> 573597 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.search.facet.TestJsonFacets_D8987511DDB3CC4B-001/s1-001/solr.xml
   [junit4]   2> 573605 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay 
is ignored
   [junit4]   2> 573605 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 573606 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@5fb0778d, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 573691 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
   [junit4]   2> 573692 WARN  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@2dc1fe46[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 573692 WARN  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@2dc1fe46[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 573693 WARN  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@7f3030ee[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 573693 WARN  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@7f3030ee[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 573703 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 573704 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history 
in memory.
   [junit4]   2> 573715 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5fb0778d
   [junit4]   2> 573723 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5fb0778d
   [junit4]   2> 573723 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5fb0778d
   [junit4]   2> 573724 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.search.facet.TestJsonFacets_D8987511DDB3CC4B-001/s1-001/.
   [junit4]   2> 573724 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 573728 INFO  (coreLoadExecutor-4542-thread-1) [    
x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.3.0
   [junit4]   2> 573736 INFO  (coreLoadExecutor-4542-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema [collection1] Schema name=example
   [junit4]   2> 573770 INFO  (coreLoadExecutor-4542-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema Loaded schema example/1.6 with uniqueid 
field id
   [junit4]   2> 573775 INFO  (coreLoadExecutor-4542-thread-1) [    
x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from instancedir 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.search.facet.TestJsonFacets_D8987511DDB3CC4B-001/s1-001/./collection1,
 trusted=true
   [junit4]   2> 573775 INFO  (coreLoadExecutor-4542-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@5fb0778d
   [junit4]   2> 573775 INFO  (coreLoadExecutor-4542-thread-1) [    
x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.search.facet.TestJsonFacets_D8987511DDB3CC4B-001/s1-001/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.search.facet.TestJsonFacets_D8987511DDB3CC4B-001/s1-001/./collection1/data/]
   [junit4]   2> 573776 INFO  (coreLoadExecutor-4542-thread-1) [    
x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=20, maxMergeAtOnceExplicit=39, maxMergedSegmentMB=36.189453125, 
floorSegmentMB=1.376953125, forceMergeDeletesPctAllowed=26.143291069956067, 
segmentsPerTier=13.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.4105741823343425, deletesPctAllowed=25.061599473205753
   [junit4]   2> 573777 WARN  (coreLoadExecutor-4542-thread-1) [    
x:collection1 ] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler 
{type = requestHandler,name = /dump,class = DumpRequestHandler,attributes = 
{initParams=a, name=/dump, class=DumpRequestHandler},args = 
{defaults={a=A,b=B}}}
   [junit4]   2> 573800 INFO  (coreLoadExecutor-4542-thread-1) [    
x:collection1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 573800 INFO  (coreLoadExecutor-4542-thread-1) [    
x:collection1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 573802 INFO  (coreLoadExecutor-4542-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 573802 INFO  (coreLoadExecutor-4542-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 573802 INFO  (coreLoadExecutor-4542-thread-1) [    
x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=16, maxMergeAtOnceExplicit=39, maxMergedSegmentMB=86.2236328125, 
floorSegmentMB=1.486328125, forceMergeDeletesPctAllowed=12.527092357664408, 
segmentsPerTier=14.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.7612272982392201, deletesPctAllowed=47.37578688703414
   [junit4]   2> 573803 INFO  (coreLoadExecutor-4542-thread-1) [    
x:collection1 ] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@29f92084[collection1] main]
   [junit4]   2> 573803 INFO  (coreLoadExecutor-4542-thread-1) [    
x:collection1 ] o.a.s.r.ManagedResourceStorage File-based storage initialized 
to use dir: 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.search.facet.TestJsonFacets_D8987511DDB3CC4B-001/s1-001/collection1/conf
   [junit4]   2> 573803 INFO  (coreLoadExecutor-4542-thread-1) [    
x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 573803 INFO  (coreLoadExecutor-4542-thread-1) [    
x:collection1 ] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1640786907654782976
   [junit4]   2> 573804 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.SolrTestCaseHS ===> Started solr server port=40467 
home=/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.search.facet.TestJsonFacets_D8987511DDB3CC4B-001/s1-001
   [junit4]   2> 573805 INFO  
(searcherExecutor-4543-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@29f92084[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 573811 WARN  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
   [junit4]   2> 573812 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
   [junit4]   2> 573812 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 573812 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.e.j.s.Server jetty-9.4.19.v20190610; built: 2019-06-10T16:30:51.723Z; git: 
afcf563148970e98786327af5e07c261fda175d3; jvm 11.0.3+7
   [junit4]   2> 573813 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 573813 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 573813 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 573813 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@586ce9f3{/solr,null,AVAILABLE}
   [junit4]   2> 573813 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.e.j.s.AbstractConnector Started ServerConnector@6c31f155{HTTP/1.1,[http/1.1, 
h2c]}{127.0.0.1:45959}
   [junit4]   2> 573813 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.e.j.s.Server Started @573842ms
   [junit4]   2> 573813 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {schema=schema_latest.xml, 
hostContext=/solr, solrconfig=solrconfig-tlog.xml, hostPort=45959}
   [junit4]   2> 573814 ERROR 
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 573814 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 573814 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.3.0
   [junit4]   2> 573814 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 573814 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 573814 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2019-08-02T20:05:32.537077Z
   [junit4]   2> 573814 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.search.facet.TestJsonFacets_D8987511DDB3CC4B-001/s2-001/solr.xml
   [junit4]   2> 573815 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay 
is ignored
   [junit4]   2> 573815 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 573816 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@5fb0778d, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 574084 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
   [junit4]   2> 574084 WARN  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@7f42714b[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 574084 WARN  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@7f42714b[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 574086 WARN  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@7d2bcfda[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 574086 WARN  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@7d2bcfda[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 574095 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 574095 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history 
in memory.
   [junit4]   2> 574106 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5fb0778d
   [junit4]   2> 574114 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5fb0778d
   [junit4]   2> 574114 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5fb0778d
   [junit4]   2> 574115 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.search.facet.TestJsonFacets_D8987511DDB3CC4B-001/s2-001/.
   [junit4]   2> 574115 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 574119 INFO  (coreLoadExecutor-4556-thread-1) [    
x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.3.0
   [junit4]   2> 574128 INFO  (coreLoadExecutor-4556-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema [collection1] Schema name=example
   [junit4]   2> 574160 INFO  (coreLoadExecutor-4556-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema Loaded schema example/1.6 with uniqueid 
field id
   [junit4]   2> 574165 INFO  (coreLoadExecutor-4556-thread-1) [    
x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from instancedir 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.search.facet.TestJsonFacets_D8987511DDB3CC4B-001/s2-001/./collection1,
 trusted=true
   [junit4]   2> 574165 INFO  (coreLoadExecutor-4556-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@5fb0778d
   [junit4]   2> 574165 INFO  (coreLoadExecutor-4556-thread-1) [    
x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.search.facet.TestJsonFacets_D8987511DDB3CC4B-001/s2-001/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.search.facet.TestJsonFacets_D8987511DDB3CC4B-001/s2-001/./collection1/data/]
   [junit4]   2> 574166 INFO  (coreLoadExecutor-4556-thread-1) [    
x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=20, maxMergeAtOnceExplicit=39, maxMergedSegmentMB=36.189453125, 
floorSegmentMB=1.376953125, forceMergeDeletesPctAllowed=26.143291069956067, 
segmentsPerTier=13.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.4105741823343425, deletesPctAllowed=25.061599473205753
   [junit4]   2> 574167 WARN  (coreLoadExecutor-4556-thread-1) [    
x:collection1 ] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler 
{type = requestHandler,name = /dump,class = DumpRequestHandler,attributes = 
{initParams=a, name=/dump, class=DumpRequestHandler},args = 
{defaults={a=A,b=B}}}
   [junit4]   2> 574187 INFO  (coreLoadExecutor-4556-thread-1) [    
x:collection1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 574187 INFO  (coreLoadExecutor-4556-thread-1) [    
x:collection1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 574196 INFO  (coreLoadExecutor-4556-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 574196 INFO  (coreLoadExecutor-4556-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 574196 INFO  (coreLoadExecutor-4556-thread-1) [    
x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=16, maxMergeAtOnceExplicit=39, maxMergedSegmentMB=86.2236328125, 
floorSegmentMB=1.486328125, forceMergeDeletesPctAllowed=12.527092357664408, 
segmentsPerTier=14.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.7612272982392201, deletesPctAllowed=47.37578688703414
   [junit4]   2> 574197 INFO  (coreLoadExecutor-4556-thread-1) [    
x:collection1 ] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@34fce4da[collection1] main]
   [junit4]   2> 574197 INFO  (coreLoadExecutor-4556-thread-1) [    
x:collection1 ] o.a.s.r.ManagedResourceStorage File-based storage initialized 
to use dir: 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.search.facet.TestJsonFacets_D8987511DDB3CC4B-001/s2-001/collection1/conf
   [junit4]   2> 574197 INFO  (coreLoadExecutor-4556-thread-1) [    
x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 574197 INFO  (coreLoadExecutor-4556-thread-1) [    
x:collection1 ] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1640786908067921920
   [junit4]   2> 574198 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.SolrTestCaseHS ===> Started solr server port=45959 
home=/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.search.facet.TestJsonFacets_D8987511DDB3CC4B-001/s2-001
   [junit4]   2> 574199 INFO  
(searcherExecutor-4557-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@34fce4da[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 574206 INFO  (qtp1409131898-12095) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{deleteByQuery=*:* (-1640786908076310528)} 0 1
   [junit4]   2> 574209 INFO  (qtp1906243960-12115) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{deleteByQuery=*:* (-1640786908079456256)} 0 1
   [junit4]   2> 574211 INFO  (qtp2119721103-12135) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{deleteByQuery=*:* (-1640786908081553408)} 0 1
   [junit4]   2> 574212 INFO  (qtp1409131898-12096) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[1 (1640786908083650560)]} 0 0
   [junit4]   2> 574213 INFO  (qtp1409131898-12094) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[2 (1640786908084699136)]} 0 0
   [junit4]   2> 574214 INFO  (qtp1906243960-12116) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[3 (1640786908085747712)]} 0 0
   [junit4]   2> 574214 INFO  (qtp1906243960-12114) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[4 (1640786908085747713)]} 0 0
   [junit4]   2> 574215 INFO  (qtp2119721103-12136) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[5 (1640786908086796288)]} 0 0
   [junit4]   2> 574215 INFO  (qtp2119721103-12134) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[6 (1640786908086796289)]} 0 0
   [junit4]   2> 574216 INFO  (qtp1409131898-12095) [    x:collection1 ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1640786908087844864,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 574216 INFO  (qtp1409131898-12095) [    x:collection1 ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@66ec1c25 
commitCommandVersion:1640786908087844864
   [junit4]   2> 574218 INFO  (qtp1409131898-12095) [    x:collection1 ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@47d1192c[collection1] main]
   [junit4]   2> 574218 INFO  (qtp1409131898-12095) [    x:collection1 ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 574220 INFO  
(searcherExecutor-4529-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@47d1192c[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.3.0):C2:[diagnostics={os=Linux,
 java.vendor=AdoptOpenJDK, java.version=11.0.3, java.vm.version=11.0.3+7, 
lucene.version=8.3.0, os.arch=amd64, java.runtime.version=11.0.3+7, 
source=flush, os.version=4.18.0-25-generic, 
timestamp=1564776332940}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
   [junit4]   2> 574220 INFO  (qtp1409131898-12095) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 4
   [junit4]   2> 574221 INFO  (qtp1906243960-12115) [    x:collection1 ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1640786908093087744,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 574221 INFO  (qtp1906243960-12115) [    x:collection1 ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@14c96671 
commitCommandVersion:1640786908093087744
   [junit4]   2> 574222 INFO  (qtp1906243960-12115) [    x:collection1 ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@4f570fa2[collection1] main]
   [junit4]   2> 574223 INFO  (qtp1906243960-12115) [    x:collection1 ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 574224 INFO  
(searcherExecutor-4543-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@4f570fa2[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.3.0):C2:[diagnostics={os=Linux,
 java.vendor=AdoptOpenJDK, java.version=11.0.3, java.vm.version=11.0.3+7, 
lucene.version=8.3.0, os.arch=amd64, java.runtime.version=11.0.3+7, 
source=flush, os.version=4.18.0-25-generic, 
timestamp=1564776332944}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
   [junit4]   2> 574224 INFO  (qtp1906243960-12115) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 3
   [junit4]   2> 574224 INFO  (qtp2119721103-12135) [    x:collection1 ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1640786908096233472,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 574224 INFO  (qtp2119721103-12135) [    x:collection1 ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@22ba1f4d 
commitCommandVersion:1640786908096233472
   [junit4]   2> 574226 INFO  (qtp2119721103-12135) [    x:collection1 ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@4796a8c9[collection1] main]
   [junit4]   2> 574226 INFO  (qtp2119721103-12135) [    x:collection1 ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 574227 INFO  
(searcherExecutor-4557-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@4796a8c9[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.3.0):C2:[diagnostics={os=Linux,
 java.vendor=AdoptOpenJDK, java.version=11.0.3, java.vm.version=11.0.3+7, 
lucene.version=8.3.0, os.arch=amd64, java.runtime.version=11.0.3+7, 
source=flush, os.version=4.18.0-25-generic, 
timestamp=1564776332948}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
   [junit4]   2> 574227 INFO  (qtp2119721103-12135) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 2
   [junit4]   2> 574255 INFO  (qtp2119721103-12135) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/select 
params={df=text&distrib=false&_facet_={}&fl=id&fl=score&shards.purpose=1048580&start=0&fsv=true&cat_s=cat_s&shard.url=127.0.0.1:45959/solr/collection1&rows=10&version=2&q=*:*&json.facet={cat0:{type:terms,+field:cat_s,+sort:'count+desc',+limit:1,+overrequest:0},cat1:{type:terms,+field:cat_s,+sort:'count+desc',+limit:1,+overrequest:1},catDef:{type:terms,+field:cat_s,+sort:'count+desc',+limit:1,+overrequest:-1},catBig:{type:terms,+field:cat_s,+sort:'count+desc',+offset:1,+limit:2147483647,+overrequest:2147483647}}&omitHeader=false&NOW=1564776332951&isShard=true&wt=javabin}
 hits=2 status=0 QTime=20
   [junit4]   2> 574255 INFO  (qtp1409131898-12095) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/select 
params={df=text&distrib=false&_facet_={}&fl=id&fl=score&shards.purpose=1048580&start=0&fsv=true&cat_s=cat_s&shard.url=127.0.0.1:42691/solr/collection1&rows=10&version=2&q=*:*&json.facet={cat0:{type:terms,+field:cat_s,+sort:'count+desc',+limit:1,+overrequest:0},cat1:{type:terms,+field:cat_s,+sort:'count+desc',+limit:1,+overrequest:1},catDef:{type:terms,+field:cat_s,+sort:'count+desc',+limit:1,+overrequest:-1},catBig:{type:terms,+field:cat_s,+sort:'count+desc',+offset:1,+limit:2147483647,+overrequest:2147483647}}&omitHeader=false&NOW=1564776332951&isShard=true&wt=javabin}
 hits=2 status=0 QTime=20
   [junit4]   2> 574255 INFO  (qtp1906243960-12114) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/select 
params={df=text&distrib=false&_facet_={}&fl=id&fl=score&shards.purpose=1048580&start=0&fsv=true&cat_s=cat_s&shard.url=127.0.0.1:40467/solr/collection1&rows=10&version=2&q=*:*&json.facet={cat0:{type:terms,+field:cat_s,+sort:'count+desc',+limit:1,+overrequest:0},cat1:{type:terms,+field:cat_s,+sort:'count+desc',+limit:1,+overrequest:1},catDef:{type:terms,+field:cat_s,+sort:'count+desc',+limit:1,+overrequest:-1},catBig:{type:terms,+field:cat_s,+sort:'count+desc',+offset:1,+limit:2147483647,+overrequest:2147483647}}&omitHeader=false&NOW=1564776332951&isShard=true&wt=javabin}
 hits=2 status=0 QTime=20
   [junit4]   2> 574259 INFO  (qtp1906243960-12115) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/select 
params={q=*:*&df=text&distrib=false&omitHeader=false&shards.purpose=64&NOW=1564776332951&ids=3,4&isShard=true&cat_s=cat_s&shard.url=127.0.0.1:40467/solr/collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 574259 INFO  (qtp1409131898-12096) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/select 
params={q=*:*&df=text&distrib=false&omitHeader=false&shards.purpose=64&NOW=1564776332951&ids=1,2&isShard=true&cat_s=cat_s&shard.url=127.0.0.1:42691/solr/collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 574259 INFO  (qtp2119721103-12136) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/select 
params={q=*:*&df=text&distrib=false&omitHeader=false&shards.purpose=64&NOW=1564776332951&ids=5,6&isShard=true&cat_s=cat_s&shard.url=127.0.0.1:45959/solr/collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 574260 INFO  (qtp1906243960-12116) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/select 
params={shards=127.0.0.1:42691/solr/collection1,127.0.0.1:40467/solr/collection1,127.0.0.1:45959/solr/collection1&shards=debugQuery&shards=true&q=*:*&json.facet={cat0:{type:terms,+field:${cat_s},+sort:'count+desc',+limit:1,+overrequest:0},cat1:{type:terms,+field:${cat_s},+sort:'count+desc',+limit:1,+overrequest:1},catDef:{type:terms,+field:${cat_s},+sort:'count+desc',+limit:1,+overrequest:-1},catBig:{type:terms,+field:${cat_s},+sort:'count+desc',+offset:1,+limit:2147483647,+overrequest:2147483647}}&indent=true&cat_s=cat_s&wt=json&version=2.2}
 hits=6 status=0 QTime=31
   [junit4]   2> 574264 INFO  
(TEST-TestJsonFacets.testOverrequest-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.SolrTestCaseJ4 ###Ending testOverrequest {p0=ENUM}
   [junit4]   2> 574287 INFO  
(TEST-TestJsonFacets.testDomainGraph-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.SolrTestCaseJ4 ###Starting testDomainGraph {p0=ENUM}
   [junit4]   2> 574288 INFO  
(TEST-TestJsonFacets.testDomainGraph-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{deleteByQuery=*:* (-1640786908162293760)} 0 0
   [junit4]   2> 574289 INFO  
(TEST-TestJsonFacets.testDomainGraph-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[1 (1640786908164390912)]} 0 0
   [junit4]   2> 574290 INFO  
(TEST-TestJsonFacets.testDomainGraph-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[2 (1640786908165439488)]} 0 0
   [junit4]   2> 574290 INFO  
(TEST-TestJsonFacets.testDomainGraph-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[3 (1640786908165439489)]} 0 0
   [junit4]   2> 574290 INFO  
(TEST-TestJsonFacets.testDomainGraph-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1640786908165439490,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 574290 INFO  
(TEST-TestJsonFacets.testDomainGraph-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@2db9f8be 
commitCommandVersion:1640786908165439490
   [junit4]   2> 574297 INFO  
(TEST-TestJsonFacets.testDomainGraph-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@45fb83df[collection1] main]
   [junit4]   2> 574297 INFO  
(TEST-TestJsonFacets.testDomainGraph-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 574298 INFO  (searcherExecutor-4515-thread-1) [     ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@45fb83df[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.3.0):C3:[diagnostics={os=Linux,
 java.vendor=AdoptOpenJDK, java.version=11.0.3, java.vm.version=11.0.3+7, 
lucene.version=8.3.0, os.arch=amd64, java.runtime.version=11.0.3+7, 
source=flush, os.version=4.18.0-25-generic, 
timestamp=1564776333015}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
   [junit4]   2> 574298 INFO  
(TEST-TestJsonFacets.testDomainGraph-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{commit=} 0 8
   [junit4]   2> 574299 INFO  
(TEST-TestJsonFacets.testDomainGraph-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[4 (1640786908173828096)]} 0 0
   [junit4]   2> 574300 INFO  
(TEST-TestJsonFacets.testDomainGraph-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[5 (1640786908174876672)]} 0 0
   [junit4]   2> 574300 INFO  
(TEST-TestJsonFacets.testDomainGraph-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1640786908175925248,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 574300 INFO  
(TEST-TestJsonFacets.testDomainGraph-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@2db9f8be 
commitCommandVersion:1640786908175925248
   [junit4]   2> 574303 INFO  
(TEST-TestJsonFacets.testDomainGraph-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@2bc5d10f[collection1] main]
   [junit4]   2> 574303 INFO  
(TEST-TestJsonFacets.testDomainGraph-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 574304 INFO  (searcherExecutor-4515-thread-1) [     ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@2bc5d10f[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.3.0):C3:[diagnostics={os=Linux,
 java.vendor=AdoptOpenJDK, java.version=11.0.3, java.vm.version=11.0.3+7, 
lucene.version=8.3.0, os.arch=amd64, java.runtime.version=11.0.3+7, 
source=flush, os.version=4.18.0-25-generic, 
timestamp=1564776333015}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])
 Uninverting(_1(8.3.0):C2:[diagnostics={os=Linux, java.vendor=AdoptOpenJDK, 
java.version=11.0.3, java.vm.version=11.0.3+7, lucene.version=8.3.0, 
os.arch=amd64, java.runtime.version=11.0.3+7, source=flush, 
os.version=4.18.0-25-generic, 
timestamp=1564776333024}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
   [junit4]   2> 574304 INFO  
(TEST-TestJsonFacets.testDomainGraph-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{commit=} 0 4
   [junit4]   2> 574305 INFO  
(TEST-TestJsonFacets.testDomainGraph-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[6 (1640786908181168128)]} 0 0
   [junit4]   2> 574306 INFO  
(TEST-TestJsonFacets.testDomainGraph-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1640786908182216704,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 574306 INFO  
(TEST-TestJsonFacets.testDomainGraph-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@2db9f8be 
commitCommandVersion:1640786908182216704
   [junit4]   2> 574309 INFO  
(TEST-TestJsonFacets.testDomainGraph-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@6513dcfc[collection1] main]
   [junit4]   2> 574309 INFO  
(TEST-TestJsonFacets.testDomainGraph-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 574310 INFO  (searcherExecutor-4515-thread-1) [     ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@6513dcfc[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.3.0):C3:[diagnostics={os=Linux,
 java.vendor=AdoptOpenJDK, java.version=11.0.3, java.vm.version=11.0.3+7, 
lucene.version=8.3.0, os.arch=amd64, java.runtime.version=11.0.3+7, 
source=flush, os.version=4.18.0-25-generic, 
timestamp=1564776333015}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])
 Uninverting(_1(8.3.0):C2:[diagnostics={os=Linux, java.vendor=AdoptOpenJDK, 
java.version=11.0.3, java.vm.version=11.0.3+7, lucene.version=8.3.0, 
os.arch=amd64, java.runtime.version=11.0.3+7, source=flush, 
os.version=4.18.0-25-generic, 
timestamp=1564776333024}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])
 Uninverting(_2(8.3.0):C1:[diagnostics={os=Linux, java.vendor=AdoptOpenJDK, 
java.version=11.0.3, java.vm.version=11.0.3+7, lucene.version=8.3.0, 
os.arch=amd64, java.runtime.version=11.0.3+7, source=flush, 
os.version=4.18.0-25-generic, 
timestamp=1564776333030}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
   [junit4]   2> 574310 INFO  
(TEST-TestJsonFacets.testDomainGraph-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{commit=} 0 4
   [junit4]   2> 574321 INFO  
(TEST-TestJsonFacets.testDomainGraph-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&json.facet={x:+{+type:+terms,+field:+'num_i',+++++++facet:+{+y:+{+domain:+{+graph:+{+from:+'cat_s',+to:+'cat_s'+}+},+++++++++++++++++++++type:+terms,+field:+'where_s'+++++++++++++++++++}+}+}+}&rows=0&wt=xml}
 hits=6 status=0 QTime=10
   [junit4]   2> 574323 INFO  
(TEST-TestJsonFacets.testDomainGraph-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&json.facet={x:+{+type:+terms,+field:+'num_i',+++++++facet:+{+y:+{+domain:+{+graph:+{+from:+'cat_s',+to:+'cat_s',+traversalFilter:+'where_s:NY'+}+},+++++++++++++++++++++type:+terms,+field:+'where_s'+++++++++++++++++++}+}+}+}&rows=0&wt=xml}
 hits=6 status=0 QTime=1
   [junit4]   2> 574323 INFO  
(TEST-TestJsonFacets.testDomainGraph-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.SolrTestCaseJ4 ###Ending testDomainGraph {p0=ENUM}
   [junit4]   2> 574330 INFO  
(TEST-TestJsonFacets.testBlockJoin-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.SolrTestCaseJ4 ###Starting testBlockJoin {p0=ENUM}
   [junit4]   2> 574331 INFO  
(TEST-TestJsonFacets.testBlockJoin-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@eca890b[collection1] realtime]
   [junit4]   2> 574331 INFO  
(TEST-TestJsonFacets.testBlockJoin-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{deleteByQuery=*:* (-1640786908207382528)} 0 1
   [junit4]   2> 574332 INFO  
(TEST-TestJsonFacets.testBlockJoin-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[1 (1640786908209479680)]} 0 0
   [junit4]   2> 574332 INFO  
(TEST-TestJsonFacets.testBlockJoin-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[2 (1640786908209479681)]} 0 0
   [junit4]   2> 574333 INFO  
(TEST-TestJsonFacets.testBlockJoin-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[3 (1640786908210528256)]} 0 0
   [junit4]   2> 574333 INFO  
(TEST-TestJsonFacets.testBlockJoin-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={versions=true&wt=json&indent=true}{add=[4 (1640786908210528257)]} 0 0
   [junit4]   2> 574333 INFO  
(TEST-TestJsonFacets.testBlockJoin-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1640786908210528258,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 574333 INFO  
(TEST-TestJsonFacets.testBlockJoin-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@2db9f8be 
commitCommandVersion:1640786908210528258
   [junit4]   2> 574335 INFO  
(TEST-TestJsonFacets.testBlockJoin-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@4ff42933[collection1] main]
   [junit4]   2> 574336 INFO  
(TEST-TestJsonFacets.testBlockJoin-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 574337 INFO  (searcherExecutor-4515-thread-1) [     ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@4ff42933[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_3(8.3.0):C10:[diagnostics={os=Linux,
 java.vendor=AdoptOpenJDK, java.version=11.0.3, java.vm.version=11.0.3+7, 
lucene.version=8.3.0, os.arch=amd64, java.runtime.version=11.0.3+7, 
source=flush, os.version=4.18.0-25-generic, 
timestamp=1564776333057}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
   [junit4]   2> 574337 INFO  
(TEST-TestJsonFacets.testBlockJoin-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{commit=} 0 4
   [junit4]   2> 574343 INFO  
(TEST-TestJsonFacets.testBlockJoin-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.s.f.UnInvertedField UnInverted multi-valued field 
{field=v_t,memSize=4741,tindexSize=41,time=0,phase1=0,nTerms=6,bigTerms=4,termInstances=4,uses=0}
   [junit4]   2> 574344 INFO  
(TEST-TestJsonFacets.testBlockJoin-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={rows=0&q=*:*&json.facet={+pages:{+type:query,+domain:{blockChildren:'type_s:book'}+,+facet:{+x:{field:v_t}+}+},pages2:{type:terms,+field:v_t,+domain:{blockChildren:'type_s:book'}+},books:{+type:query,+domain:{blockParent:'type_s:book'}++,+facet:{+x:{field:v_t}+}+},books2:{type:terms,+field:v_t,+domain:{blockParent:'type_s:book'}+},pageof3:{+type:query,+q:'id:3',+facet+:+{+x+:+{+type:terms,+field:page_s,+domain:{blockChildren:'type_s:book'}}}+},bookof22:{+type:query,+q:'id:2.2',+facet+:+{+x+:+{+type:terms,+field:book_s,+domain:{blockParent:'type_s:book'}}}+},missing_blockParent:{+type:query,+domain:{blockParent:'type_s:does_not_exist'}+},missing_blockChildren:{+type:query,+domain:{blockChildren:'type_s:does_not_exist'}+}}&wt=json&indent=true}
 hits=10 status=0 QTime=6
   [junit4]   2> 574345 INFO  
(TEST-TestJsonFacets.testBlockJoin-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=no_match_s:NO_MATCHES&json.facet={+processEmpty:true,pages:{+type:query,+domain:{blockChildren:'type_s:book'}+},books:{+type:query,+domain:{blockParent:'type_s:book'}+}}&wt=json&indent=true}
 hits=0 status=0 QTime=0
   [junit4]   2> 574346 INFO  
(TEST-TestJsonFacets.testBlockJoin-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&json.facet={books:{+type:terms,+field:book_s,+facet:{+pages:{type:terms,+field:v_t,+domain:{blockChildren:'type_s:book'}}+}+}}&wt=json&indent=true}
 hits=10 status=0 QTime=0
   [junit4]   2> 574347 INFO  
(TEST-TestJsonFacets.testBlockJoin-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={rows=0&q=*:*&json.facet={+pages1:{type:terms,+field:v_t,+domain:{blockChildren:'type_s:book',+filter:'*:*'}+},pages2:{type:terms,+field:v_t,+domain:{blockChildren:'type_s:book',+filter:'-id:3.1'}+},books:{type:terms,+field:v_t,+domain:{blockParent:'type_s:book',+filter:'*:*'}+},books2:{type:terms,+field:v_t,+domain:{blockParent:'type_s:book',+filter:'id:1'}+}}&wt=json&indent=true}
 hits=10 status=0 QTime=0
   [junit4]   2> 574348 INFO  
(TEST-TestJsonFacets.testBlockJoin-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={rows=0&q=*:*&f1=-id:3.1&f2=id:1&json.facet={+pages1:{type:terms,+field:v_t,+domain:{blockChildren:'type_s:book',+filter:[]}+},pages2:{type:terms,+field:v_t,+domain:{blockChildren:'type_s:book',+filter:{param:f1}+}+},books:{type:terms,+field:v_t,+domain:{blockParent:'type_s:book',+filter:[{param:q},{param:missing_param}]}+},books2:{type:terms,+field:v_t,+domain:{blockParent:'type_s:book',+filter:[{param:f2}]+}+}}&wt=json&indent=true}
 hits=10 status=0 QTime=0
   [junit4]   2> 574348 INFO  
(TEST-TestJsonFacets.testBlockJoin-seed#[D8987511DDB3CC4B]) [     ] 
o.a.s.SolrTestCaseJ4 ###Ending testBlockJoin {p0=ENUM}
   [junit4]   2> 574357 INFO  
(TEST-TestJsonFacets.testPrelimSortingSingleNodeExtraFacet-seed#[D8987511DDB3CC4B])
 [     ] o.a.s.SolrTestCaseJ4 ###Starting testPrelimSortingSingleNodeExtraFacet 
{p0=ENUM}
   [junit4]   2> 574362 WARN  
(TEST-TestJsonFacets.testPrelimSortingSingleNodeExtraFacet-seed#[D8987511DDB3CC4B])
 [     ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
   [junit4]   2> 574362 INFO  
(TEST-TestJsonFacets.testPrelimSortingSingleNodeExtraFacet-seed#[D8987511DDB3CC4B])
 [     ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
   [junit4]   2> 574362 INFO  
(TEST-TestJsonFacets.testPrelimSortingSingleNodeExtraFacet-seed#[D8987511DDB3CC4B])
 [     ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 
1 ...
   [junit4]   2> 574362 INFO  
(TEST-TestJsonFacets.testPrelimSortingSingleNodeExtraFacet-seed#[D8987511DDB3CC4B])
 [     ] o.e.j.s.Server jetty-9.4.19.v20190610; built: 
2019-06-10T16:30:51.723Z; git: afcf563148970e98786327af5e07c261fda175d3; jvm 
11.0.3+7
   [junit4]   2> 574380 INFO  
(TEST-TestJsonFacets.testPrelimSortingSingleNodeExtraFacet-seed#[D8987511DDB3CC4B])
 [     ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 574380 INFO  
(TEST-TestJsonFacets.testPrelimSortingSingleNodeExtraFacet-seed#[D8987511DDB3CC4B])
 [     ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 574380 INFO  
(TEST-TestJsonFacets.testPrelimSortingSingleNodeExtraFacet-seed#[D8987511DDB3CC4B])
 [     ] o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 574381 INFO  
(TEST-TestJsonFacets.testPrelimSortingSingleNodeExtraFacet-seed#[D8987511DDB3CC4B])
 [     ] o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@5c3b05e2{/solr,null,AVAILABLE}
   [junit4]   2> 574381 INFO  
(TEST-TestJsonFacets.testPrelimSortingSingleNodeExtraFacet-seed#[D8987511DDB3CC4B])
 [     ] o.e.j.s.AbstractConnector Started 
ServerConnector@93c1eeb{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:35519}
   [junit4]   2> 574381 INFO  
(TEST-TestJsonFacets.testPrelimSortingSingleNodeExtraFacet-seed#[D8987511DDB3CC4B])
 [     ] o.e.j.s.Server Started @574410ms
   [junit4]   2> 574381 INFO  
(TEST-TestJsonFacets.testPrelimSortingSingleNodeExtraFacet-seed#[D8987511DDB3CC4B])
 [     ] o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{schema=schema_latest.xml, hostContext=/solr, solrconfig=solrconfig-tlog.xml, 
hostPort=35519}
   [junit4]   2> 574381 ERROR 
(TEST-TestJsonFacets.testPrelimSortingSingleNodeExtraFacet-seed#[D8987511DDB3CC4B])
 [     ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging 
may be missing or incomplete.
   [junit4]   2> 574381 INFO  
(TEST-TestJsonFacets.testPrelimSortingSingleNodeExtraFacet-seed#[D8987511DDB3CC4B])
 [     ] o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 574381 INFO  
(TEST-TestJsonFacets.testPrelimSortingSingleNodeExtraFacet-seed#[D8987511DDB3CC4B])
 [     ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? 
version 8.3.0
   [junit4]   2> 574381 INFO  
(TEST-TestJsonFacets.testPrelimSortingSingleNodeExtraFacet-seed#[D8987511DDB3CC4B])
 [     ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone 
mode on port null
   [junit4]   2> 574381 INFO  
(TEST-TestJsonFacets.testPrelimSortingSingleNodeExtraFacet-seed#[D8987511DDB3CC4B])
 [     ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 574381 INFO  
(TEST-TestJsonFacets.testPrelimSortingSingleNodeExtraFacet-seed#[D8987511DDB3CC4B])
 [     ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2019-08-02T20:05:33.104949Z
   [junit4]   2> 574382 INFO  
(TEST-TestJsonFacets.testPrelimSortingSingleNodeExtraFacet-seed#[D8987511DDB3CC4B])
 [     ] o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.search.facet.TestJsonFacets_D8987511DDB3CC4B-001/s0-002/solr.xml
   [junit4]   2> 574383 INFO  
(TEST-TestJsonFacets.testPrelimSortingSingleNodeExtraFacet-seed#[D8987511DDB3CC4B])
 [     ] o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverWorkLoopDelay is ignored
   [junit4]   2> 574383 INFO  
(TEST-TestJsonFacets.testPrelimSortingSingleNodeExtraFacet-seed#[D8987511DDB3CC4B])
 [     ] o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 574384 INFO  
(TEST-TestJsonFacets.testPrelimSortingSingleNodeExtraFacet-seed#[D8987511DDB3CC4B])
 [     ] o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@5fb0778d, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 574520 INFO  
(TEST-TestJsonFacets.testPrelimSortingSingleNodeExtraFacet-seed#[D8987511DDB3CC4B])
 [     ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
   [junit4]   2> 574521 WARN  
(TEST-TestJsonFacets.testPrelimSortingSingleNodeExtraFacet-seed#[D8987511DDB3CC4B])
 [     ] o.e.j.u.s.S.config Trusting all certificates configured for 
Client@6dcd3625[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 574521 WARN  
(TEST-TestJsonFacets.testPrelimSortingSingleNodeExtraFacet-seed#[D8987511DDB3CC4B])
 [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm 
configured for Client@6dcd3625[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 574523 WARN  
(TEST-TestJsonFacets.testPrelimSortingSingleNodeExtraFacet-seed#[D8987511DDB3CC4B])
 [     ] o.e.j.u.s.S.config Trusting all certificates configured for 
Client@3607b6a3[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 574523 WARN  
(TEST-TestJsonFacets.testPrelimSortingSingleNodeExtraFacet-seed#[D8987511DDB3CC4B])
 [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm 
configured for Client@3607b6a3[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 574532 INFO  
(TEST-TestJsonFacets.testPrelimSortingSingleNodeExtraFacet-seed#[D8987511DDB3CC4B])
 [     ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 574532 INFO  
(TEST-TestJsonFacets.testPrelimSortingSingleNodeExtraFacet-seed#[D8987511DDB3CC4B])
 [     ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics 
history in memory.
   [junit4]   2> 574544 INFO  
(TEST-TestJsonFacets.testPrelimSortingSingleNodeExtraFacet-seed#[D8987511DDB3CC4B])
 [     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 
'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5fb0778d
   [junit4]   2> 574551 INFO  
(TEST-TestJsonFacets.testPrelimSortingSingleNodeExtraFacet-seed#[D8987511DDB3CC4B])
 [     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 
'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5fb0778d
   [junit4]   2> 574551 INFO  
(TEST-TestJsonFacets.testPrelimSortingSingleNodeExtraFacet-seed#[D8987511DDB3CC4B])
 [     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5fb0778d
   [junit4]   2> 574553 INFO  
(TEST-TestJsonFacets.testPrelimSortingSingleNodeExtraFacet-seed#[D8987511DDB3CC4B])
 [     ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.search.facet.TestJsonFacets_D8987511DDB3CC4B-001/s0-002/.
   [junit4]   2> 574553 INFO  
(TEST-TestJsonFacets.testPrelimSortingSingleNodeExtraFacet-seed#[D8987511DDB3CC4B])
 [     ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 574556 INFO  (coreLoadExecutor-4570-thread-1) [    
x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.3.0
   [junit4]   2> 574564 INFO  (coreLoadExecutor-4570-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema [collection1] Schema name=example
   [junit4]   2> 574614 INFO  (coreLoadExecutor-4570-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema Loaded schema example/1.6 with uniqueid 
field id
   [junit4]   2> 574628 INFO  (coreLoadExecutor-4570-thread-1) [    
x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from instancedir 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.search.facet.TestJsonFacets_D8987511DDB3CC4B-001/s0-002/./collection1,
 trusted=true
   [junit4]   2> 574628 INFO  (coreLoadExecutor-4570-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@5fb0778d
   [junit4]   2> 574628 INFO  (coreLoadExecutor-4570-thread-1) [    
x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.search.facet.TestJsonFacets_D8987511DDB3CC4B-001/s0-002/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.search.facet.TestJsonFacets_D8987511DDB3CC4B-001/s0-002/./collection1/data/]
   [junit4]   2> 574630 INFO  (coreLoadExecutor-4570-thread-1) [    
x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=20, maxMergeAtOnceExplicit=39, maxMergedSegmentMB=36.189453125, 
floorSegmentMB=1.376953125, forceMergeDeletesPctAllowed=26.143291069956067, 
segmentsPerTier=13.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.4105741823343425, deletesPctAllowed=25.061599473205753
   [junit4]   2> 574630 WARN  (coreLoadExecutor-4570-thread-1) [    
x:collection1 ] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler 
{type = requestHandler,name = /dump,class = DumpRequestHandler,attributes = 
{initParams=a, name=/dump, class=DumpRequestHandler},args = 
{defaults={a=A,b=B}}}
   [junit4]   2> 574661 INFO  (coreLoadExecutor-4570-thread-1) [    
x:collection1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 574661 INFO  (coreLoadExecutor-4570-thread-1) [    
x:collection1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 574663 INFO  (coreLoadExecutor-4570-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 574663 INFO  (coreLoadExecutor-4570-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 574664 INFO  (coreLoadExecutor-4570-thread-1) [    
x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=16, maxMergeAtOnceExplicit=39, maxMergedSegmentMB=86.2236328125, 
floorSegmentMB=1.486328125, forceMergeDeletesPctAllowed=12.527092357664408, 
segmentsPerTier=14.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.7612272982392201, deletesPctAllowed=47.37578688703414
   [junit4]   2> 574664 INFO  (coreLoadExecutor-4570-thread-1) [    
x:collection1 ] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@465457f5[collection1] main]
   [junit4]   2> 574664 INFO  (coreLoadExecutor-4570-thread-1) [    
x:collection1 ] o.a.s.r.ManagedResourceStorage File-based storage initialized 
to use dir: 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.search.facet.TestJsonFacets_D8987511DDB3CC4B-001/s0-002/collection1/conf
   [junit4]   2> 574664 INFO  (coreLoadExecutor-4570-thread-1) [    
x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 574665 INFO  (coreLoadExecutor-4570-thread-1) [    
x:collection1 ] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1640786908558655488
   [junit4]   2> 574666 INFO  
(TEST-TestJsonFacets.testPrelimSortingSingleNodeExtraFacet-seed#[D8987511DDB3CC4B])
 [     ] o.a.s.SolrTestCaseHS ===> Started solr server port=35519 
home=/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.search.facet.TestJsonFacets_D8987511DDB3CC4B-001/s0-002
   [junit4]   2> 574667 INFO  
(searcherExecutor-4571-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@465457f5[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 574668 INFO  (qtp1175791803-12171) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{deleteByQuery=*:* (-1640786908561801216)} 0 1
   [junit4]   2> 574669 INFO  (qtp1175791803-12172) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[1 (1640786908562849792)]} 0 0
   [junit4]   2> 574670 INFO  (qtp1175791803-12170) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[2 (1640786908563898368)]} 0 0
   [junit4]   2> 574670 INFO  (qtp1175791803-12171) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[3 (1640786908563898369)]} 0 0
   [junit4]   2> 574671 INFO  (qtp1175791803-12172) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[4 (1640786908564946944)]} 0 0
   [junit4]   2> 574671 INFO  (qtp1175791803-12170) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[5 (1640786908564946945)]} 0 0
   [junit4]   2> 574671 INFO  (qtp1175791803-12171) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[6 (1640786908564946946)]} 0 0
   [junit4]   2> 574672 INFO  (qtp1175791803-12172) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[7 (1640786908565995520)]} 0 0
   [junit4]   2> 574672 INFO  (qtp1175791803-12170) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[8 (1640786908565995521)]} 0 0
   [junit4]   2> 574672 INFO  (qtp1175791803-12171) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[9 (1640786908565995522)]} 0 0
   [junit4]   2> 574673 INFO  (qtp1175791803-12172) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[10 (1640786908567044096)]} 0 0
   

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

xecutor-5912-thread-1) [    x:collection1 ] o.a.s.c.SolrCore [collection1]  
CLOSING SolrCore org.apache.solr.core.SolrCore@3ae3b8db
   [junit4]   2> 653443 INFO  (coreCloseExecutor-5912-thread-1) [    
x:collection1 ] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=3ae3b8db
   [junit4]   2> 653443 INFO  (coreCloseExecutor-5912-thread-1) [    
x:collection1 ] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@602f0cb8: rootName = null, 
domain = solr.core.collection1, service url = null, agent id = null] for 
registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@2ca37343
   [junit4]   2> 653445 INFO  
(SUITE-TestJsonFacets-seed#[D8987511DDB3CC4B]-worker) [     ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 653445 INFO  
(SUITE-TestJsonFacets-seed#[D8987511DDB3CC4B]-worker) [     ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@2c5bb8ab: rootName = null, 
domain = solr.node, service url = null, agent id = null] for registry solr.node 
/ com.codahale.metrics.MetricRegistry@2bab9bd
   [junit4]   2> 653445 INFO  
(SUITE-TestJsonFacets-seed#[D8987511DDB3CC4B]-worker) [     ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 653446 INFO  
(SUITE-TestJsonFacets-seed#[D8987511DDB3CC4B]-worker) [     ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@3f148af0: rootName = null, 
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / 
com.codahale.metrics.MetricRegistry@1cd56e9c
   [junit4]   2> 653446 INFO  
(SUITE-TestJsonFacets-seed#[D8987511DDB3CC4B]-worker) [     ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 653446 INFO  
(SUITE-TestJsonFacets-seed#[D8987511DDB3CC4B]-worker) [     ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@2b419dce: rootName = null, 
domain = solr.jetty, service url = null, agent id = null] for registry 
solr.jetty / com.codahale.metrics.MetricRegistry@727e5cff
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.search.facet.TestJsonFacets_D8987511DDB3CC4B-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene80): 
{super_s=FST50, cat_sds=FST50, where_s_multi_not_uninvert=FST50, 
where_sds=PostingsFormat(name=LuceneVarGapDocFreqInterval), book_id_s=FST50, 
super_sds=PostingsFormat(name=LuceneVarGapDocFreqInterval), 
cat_ss=PostingsFormat(name=Asserting), sparse_ss=FST50, 
book_s=PostingsFormat(name=Asserting), super_sd=PostingsFormat(name=Asserting), 
where_s=PostingsFormat(name=Asserting), 
where_s_multi_not_uninvert_dv=BlockTreeOrds(blocksize=128), 
sparse_sd=BlockTreeOrds(blocksize=128), id=PostingsFormat(name=Asserting), 
multi_ss=PostingsFormat(name=LuceneVarGapDocFreqInterval), 
type_s=PostingsFormat(name=LuceneVarGapDocFreqInterval), 
where_s_single_not_uninvert_dv=FST50, 
sparse_sds=PostingsFormat(name=Asserting), page_s=FST50, 1_s=FST50, 
2_s=PostingsFormat(name=LuceneVarGapDocFreqInterval), 
cat_sd=PostingsFormat(name=LuceneVarGapDocFreqInterval), 
3_s=PostingsFormat(name=Asserting), super_ss=BlockTreeOrds(blocksize=128), 
_root_=PostingsFormat(name=LuceneVarGapDocFreqInterval), 
val_b=BlockTreeOrds(blocksize=128), multi_sds=BlockTreeOrds(blocksize=128), 
cat_s=PostingsFormat(name=LuceneVarGapDocFreqInterval), 
v_t=PostingsFormat(name=Asserting), where_sd=FST50, 
foo_s=PostingsFormat(name=LuceneVarGapDocFreqInterval), 
make_s=PostingsFormat(name=LuceneVarGapDocFreqInterval), x_t=FST50, y_s=FST50, 
z_t=PostingsFormat(name=Asserting), 
where_s_single_not_uninvert=PostingsFormat(name=LuceneVarGapDocFreqInterval), 
sparse_s=BlockTreeOrds(blocksize=128), where_ss=BlockTreeOrds(blocksize=128), 
model_s=FST50}, docValues:{num_dd=DocValuesFormat(name=Lucene80), 
num_lds=DocValuesFormat(name=Lucene80), 
sparse_num_f=DocValuesFormat(name=Lucene80), 
where_s_multi_not_uninvert=DocValuesFormat(name=Asserting), 
where_sds=DocValuesFormat(name=Lucene80), 
sparse_num_d=DocValuesFormat(name=Direct), 
Z_num_id=DocValuesFormat(name=Lucene80), cat_ss=DocValuesFormat(name=Lucene80), 
sparse_num_dd=DocValuesFormat(name=Direct), 
Z_num_i=DocValuesFormat(name=Lucene80), id=DocValuesFormat(name=Lucene80), 
Z_num_l=DocValuesFormat(name=Lucene80), 
where_s_single_not_uninvert_dv=DocValuesFormat(name=Asserting), 
date_dtd=DocValuesFormat(name=Lucene80), cat_sd=DocValuesFormat(name=Lucene80), 
_root_=DocValuesFormat(name=Lucene80), multi_sds=DocValuesFormat(name=Direct), 
num_f=DocValuesFormat(name=Asserting), 
where_sd=DocValuesFormat(name=Asserting), num_id=DocValuesFormat(name=Direct), 
num_d=DocValuesFormat(name=Lucene80), bar_i=DocValuesFormat(name=Asserting), 
num_ds=DocValuesFormat(name=Direct), date_dtds=DocValuesFormat(name=Direct), 
num_i=DocValuesFormat(name=Direct), cost_f=DocValuesFormat(name=Direct), 
num_l=DocValuesFormat(name=Lucene80), num_ls=DocValuesFormat(name=Direct), 
where_ss=DocValuesFormat(name=Direct), 
where_s_not_indexed_sS=DocValuesFormat(name=Lucene80), 
num_ids=DocValuesFormat(name=Asserting), 
super_s=DocValuesFormat(name=Asserting), 
date_dt=DocValuesFormat(name=Asserting), 
cat_sds=DocValuesFormat(name=Asserting), 
super_sds=DocValuesFormat(name=Lucene80), 
Z_long_ld=DocValuesFormat(name=Lucene80), 
sparse_ss=DocValuesFormat(name=Asserting), 
super_sd=DocValuesFormat(name=Lucene80), 
where_s_multi_not_uninvert_dv=DocValuesFormat(name=Direct), 
where_s=DocValuesFormat(name=Lucene80), 
Z_long_l=DocValuesFormat(name=Lucene80), 
sparse_sd=DocValuesFormat(name=Direct), num_is=DocValuesFormat(name=Asserting), 
multi_ss=DocValuesFormat(name=Lucene80), 
sparse_sds=DocValuesFormat(name=Lucene80), 
super_ss=DocValuesFormat(name=Direct), val_b=DocValuesFormat(name=Direct), 
cat_s=DocValuesFormat(name=Lucene80), 
where_s_single_not_uninvert=DocValuesFormat(name=Lucene80), 
_version_=DocValuesFormat(name=Lucene80), 
sparse_s=DocValuesFormat(name=Direct), num_dds=DocValuesFormat(name=Lucene80), 
num_fds=DocValuesFormat(name=Direct), num_fs=DocValuesFormat(name=Lucene80)}, 
maxPointsInLeafNode=517, maxMBSortInHeap=7.491317444340819, 
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@4ae6db7),
 locale=ii-CN, timezone=Asia/Sakhalin
   [junit4]   2> NOTE: Linux 4.18.0-25-generic amd64/AdoptOpenJDK 11.0.3 
(64-bit)/cpus=8,threads=1,free=261163200,total=536870912
   [junit4]   2> NOTE: All tests run in this JVM: [IndexSizeEstimatorTest, 
TestInPlaceUpdatesStandalone, TestSolrTestCaseJ4, MinimalSchemaTest, 
TestDistribDocBasedVersion, PeerSyncWithIndexFingerprintCachingTest, 
SolrCloudReportersTest, RegexBoostProcessorTest, HighlighterMaxOffsetTest, 
DeleteShardTest, WrapperMergePolicyFactoryTest, HLLSerializationTest, 
CreateCollectionCleanupTest, TestCoreBackup, LeaderElectionContextKeyTest, 
DistributedFacetPivotSmallTest, BJQParserTest, TestQueryTypes, 
TestExactSharedStatsCache, TestDynamicFieldCollectionResource, NodeMutatorTest, 
MetricTriggerTest, ScheduledTriggerTest, XsltUpdateRequestHandlerTest, 
SegmentsInfoRequestHandlerTest, JsonLoaderTest, CacheHeaderTest, 
TestLMJelinekMercerSimilarityFactory, ChangedSchemaMergeTest, 
SaslZkACLProviderTest, MoveReplicaHDFSFailoverTest, TestCustomStream, 
MultiSolrCloudTestCaseTest, CdcrBootstrapTest, CoreAdminRequestStatusTest, 
PrimUtilsTest, TestLFUCache, TestCloudRecovery, 
TestEmbeddedSolrServerAdminHandler, TestComplexPhraseQParserPlugin, 
ConcurrentCreateRoutedAliasTest, DimensionalRoutedAliasUpdateProcessorTest, 
JWTAuthPluginTest, TestReload, JavabinLoaderTest, DataDrivenBlockJoinTest, 
SolrJmxReporterCloudTest, SpellPossibilityIteratorTest, TestDynamicLoadingUrl, 
TestCodecSupport, TestCloudPhrasesIdentificationComponent, 
TestSimGenericDistributedQueue, TermVectorComponentDistributedTest, 
TestSolr4Spatial, BlockJoinFacetSimpleTest, TestExclusionRuleCollectionAccess, 
RegexBytesRefFilterTest, TestDocTermOrds, ClassificationUpdateProcessorTest, 
TestSimDistributedQueue, PreAnalyzedFieldTest, ExternalFileFieldSortTest, 
DisMaxRequestHandlerTest, TestInfoStreamLogging, 
DistributedQueryComponentCustomSortTest, ManagedSchemaRoundRobinCloudTest, 
ReplaceNodeTest, TestChildDocTransformerHierarchy, 
TestTolerantUpdateProcessorRandomCloud, TestSolrConfigHandlerCloud, 
SolrMetricReporterTest, TestSolrDeletionPolicy1, TestStressVersions, 
SolrCoreTest, TestImpersonationWithHadoopAuth, TestDocSet, RequestLoggingTest, 
NoCacheHeaderTest, TestFieldResource, SpatialRPTFieldTypeTest, 
TestSolrCloudSnapshots, LeaderFailoverAfterPartitionTest, TestJsonFacets]
   [junit4] Completed [227/872 (1!)] on J1 in 80.58s, 174 tests, 1 failure <<< 
FAILURES!

[...truncated 47086 lines...]
[repro] Jenkins log URL: 
https://jenkins.thetaphi.de/job/Lucene-Solr-8.x-Linux/960/consoleText

[repro] Revision: 0bebca85577a697d55b7bea79ef933824cae1597

[repro] Ant options: "-Dargs=-XX:-UseCompressedOops -XX:+UseG1GC"
[repro] Repro line:  ant test  -Dtestcase=TestJsonFacets 
-Dtests.method=testErrors -Dtests.seed=D8987511DDB3CC4B -Dtests.multiplier=3 
-Dtests.slow=true -Dtests.locale=ii-CN -Dtests.timezone=Asia/Sakhalin 
-Dtests.asserts=true -Dtests.file.encoding=US-ASCII

[repro] ant clean

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

[...truncated 3582 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5 
-Dtests.class="*.TestJsonFacets" -Dtests.showOutput=onerror 
"-Dargs=-XX:-UseCompressedOops -XX:+UseG1GC" -Dtests.seed=D8987511DDB3CC4B 
-Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=ii-CN 
-Dtests.timezone=Asia/Sakhalin -Dtests.asserts=true 
-Dtests.file.encoding=US-ASCII

[...truncated 940 lines...]
[repro] Failures:
[repro]   0/5 failed: org.apache.solr.search.facet.TestJsonFacets
[repro] Exiting with code 0

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

Reply via email to