Build: https://jenkins.thetaphi.de/job/Lucene-Solr-8.x-Linux/3952/
Java: 64bit/jdk1.8.0_201 -XX:-UseCompressedOops -XX:+UseParallelGC

1 tests failed.
FAILED:  org.apache.solr.TestDistributedGrouping.test

Error Message:
Error from server at https://127.0.0.1:44439/collection1: 
org.apache.solr.client.solrj.SolrServerException: Time allowed to handle this 
request exceeded:[https://[::1]:4, https://[::1]:8, https://[::1]:6]

Stack Trace:
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error 
from server at https://127.0.0.1:44439/collection1: 
org.apache.solr.client.solrj.SolrServerException: Time allowed to handle this 
request exceeded:[https://[::1]:4, https://[::1]:8, https://[::1]:6]
        at 
__randomizedtesting.SeedInfo.seed([23D6F5950C7D8424:AB82CA4FA281E9DC]:0)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:681)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:266)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:248)
        at 
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:214)
        at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:1003)
        at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:1018)
        at 
org.apache.solr.BaseDistributedSearchTestCase.queryServer(BaseDistributedSearchTestCase.java:625)
        at 
org.apache.solr.TestDistributedGrouping.simpleQuery(TestDistributedGrouping.java:455)
        at 
org.apache.solr.TestDistributedGrouping.test(TestDistributedGrouping.java:443)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsRepeatStatement.callStatement(BaseDistributedSearchTestCase.java:1117)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:1061)
        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 
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.lang.Thread.run(Thread.java:748)




Build Log:
[...truncated 14546 lines...]
   [junit4] Suite: org.apache.solr.TestDistributedGrouping
   [junit4]   2> 431683 INFO  
