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

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

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

Stack Trace:
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error 
from server at https://127.0.0.1:36205/b/et/collection1: 
org.apache.solr.client.solrj.SolrServerException: Time allowed to handle this 
request exceeded:[https://[::1]:6/b/et, https://[::1]:4/b/et, 
https://[::1]:8/b/et]
        at 
__randomizedtesting.SeedInfo.seed([77F4A3BBDDFFBE93:FFA09C617303D36B]: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 14235 lines...]
   [junit4] Suite: org.apache.solr.TestDistributedGrouping
   [junit4]   2> 329524 INFO  
(SUITE-TestDistributedGrouping-seed#[77F4A3BBDDFFBE93]-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> 329524 INFO  
(SUITE-TestDistributedGrouping-seed#[77F4A3BBDDFFBE93]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Created dataDir: 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J2/temp/solr.TestDistributedGrouping_77F4A3BBDDFFBE93-001/data-dir-43-001
   [junit4]   2> 329524 WARN  
(SUITE-TestDistributedGrouping-seed#[77F4A3BBDDFFBE93]-worker) [     ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=2 numCloses=2
   [junit4]   2> 329525 INFO  
(SUITE-TestDistributedGrouping-seed#[77F4A3BBDDFFBE93]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) 
w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 329526 INFO  
(SUITE-TestDistributedGrouping-seed#[77F4A3BBDDFFBE93]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via: 
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
   [junit4]   2> 329526 INFO  
(SUITE-TestDistributedGrouping-seed#[77F4A3BBDDFFBE93]-worker) [     ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 329527 INFO  
(SUITE-TestDistributedGrouping-seed#[77F4A3BBDDFFBE93]-worker) [     ] 
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /b/et
   [junit4]   2> 329606 INFO  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J2/temp/solr.TestDistributedGrouping_77F4A3BBDDFFBE93-001/tempDir-001/control/cores/collection1
   [junit4]   2> 329608 WARN  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, 
break even is size 23
   [junit4]   2> 329608 INFO  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 329608 INFO  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
   [junit4]   2> 329608 INFO  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
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> 329621 INFO  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 329621 INFO  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 329621 INFO  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 329622 INFO  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@54be9df0{/b/et,null,AVAILABLE}
   [junit4]   2> 329632 INFO  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.e.j.s.AbstractConnector Started ServerConnector@12fe8a04{SSL, (ssl, 
http/1.1)}{127.0.0.1:37997}
   [junit4]   2> 329632 INFO  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.e.j.s.Server Started @329661ms
   [junit4]   2> 329632 INFO  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/b/et, 
hostPort=37997, 
coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J2/temp/solr.TestDistributedGrouping_77F4A3BBDDFFBE93-001/tempDir-001/control/cores}
   [junit4]   2> 329633 ERROR 
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 329633 INFO  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 329633 INFO  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.7.0
   [junit4]   2> 329633 INFO  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 329633 INFO  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr
   [junit4]   2> 329633 INFO  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2020-08-19T03:29:12.858Z
   [junit4]   2> 329633 INFO  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J2/temp/solr.TestDistributedGrouping_77F4A3BBDDFFBE93-001/tempDir-001/control/solr.xml
   [junit4]   2> 329636 INFO  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay 
is ignored
   [junit4]   2> 329636 INFO  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 329638 INFO  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@3441b2bd, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 329720 INFO  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
   [junit4]   2> 329721 WARN  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
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> 329723 WARN  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@209f5225[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 329723 WARN  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@209f5225[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 329727 WARN  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
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> 329733 WARN  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@18f1260d[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 329733 WARN  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@18f1260d[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 329735 WARN  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
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> 329747 INFO  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 329747 INFO  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history 
in memory.
   [junit4]   2> 329761 INFO  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3441b2bd
   [junit4]   2> 329766 INFO  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3441b2bd
   [junit4]   2> 329767 INFO  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3441b2bd
   [junit4]   2> 329769 INFO  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J2/temp/solr.TestDistributedGrouping_77F4A3BBDDFFBE93-001/tempDir-001/control/cores
   [junit4]   2> 329769 INFO  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 329787 INFO  (coreLoadExecutor-4675-thread-1) [    
x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.7.0
   [junit4]   2> 329831 INFO  (coreLoadExecutor-4675-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema Schema name=test
   [junit4]   2> 329939 INFO  (coreLoadExecutor-4675-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field 
id
   [junit4]   2> 329947 INFO  (coreLoadExecutor-4675-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> 329947 INFO  (coreLoadExecutor-4675-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@3441b2bd
   [junit4]   2> 329947 INFO  (coreLoadExecutor-4675-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/J2/temp/solr.TestDistributedGrouping_77F4A3BBDDFFBE93-001/tempDir-001/control/cores/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J2/temp/solr.TestDistributedGrouping_77F4A3BBDDFFBE93-001/tempDir-001/control/cores/collection1/data/]
   [junit4]   2> 329948 INFO  (coreLoadExecutor-4675-thread-1) [    
x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=22, maxMergeAtOnceExplicit=37, maxMergedSegmentMB=40.6630859375, 
floorSegmentMB=2.1142578125, forceMergeDeletesPctAllowed=3.718152343627763, 
segmentsPerTier=32.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.6928177417173387, deletesPctAllowed=25.97467662290196
   [junit4]   2> 330036 INFO  (coreLoadExecutor-4675-thread-1) [    
x:collection1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 330036 INFO  (coreLoadExecutor-4675-thread-1) [    
x:collection1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 330037 INFO  (coreLoadExecutor-4675-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 330037 INFO  (coreLoadExecutor-4675-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 330037 INFO  (coreLoadExecutor-4675-thread-1) [    
x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=49, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=1.0]
   [junit4]   2> 330048 INFO  (coreLoadExecutor-4675-thread-1) [    
x:collection1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 330051 INFO  (coreLoadExecutor-4675-thread-1) [    
x:collection1 ] o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 330079 INFO  (coreLoadExecutor-4675-thread-1) [    
x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 330079 INFO  (coreLoadExecutor-4675-thread-1) [    
x:collection1 ] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1675422862728495104
   [junit4]   2> 330083 INFO  
(searcherExecutor-4677-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 330091 INFO  
(searcherExecutor-4677-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 330091 INFO  
(searcherExecutor-4677-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 330091 INFO  
(searcherExecutor-4677-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 330092 INFO  
(searcherExecutor-4677-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 330092 INFO  
(searcherExecutor-4677-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 330092 INFO  
(searcherExecutor-4677-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 330092 INFO  
(searcherExecutor-4677-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 330092 INFO  
(searcherExecutor-4677-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 330093 INFO  
(searcherExecutor-4677-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 330164 INFO  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J2/temp/solr.TestDistributedGrouping_77F4A3BBDDFFBE93-001/tempDir-001/shard0/cores/collection1
   [junit4]   2> 330166 WARN  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, 
break even is size 23
   [junit4]   2> 330166 INFO  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 330166 INFO  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
   [junit4]   2> 330166 INFO  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
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> 330200 INFO  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 330200 INFO  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 330200 INFO  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 330201 INFO  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@1d4f165a{/b/et,null,AVAILABLE}
   [junit4]   2> 330203 INFO  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.e.j.s.AbstractConnector Started ServerConnector@31514adb{SSL, (ssl, 
http/1.1)}{127.0.0.1:36205}
   [junit4]   2> 330203 INFO  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.e.j.s.Server Started @330232ms
   [junit4]   2> 330203 INFO  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/b/et, 
hostPort=36205, 
coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J2/temp/solr.TestDistributedGrouping_77F4A3BBDDFFBE93-001/tempDir-001/shard0/cores}
   [junit4]   2> 330204 ERROR 
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 330204 INFO  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 330204 INFO  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.7.0
   [junit4]   2> 330204 INFO  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 330204 INFO  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr
   [junit4]   2> 330204 INFO  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2020-08-19T03:29:13.429Z
   [junit4]   2> 330204 INFO  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J2/temp/solr.TestDistributedGrouping_77F4A3BBDDFFBE93-001/tempDir-001/shard0/solr.xml
   [junit4]   2> 330207 INFO  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay 
is ignored
   [junit4]   2> 330207 INFO  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 330213 INFO  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@3441b2bd, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 330284 INFO  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
   [junit4]   2> 330289 WARN  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
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> 330290 WARN  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@6bbbfdc6[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 330290 WARN  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@6bbbfdc6[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 330294 WARN  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
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> 330304 WARN  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@26b832d1[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 330304 WARN  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@26b832d1[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 330305 WARN  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
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> 330339 INFO  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 330339 INFO  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history 
in memory.
   [junit4]   2> 330367 INFO  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3441b2bd
   [junit4]   2> 330375 INFO  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3441b2bd
   [junit4]   2> 330375 INFO  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3441b2bd
   [junit4]   2> 330389 INFO  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J2/temp/solr.TestDistributedGrouping_77F4A3BBDDFFBE93-001/tempDir-001/shard0/cores
   [junit4]   2> 330389 INFO  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 330424 INFO  (coreLoadExecutor-4693-thread-1) [    
x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.7.0
   [junit4]   2> 330491 INFO  (coreLoadExecutor-4693-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema Schema name=test
   [junit4]   2> 330656 INFO  (coreLoadExecutor-4693-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field 
id
   [junit4]   2> 330673 INFO  (coreLoadExecutor-4693-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> 330673 INFO  (coreLoadExecutor-4693-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@3441b2bd
   [junit4]   2> 330673 INFO  (coreLoadExecutor-4693-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/J2/temp/solr.TestDistributedGrouping_77F4A3BBDDFFBE93-001/tempDir-001/shard0/cores/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J2/temp/solr.TestDistributedGrouping_77F4A3BBDDFFBE93-001/tempDir-001/shard0/cores/collection1/data/]
   [junit4]   2> 330675 INFO  (coreLoadExecutor-4693-thread-1) [    
x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=22, maxMergeAtOnceExplicit=37, maxMergedSegmentMB=40.6630859375, 
floorSegmentMB=2.1142578125, forceMergeDeletesPctAllowed=3.718152343627763, 
segmentsPerTier=32.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.6928177417173387, deletesPctAllowed=25.97467662290196
   [junit4]   2> 330740 INFO  (coreLoadExecutor-4693-thread-1) [    
x:collection1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 330740 INFO  (coreLoadExecutor-4693-thread-1) [    
x:collection1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 330741 INFO  (coreLoadExecutor-4693-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 330741 INFO  (coreLoadExecutor-4693-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 330742 INFO  (coreLoadExecutor-4693-thread-1) [    
x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=49, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=1.0]
   [junit4]   2> 330743 INFO  (coreLoadExecutor-4693-thread-1) [    
x:collection1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 330750 INFO  (coreLoadExecutor-4693-thread-1) [    
x:collection1 ] o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 330765 INFO  (coreLoadExecutor-4693-thread-1) [    
x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 330765 INFO  (coreLoadExecutor-4693-thread-1) [    
x:collection1 ] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1675422863447818240
   [junit4]   2> 330766 INFO  
(searcherExecutor-4695-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 330766 INFO  
(searcherExecutor-4695-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 330766 INFO  
(searcherExecutor-4695-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 330766 INFO  
(searcherExecutor-4695-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 330766 INFO  
(searcherExecutor-4695-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 330766 INFO  
(searcherExecutor-4695-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 330766 INFO  
(searcherExecutor-4695-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 330766 INFO  
(searcherExecutor-4695-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 330766 INFO  
(searcherExecutor-4695-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 330767 INFO  
(searcherExecutor-4695-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 330773 INFO  
(TEST-TestDistributedGrouping.test-seed#[77F4A3BBDDFFBE93]) [     ] 
o.a.s.SolrTestCaseJ4 ###Starting test
   [junit4]   2> 330798 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{deleteByQuery=*:* (-1675422863480324096)} 0 2
   [junit4]   2> 330822 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{deleteByQuery=*:* (-1675422863505489920)} 0 1
   [junit4]   2> 330823 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 0
   [junit4]   2> 330824 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 0
   [junit4]   2> 330865 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/b/et 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=36
   [junit4]   2> 330949 INFO  (qtp170667132-9019) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/b/et 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=[::1]:6/b/et|[::1]:4/b/et|[::1]:8/b/et|https://127.0.0.1:36205/b/et/collection1&rows=100&rid=127.0.0.1-52202&version=2&q=*:*&omitHeader=false&NOW=1597807754093&isShard=true&wt=javabin&group.field=a_i1&group=true}
 status=0 QTime=14
   [junit4]   2> 330966 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/b/et path=/select 
params={q=*:*&shards=[::1]:6/b/et|[::1]:4/b/et|[::1]:8/b/et|https://127.0.0.1:36205/b/et/collection1&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-52202 status=0 QTime=97
   [junit4]   2> 330970 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/b/et 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> 330974 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/b/et 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=https://127.0.0.1:36205/b/et/collection1|[::1]:6/b/et&rows=100&rid=127.0.0.1-52204&version=2&q=*:*&omitHeader=false&NOW=1597807754197&isShard=true&hl.fl=a_t&wt=javabin&group.field=a_i1&group=true}
 status=0 QTime=0
   [junit4]   2> 330978 INFO  (qtp170667132-9019) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/b/et path=/select 
params={q=*:*&shards=https://127.0.0.1:36205/b/et/collection1|[::1]:6/b/et&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-52204 status=0 QTime=6
   [junit4]   2> 330980 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/b/et 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> 330983 INFO  (qtp170667132-9019) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/b/et 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=[::1]:4/b/et|[::1]:8/b/et|https://127.0.0.1:36205/b/et/collection1&rows=100&rid=127.0.0.1-52206&version=2&q=*:*&omitHeader=false&NOW=1597807754206&isShard=true&facet=false&wt=javabin&group.field=a_i1&group=true}
 status=0 QTime=0
   [junit4]   2> 330997 INFO  (qtp170667132-9019) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/b/et 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=[::1]:4/b/et|[::1]:8/b/et|https://127.0.0.1:36205/b/et/collection1&rows=100&rid=127.0.0.1-52206&version=2&group.distributed.second=true&q=*:*&f.a_t.facet.limit=160&omitHeader=false&NOW=1597807754206&isShard=true&facet=true&wt=javabin&group.field=a_i1&group=true}
 status=0 QTime=6
   [junit4]   2> 331007 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/b/et path=/select 
params={q=*:*&shards=[::1]:4/b/et|[::1]:8/b/et|https://127.0.0.1:36205/b/et/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-52206 status=0 QTime=25
   [junit4]   2> 331030 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/b/et 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=21
   [junit4]   2> 331034 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/b/et 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:36205/b/et/collection1&rows=100&rid=127.0.0.1-52208&version=2&q=*:*&stats=false&omitHeader=false&NOW=1597807754258&isShard=true&wt=javabin&group.field=a_i1&group=true&stats.field=a_i1}
 status=0 QTime=0
   [junit4]   2> 331037 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/b/et 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:36205/b/et/collection1&rows=100&rid=127.0.0.1-52208&version=2&group.distributed.second=true&q=*:*&stats=true&omitHeader=false&NOW=1597807754258&isShard=true&wt=javabin&group.field=a_i1&group=true&stats.field=a_i1}
 status=0 QTime=0
   [junit4]   2> 331038 INFO  (qtp170667132-9019) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/b/et path=/select 
params={q=*:*&shards=https://127.0.0.1:36205/b/et/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-52208 status=0 QTime=5
   [junit4]   2> 331040 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/b/et 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> 331044 INFO  (qtp170667132-9019) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/b/et 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=https://127.0.0.1:36205/b/et/collection1&rows=100&rid=127.0.0.1-52210&version=2&spellcheck.build=true&q=kings&spellcheck=true&omitHeader=false&NOW=1597807754266&isShard=true&wt=javabin&group.field=a_i1&group=true}
 status=0 QTime=0
   [junit4]   2> 331045 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/b/et 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=https://127.0.0.1:36205/b/et/collection1&spellcheck=true&wt=javabin&group.field=a_i1&group=true}
 rid=127.0.0.1-52210 status=0 QTime=3
   [junit4]   2> 331051 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/b/et 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=5
   [junit4]   2> 331053 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/b/et 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:36205/b/et/collection1|[::1]:8/b/et|[::1]:4/b/et&rows=100&rid=127.0.0.1-52212&version=2&q=*:*&group.truncate=true&omitHeader=false&NOW=1597807754277&isShard=true&facet=false&wt=javabin&group.field=a_i1&group=true}
 status=0 QTime=0
   [junit4]   2> 331058 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/b/et path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=20&fq=a_s:a&shard.url=https://127.0.0.1:36205/b/et/collection1|[::1]:8/b/et|[::1]:4/b/et&rid=127.0.0.1-52212&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=1597807754277&isShard=true&facet=true}
 status=0 QTime=3
   [junit4]   2> 331060 INFO  (qtp170667132-9019) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/b/et 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:36205/b/et/collection1|[::1]:8/b/et|[::1]:4/b/et&group.truncate=true&facet=true&wt=javabin&group.field=a_i1&group=true}
 rid=127.0.0.1-52212 status=0 QTime=7
   [junit4]   2> 331065 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[1 (1675422863759245312)]} 0 3
   [junit4]   2> 331069 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[1 (1675422863763439616)]} 0 2
   [junit4]   2> 331071 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[2 (1675422863767633920)]} 0 1
   [junit4]   2> 331073 INFO  (qtp170667132-9019) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[2 (1675422863769731072)]} 0 1
   [junit4]   2> 331080 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[3 (1675422863772876800)]} 0 5
   [junit4]   2> 331085 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[3 (1675422863782313984)]} 0 1
   [junit4]   2> 331087 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[4 (1675422863784411136)]} 0 0
   [junit4]   2> 331089 INFO  (qtp170667132-9019) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[4 (1675422863786508288)]} 0 0
   [junit4]   2> 331092 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[5 (1675422863788605440)]} 0 2
   [junit4]   2> 331094 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[5 (1675422863791751168)]} 0 0
   [junit4]   2> 331096 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[6 (1675422863793848320)]} 0 0
   [junit4]   2> 331097 INFO  (qtp170667132-9019) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[6 (1675422863794896896)]} 0 0
   [junit4]   2> 331098 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[7 (1675422863796994048)]} 0 0
   [junit4]   2> 331100 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[7 (1675422863798042624)]} 0 0
   [junit4]   2> 331101 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[8 (1675422863800139776)]} 0 0
   [junit4]   2> 331103 INFO  (qtp170667132-9019) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[8 (1675422863801188352)]} 0 0
   [junit4]   2> 331104 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[9 (1675422863802236928)]} 0 0
   [junit4]   2> 331108 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[9 (1675422863804334080)]} 0 3
   [junit4]   2> 331110 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[10 (1675422863808528384)]} 0 0
   [junit4]   2> 331112 INFO  (qtp170667132-9019) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[10 (1675422863810625536)]} 0 0
   [junit4]   2> 331114 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[11 (1675422863812722688)]} 0 0
   [junit4]   2> 331115 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[11 (1675422863813771264)]} 0 0
   [junit4]   2> 331121 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[12 (1675422863820062720)]} 0 1
   [junit4]   2> 331122 INFO  (qtp170667132-9019) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[12 (1675422863822159872)]} 0 0
   [junit4]   2> 331124 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[14 (1675422863823208448)]} 0 0
   [junit4]   2> 331135 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[14 (1675422863834742784)]} 0 1
   [junit4]   2> 331137 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[15 (1675422863836839936)]} 0 0
   [junit4]   2> 331144 INFO  (qtp170667132-9019) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[15 (1675422863838937088)]} 0 6
   [junit4]   2> 331149 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[16 (1675422863849422848)]} 0 0
   [junit4]   2> 331150 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[16 (1675422863851520000)]} 0 0
   [junit4]   2> 331152 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[17 (1675422863853617152)]} 0 0
   [junit4]   2> 331154 INFO  (qtp170667132-9019) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[17 (1675422863854665728)]} 0 0
   [junit4]   2> 331156 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[18 (1675422863856762880)]} 0 1
   [junit4]   2> 331158 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[18 (1675422863858860032)]} 0 0
   [junit4]   2> 331159 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[19 (1675422863860957184)]} 0 0
   [junit4]   2> 331164 INFO  (qtp170667132-9019) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[19 (1675422863865151488)]} 0 2
   [junit4]   2> 331168 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[20 (1675422863869345792)]} 0 1
   [junit4]   2> 331169 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[20 (1675422863871442944)]} 0 0
   [junit4]   2> 331171 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[21 (1675422863872491520)]} 0 0
   [junit4]   2> 331176 INFO  (qtp170667132-9019) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[21 (1675422863878782976)]} 0 0
   [junit4]   2> 331184 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[22 (1675422863887171584)]} 0 0
   [junit4]   2> 331191 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[22 (1675422863893463040)]} 0 1
   [junit4]   2> 331193 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[23 (1675422863896608768)]} 0 0
   [junit4]   2> 331195 INFO  (qtp170667132-9019) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[23 (1675422863897657344)]} 0 0
   [junit4]   2> 331197 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[100 (1675422863899754496)]} 0 0
   [junit4]   2> 331198 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[100 (1675422863901851648)]} 0 0
   [junit4]   2> 331200 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[101 (1675422863903948800)]} 0 0
   [junit4]   2> 331202 INFO  (qtp170667132-9019) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[101 (1675422863904997376)]} 0 0
   [junit4]   2> 331205 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[102 (1675422863908143104)]} 0 0
   [junit4]   2> 331207 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[102 (1675422863911288832)]} 0 0
   [junit4]   2> 331210 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[103 (1675422863913385984)]} 0 0
   [junit4]   2> 331214 INFO  (qtp170667132-9019) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[103 (1675422863917580288)]} 0 0
   [junit4]   2> 331215 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[104 (1675422863919677440)]} 0 0
   [junit4]   2> 331218 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[104 (1675422863922823168)]} 0 0
   [junit4]   2> 331220 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[105 (1675422863924920320)]} 0 0
   [junit4]   2> 331222 INFO  (qtp170667132-9019) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[105 (1675422863927017472)]} 0 0
   [junit4]   2> 331224 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[106 (1675422863929114624)]} 0 0
   [junit4]   2> 331226 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[106 (1675422863930163200)]} 0 0
   [junit4]   2> 331227 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[107 (1675422863932260352)]} 0 0
   [junit4]   2> 331229 INFO  (qtp170667132-9019) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[107 (1675422863934357504)]} 0 0
   [junit4]   2> 331243 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[108 (1675422863949037568)]} 0 0
   [junit4]   2> 331245 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[108 (1675422863950086144)]} 0 0
   [junit4]   2> 331255 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[109 (1675422863961620480)]} 0 0
   [junit4]   2> 331257 INFO  (qtp170667132-9019) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[109 (1675422863963717632)]} 0 0
   [junit4]   2> 331260 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[110 (1675422863966863360)]} 0 0
   [junit4]   2> 331262 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[110 (1675422863967911936)]} 0 0
   [junit4]   2> 331263 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[111 (1675422863970009088)]} 0 0
   [junit4]   2> 331264 INFO  (qtp170667132-9019) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[111 (1675422863971057664)]} 0 0
   [junit4]   2> 331266 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[112 (1675422863972106240)]} 0 0
   [junit4]   2> 331267 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[112 (1675422863973154816)]} 0 0
   [junit4]   2> 331268 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[113 (1675422863975251968)]} 0 0
   [junit4]   2> 331270 INFO  (qtp170667132-9019) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[113 (1675422863977349120)]} 0 0
   [junit4]   2> 331272 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[114 (1675422863978397696)]} 0 0
   [junit4]   2> 331273 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[114 (1675422863980494848)]} 0 0
   [junit4]   2> 331274 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[115 (1675422863981543424)]} 0 0
   [junit4]   2> 331275 INFO  (qtp170667132-9019) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[115 (1675422863982592000)]} 0 0
   [junit4]   2> 331276 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[116 (1675422863983640576)]} 0 0
   [junit4]   2> 331277 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[116 (1675422863984689152)]} 0 0
   [junit4]   2> 331287 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[117 (1675422863985737728)]} 0 9
   [junit4]   2> 331289 INFO  (qtp170667132-9019) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[117 (1675422863996223488)]} 0 0
   [junit4]   2> 331290 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[118 (1675422863998320640)]} 0 0
   [junit4]   2> 331291 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[118 (1675422863999369216)]} 0 0
   [junit4]   2> 331293 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[119 (1675422864000417792)]} 0 0
   [junit4]   2> 331294 INFO  (qtp170667132-9019) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[119 (1675422864001466368)]} 0 0
   [junit4]   2> 331295 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[120 (1675422864002514944)]} 0 0
   [junit4]   2> 331296 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[120 (1675422864003563520)]} 0 0
   [junit4]   2> 331297 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[121 (1675422864005660672)]} 0 0
   [junit4]   2> 331298 INFO  (qtp170667132-9019) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[121 (1675422864006709248)]} 0 0
   [junit4]   2> 331299 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[122 (1675422864007757824)]} 0 0
   [junit4]   2> 331300 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[122 (1675422864008806400)]} 0 0
   [junit4]   2> 331302 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[123 (1675422864009854976)]} 0 0
   [junit4]   2> 331303 INFO  (qtp170667132-9019) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[123 (1675422864010903552)]} 0 0
   [junit4]   2> 331304 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[124 (1675422864011952128)]} 0 0
   [junit4]   2> 331309 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[124 (1675422864017195008)]} 0 0
   [junit4]   2> 331310 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[125 (1675422864019292160)]} 0 0
   [junit4]   2> 331311 INFO  (qtp170667132-9019) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[125 (1675422864020340736)]} 0 0
   [junit4]   2> 331312 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[126 (1675422864021389312)]} 0 0
   [junit4]   2> 331313 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[126 (1675422864022437888)]} 0 0
   [junit4]   2> 331314 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[127 (1675422864022437888)]} 0 0
   [junit4]   2> 331314 INFO  (qtp170667132-9019) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[127 (1675422864023486464)]} 0 0
   [junit4]   2> 331315 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[128 (1675422864024535040)]} 0 0
   [junit4]   2> 331315 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[128 (1675422864024535040)]} 0 0
   [junit4]   2> 331320 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[129 (1675422864029777920)]} 0 0
   [junit4]   2> 331328 INFO  (qtp170667132-9019) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[129 (1675422864038166528)]} 0 0
   [junit4]   2> 331332 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[130 (1675422864042360832)]} 0 0
   [junit4]   2> 331333 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[130 (1675422864043409408)]} 0 0
   [junit4]   2> 331335 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[131 (1675422864044457984)]} 0 0
   [junit4]   2> 331337 INFO  (qtp170667132-9019) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[131 (1675422864047603712)]} 0 0
   [junit4]   2> 331340 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[132 (1675422864049700864)]} 0 1
   [junit4]   2> 331344 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[132 (1675422864054943744)]} 0 0
   [junit4]   2> 331345 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[133 (1675422864055992320)]} 0 0
   [junit4]   2> 331346 INFO  (qtp170667132-9019) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[133 (1675422864057040896)]} 0 0
   [junit4]   2> 331347 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[134 (1675422864057040896)]} 0 0
   [junit4]   2> 331349 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[134 (1675422864059138048)]} 0 0
   [junit4]   2> 331350 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[135 (1675422864060186624)]} 0 0
   [junit4]   2> 331351 INFO  (qtp170667132-9019) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[135 (1675422864062283776)]} 0 0
   [junit4]   2> 331352 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[136 (1675422864063332352)]} 0 0
   [junit4]   2> 331353 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[136 (1675422864064380928)]} 0 0
   [junit4]   2> 331355 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[137 (1675422864065429504)]} 0 0
   [junit4]   2> 331358 INFO  (qtp170667132-9019) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[137 (1675422864068575232)]} 0 0
   [junit4]   2> 331359 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[138 (1675422864070672384)]} 0 0
   [junit4]   2> 331360 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[138 (1675422864071720960)]} 0 0
   [junit4]   2> 331361 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[139 (1675422864072769536)]} 0 0
   [junit4]   2> 331362 INFO  (qtp170667132-9019) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[139 (1675422864073818112)]} 0 0
   [junit4]   2> 331363 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[140 (1675422864074866688)]} 0 0
   [junit4]   2> 331364 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[140 (1675422864075915264)]} 0 0
   [junit4]   2> 331366 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[141 (1675422864078012416)]} 0 0
   [junit4]   2> 331368 INFO  (qtp170667132-9019) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[141 (1675422864080109568)]} 0 0
   [junit4]   2> 331370 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[142 (1675422864081158144)]} 0 0
   [junit4]   2> 331371 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[142 (1675422864082206720)]} 0 0
   [junit4]   2> 331371 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[143 (1675422864083255296)]} 0 0
   [junit4]   2> 331375 INFO  (qtp170667132-9019) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[143 (1675422864086401024)]} 0 1
   [junit4]   2> 331377 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[144 (1675422864088498176)]} 0 0
   [junit4]   2> 331378 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[144 (1675422864090595328)]} 0 0
   [junit4]   2> 331379 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[145 (1675422864091643904)]} 0 0
   [junit4]   2> 331381 INFO  (qtp170667132-9019) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[145 (1675422864092692480)]} 0 0
   [junit4]   2> 331382 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[146 (1675422864093741056)]} 0 0
   [junit4]   2> 331383 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[146 (1675422864094789632)]} 0 0
   [junit4]   2> 331384 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[147 (1675422864096886784)]} 0 0
   [junit4]   2> 331386 INFO  (qtp170667132-9019) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[147 (1675422864098983936)]} 0 0
   [junit4]   2> 331387 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[148 (1675422864100032512)]} 0 0
   [junit4]   2> 331390 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[148 (1675422864101081088)]} 0 2
   [junit4]   2> 331392 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[149 (1675422864105275392)]} 0 1
   [junit4]   2> 331394 INFO  (qtp170667132-9019) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[149 (1675422864106323968)]} 0 0
   [junit4]   2> 331395 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[500 (1675422864107372544)]} 0 0
   [junit4]   2> 331396 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[500 (1675422864109469696)]} 0 0
   [junit4]   2> 331397 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[501 (1675422864110518272)]} 0 0
   [junit4]   2> 331398 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[501 (1675422864111566848)]} 0 0
   [junit4]   2> 331399 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[502 (1675422864112615424)]} 0 0
   [junit4]   2> 331402 INFO  (qtp170667132-9019) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[502 (1675422864114712576)]} 0 0
   [junit4]   2> 331404 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[503 (1675422864117858304)]} 0 0
   [junit4]   2> 331405 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[503 (1675422864118906880)]} 0 0
   [junit4]   2> 331414 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[504 (1675422864128344064)]} 0 0
   [junit4]   2> 331415 INFO  (qtp170667132-9019) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[504 (1675422864129392640)]} 0 0
   [junit4]   2> 331417 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[505 (1675422864130441216)]} 0 0
   [junit4]   2> 331418 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[505 (1675422864131489792)]} 0 0
   [junit4]   2> 331419 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[506 (1675422864133586944)]} 0 0
   [junit4]   2> 331420 INFO  (qtp170667132-9019) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[506 (1675422864133586944)]} 0 0
   [junit4]   2> 331421 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[507 (1675422864135684096)]} 0 0
   [junit4]   2> 331422 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[507 (1675422864136732672)]} 0 0
   [junit4]   2> 331423 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[508 (1675422864136732672)]} 0 0
   [junit4]   2> 331424 INFO  (qtp170667132-9019) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[508 (1675422864137781248)]} 0 0
   [junit4]   2> 331425 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[509 (1675422864139878400)]} 0 0
   [junit4]   2> 331426 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[509 (1675422864140926976)]} 0 0
   [junit4]   2> 331428 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[510 (1675422864141975552)]} 0 0
   [junit4]   2> 331429 INFO  (qtp170667132-9019) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[510 (1675422864143024128)]} 0 0
   [junit4]   2> 331430 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[511 (1675422864144072704)]} 0 0
   [junit4]   2> 331430 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[511 (1675422864145121280)]} 0 0
   [junit4]   2> 331431 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[512 (1675422864146169856)]} 0 0
   [junit4]   2> 331432 INFO  (qtp170667132-9019) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[512 (1675422864147218432)]} 0 0
   [junit4]   2> 331433 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[513 (1675422864148267008)]} 0 0
   [junit4]   2> 331435 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[513 (1675422864150364160)]} 0 0
   [junit4]   2> 331436 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[514 (1675422864151412736)]} 0 0
   [junit4]   2> 331437 INFO  (qtp170667132-9019) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[514 (1675422864152461312)]} 0 0
   [junit4]   2> 331437 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[515 (1675422864152461312)]} 0 0
   [junit4]   2> 331438 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[515 (1675422864153509888)]} 0 0
   [junit4]   2> 331439 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[516 (1675422864154558464)]} 0 0
   [junit4]   2> 331439 INFO  (qtp170667132-9019) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[516 (1675422864154558464)]} 0 0
   [junit4]   2> 331440 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[517 (1675422864154558465)]} 0 0
   [junit4]   2> 331441 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[517 (1675422864156655616)]} 0 0
   [junit4]   2> 331442 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[518 (1675422864157704192)]} 0 0
   [junit4]   2> 331443 INFO  (qtp170667132-9019) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[518 (1675422864158752768)]} 0 0
   [junit4]   2> 331443 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[519 (1675422864158752768)]} 0 0
   [junit4]   2> 331444 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[519 (1675422864159801344)]} 0 0
   [junit4]   2> 331444 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[520 (1675422864159801344)]} 0 0
   [junit4]   2> 331444 INFO  (qtp170667132-9019) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[520 (1675422864159801345)]} 0 0
   [junit4]   2> 331445 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[521 (1675422864160849920)]} 0 0
   [junit4]   2> 331445 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[521 (1675422864160849920)]} 0 0
   [junit4]   2> 331445 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[522 (1675422864160849921)]} 0 0
   [junit4]   2> 331446 INFO  (qtp170667132-9019) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[522 (1675422864160849921)]} 0 0
   [junit4]   2> 331446 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[523 (1675422864161898496)]} 0 0
   [junit4]   2> 331446 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[523 (1675422864161898496)]} 0 0
   [junit4]   2> 331446 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[524 (1675422864161898497)]} 0 0
   [junit4]   2> 331447 INFO  (qtp170667132-9019) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[524 (1675422864162947072)]} 0 0
   [junit4]   2> 331447 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[525 (1675422864162947072)]} 0 0
   [junit4]   2> 331448 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[525 (1675422864162947073)]} 0 0
   [junit4]   2> 331448 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[526 (1675422864163995648)]} 0 0
   [junit4]   2> 331448 INFO  (qtp170667132-9019) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[526 (1675422864163995648)]} 0 0
   [junit4]   2> 331449 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[527 (1675422864165044224)]} 0 0
   [junit4]   2> 331449 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[527 (1675422864165044224)]} 0 0
   [junit4]   2> 331450 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[528 (1675422864166092800)]} 0 0
   [junit4]   2> 331450 INFO  (qtp170667132-9019) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[528 (1675422864166092800)]} 0 0
   [junit4]   2> 331451 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[529 (1675422864167141376)]} 0 0
   [junit4]   2> 331451 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[529 (1675422864167141376)]} 0 0
   [junit4]   2> 331452 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[530 (1675422864168189952)]} 0 0
   [junit4]   2> 331453 INFO  (qtp170667132-9019) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[530 (1675422864169238528)]} 0 0
   [junit4]   2> 331453 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[531 (1675422864169238528)]} 0 0
   [junit4]   2> 331454 INFO  (qtp170667132-9013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[531 (1675422864170287104)]} 0 0
   [junit4]   2> 331454 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[532 (1675422864170287104)]} 0 0
   [junit4]   2> 331455 INFO  (qtp170667132-9019) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[532 (1675422864171335680)]} 0 0
   [junit4]   2> 331455 INFO  (qtp193435014-9011) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/b/et path=/update 