(SUITE-TestDistributedGrouping-seed#[23D6F5950C7D8424]-worker) [     ] 
o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to 
test-framework derived value of 
'/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/server/solr/configsets/_default/conf'
   [junit4]   2> 431684 INFO  
(SUITE-TestDistributedGrouping-seed#[23D6F5950C7D8424]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Created dataDir: 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J5/temp/solr.TestDistributedGrouping_23D6F5950C7D8424-001/data-dir-80-001
   [junit4]   2> 431684 WARN  
(SUITE-TestDistributedGrouping-seed#[23D6F5950C7D8424]-worker) [     ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=2 numCloses=2
   [junit4]   2> 431684 INFO  
(SUITE-TestDistributedGrouping-seed#[23D6F5950C7D8424]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) 
w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 431685 INFO  
(SUITE-TestDistributedGrouping-seed#[23D6F5950C7D8424]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via: 
@org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
   [junit4]   2> 431685 INFO  
(SUITE-TestDistributedGrouping-seed#[23D6F5950C7D8424]-worker) [     ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 431686 INFO  
(SUITE-TestDistributedGrouping-seed#[23D6F5950C7D8424]-worker) [     ] 
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /
   [junit4]   2> 431762 INFO  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J5/temp/solr.TestDistributedGrouping_23D6F5950C7D8424-001/tempDir-001/control/cores/collection1
   [junit4]   2> 431764 WARN  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, 
break even is size 23
   [junit4]   2> 431764 INFO  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 431764 INFO  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
   [junit4]   2> 431764 INFO  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git: 
a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 1.8.0_201-b09
   [junit4]   2> 431767 INFO  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 431767 INFO  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 431767 INFO  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 431768 INFO  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@68357fe6{/,null,AVAILABLE}
   [junit4]   2> 431771 INFO  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.e.j.s.AbstractConnector Started ServerConnector@625e1f05{SSL, (ssl, 
http/1.1)}{127.0.0.1:37621}
   [junit4]   2> 431771 INFO  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.e.j.s.Server Started @431799ms
   [junit4]   2> 431771 INFO  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, hostPort=37621, 
coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J5/temp/solr.TestDistributedGrouping_23D6F5950C7D8424-001/tempDir-001/control/cores}
   [junit4]   2> 431771 ERROR 
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 431771 INFO  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 431771 INFO  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.7.0
   [junit4]   2> 431771 INFO  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 431771 INFO  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr
   [junit4]   2> 431771 INFO  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2020-08-04T21:24:51.432Z
   [junit4]   2> 431771 INFO  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J5/temp/solr.TestDistributedGrouping_23D6F5950C7D8424-001/tempDir-001/control/solr.xml
   [junit4]   2> 431775 INFO  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay 
is ignored
   [junit4]   2> 431775 INFO  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 431776 INFO  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@356a437f, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 431909 INFO  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
   [junit4]   2> 431909 WARN  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport 
since Java 8 or lower versions does not support SSL + HTTP/2
   [junit4]   2> 431910 WARN  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@2b61c97[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 431910 WARN  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@2b61c97[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 431916 WARN  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport 
since Java 8 or lower versions does not support SSL + HTTP/2
   [junit4]   2> 431916 WARN  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@82c3e59[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 431916 WARN  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@82c3e59[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 431917 WARN  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.a.s.c.CoreContainer Not all security plugins configured!  
authentication=disabled authorization=disabled.  Solr is only as secure as you 
make it. Consider configuring authentication/authorization before exposing Solr 
to users internal or external.  See https://s.apache.org/solrsecurity for more 
info
   [junit4]   2> 431929 INFO  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 431929 INFO  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history 
in memory.
   [junit4]   2> 431943 INFO  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@356a437f
   [junit4]   2> 431950 INFO  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@356a437f
   [junit4]   2> 431950 INFO  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@356a437f
   [junit4]   2> 431951 INFO  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J5/temp/solr.TestDistributedGrouping_23D6F5950C7D8424-001/tempDir-001/control/cores
   [junit4]   2> 431951 INFO  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 431971 INFO  (coreLoadExecutor-6090-thread-1) [    
x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.7.0
   [junit4]   2> 432010 INFO  (coreLoadExecutor-6090-thread-1) [    
x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from configset 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1,
 trusted=true
   [junit4]   2> 432013 INFO  (coreLoadExecutor-6090-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema Schema name=test
   [junit4]   2> 432118 INFO  (coreLoadExecutor-6090-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field 
id
   [junit4]   2> 432124 INFO  (coreLoadExecutor-6090-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@356a437f
   [junit4]   2> 432124 INFO  (coreLoadExecutor-6090-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/J5/temp/solr.TestDistributedGrouping_23D6F5950C7D8424-001/tempDir-001/control/cores/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J5/temp/solr.TestDistributedGrouping_23D6F5950C7D8424-001/tempDir-001/control/cores/collection1/data/]
   [junit4]   2> 432125 INFO  (coreLoadExecutor-6090-thread-1) [    
x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=27, maxMergeAtOnceExplicit=40, maxMergedSegmentMB=30.5029296875, 
floorSegmentMB=1.6328125, forceMergeDeletesPctAllowed=10.438068854287199, 
segmentsPerTier=10.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.36363394872578847, deletesPctAllowed=42.4043379372648
   [junit4]   2> 432160 INFO  (coreLoadExecutor-6090-thread-1) [    
x:collection1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 432160 INFO  (coreLoadExecutor-6090-thread-1) [    
x:collection1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 432160 INFO  (coreLoadExecutor-6090-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 432160 INFO  (coreLoadExecutor-6090-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 432161 INFO  (coreLoadExecutor-6090-thread-1) [    
x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=31, maxMergeAtOnceExplicit=43, maxMergedSegmentMB=66.607421875, 
floorSegmentMB=0.765625, forceMergeDeletesPctAllowed=19.604394640810025, 
segmentsPerTier=19.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.2061307017473901, deletesPctAllowed=22.25050160437952
   [junit4]   2> 432161 INFO  (coreLoadExecutor-6090-thread-1) [    
x:collection1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 432163 INFO  (coreLoadExecutor-6090-thread-1) [    
x:collection1 ] o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 432178 INFO  (coreLoadExecutor-6090-thread-1) [    
x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 432179 INFO  (coreLoadExecutor-6090-thread-1) [    
x:collection1 ] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1674131581792419840
   [junit4]   2> 432179 INFO  
(searcherExecutor-6092-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 432180 INFO  
(searcherExecutor-6092-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 432180 INFO  
(searcherExecutor-6092-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 432180 INFO  
(searcherExecutor-6092-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 432180 INFO  
(searcherExecutor-6092-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 432180 INFO  
(searcherExecutor-6092-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 432180 INFO  
(searcherExecutor-6092-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 432180 INFO  
(searcherExecutor-6092-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 432180 INFO  
(searcherExecutor-6092-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 432181 INFO  
(searcherExecutor-6092-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 432254 INFO  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J5/temp/solr.TestDistributedGrouping_23D6F5950C7D8424-001/tempDir-001/shard0/cores/collection1
   [junit4]   2> 432255 WARN  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, 
break even is size 23
   [junit4]   2> 432255 INFO  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 432255 INFO  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
   [junit4]   2> 432255 INFO  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git: 
a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 1.8.0_201-b09
   [junit4]   2> 432255 INFO  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 432255 INFO  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 432255 INFO  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 432256 INFO  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@46bf7c2{/,null,AVAILABLE}
   [junit4]   2> 432257 INFO  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.e.j.s.AbstractConnector Started ServerConnector@34f895ec{SSL, (ssl, 
http/1.1)}{127.0.0.1:44439}
   [junit4]   2> 432257 INFO  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.e.j.s.Server Started @432284ms
   [junit4]   2> 432257 INFO  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, hostPort=44439, 
coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J5/temp/solr.TestDistributedGrouping_23D6F5950C7D8424-001/tempDir-001/shard0/cores}
   [junit4]   2> 432257 ERROR 
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 432257 INFO  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 432257 INFO  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.7.0
   [junit4]   2> 432257 INFO  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 432257 INFO  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr
   [junit4]   2> 432257 INFO  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2020-08-04T21:24:51.918Z
   [junit4]   2> 432257 INFO  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J5/temp/solr.TestDistributedGrouping_23D6F5950C7D8424-001/tempDir-001/shard0/solr.xml
   [junit4]   2> 432282 INFO  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay 
is ignored
   [junit4]   2> 432282 INFO  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 432283 INFO  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@356a437f, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 432310 INFO  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
   [junit4]   2> 432310 WARN  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport 
since Java 8 or lower versions does not support SSL + HTTP/2
   [junit4]   2> 432311 WARN  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@72c60211[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 432311 WARN  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@72c60211[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 432315 WARN  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport 
since Java 8 or lower versions does not support SSL + HTTP/2
   [junit4]   2> 432316 WARN  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@4d262ebe[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 432316 WARN  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@4d262ebe[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 432317 WARN  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.a.s.c.CoreContainer Not all security plugins configured!  
authentication=disabled authorization=disabled.  Solr is only as secure as you 
make it. Consider configuring authentication/authorization before exposing Solr 
to users internal or external.  See https://s.apache.org/solrsecurity for more 
info
   [junit4]   2> 432330 INFO  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 432330 INFO  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history 
in memory.
   [junit4]   2> 432342 INFO  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@356a437f
   [junit4]   2> 432348 INFO  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@356a437f
   [junit4]   2> 432348 INFO  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@356a437f
   [junit4]   2> 432349 INFO  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J5/temp/solr.TestDistributedGrouping_23D6F5950C7D8424-001/tempDir-001/shard0/cores
   [junit4]   2> 432349 INFO  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 432359 INFO  (coreLoadExecutor-6108-thread-1) [    
x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.7.0
   [junit4]   2> 432379 INFO  (coreLoadExecutor-6108-thread-1) [    
x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from configset 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1,
 trusted=true
   [junit4]   2> 432383 INFO  (coreLoadExecutor-6108-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema Schema name=test
   [junit4]   2> 432489 INFO  (coreLoadExecutor-6108-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field 
id
   [junit4]   2> 432494 INFO  (coreLoadExecutor-6108-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@356a437f
   [junit4]   2> 432495 INFO  (coreLoadExecutor-6108-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/J5/temp/solr.TestDistributedGrouping_23D6F5950C7D8424-001/tempDir-001/shard0/cores/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J5/temp/solr.TestDistributedGrouping_23D6F5950C7D8424-001/tempDir-001/shard0/cores/collection1/data/]
   [junit4]   2> 432496 INFO  (coreLoadExecutor-6108-thread-1) [    
x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=27, maxMergeAtOnceExplicit=40, maxMergedSegmentMB=30.5029296875, 
floorSegmentMB=1.6328125, forceMergeDeletesPctAllowed=10.438068854287199, 
segmentsPerTier=10.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.36363394872578847, deletesPctAllowed=42.4043379372648
   [junit4]   2> 432525 INFO  (coreLoadExecutor-6108-thread-1) [    
x:collection1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 432525 INFO  (coreLoadExecutor-6108-thread-1) [    
x:collection1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 432526 INFO  (coreLoadExecutor-6108-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 432526 INFO  (coreLoadExecutor-6108-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 432526 INFO  (coreLoadExecutor-6108-thread-1) [    
x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=31, maxMergeAtOnceExplicit=43, maxMergedSegmentMB=66.607421875, 
floorSegmentMB=0.765625, forceMergeDeletesPctAllowed=19.604394640810025, 
segmentsPerTier=19.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.2061307017473901, deletesPctAllowed=22.25050160437952
   [junit4]   2> 432527 INFO  (coreLoadExecutor-6108-thread-1) [    
x:collection1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 432529 INFO  (coreLoadExecutor-6108-thread-1) [    
x:collection1 ] o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 432537 INFO  (coreLoadExecutor-6108-thread-1) [    
x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 432537 INFO  (coreLoadExecutor-6108-thread-1) [    
x:collection1 ] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1674131582167810048
   [junit4]   2> 432538 INFO  
(searcherExecutor-6110-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 432539 INFO  
(searcherExecutor-6110-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 432539 INFO  
(searcherExecutor-6110-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 432539 INFO  
(searcherExecutor-6110-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 432539 INFO  
(searcherExecutor-6110-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 432539 INFO  
(searcherExecutor-6110-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 432539 INFO  
(searcherExecutor-6110-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 432539 INFO  
(searcherExecutor-6110-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 432539 INFO  
(searcherExecutor-6110-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 432539 INFO  
(TEST-TestDistributedGrouping.test-seed#[23D6F5950C7D8424]) [     ] 
o.a.s.SolrTestCaseJ4 ###Starting test
   [junit4]   2> 432540 INFO  
(searcherExecutor-6110-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 432554 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{deleteByQuery=*:* (-1674131582183538688)} 0 2
   [junit4]   2> 432566 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{deleteByQuery=*:* (-1674131582196121600)} 0 1
   [junit4]   2> 432567 INFO  (qtp875097092-10156) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 0
   [junit4]   2> 432568 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 0
   [junit4]   2> 432570 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&fl=id,a_i1&group.limit=-1&sort=a_i1+asc,+id+asc&rows=100&wt=javabin&version=2&group.field=a_i1&group=true}
 hits=0 status=0 QTime=1
   [junit4]   2> 432590 INFO  (qtp1071442517-10161) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={df=text&group.distributed.first=true&distrib=false&fl=id&group.limit=-1&shards.purpose=2048&start=0&sort=a_i1+asc,+id+asc&shard.url=https://127.0.0.1:44439/collection1|[::1]:8/|[::1]:4/|[::1]:6/&rows=100&rid=127.0.0.1-8847&version=2&q=*:*&omitHeader=false&NOW=1596576292232&isShard=true&wt=javabin&group.field=a_i1&group=true}
 status=0 QTime=1
   [junit4]   2> 432591 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=https://127.0.0.1:44439/collection1|[::1]:8/|[::1]:4/|[::1]:6/&fl=id,a_i1&group.limit=-1&sort=a_i1+asc,+id+asc&rows=100&wt=javabin&version=2&group.field=a_i1&group=true}
 rid=127.0.0.1-8847 status=0 QTime=20
   [junit4]   2> 432593 INFO  (qtp875097092-10156) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&hl=true&fl=id,a_i1&group.limit=-1&sort=a_i1+asc,+id+asc&hl.fl=a_t&rows=100&wt=javabin&version=2&group.field=a_i1&group=true}
 hits=0 status=0 QTime=0
   [junit4]   2> 432598 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={df=text&group.distributed.first=true&distrib=false&hl=false&fl=id&group.limit=-1&shards.purpose=2048&start=0&sort=a_i1+asc,+id+asc&shard.url=[::1]:8/|[::1]:6/|[::1]:4/|https://127.0.0.1:44439/collection1&rows=100&rid=127.0.0.1-8849&version=2&q=*:*&omitHeader=false&NOW=1596576292255&isShard=true&hl.fl=a_t&wt=javabin&group.field=a_i1&group=true}
 status=0 QTime=0
   [junit4]   2> 432599 INFO  (qtp1071442517-10161) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=[::1]:8/|[::1]:6/|[::1]:4/|https://127.0.0.1:44439/collection1&hl=true&fl=id,a_i1&group.limit=-1&sort=a_i1+asc,+id+asc&hl.fl=a_t&rows=100&wt=javabin&version=2&group.field=a_i1&group=true}
 rid=127.0.0.1-8849 status=0 QTime=5
   [junit4]   2> 432606 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&facet.field=a_t&distrib=false&fl=id,a_i1&group.limit=-1&sort=a_i1+asc,+id+asc&rows=100&facet=true&wt=javabin&version=2&group.field=a_i1&group=true}
 hits=0 status=0 QTime=0
   [junit4]   2> 432608 INFO  (qtp1071442517-10161) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={facet.field=a_t&df=text&group.distributed.first=true&distrib=false&fl=id&group.limit=-1&shards.purpose=2048&start=0&sort=a_i1+asc,+id+asc&shard.url=https://127.0.0.1:44439/collection1&rows=100&rid=127.0.0.1-8851&version=2&q=*:*&omitHeader=false&NOW=1596576292268&isShard=true&facet=false&wt=javabin&group.field=a_i1&group=true}
 status=0 QTime=0
   [junit4]   2> 432609 INFO  (qtp1071442517-10161) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={facet.field=a_t&df=text&distrib=false&fl=id&group.limit=-1&shards.purpose=20&start=0&f.a_t.facet.mincount=0&sort=a_i1+asc,+id+asc&shard.url=https://127.0.0.1:44439/collection1&rows=100&rid=127.0.0.1-8851&version=2&group.distributed.second=true&q=*:*&f.a_t.facet.limit=160&omitHeader=false&NOW=1596576292268&isShard=true&facet=true&wt=javabin&group.field=a_i1&group=true}
 status=0 QTime=0
   [junit4]   2> 432610 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=https://127.0.0.1:44439/collection1&facet.field=a_t&fl=id,a_i1&group.limit=-1&sort=a_i1+asc,+id+asc&rows=100&facet=true&wt=javabin&version=2&group.field=a_i1&group=true}
 rid=127.0.0.1-8851 status=0 QTime=3
   [junit4]   2> 432611 INFO  (qtp875097092-10156) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&stats=true&fl=id,a_i1&group.limit=-1&sort=a_i1+asc,+id+asc&rows=100&wt=javabin&version=2&group.field=a_i1&group=true&stats.field=a_i1}
 hits=0 status=0 QTime=0
   [junit4]   2> 432613 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={df=text&group.distributed.first=true&distrib=false&fl=id&group.limit=-1&shards.purpose=2048&start=0&sort=a_i1+asc,+id+asc&shard.url=https://127.0.0.1:44439/collection1&rows=100&rid=127.0.0.1-8853&version=2&q=*:*&stats=false&omitHeader=false&NOW=1596576292273&isShard=true&wt=javabin&group.field=a_i1&group=true&stats.field=a_i1}
 status=0 QTime=0
   [junit4]   2> 432614 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={df=text&distrib=false&fl=id&group.limit=-1&shards.purpose=516&start=0&sort=a_i1+asc,+id+asc&shard.url=https://127.0.0.1:44439/collection1&rows=100&rid=127.0.0.1-8853&version=2&group.distributed.second=true&q=*:*&stats=true&omitHeader=false&NOW=1596576292273&isShard=true&wt=javabin&group.field=a_i1&group=true&stats.field=a_i1}
 status=0 QTime=0
   [junit4]   2> 432614 INFO  (qtp1071442517-10161) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=https://127.0.0.1:44439/collection1&stats=true&fl=id,a_i1&group.limit=-1&sort=a_i1+asc,+id+asc&rows=100&wt=javabin&version=2&group.field=a_i1&group=true&stats.field=a_i1}
 rid=127.0.0.1-8853 status=0 QTime=2
   [junit4]   2> 432615 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={df=subject&distrib=false&qt=spellCheckCompRH&fl=id,a_i1&group.limit=-1&sort=a_i1+asc,+id+asc&rows=100&version=2&spellcheck.build=true&q=kings&spellcheck=true&wt=javabin&group.field=a_i1&group=true}
 hits=0 status=0 QTime=0
   [junit4]   2> 432617 INFO  (qtp1071442517-10161) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={df=subject&group.distributed.first=true&distrib=false&qt=spellCheckCompRH&fl=id&group.limit=-1&shards.purpose=2048&start=0&sort=a_i1+asc,+id+asc&shard.url=[::1]:8/|[::1]:4/|[::1]:6/|https://127.0.0.1:44439/collection1&rows=100&rid=127.0.0.1-8855&version=2&spellcheck.build=true&q=kings&spellcheck=true&omitHeader=false&NOW=1596576292277&isShard=true&wt=javabin&group.field=a_i1&group=true}
 status=0 QTime=0
   [junit4]   2> 432618 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={df=subject&qt=spellCheckCompRH&fl=id,a_i1&group.limit=-1&sort=a_i1+asc,+id+asc&rows=100&version=2&spellcheck.build=true&q=kings&shards=[::1]:8/|[::1]:4/|[::1]:6/|https://127.0.0.1:44439/collection1&spellcheck=true&wt=javabin&group.field=a_i1&group=true}
 rid=127.0.0.1-8855 status=0 QTime=2
   [junit4]   2> 432624 INFO  (qtp875097092-10156) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={facet.field=a_t&distrib=false&fl=id,a_i1&group.limit=-1&fq=a_s:a&sort=a_i1+asc,+id+asc&rows=100&version=2&q=*:*&group.truncate=true&facet=true&wt=javabin&group.field=a_i1&group=true}
 hits=0 status=0 QTime=4
   [junit4]   2> 432629 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={facet.field=a_t&df=text&group.distributed.first=true&distrib=false&fl=id&group.limit=-1&shards.purpose=2048&start=0&fq=a_s:a&sort=a_i1+asc,+id+asc&shard.url=https://127.0.0.1:44439/collection1|[::1]:4/&rows=100&rid=127.0.0.1-8857&version=2&q=*:*&group.truncate=true&omitHeader=false&NOW=1596576292288&isShard=true&facet=false&wt=javabin&group.field=a_i1&group=true}
 status=0 QTime=0
   [junit4]   2> 432630 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=20&fq=a_s:a&shard.url=https://127.0.0.1:44439/collection1|[::1]:4/&rid=127.0.0.1-8857&wt=javabin&group.field=a_i1&group=true&facet.field=a_t&group.limit=-1&start=0&f.a_t.facet.mincount=0&sort=a_i1+asc,+id+asc&rows=100&version=2&group.distributed.second=true&q=*:*&f.a_t.facet.limit=160&group.truncate=true&omitHeader=false&NOW=1596576292288&isShard=true&facet=true}
 status=0 QTime=0
   [junit4]   2> 432631 INFO  (qtp1071442517-10161) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={facet.field=a_t&fl=id,a_i1&group.limit=-1&fq=a_s:a&sort=a_i1+asc,+id+asc&rows=100&version=2&q=*:*&shards=https://127.0.0.1:44439/collection1|[::1]:4/&group.truncate=true&facet=true&wt=javabin&group.field=a_i1&group=true}
 rid=127.0.0.1-8857 status=0 QTime=4
   [junit4]   2> 432634 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[1 (1674131582267424768)]} 0 1
   [junit4]   2> 432637 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[1 (1674131582270570496)]} 0 1
   [junit4]   2> 432639 INFO  (qtp875097092-10156) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[2 (1674131582272667648)]} 0 1
   [junit4]   2> 432644 INFO  (qtp1071442517-10161) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[2 (1674131582280007680)]} 0 0
   [junit4]   2> 432646 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[3 (1674131582281056256)]} 0 0
   [junit4]   2> 432648 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[3 (1674131582284201984)]} 0 0
   [junit4]   2> 432649 INFO  (qtp875097092-10156) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[4 (1674131582285250560)]} 0 0
   [junit4]   2> 432651 INFO  (qtp1071442517-10161) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[4 (1674131582286299136)]} 0 0
   [junit4]   2> 432654 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[5 (1674131582287347712)]} 0 2
   [junit4]   2> 432656 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[5 (1674131582291542016)]} 0 0
   [junit4]   2> 432657 INFO  (qtp875097092-10156) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[6 (1674131582292590592)]} 0 0
   [junit4]   2> 432658 INFO  (qtp1071442517-10161) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[6 (1674131582294687744)]} 0 0
   [junit4]   2> 432659 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[7 (1674131582295736320)]} 0 0
   [junit4]   2> 432660 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[7 (1674131582296784896)]} 0 0
   [junit4]   2> 432661 INFO  (qtp875097092-10156) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[8 (1674131582297833472)]} 0 0
   [junit4]   2> 432662 INFO  (qtp1071442517-10161) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[8 (1674131582298882048)]} 0 0
   [junit4]   2> 432664 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[9 (1674131582300979200)]} 0 0
   [junit4]   2> 432665 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[9 (1674131582302027776)]} 0 0
   [junit4]   2> 432666 INFO  (qtp875097092-10156) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[10 (1674131582303076352)]} 0 0
   [junit4]   2> 432667 INFO  (qtp1071442517-10161) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[10 (1674131582304124928)]} 0 0
   [junit4]   2> 432668 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[11 (1674131582305173504)]} 0 0
   [junit4]   2> 432668 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[11 (1674131582305173504)]} 0 0
   [junit4]   2> 432669 INFO  (qtp875097092-10156) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[12 (1674131582306222080)]} 0 0
   [junit4]   2> 432669 INFO  (qtp1071442517-10161) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[12 (1674131582306222080)]} 0 0
   [junit4]   2> 432670 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[14 (1674131582307270656)]} 0 0
   [junit4]   2> 432671 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[14 (1674131582307270656)]} 0 0
   [junit4]   2> 432671 INFO  (qtp875097092-10156) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[15 (1674131582308319232)]} 0 0
   [junit4]   2> 432671 INFO  (qtp1071442517-10161) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[15 (1674131582308319232)]} 0 0
   [junit4]   2> 432674 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[16 (1674131582309367808)]} 0 2
   [junit4]   2> 432677 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[16 (1674131582312513536)]} 0 2
   [junit4]   2> 432679 INFO  (qtp875097092-10156) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[17 (1674131582315659264)]} 0 0
   [junit4]   2> 432680 INFO  (qtp1071442517-10161) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[17 (1674131582316707840)]} 0 0
   [junit4]   2> 432681 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[18 (1674131582317756416)]} 0 0
   [junit4]   2> 432682 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[18 (1674131582318804992)]} 0 0
   [junit4]   2> 432682 INFO  (qtp875097092-10156) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[19 (1674131582319853568)]} 0 0
   [junit4]   2> 432683 INFO  (qtp1071442517-10161) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[19 (1674131582320902144)]} 0 0
   [junit4]   2> 432684 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[20 (1674131582321950720)]} 0 0
   [junit4]   2> 432684 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[20 (1674131582321950720)]} 0 0
   [junit4]   2> 432686 INFO  (qtp875097092-10156) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[21 (1674131582322999296)]} 0 0
   [junit4]   2> 432686 INFO  (qtp1071442517-10161) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[21 (1674131582324047872)]} 0 0
   [junit4]   2> 432687 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[22 (1674131582325096448)]} 0 0
   [junit4]   2> 432687 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[22 (1674131582325096448)]} 0 0
   [junit4]   2> 432688 INFO  (qtp875097092-10156) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[23 (1674131582326145024)]} 0 0
   [junit4]   2> 432689 INFO  (qtp1071442517-10161) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[23 (1674131582326145024)]} 0 0
   [junit4]   2> 432692 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[100 (1674131582330339328)]} 0 0
   [junit4]   2> 432693 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[100 (1674131582331387904)]} 0 0
   [junit4]   2> 432694 INFO  (qtp875097092-10156) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[101 (1674131582332436480)]} 0 0
   [junit4]   2> 432695 INFO  (qtp1071442517-10161) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[101 (1674131582332436480)]} 0 0
   [junit4]   2> 432695 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[102 (1674131582333485056)]} 0 0
   [junit4]   2> 432696 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[102 (1674131582333485056)]} 0 0
   [junit4]   2> 432696 INFO  (qtp875097092-10156) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[103 (1674131582334533632)]} 0 0
   [junit4]   2> 432698 INFO  (qtp1071442517-10161) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[103 (1674131582335582208)]} 0 0
   [junit4]   2> 432698 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[104 (1674131582336630784)]} 0 0
   [junit4]   2> 432700 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[104 (1674131582338727936)]} 0 0
   [junit4]   2> 432701 INFO  (qtp875097092-10156) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[105 (1674131582339776512)]} 0 0
   [junit4]   2> 432702 INFO  (qtp1071442517-10161) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[105 (1674131582339776512)]} 0 0
   [junit4]   2> 432702 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[106 (1674131582340825088)]} 0 0
   [junit4]   2> 432703 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[106 (1674131582341873664)]} 0 0
   [junit4]   2> 432703 INFO  (qtp875097092-10156) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[107 (1674131582341873664)]} 0 0
   [junit4]   2> 432704 INFO  (qtp1071442517-10161) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[107 (1674131582342922240)]} 0 0
   [junit4]   2> 432704 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[108 (1674131582342922240)]} 0 0
   [junit4]   2> 432705 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[108 (1674131582342922241)]} 0 0
   [junit4]   2> 432706 INFO  (qtp875097092-10156) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[109 (1674131582343970816)]} 0 0
   [junit4]   2> 432707 INFO  (qtp1071442517-10161) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[109 (1674131582345019392)]} 0 0
   [junit4]   2> 432707 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[110 (1674131582346067968)]} 0 0
   [junit4]   2> 432708 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[110 (1674131582347116544)]} 0 0
   [junit4]   2> 432711 INFO  (qtp875097092-10156) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[111 (1674131582350262272)]} 0 0
   [junit4]   2> 432712 INFO  (qtp1071442517-10161) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[111 (1674131582351310848)]} 0 0
   [junit4]   2> 432713 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[112 (1674131582352359424)]} 0 0
   [junit4]   2> 432714 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[112 (1674131582353408000)]} 0 0
   [junit4]   2> 432715 INFO  (qtp875097092-10156) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[113 (1674131582353408000)]} 0 0
   [junit4]   2> 432715 INFO  (qtp1071442517-10161) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[113 (1674131582354456576)]} 0 0
   [junit4]   2> 432716 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[114 (1674131582354456576)]} 0 0
   [junit4]   2> 432716 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[114 (1674131582355505152)]} 0 0
   [junit4]   2> 432717 INFO  (qtp875097092-10156) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[115 (1674131582356553728)]} 0 0
   [junit4]   2> 432717 INFO  (qtp1071442517-10161) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[115 (1674131582356553728)]} 0 0
   [junit4]   2> 432718 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[116 (1674131582357602304)]} 0 0
   [junit4]   2> 432718 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[116 (1674131582357602304)]} 0 0
   [junit4]   2> 432719 INFO  (qtp875097092-10156) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[117 (1674131582358650880)]} 0 0
   [junit4]   2> 432720 INFO  (qtp1071442517-10161) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[117 (1674131582358650880)]} 0 0
   [junit4]   2> 432720 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[118 (1674131582359699456)]} 0 0
   [junit4]   2> 432721 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[118 (1674131582359699456)]} 0 0
   [junit4]   2> 432721 INFO  (qtp875097092-10156) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[119 (1674131582360748032)]} 0 0
   [junit4]   2> 432722 INFO  (qtp1071442517-10161) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[119 (1674131582360748032)]} 0 0
   [junit4]   2> 432722 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[120 (1674131582361796608)]} 0 0
   [junit4]   2> 432722 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[120 (1674131582361796608)]} 0 0
   [junit4]   2> 432723 INFO  (qtp875097092-10156) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[121 (1674131582362845184)]} 0 0
   [junit4]   2> 432723 INFO  (qtp1071442517-10161) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[121 (1674131582362845184)]} 0 0
   [junit4]   2> 432724 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[122 (1674131582362845185)]} 0 0
   [junit4]   2> 432724 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[122 (1674131582363893760)]} 0 0
   [junit4]   2> 432724 INFO  (qtp875097092-10156) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[123 (1674131582363893760)]} 0 0
   [junit4]   2> 432725 INFO  (qtp1071442517-10161) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[123 (1674131582364942336)]} 0 0
   [junit4]   2> 432725 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[124 (1674131582364942336)]} 0 0
   [junit4]   2> 432728 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[124 (1674131582367039488)]} 0 0
   [junit4]   2> 432728 INFO  (qtp875097092-10156) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[125 (1674131582368088064)]} 0 0
   [junit4]   2> 432729 INFO  (qtp1071442517-10161) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[125 (1674131582369136640)]} 0 0
   [junit4]   2> 432729 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[126 (1674131582369136640)]} 0 0
   [junit4]   2> 432730 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[126 (1674131582370185216)]} 0 0
   [junit4]   2> 432730 INFO  (qtp875097092-10156) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[127 (1674131582370185216)]} 0 0
   [junit4]   2> 432731 INFO  (qtp1071442517-10161) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[127 (1674131582371233792)]} 0 0
   [junit4]   2> 432731 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[128 (1674131582371233792)]} 0 0
   [junit4]   2> 432732 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[128 (1674131582372282368)]} 0 0
   [junit4]   2> 432732 INFO  (qtp875097092-10156) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[129 (1674131582372282368)]} 0 0
   [junit4]   2> 432733 INFO  (qtp1071442517-10161) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[129 (1674131582373330944)]} 0 0
   [junit4]   2> 432733 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[130 (1674131582373330944)]} 0 0
   [junit4]   2> 432734 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[130 (1674131582373330945)]} 0 0
   [junit4]   2> 432734 INFO  (qtp875097092-10156) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[131 (1674131582374379520)]} 0 0
   [junit4]   2> 432735 INFO  (qtp1071442517-10161) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[131 (1674131582374379520)]} 0 0
   [junit4]   2> 432735 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[132 (1674131582375428096)]} 0 0
   [junit4]   2> 432735 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[132 (1674131582375428096)]} 0 0
   [junit4]   2> 432736 INFO  (qtp875097092-10156) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[133 (1674131582376476672)]} 0 0
   [junit4]   2> 432737 INFO  (qtp1071442517-10161) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[133 (1674131582376476672)]} 0 0
   [junit4]   2> 432737 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[134 (1674131582377525248)]} 0 0
   [junit4]   2> 432748 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[134 (1674131582389059584)]} 0 0
   [junit4]   2> 432750 INFO  (qtp875097092-10156) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[135 (1674131582390108160)]} 0 0
   [junit4]   2> 432752 INFO  (qtp1071442517-10161) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[135 (1674131582392205312)]} 0 0
   [junit4]   2> 432753 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[136 (1674131582393253888)]} 0 0
   [junit4]   2> 432753 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[136 (1674131582394302464)]} 0 0
   [junit4]   2> 432754 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[137 (1674131582394302464)]} 0 0
   [junit4]   2> 432754 INFO  (qtp1071442517-10161) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[137 (1674131582395351040)]} 0 0
   [junit4]   2> 432754 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[138 (1674131582395351040)]} 0 0
   [junit4]   2> 432755 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[138 (1674131582396399616)]} 0 0
   [junit4]   2> 432756 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[139 (1674131582396399616)]} 0 0
   [junit4]   2> 432756 INFO  (qtp1071442517-10161) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[139 (1674131582397448192)]} 0 0
   [junit4]   2> 432756 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[140 (1674131582397448192)]} 0 0
   [junit4]   2> 432757 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[140 (1674131582398496768)]} 0 0
   [junit4]   2> 432757 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[141 (1674131582398496768)]} 0 0
   [junit4]   2> 432758 INFO  (qtp1071442517-10161) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[141 (1674131582399545344)]} 0 0
   [junit4]   2> 432759 INFO  (qtp875097092-10156) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[142 (1674131582400593920)]} 0 0
   [junit4]   2> 432760 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[142 (1674131582400593920)]} 0 0
   [junit4]   2> 432760 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[143 (1674131582401642496)]} 0 0
   [junit4]   2> 432760 INFO  (qtp1071442517-10161) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[143 (1674131582401642496)]} 0 0
   [junit4]   2> 432761 INFO  (qtp875097092-10156) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[144 (1674131582402691072)]} 0 0
   [junit4]   2> 432761 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[144 (1674131582402691072)]} 0 0
   [junit4]   2> 432761 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[145 (1674131582402691073)]} 0 0
   [junit4]   2> 432762 INFO  (qtp1071442517-10161) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[145 (1674131582403739648)]} 0 0
   [junit4]   2> 432762 INFO  (qtp875097092-10156) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[146 (1674131582403739648)]} 0 0
   [junit4]   2> 432762 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[146 (1674131582403739649)]} 0 0
   [junit4]   2> 432763 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[147 (1674131582404788224)]} 0 0
   [junit4]   2> 432763 INFO  (qtp1071442517-10161) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[147 (1674131582404788224)]} 0 0
   [junit4]   2> 432764 INFO  (qtp875097092-10156) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[148 (1674131582405836800)]} 0 0
   [junit4]   2> 432765 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[148 (1674131582406885376)]} 0 0
   [junit4]   2> 432765 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[149 (1674131582406885376)]} 0 0
   [junit4]   2> 432766 INFO  (qtp1071442517-10161) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[149 (1674131582407933952)]} 0 0
   [junit4]   2> 432767 INFO  (qtp875097092-10156) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[500 (1674131582407933952)]} 0 0
   [junit4]   2> 432767 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[500 (1674131582408982528)]} 0 0
   [junit4]   2> 432767 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[501 (1674131582408982528)]} 0 0
   [junit4]   2> 432768 INFO  (qtp1071442517-10161) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[501 (1674131582410031104)]} 0 0
   [junit4]   2> 432768 INFO  (qtp875097092-10156) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[502 (1674131582410031104)]} 0 0
   [junit4]   2> 432768 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[502 (1674131582410031105)]} 0 0
   [junit4]   2> 432768 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[503 (1674131582410031105)]} 0 0
   [junit4]   2> 432769 INFO  (qtp1071442517-10161) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[503 (1674131582411079680)]} 0 0
   [junit4]   2> 432769 INFO  (qtp875097092-10156) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[504 (1674131582411079680)]} 0 0
   [junit4]   2> 432769 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[504 (1674131582411079681)]} 0 0
   [junit4]   2> 432770 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[505 (1674131582412128256)]} 0 0
   [junit4]   2> 432770 INFO  (qtp1071442517-10161) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[505 (1674131582412128256)]} 0 0
   [junit4]   2> 432770 INFO  (qtp875097092-10156) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[506 (1674131582412128257)]} 0 0
   [junit4]   2> 432771 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[506 (1674131582412128257)]} 0 0
   [junit4]   2> 432771 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[507 (1674131582413176832)]} 0 0
   [junit4]   2> 432771 INFO  (qtp1071442517-10161) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[507 (1674131582413176832)]} 0 0
   [junit4]   2> 432772 INFO  (qtp875097092-10156) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[508 (1674131582414225408)]} 0 0
   [junit4]   2> 432772 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[508 (1674131582414225408)]} 0 0
   [junit4]   2> 432772 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[509 (1674131582414225409)]} 0 0
   [junit4]   2> 432773 INFO  (qtp1071442517-10161) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[509 (1674131582415273984)]} 0 0
   [junit4]   2> 432773 INFO  (qtp875097092-10156) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[510 (1674131582415273984)]} 0 0
   [junit4]   2> 432773 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[510 (1674131582415273985)]} 0 0
   [junit4]   2> 432774 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[511 (1674131582416322560)]} 0 0
   [junit4]   2> 432774 INFO  (qtp1071442517-10161) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[511 (1674131582416322560)]} 0 0
   [junit4]   2> 432775 INFO  (qtp875097092-10156) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[512 (1674131582417371136)]} 0 0
   [junit4]   2> 432775 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[512 (1674131582417371136)]} 0 0
   [junit4]   2> 432776 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[513 (1674131582417371137)]} 0 0
   [junit4]   2> 432776 INFO  (qtp1071442517-10161) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[513 (1674131582418419712)]} 0 0
   [junit4]   2> 432776 INFO  (qtp875097092-10156) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[514 (1674131582418419712)]} 0 0
   [junit4]   2> 432777 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[514 (1674131582418419713)]} 0 0
   [junit4]   2> 432777 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[515 (1674131582419468288)]} 0 0
   [junit4]   2> 432777 INFO  (qtp1071442517-10161) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[515 (1674131582419468288)]} 0 0
   [junit4]   2> 432777 INFO  (qtp875097092-10156) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[516 (1674131582419468289)]} 0 0
   [junit4]   2> 432778 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[516 (1674131582420516864)]} 0 0
   [junit4]   2> 432778 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[517 (1674131582420516864)]} 0 0
   [junit4]   2> 432778 INFO  (qtp1071442517-10161) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[517 (1674131582420516865)]} 0 0
   [junit4]   2> 432779 INFO  (qtp875097092-10156) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[518 (1674131582421565440)]} 0 0
   [junit4]   2> 432779 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[518 (1674131582421565440)]} 0 0
   [junit4]   2> 432779 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[519 (1674131582421565441)]} 0 0
   [junit4]   2> 432780 INFO  (qtp1071442517-10161) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[519 (1674131582422614016)]} 0 0
   [junit4]   2> 432780 INFO  (qtp875097092-10156) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[520 (1674131582422614016)]} 0 0
   [junit4]   2> 432780 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[520 (1674131582422614017)]} 0 0
   [junit4]   2> 432781 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[521 (1674131582423662592)]} 0 0
   [junit4]   2> 432781 INFO  (qtp1071442517-10161) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[521 (1674131582423662592)]} 0 0
   [junit4]   2> 432781 INFO  (qtp875097092-10156) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[522 (1674131582423662593)]} 0 0
   [junit4]   2> 432782 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[522 (1674131582424711168)]} 0 0
   [junit4]   2> 432782 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[523 (1674131582424711168)]} 0 0
   [junit4]   2> 432782 INFO  (qtp1071442517-10161) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[523 (1674131582424711169)]} 0 0
   [junit4]   2> 432783 INFO  (qtp875097092-10156) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[524 (1674131582424711169)]} 0 0
   [junit4]   2> 432783 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[524 (1674131582425759744)]} 0 0
   [junit4]   2> 432783 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[525 (1674131582425759744)]} 0 0
   [junit4]   2> 432784 INFO  (qtp1071442517-10161) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[525 (1674131582425759745)]} 0 0
   [junit4]   2> 432784 INFO  (qtp875097092-10156) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[526 (1674131582426808320)]} 0 0
   [junit4]   2> 432784 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[526 (1674131582426808320)]} 0 0
   [junit4]   2> 432785 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[527 (1674131582427856896)]} 0 0
   [junit4]   2> 432785 INFO  (qtp1071442517-10161) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[527 (1674131582427856896)]} 0 0
   [junit4]   2> 432785 INFO  (qtp875097092-10156) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[528 (1674131582427856897)]} 0 0
   [junit4]   2> 432786 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[528 (1674131582428905472)]} 0 0
   [junit4]   2> 432786 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[529 (1674131582428905472)]} 0 0
   [junit4]   2> 432787 INFO  (qtp1071442517-10161) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[529 (1674131582428905473)]} 0 0
   [junit4]   2> 432787 INFO  (qtp875097092-10156) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[530 (1674131582429954048)]} 0 0
   [junit4]   2> 432792 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[530 (1674131582435196928)]} 0 0
   [junit4]   2> 432792 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[531 (1674131582435196928)]} 0 0
   [junit4]   2> 432793 INFO  (qtp1071442517-10161) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[531 (1674131582436245504)]} 0 0
   [junit4]   2> 432795 INFO  (qtp875097092-10156) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[532 (1674131582437294080)]} 0 0
   [junit4]   2> 432795 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[532 (1674131582438342656)]} 0 0
   [junit4]   2> 432796 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[533 (1674131582439391232)]} 0 0
   [junit4]   2> 432796 INFO  (qtp1071442517-10161) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[533 (1674131582439391232)]} 0 0
   [junit4]   2> 432797 INFO  (qtp875097092-10156) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[534 (1674131582439391233)]} 0 0
   [junit4]   2> 432797 INFO  (qtp1071442517-10157) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[534 (1674131582440439808)]} 0 0
   [junit4]   2> 432797 INFO  (qtp875097092-10154) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[535 (1674131582440439808)]} 0 0
   [junit4]   2> 432798 INFO  (qtp1071442517-10161) [    x:collection1 ] o.a.s.

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

de, service url = null, agent id = null] for registry 
solr.node/com.codahale.metrics.MetricRegistry@1429b810
   [junit4]   2> 434295 INFO  (closeThreadPool-6116-thread-4) [     ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm 
tag=null
   [junit4]   2> 434295 INFO  (closeThreadPool-6116-thread-4) [     ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@5392f37b: rootName = null, 
domain = solr.jvm, service url = null, agent id = null] for registry 
solr.jvm/com.codahale.metrics.MetricRegistry@4eb41940
   [junit4]   2> 434297 INFO  (closeThreadPool-6116-thread-4) [     ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty 
tag=null
   [junit4]   2> 434297 INFO  (closeThreadPool-6116-thread-4) [     ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@51130fd: rootName = null, 
domain = solr.jetty, service url = null, agent id = null] for registry 
solr.jetty/com.codahale.metrics.MetricRegistry@4b224c7c
   [junit4]   2> 434304 INFO  (closeThreadPool-6116-thread-2) [     ] 
o.e.j.s.AbstractConnector Stopped ServerConnector@625e1f05{SSL, (ssl, 
http/1.1)}{127.0.0.1:0}
   [junit4]   2> 434304 INFO  (closeThreadPool-6116-thread-2) [     ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@68357fe6{/,null,UNAVAILABLE}
   [junit4]   2> 434305 INFO  (closeThreadPool-6116-thread-2) [     ] 
o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 434309 INFO  (closeThreadPool-6116-thread-4) [     ] 
o.e.j.s.AbstractConnector Stopped ServerConnector@34f895ec{SSL, (ssl, 
http/1.1)}{127.0.0.1:0}
   [junit4]   2> 434309 INFO  (closeThreadPool-6116-thread-4) [     ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@46bf7c2{/,null,UNAVAILABLE}
   [junit4]   2> 434309 INFO  (closeThreadPool-6116-thread-4) [     ] 
o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=TestDistributedGrouping -Dtests.method=test 
-Dtests.seed=23D6F5950C7D8424 -Dtests.multiplier=3 -Dtests.slow=true 
-Dtests.locale=id -Dtests.timezone=Antarctica/Syowa -Dtests.asserts=true 
-Dtests.file.encoding=ISO-8859-1
   [junit4] ERROR   2.63s J5 | TestDistributedGrouping.test <<<
   [junit4]    > Throwable #1: 
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error 
from server at https://127.0.0.1:44439/collection1: 
org.apache.solr.client.solrj.SolrServerException: Time allowed to handle this 
request exceeded:[https://[::1]:4, https://[::1]:8, https://[::1]:6]
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([23D6F5950C7D8424:AB82CA4FA281E9DC]:0)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:681)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:266)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:248)
   [junit4]    >        at 
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:214)
   [junit4]    >        at 
org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:1003)
   [junit4]    >        at 