params={wt=javabin&version=2}{add=[533 (1675

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

 (coreCloseExecutor-4707-thread-1) [     ] o.a.s.c.SolrCore [collection1]  
CLOSING SolrCore org.apache.solr.core.SolrCore@261abc0d
   [junit4]   2> 333656 INFO  (coreCloseExecutor-4707-thread-1) [     ] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1 tag=SolrCore@261abc0d
   [junit4]   2> 333656 INFO  (coreCloseExecutor-4707-thread-1) [     ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@353c6b3c: rootName = null, 
domain = solr.core.collection1, service url = null, agent id = null] for 
registry solr.core.collection1/com.codahale.metrics.MetricRegistry@5fb1f202
   [junit4]   2> 333689 INFO  (coreCloseExecutor-4707-thread-1) [     ] 
o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close()  ... SKIPPED 
(unnecessary).
   [junit4]   2> 333690 INFO  (coreCloseExecutor-4704-thread-1) [     ] 
o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close()  ... SKIPPED 
(unnecessary).
   [junit4]   2> 333746 INFO  (closeThreadPool-4701-thread-2) [     ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node 
tag=null
   [junit4]   2> 333746 INFO  (closeThreadPool-4701-thread-2) [     ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@1f2ed756: rootName = null, 
domain = solr.node, service url = null, agent id = null] for registry 
solr.node/com.codahale.metrics.MetricRegistry@ace277e
   [junit4]   2> 333749 INFO  (closeThreadPool-4701-thread-2) [     ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm 
tag=null
   [junit4]   2> 333749 INFO  (closeThreadPool-4701-thread-2) [     ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@3c566e8b: rootName = null, 
domain = solr.jvm, service url = null, agent id = null] for registry 
solr.jvm/com.codahale.metrics.MetricRegistry@453cf659
   [junit4]   2> 333750 INFO  (closeThreadPool-4701-thread-4) [     ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node 
tag=null
   [junit4]   2> 333750 INFO  (closeThreadPool-4701-thread-4) [     ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@3c15142: rootName = null, 
domain = solr.node, service url = null, agent id = null] for registry 
solr.node/com.codahale.metrics.MetricRegistry@746b9af0
   [junit4]   2> 333754 INFO  (closeThreadPool-4701-thread-4) [     ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm 
tag=null
   [junit4]   2> 333754 INFO  (closeThreadPool-4701-thread-4) [     ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@4f72d82e: rootName = null, 
domain = solr.jvm, service url = null, agent id = null] for registry 
solr.jvm/com.codahale.metrics.MetricRegistry@453cf659
   [junit4]   2> 333755 INFO  (closeThreadPool-4701-thread-2) [     ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty 
tag=null
   [junit4]   2> 333755 INFO  (closeThreadPool-4701-thread-2) [     ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@722fcb0e: rootName = null, 
domain = solr.jetty, service url = null, agent id = null] for registry 
solr.jetty/com.codahale.metrics.MetricRegistry@7630ce10
   [junit4]   2> 333756 INFO  (closeThreadPool-4701-thread-4) [     ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty 
tag=null
   [junit4]   2> 333756 INFO  (closeThreadPool-4701-thread-4) [     ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@25471744: rootName = null, 
domain = solr.jetty, service url = null, agent id = null] for registry 
solr.jetty/com.codahale.metrics.MetricRegistry@7630ce10
   [junit4]   2> 333783 INFO  (closeThreadPool-4701-thread-4) [     ] 
o.e.j.s.AbstractConnector Stopped ServerConnector@31514adb{SSL, (ssl, 
http/1.1)}{127.0.0.1:0}
   [junit4]   2> 333784 INFO  (closeThreadPool-4701-thread-4) [     ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@1d4f165a{/b/et,null,UNAVAILABLE}
   [junit4]   2> 333785 INFO  (closeThreadPool-4701-thread-4) [     ] 
o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 333826 INFO  (closeThreadPool-4701-thread-2) [     ] 
o.e.j.s.AbstractConnector Stopped ServerConnector@12fe8a04{SSL, (ssl, 
http/1.1)}{127.0.0.1:0}
   [junit4]   2> 333827 INFO  (closeThreadPool-4701-thread-2) [     ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@54be9df0{/b/et,null,UNAVAILABLE}
   [junit4]   2> 333827 INFO  (closeThreadPool-4701-thread-2) [     ] 
o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=TestDistributedGrouping -Dtests.method=test 
-Dtests.seed=77F4A3BBDDFFBE93 -Dtests.multiplier=3 -Dtests.slow=true 
-Dtests.locale=ar-OM -Dtests.timezone=America/Grenada -Dtests.asserts=true 
-Dtests.file.encoding=US-ASCII
   [junit4] ERROR   4.30s J2 | TestDistributedGrouping.test <<<
   [junit4]    > Throwable #1: 
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error 
from server at https://127.0.0.1:36205/b/et/collection1: 
org.apache.solr.client.solrj.SolrServerException: Time allowed to handle this 
request exceeded:[https://[::1]:6/b/et, https://[::1]:4/b/et, 
https://[::1]:8/b/et]
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([77F4A3BBDDFFBE93:FFA09C617303D36B]: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/J2/temp/solr.TestDistributedGrouping_77F4A3BBDDFFBE93-001
   [junit4]   2> NOTE: test params are: codec=CheapBastard, 
sim=Asserting(RandomSimilarity(queryNorm=false): {}), locale=ar-OM, 
timezone=America/Grenada
   [junit4]   2> NOTE: Linux 5.4.0-40-generic amd64/Oracle Corporation 
1.8.0_201 (64-bit)/cpus=16,threads=1,free=243861192,total=518979584
   [junit4]   2> NOTE: All tests run in this JVM: [TestTermsQParserPlugin, 
TestInPlaceUpdatesRequiredField, PKIAuthenticationIntegrationTest, 
TestCollectionsAPIViaSolrCloudCluster, CoreAdminCreateDiscoverTest, 
TestCloudConsistency, SolrCloudExampleTest, TestConfigsApi, 
BasicAuthStandaloneTest, TestGraphMLResponseWriter, 
ChaosMonkeyNothingIsSafeWithPullReplicasTest, 
OverseerSolrResponseUnsafeSerializationTest, TestSchemalessBufferedUpdates, 
TestRealTimeGet, TestSnapshotCloudManager, RangeFacetCloudTest, 
TestConfigSetsAPIZkFailure, SaslZkACLProviderTest, FastVectorHighlighterTest, 
TestTolerantUpdateProcessorCloud, TestNestedDocsSort, TestCaffeineCache, 
MetricsHandlerTest, TestImplicitCoreProperties, 
ForceLeaderWithTlogReplicasTest, CustomCollectionTest, PluginInfoTest, 
TestCopyFieldCollectionResource, TestSimDistribStateManager, 
ResponseBuilderTest, DefaultValueUpdateProcessorTest, 
TestSolrJacksonAnnotation, TestQueryingOnDownCollection, 
TriggerCooldownIntegrationTest, ReturnFieldsTest, TestLockTree, 
SearchHandlerTest, BlockJoinFacetDistribTest, 
TlogReplayBufferedWhileIndexingTest, DocValuesMissingTest, TestCloudRecovery, 
TestUniqueKeyFieldResource, ScheduledTriggerIntegrationTest, HdfsSyncSliceTest, 
TestFastOutputStream, UUIDUpdateProcessorFallbackTest, AtomicUpdatesTest, 
HttpSolrCallGetCoreTest, OutOfBoxZkACLAndCredentialsProvidersTest, 
BooleanFieldTest, TestDistributedGrouping]
   [junit4] Completed [249/919 (1!)] on J2 in 4.52s, 1 test, 1 error <<< 
FAILURES!

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

[repro] Revision: 0f88cce8418f8a65b1643951a43fff66722f9547

[repro] Ant options: "-Dargs=-XX:-UseCompressedOops -XX:+UseSerialGC"
[repro] Repro line:  ant test  -Dtestcase=TestDistributedGrouping 
-Dtests.method=test -Dtests.seed=77F4A3BBDDFFBE93 -Dtests.multiplier=3 
-Dtests.slow=true -Dtests.locale=ar-OM -Dtests.timezone=America/Grenada 
-Dtests.asserts=true -Dtests.file.encoding=US-ASCII

[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 3447 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5 
-Dtests.class="*.TestDistributedGrouping" -Dtests.showOutput=onerror 
"-Dargs=-XX:-UseCompressedOops -XX:+UseSerialGC" -Dtests.seed=77F4A3BBDDFFBE93 
-Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=ar-OM 
-Dtests.timezone=America/Grenada -Dtests.asserts=true 
-Dtests.file.encoding=US-ASCII

[...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