org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:1018)
   [junit4]    >        at 
org.apache.solr.BaseDistributedSearchTestCase.queryServer(BaseDistributedSearchTestCase.java:625)
   [junit4]    >        at 
org.apache.solr.TestDistributedGrouping.simpleQuery(TestDistributedGrouping.java:455)
   [junit4]    >        at 
org.apache.solr.TestDistributedGrouping.test(TestDistributedGrouping.java:443)
   [junit4]    >        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsRepeatStatement.callStatement(BaseDistributedSearchTestCase.java:1117)
   [junit4]    >        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:1061)
   [junit4]    >        at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J5/temp/solr.TestDistributedGrouping_23D6F5950C7D8424-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene86): 
{other_tl1=PostingsFormat(name=Direct), 
SubjectTerms_mfacet=PostingsFormat(name=Direct), 
range_facet_l_dv=BlockTreeOrds(blocksize=128), 
n_l1=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)), 
multiDefault=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)),
 intDefault=PostingsFormat(name=Direct), n_td1=PostingsFormat(name=Direct), 
n_d1=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)), 
n_f1=PostingsFormat(name=Direct), 
range_facet_l=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)),
 b_n_tdt1=BlockTreeOrds(blocksize=128), n_tl1=PostingsFormat(name=Direct), 
a_n_tdt1=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)),
 a_s=PostingsFormat(name=Asserting), 
n_tf1=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)), 
a_t=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)), 
id=BlockTreeOrds(blocksize=128), text=PostingsFormat(name=Asserting), 
oddField_s1=PostingsFormat(name=Direct), a_idv=PostingsFormat(name=Asserting), 
timestamp=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)),
 _root_=PostingsFormat(name=Direct), n_dt1=PostingsFormat(name=Direct), 
a_i1=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)), 
n_ti1=BlockTreeOrds(blocksize=128), rnd_b=BlockTreeOrds(blocksize=128), 
foo_b=PostingsFormat(name=Asserting), n_tdt1=PostingsFormat(name=Direct), 
foo_d=BlockTreeOrds(blocksize=128), id_i1=PostingsFormat(name=Direct), 
range_facet_i_dv=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)),
 foo_f=PostingsFormat(name=Asserting)}, 
docValues:{range_facet_l_dv=DocValuesFormat(name=Lucene80), 
_version_=DocValuesFormat(name=Lucene80), 
a_b_dvo=DocValuesFormat(name=Lucene80), a_s_dvo=DocValuesFormat(name=Lucene80), 
range_facet_i_dv=DocValuesFormat(name=Asserting), 
intDvoDefault=DocValuesFormat(name=Lucene80), 
a_idv=DocValuesFormat(name=Direct), timestamp=DocValuesFormat(name=Asserting)}, 
maxPointsInLeafNode=639, maxMBSortInHeap=6.242362433622361, 
sim=Asserting(RandomSimilarity(queryNorm=false): {}), locale=id, 
timezone=Antarctica/Syowa
   [junit4]   2> NOTE: Linux 5.4.0-40-generic amd64/Oracle Corporation 
1.8.0_201 (64-bit)/cpus=16,threads=1,free=228953936,total=525336576
   [junit4]   2> NOTE: All tests run in this JVM: [NumberUtilsTest, 
TestJsonRequest, TestRawResponseWriter, RequiredFieldsTest, TestFaceting, 
TestFieldResource, TestPullReplica, PhrasesIdentificationComponentTest, 
DistributedDebugComponentTest, TestDocumentBuilder, 
WrapperMergePolicyFactoryTest, BasicAuthOnSingleNodeTest, 
LeaderFailureAfterFreshStartTest, HdfsWriteToMultipleCollectionsTest, 
TestClusterProperties, HttpPartitionTest, BinaryUpdateRequestHandlerTest, 
RouteFieldTest, TestCoreContainer, TestFieldSortValues, TestSchemaField, 
TestTlogReplayVsRecovery, TestIndexSearcher, TestInPlaceUpdatesDistrib, 
TestDynamicLoadingUrl, CreateCollectionCleanupTest, BasicDistributedZkTest, 
HdfsRecoveryZkTest, MultiDestinationAuditLoggerTest, 
DistributedIntervalFacetingTest, TestJsonRangeFacets, CdcrOpsAndBoundariesTest, 
BigEndianAscendingWordDeserializerTest, TestStressThreadBackup, 
TestSchemaVersionResource, MigrateRouteKeyTest, TestCustomDocTransformer, 
TestSimGenericDistributedQueue, TestSolrCLIRunExample, 
ConcurrentCreateCollectionTest, DirectUpdateHandlerTest, 
TestSolrCloudWithDelegationTokens, CircularListTest, TestCodecSupport, 
ExitableDirectoryReaderTest, RestoreTriggerStateTest, 
SpellingQueryConverterTest, OverseerTest, TestSimClusterStateProvider, 
TestShardHandlerFactory, HLLUtilTest, TestDistribDocBasedVersion, 
URLClassifyProcessorTest, DistributedFacetPivotSmallTest, 
AdminHandlersProxyTest, TestCloudJSONFacetSKGEquiv, 
HdfsBasicDistributedZk2Test, TestSolrXml, OpenExchangeRatesOrgProviderTest, 
CoreMergeIndexesAdminHandlerTest, TestExportWriter, 
TestFuzzyAnalyzedSuggestions, UtilsToolTest, SolrIndexMetricsTest, AssignTest, 
BadCopyFieldTest, DistributedSpellCheckComponentTest, 
TestSha256AuthenticationProvider, OverseerModifyCollectionTest, 
DirectSolrConnectionTest, TestDFRSimilarityFactory, TestBinaryField, TestSort, 
TaggingAttributeTest, TestRequestStatusCollectionAPI, TestMacroExpander, 
EchoParamsTest, MinimalSchemaTest, OutputWriterTest, SampleTest, 
SolrInfoBeanTest, SolrTestCaseJ4Test, TestCrossCoreJoin, 
TestCursorMarkWithoutUniqueKey, TestDistributedGrouping]
   [junit4] Completed [338/917 (1!)] on J5 in 2.77s, 1 test, 1 error <<< 
FAILURES!

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

[repro] Revision: 83569665e7a235a208752e3733586d2cb5c1a4e0

[repro] Ant options: "-Dargs=-XX:-UseCompressedOops -XX:+UseParallelGC"
[repro] Repro line:  ant test  -Dtestcase=TestDistributedGrouping 
-Dtests.method=test -Dtests.seed=23D6F5950C7D8424 -Dtests.multiplier=3 
-Dtests.slow=true -Dtests.locale=id -Dtests.timezone=Antarctica/Syowa 
-Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1

[repro] JUnit rest result XML files will be moved to: ./repro-reports
[repro] ant clean

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

[...truncated 3446 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5 
-Dtests.class="*.TestDistributedGrouping" -Dtests.showOutput=onerror 
"-Dargs=-XX:-UseCompressedOops -XX:+UseParallelGC" 
-Dtests.seed=23D6F5950C7D8424 -Dtests.multiplier=3 -Dtests.slow=true 
-Dtests.locale=id -Dtests.timezone=Antarctica/Syowa -Dtests.asserts=true 
-Dtests.file.encoding=ISO-8859-1

[...truncated 76 lines...]
[repro] Failures w/original seeds:
[repro]   0/5 failed: org.apache.solr.TestDistributedGrouping
[repro] Exiting with code 0

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

Reply via email to