Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Windows/9191/
Java: 64bit/jdk-11.0.6 -XX:-UseCompressedOops -XX:+UseParallelGC

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

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

Stack Trace:
org.apache.solr.client.solrj.impl.BaseHttpSolrClient$RemoteSolrException: Error 
from server at http://127.0.0.1:52134/wk/collection1: 
org.apache.solr.client.solrj.SolrServerException: Time allowed to handle this 
request exceeded:[http://[::1]:4/wk, http://[::1]:6/wk, http://[::1]:8/wk]
        at 
__randomizedtesting.SeedInfo.seed([B64F89FCE2B82CE4:3E1BB6264C44411C]: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:210)
        at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:1004)
        at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:1019)
        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 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.base/java.lang.reflect.Method.invoke(Method.java:566)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1754)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:942)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:978)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:992)
        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:370)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:819)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:470)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:951)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:836)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:887)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:898)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:370)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.lambda$forkTimeoutingTask$0(ThreadLeakControl.java:826)
        at java.base/java.lang.Thread.run(Thread.java:834)




Build Log:
[...truncated 13342 lines...]
   [junit4] Suite: org.apache.solr.TestDistributedGrouping
   [junit4]   2> 509508 INFO  
(SUITE-TestDistributedGrouping-seed#[B64F89FCE2B82CE4]-worker) [     ] 
o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to 
test-framework derived value of 
'C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\server\solr\configsets\_default\conf'
   [junit4]   2> 509508 INFO  
(SUITE-TestDistributedGrouping-seed#[B64F89FCE2B82CE4]-worker) [     ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 509509 INFO  
(SUITE-TestDistributedGrouping-seed#[B64F89FCE2B82CE4]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Created dataDir: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J4\temp\solr.TestDistributedGrouping_B64F89FCE2B82CE4-001\data-dir-91-001
   [junit4]   2> 509509 WARN  
(SUITE-TestDistributedGrouping-seed#[B64F89FCE2B82CE4]-worker) [     ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=2 numCloses=2
   [junit4]   2> 509509 INFO  
(SUITE-TestDistributedGrouping-seed#[B64F89FCE2B82CE4]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) 
w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 509510 INFO  
(SUITE-TestDistributedGrouping-seed#[B64F89FCE2B82CE4]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via: 
@org.apache.solr.util.RandomizeSSL(reason="", value=0.0/0.0, ssl=0.0/0.0, 
clientAuth=0.0/0.0)
   [junit4]   2> 509511 INFO  
(SUITE-TestDistributedGrouping-seed#[B64F89FCE2B82CE4]-worker) [     ] 
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /wk/
   [junit4]   2> 512770 INFO  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J4\temp\solr.TestDistributedGrouping_B64F89FCE2B82CE4-001\tempDir-001\control\cores\collection1
   [junit4]   2> 512795 INFO  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 512795 INFO  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
   [junit4]   2> 512795 INFO  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git: 
a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 11.0.6+10
   [junit4]   2> 512795 INFO  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 512795 INFO  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 512795 INFO  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 512795 INFO  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@6eb18498{/wk,null,AVAILABLE}
   [junit4]   2> 512813 INFO  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.e.j.s.AbstractConnector Started ServerConnector@185b8f9f{HTTP/1.1, (http/1.1, 
h2c)}{127.0.0.1:52083}
   [junit4]   2> 512813 INFO  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.e.j.s.Server Started @514354ms
   [junit4]   2> 512813 INFO  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/wk, hostPort=52083, 
coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J4\temp\solr.TestDistributedGrouping_B64F89FCE2B82CE4-001\tempDir-001\control\cores}
   [junit4]   2> 512813 ERROR 
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 512813 INFO  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 512813 INFO  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
9.0.0
   [junit4]   2> 512813 INFO  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 512813 INFO  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr
   [junit4]   2> 512813 INFO  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2020-08-06T04:29:53.132856400Z
   [junit4]   2> 512813 INFO  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J4\temp\solr.TestDistributedGrouping_B64F89FCE2B82CE4-001\tempDir-001\control\solr.xml
   [junit4]   2> 512817 INFO  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@40b00dd4, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 513009 INFO  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
   [junit4]   2> 513077 WARN  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@2f4ce8c6[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 513077 WARN  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@2f4ce8c6[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 513091 WARN  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@21657611[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 513091 WARN  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@21657611[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 513092 WARN  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
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> 513114 INFO  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 513114 INFO  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history 
in memory.
   [junit4]   2> 513128 INFO  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@40b00dd4
   [junit4]   2> 513132 INFO  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@40b00dd4
   [junit4]   2> 513132 INFO  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@40b00dd4
   [junit4]   2> 513136 INFO  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J4\temp\solr.TestDistributedGrouping_B64F89FCE2B82CE4-001\tempDir-001\control\cores
   [junit4]   2> 513136 INFO  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 513200 INFO  (coreLoadExecutor-5781-thread-1) [    
x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0
   [junit4]   2> 513217 INFO  (coreLoadExecutor-5781-thread-1) [    
x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from configset 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\collection1,
 trusted=true
   [junit4]   2> 513222 INFO  (coreLoadExecutor-5781-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema Schema name=test
   [junit4]   2> 513315 INFO  (coreLoadExecutor-5781-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field 
id
   [junit4]   2> 513326 INFO  (coreLoadExecutor-5781-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@40b00dd4
   [junit4]   2> 513329 INFO  (coreLoadExecutor-5781-thread-1) [    
x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J4\temp\solr.TestDistributedGrouping_B64F89FCE2B82CE4-001\tempDir-001\control\cores\collection1],
 
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J4\temp\solr.TestDistributedGrouping_B64F89FCE2B82CE4-001\tempDir-001\control\cores\collection1\data\]
   [junit4]   2> 513334 INFO  (coreLoadExecutor-5781-thread-1) [    
x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=20, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.8037974748462595]
   [junit4]   2> 513497 INFO  (coreLoadExecutor-5781-thread-1) [    
x:collection1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 513497 INFO  (coreLoadExecutor-5781-thread-1) [    
x:collection1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 513501 INFO  (coreLoadExecutor-5781-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 513501 INFO  (coreLoadExecutor-5781-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 513506 INFO  (coreLoadExecutor-5781-thread-1) [    
x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=20, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=1.0]
   [junit4]   2> 513507 INFO  (coreLoadExecutor-5781-thread-1) [    
x:collection1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 513525 INFO  (coreLoadExecutor-5781-thread-1) [    
x:collection1 ] o.a.s.s.DirectSolrSpellChecker init: {name=direct, 
classname=DirectSolrSpellChecker, field=lowerfilt, minQueryLength=3}
   [junit4]   2> 513671 INFO  (coreLoadExecutor-5781-thread-1) [    
x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 513676 INFO  (coreLoadExecutor-5781-thread-1) [    
x:collection1 ] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1674248919706501120
   [junit4]   2> 513676 INFO  
(searcherExecutor-5783-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 513677 INFO  
(searcherExecutor-5783-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 513677 INFO  
(searcherExecutor-5783-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 513677 INFO  
(searcherExecutor-5783-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 513677 INFO  
(searcherExecutor-5783-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 513677 INFO  
(searcherExecutor-5783-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 513677 INFO  
(searcherExecutor-5783-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 513679 INFO  
(searcherExecutor-5783-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 513679 INFO  
(searcherExecutor-5783-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 513679 INFO  
(searcherExecutor-5783-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 516055 INFO  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J4\temp\solr.TestDistributedGrouping_B64F89FCE2B82CE4-001\tempDir-001\shard0\cores\collection1
   [junit4]   2> 516071 INFO  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 516071 INFO  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
   [junit4]   2> 516073 INFO  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git: 
a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 11.0.6+10
   [junit4]   2> 516073 INFO  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 516073 INFO  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 516073 INFO  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 516074 INFO  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@2e17fd51{/wk,null,AVAILABLE}
   [junit4]   2> 516077 INFO  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.e.j.s.AbstractConnector Started ServerConnector@717aa2d3{HTTP/1.1, (http/1.1, 
h2c)}{127.0.0.1:52134}
   [junit4]   2> 516077 INFO  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.e.j.s.Server Started @517461ms
   [junit4]   2> 516077 INFO  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/wk, hostPort=52134, 
coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J4\temp\solr.TestDistributedGrouping_B64F89FCE2B82CE4-001\tempDir-001\shard0\cores}
   [junit4]   2> 516077 ERROR 
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 516077 INFO  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 516077 INFO  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
9.0.0
   [junit4]   2> 516077 INFO  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 516077 INFO  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr
   [junit4]   2> 516077 INFO  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2020-08-06T04:29:56.396312200Z
   [junit4]   2> 516077 INFO  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J4\temp\solr.TestDistributedGrouping_B64F89FCE2B82CE4-001\tempDir-001\shard0\solr.xml
   [junit4]   2> 516096 INFO  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@40b00dd4, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 516149 INFO  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
   [junit4]   2> 516149 WARN  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@1d20b28c[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 516149 WARN  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@1d20b28c[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 516163 WARN  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@67496013[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 516163 WARN  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@67496013[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 516163 WARN  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
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> 516187 INFO  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 516187 INFO  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history 
in memory.
   [junit4]   2> 516206 INFO  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@40b00dd4
   [junit4]   2> 516212 INFO  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@40b00dd4
   [junit4]   2> 516212 INFO  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@40b00dd4
   [junit4]   2> 516217 INFO  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J4\temp\solr.TestDistributedGrouping_B64F89FCE2B82CE4-001\tempDir-001\shard0\cores
   [junit4]   2> 516217 INFO  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 516262 INFO  (coreLoadExecutor-5799-thread-1) [    
x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0
   [junit4]   2> 516303 INFO  (coreLoadExecutor-5799-thread-1) [    
x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from configset 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\collection1,
 trusted=true
   [junit4]   2> 516321 INFO  (coreLoadExecutor-5799-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema Schema name=test
   [junit4]   2> 516442 INFO  (coreLoadExecutor-5799-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field 
id
   [junit4]   2> 516460 INFO  (coreLoadExecutor-5799-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@40b00dd4
   [junit4]   2> 516460 INFO  (coreLoadExecutor-5799-thread-1) [    
x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J4\temp\solr.TestDistributedGrouping_B64F89FCE2B82CE4-001\tempDir-001\shard0\cores\collection1],
 
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J4\temp\solr.TestDistributedGrouping_B64F89FCE2B82CE4-001\tempDir-001\shard0\cores\collection1\data\]
   [junit4]   2> 516463 INFO  (coreLoadExecutor-5799-thread-1) [    
x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=20, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.8037974748462595]
   [junit4]   2> 516672 INFO  (coreLoadExecutor-5799-thread-1) [    
x:collection1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 516672 INFO  (coreLoadExecutor-5799-thread-1) [    
x:collection1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 516673 INFO  (coreLoadExecutor-5799-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 516673 INFO  (coreLoadExecutor-5799-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 516676 INFO  (coreLoadExecutor-5799-thread-1) [    
x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=20, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=1.0]
   [junit4]   2> 516677 INFO  (coreLoadExecutor-5799-thread-1) [    
x:collection1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 516711 INFO  (coreLoadExecutor-5799-thread-1) [    
x:collection1 ] o.a.s.s.DirectSolrSpellChecker init: {name=direct, 
classname=DirectSolrSpellChecker, field=lowerfilt, minQueryLength=3}
   [junit4]   2> 516831 INFO  (coreLoadExecutor-5799-thread-1) [    
x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 516831 INFO  (coreLoadExecutor-5799-thread-1) [    
x:collection1 ] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1674248923014758400
   [junit4]   2> 516831 INFO  
(searcherExecutor-5801-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 516833 INFO  
(searcherExecutor-5801-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 516833 INFO  
(searcherExecutor-5801-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 516833 INFO  
(searcherExecutor-5801-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 516833 INFO  
(searcherExecutor-5801-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 516833 INFO  
(TEST-TestDistributedGrouping.test-seed#[B64F89FCE2B82CE4]) [     ] 
o.a.s.SolrTestCaseJ4 ###Starting test
   [junit4]   2> 516833 INFO  
(searcherExecutor-5801-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 516833 INFO  
(searcherExecutor-5801-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 516833 INFO  
(searcherExecutor-5801-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 516833 INFO  
(searcherExecutor-5801-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 516833 INFO  
(searcherExecutor-5801-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 516842 INFO  (qtp1003579380-9119) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{deleteByQuery=*:* (-1674248923022098432)} 0 3
   [junit4]   2> 516846 INFO  (qtp566054268-9142) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{deleteByQuery=*:* (-1674248923027341312)} 0 2
   [junit4]   2> 516848 INFO  (qtp1003579380-9123) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 1
   [junit4]   2> 516850 INFO  (qtp566054268-9145) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 0
   [junit4]   2> 516854 INFO  (qtp1003579380-9124) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/wk 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=2
   [junit4]   2> 519402 INFO  (qtp566054268-9145) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/wk 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]:4/wk|http://127.0.0.1:52134/wk/collection1|[::1]:6/wk|[::1]:8/wk&rows=100&rid=127.0.0.1-50942&version=2&q=*:*&omitHeader=false&NOW=1596688197173&isShard=true&wt=javabin&group.field=a_i1&group=true}
 status=0 QTime=2
   [junit4]   2> 519403 INFO  (qtp566054268-9144) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/wk path=/select 
params={q=*:*&shards=[::1]:4/wk|http://127.0.0.1:52134/wk/collection1|[::1]:6/wk|[::1]:8/wk&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-50942 status=0 QTime=2340
   [junit4]   2> 519403 WARN  (qtp566054268-9144) [    x:collection1 ] 
o.a.s.c.S.SlowRequest slow: [collection1]  webapp=/wk path=/select 
params={q=*:*&shards=[::1]:4/wk|http://127.0.0.1:52134/wk/collection1|[::1]:6/wk|[::1]:8/wk&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-50942 status=0 QTime=2340
   [junit4]   2> 519406 INFO  (qtp1003579380-9118) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/wk 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> 519410 INFO  (qtp566054268-9142) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/wk 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=http://127.0.0.1:52134/wk/collection1|[::1]:8/wk|[::1]:6/wk&rows=100&rid=127.0.0.1-50944&version=2&q=*:*&omitHeader=false&NOW=1596688199728&isShard=true&hl.fl=a_t&wt=javabin&group.field=a_i1&group=true}
 status=0 QTime=0
   [junit4]   2> 519411 INFO  (qtp566054268-9143) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/wk path=/select 
params={q=*:*&shards=http://127.0.0.1:52134/wk/collection1|[::1]:8/wk|[::1]:6/wk&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-50944 status=0 QTime=1
   [junit4]   2> 519411 INFO  (qtp1003579380-9119) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/wk 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> 521984 INFO  (qtp566054268-9144) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/wk 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/wk|[::1]:6/wk|http://127.0.0.1:52134/wk/collection1&rows=100&rid=127.0.0.1-50946&version=2&q=*:*&omitHeader=false&NOW=1596688199731&isShard=true&facet=false&wt=javabin&group.field=a_i1&group=true}
 status=0 QTime=1
   [junit4]   2> 521996 INFO  (qtp566054268-9142) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/wk 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/wk|[::1]:6/wk|http://127.0.0.1:52134/wk/collection1&rows=100&rid=127.0.0.1-50946&version=2&group.distributed.second=true&q=*:*&f.a_t.facet.limit=160&omitHeader=false&NOW=1596688199731&isShard=true&facet=true&wt=javabin&group.field=a_i1&group=true}
 status=0 QTime=1
   [junit4]   2> 522000 INFO  (qtp566054268-9145) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/wk path=/select 
params={q=*:*&shards=[::1]:4/wk|[::1]:6/wk|http://127.0.0.1:52134/wk/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-50946 status=0 QTime=2378
   [junit4]   2> 522000 WARN  (qtp566054268-9145) [    x:collection1 ] 
o.a.s.c.S.SlowRequest slow: [collection1]  webapp=/wk path=/select 
params={q=*:*&shards=[::1]:4/wk|[::1]:6/wk|http://127.0.0.1:52134/wk/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-50946 status=0 QTime=2378
   [junit4]   2> 522018 INFO  (qtp1003579380-9123) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/wk 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=11
   [junit4]   2> 522031 INFO  (qtp566054268-9144) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/wk 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]:4/wk|http://127.0.0.1:52134/wk/collection1&rows=100&rid=127.0.0.1-50948&version=2&q=*:*&stats=false&omitHeader=false&NOW=1596688202337&isShard=true&wt=javabin&group.field=a_i1&group=true&stats.field=a_i1}
 status=0 QTime=0
   [junit4]   2> 522035 INFO  (qtp566054268-9142) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/wk 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=[::1]:4/wk|http://127.0.0.1:52134/wk/collection1&rows=100&rid=127.0.0.1-50948&version=2&group.distributed.second=true&q=*:*&stats=true&omitHeader=false&NOW=1596688202337&isShard=true&wt=javabin&group.field=a_i1&group=true&stats.field=a_i1}
 status=0 QTime=0
   [junit4]   2> 522035 INFO  (qtp566054268-9143) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/wk path=/select 
params={q=*:*&shards=[::1]:4/wk|http://127.0.0.1:52134/wk/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-50948 status=0 QTime=14
   [junit4]   2> 522040 INFO  (qtp1003579380-9124) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/wk 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> 522048 INFO  (qtp566054268-9144) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/wk 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=http://127.0.0.1:52134/wk/collection1&rows=100&rid=127.0.0.1-50950&version=2&spellcheck.build=true&q=kings&spellcheck=true&omitHeader=false&NOW=1596688202359&isShard=true&wt=javabin&group.field=a_i1&group=true}
 status=0 QTime=0
   [junit4]   2> 522053 INFO  (qtp566054268-9145) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/wk 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=http://127.0.0.1:52134/wk/collection1&spellcheck=true&wt=javabin&group.field=a_i1&group=true}
 rid=127.0.0.1-50950 status=0 QTime=7
   [junit4]   2> 522057 INFO  (qtp1003579380-9118) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/wk path=/select 
params={facet.field=a_t&distrib=false&fl=id,a_i1&group.limit=-1&fq=a_s:a&sort=a_i1+asc,+id+asc&rows=100&version=2&q=*:*&group.truncate=true&facet=true&wt=javabin&group.field=a_i1&group=true}
 hits=0 status=0 QTime=4
   [junit4]   2> 522061 INFO  (qtp566054268-9143) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/wk 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=http://127.0.0.1:52134/wk/collection1&rows=100&rid=127.0.0.1-50952&version=2&q=*:*&group.truncate=true&omitHeader=false&NOW=1596688202380&isShard=true&facet=false&wt=javabin&group.field=a_i1&group=true}
 status=0 QTime=0
   [junit4]   2> 522061 INFO  (qtp566054268-9144) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/wk path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=20&fq=a_s:a&shard.url=http://127.0.0.1:52134/wk/collection1&rid=127.0.0.1-50952&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=1596688202380&isShard=true&facet=true}
 status=0 QTime=0
   [junit4]   2> 522066 INFO  (qtp566054268-9142) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/wk 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=http://127.0.0.1:52134/wk/collection1&group.truncate=true&facet=true&wt=javabin&group.field=a_i1&group=true}
 rid=127.0.0.1-50952 status=0 QTime=6
   [junit4]   2> 522070 INFO  (qtp1003579380-9119) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[1 (1674248928508248064)]} 0 3
   [junit4]   2> 522077 INFO  (qtp566054268-9145) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[1 (1674248928513490944)]} 0 2
   [junit4]   2> 522079 INFO  (qtp1003579380-9123) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[2 (1674248928515588096)]} 0 3
   [junit4]   2> 522079 INFO  (qtp566054268-9143) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[2 (1674248928517685248)]} 0 0
   [junit4]   2> 522084 INFO  (qtp1003579380-9124) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[3 (1674248928522928128)]} 0 0
   [junit4]   2> 522088 INFO  (qtp566054268-9144) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[3 (1674248928527122432)]} 0 0
   [junit4]   2> 522092 INFO  (qtp1003579380-9118) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[4 (1674248928531316736)]} 0 0
   [junit4]   2> 522092 INFO  (qtp566054268-9142) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[4 (1674248928531316736)]} 0 0
   [junit4]   2> 522096 INFO  (qtp1003579380-9119) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[5 (1674248928531316737)]} 0 0
   [junit4]   2> 522096 INFO  (qtp566054268-9145) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[5 (1674248928535511040)]} 0 0
   [junit4]   2> 522107 INFO  (qtp1003579380-9123) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[6 (1674248928544948224)]} 0 1
   [junit4]   2> 522109 INFO  (qtp566054268-9143) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[6 (1674248928547045376)]} 0 0
   [junit4]   2> 522109 INFO  (qtp1003579380-9124) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[7 (1674248928549142528)]} 0 0
   [junit4]   2> 522109 INFO  (qtp566054268-9144) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[7 (1674248928549142528)]} 0 0
   [junit4]   2> 522115 INFO  (qtp1003579380-9118) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[8 (1674248928555433984)]} 0 0
   [junit4]   2> 522117 INFO  (qtp566054268-9142) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[8 (1674248928557531136)]} 0 0
   [junit4]   2> 522118 INFO  (qtp1003579380-9119) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[9 (1674248928558579712)]} 0 1
   [junit4]   2> 522120 INFO  (qtp566054268-9145) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[9 (1674248928560676864)]} 0 0
   [junit4]   2> 522121 INFO  (qtp1003579380-9123) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[10 (1674248928561725440)]} 0 0
   [junit4]   2> 522122 INFO  (qtp566054268-9143) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[10 (1674248928562774016)]} 0 0
   [junit4]   2> 522131 INFO  (qtp1003579380-9124) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[11 (1674248928572211200)]} 0 0
   [junit4]   2> 522131 INFO  (qtp566054268-9144) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[11 (1674248928572211200)]} 0 1
   [junit4]   2> 522138 INFO  (qtp1003579380-9118) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[12 (1674248928577454080)]} 0 0
   [junit4]   2> 522138 INFO  (qtp566054268-9142) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[12 (1674248928579551232)]} 0 0
   [junit4]   2> 522141 INFO  (qtp1003579380-9119) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[14 (1674248928579551232)]} 0 0
   [junit4]   2> 522141 INFO  (qtp566054268-9145) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[14 (1674248928582696960)]} 0 0
   [junit4]   2> 522144 INFO  (qtp1003579380-9123) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[15 (1674248928585842688)]} 0 0
   [junit4]   2> 522146 INFO  (qtp566054268-9143) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[15 (1674248928586891264)]} 0 0
   [junit4]   2> 522146 INFO  (qtp1003579380-9124) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[16 (1674248928587939840)]} 0 0
   [junit4]   2> 522147 INFO  (qtp566054268-9144) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[16 (1674248928588988416)]} 0 0
   [junit4]   2> 522153 INFO  (qtp1003579380-9118) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[17 (1674248928595279872)]} 0 0
   [junit4]   2> 522157 INFO  (qtp566054268-9142) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[17 (1674248928598425600)]} 0 0
   [junit4]   2> 522159 INFO  (qtp1003579380-9119) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[18 (1674248928601571328)]} 0 0
   [junit4]   2> 522159 INFO  (qtp566054268-9145) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[18 (1674248928601571328)]} 0 0
   [junit4]   2> 522169 INFO  (qtp1003579380-9123) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[19 (1674248928612057088)]} 0 1
   [junit4]   2> 522170 INFO  (qtp566054268-9143) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[19 (1674248928613105664)]} 0 1
   [junit4]   2> 522173 INFO  (qtp1003579380-9124) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[20 (1674248928616251392)]} 0 0
   [junit4]   2> 522175 INFO  (qtp566054268-9144) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[20 (1674248928618348544)]} 0 0
   [junit4]   2> 522176 INFO  (qtp1003579380-9118) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[21 (1674248928619397120)]} 0 0
   [junit4]   2> 522178 INFO  (qtp566054268-9142) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[21 (1674248928621494272)]} 0 0
   [junit4]   2> 522179 INFO  (qtp1003579380-9119) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[22 (1674248928622542848)]} 0 0
   [junit4]   2> 522180 INFO  (qtp566054268-9145) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[22 (1674248928623591424)]} 0 0
   [junit4]   2> 522181 INFO  (qtp1003579380-9123) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[23 (1674248928624640000)]} 0 0
   [junit4]   2> 522184 INFO  (qtp566054268-9143) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[23 (1674248928626737152)]} 0 0
   [junit4]   2> 522186 INFO  (qtp1003579380-9124) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[100 (1674248928629882880)]} 0 0
   [junit4]   2> 522186 INFO  (qtp566054268-9144) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[100 (1674248928629882880)]} 0 0
   [junit4]   2> 522192 INFO  (qtp1003579380-9118) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[101 (1674248928636174336)]} 0 0
   [junit4]   2> 522192 INFO  (qtp566054268-9142) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[101 (1674248928636174336)]} 0 0
   [junit4]   2> 522192 INFO  (qtp1003579380-9119) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[102 (1674248928636174337)]} 0 0
   [junit4]   2> 522192 INFO  (qtp566054268-9145) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[102 (1674248928636174337)]} 0 0
   [junit4]   2> 522192 INFO  (qtp1003579380-9123) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[103 (1674248928636174338)]} 0 0
   [junit4]   2> 522197 INFO  (qtp566054268-9143) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[103 (1674248928641417216)]} 0 0
   [junit4]   2> 522197 INFO  (qtp1003579380-9124) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[104 (1674248928641417216)]} 0 0
   [junit4]   2> 522199 INFO  (qtp566054268-9144) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[104 (1674248928643514368)]} 0 0
   [junit4]   2> 522200 INFO  (qtp1003579380-9118) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[105 (1674248928644562944)]} 0 0
   [junit4]   2> 522201 INFO  (qtp566054268-9142) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[105 (1674248928645611520)]} 0 1
   [junit4]   2> 522205 INFO  (qtp1003579380-9119) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[106 (1674248928648757248)]} 0 0
   [junit4]   2> 522206 INFO  (qtp566054268-9145) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[106 (1674248928650854400)]} 0 0
   [junit4]   2> 522208 INFO  (qtp1003579380-9123) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[107 (1674248928651902976)]} 0 0
   [junit4]   2> 522209 INFO  (qtp566054268-9143) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[107 (1674248928654000128)]} 0 0
   [junit4]   2> 522211 INFO  (qtp1003579380-9124) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[108 (1674248928656097280)]} 0 0
   [junit4]   2> 522211 INFO  (qtp566054268-9144) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[108 (1674248928656097280)]} 0 0
   [junit4]   2> 522215 INFO  (qtp1003579380-9118) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[109 (1674248928660291584)]} 0 0
   [junit4]   2> 522217 INFO  (qtp566054268-9142) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[109 (1674248928662388736)]} 0 0
   [junit4]   2> 522218 INFO  (qtp1003579380-9119) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[110 (1674248928663437312)]} 0 0
   [junit4]   2> 522218 INFO  (qtp566054268-9145) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[110 (1674248928663437312)]} 0 0
   [junit4]   2> 522225 INFO  (qtp1003579380-9123) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[111 (1674248928670777344)]} 0 0
   [junit4]   2> 522225 INFO  (qtp566054268-9143) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[111 (1674248928670777344)]} 0 0
   [junit4]   2> 522225 INFO  (qtp1003579380-9124) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[112 (1674248928670777345)]} 0 0
   [junit4]   2> 522227 INFO  (qtp566054268-9144) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[112 (1674248928672874496)]} 0 0
   [junit4]   2> 522230 INFO  (qtp1003579380-9118) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[113 (1674248928676020224)]} 0 0
   [junit4]   2> 522231 INFO  (qtp566054268-9142) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[113 (1674248928677068800)]} 0 0
   [junit4]   2> 522232 INFO  (qtp1003579380-9119) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[114 (1674248928677068800)]} 0 0
   [junit4]   2> 522233 INFO  (qtp566054268-9145) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[114 (1674248928679165952)]} 0 0
   [junit4]   2> 522245 INFO  (qtp1003579380-9123) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[115 (1674248928690700288)]} 0 1
   [junit4]   2> 522250 INFO  (qtp566054268-9143) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[115 (1674248928696991744)]} 0 0
   [junit4]   2> 522250 INFO  (qtp1003579380-9124) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[116 (1674248928696991744)]} 0 0
   [junit4]   2> 522256 INFO  (qtp566054268-9144) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[116 (1674248928700137472)]} 0 0
   [junit4]   2> 522258 INFO  (qtp1003579380-9118) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[117 (1674248928703283200)]} 0 0
   [junit4]   2> 522258 INFO  (qtp566054268-9142) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[117 (1674248928705380352)]} 0 0
   [junit4]   2> 522259 INFO  (qtp1003579380-9119) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[118 (1674248928706428928)]} 0 0
   [junit4]   2> 522259 INFO  (qtp566054268-9145) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[118 (1674248928706428928)]} 0 0
   [junit4]   2> 522259 INFO  (qtp1003579380-9123) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[119 (1674248928706428929)]} 0 0
   [junit4]   2> 522261 INFO  (qtp566054268-9143) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[119 (1674248928708526080)]} 0 0
   [junit4]   2> 522262 INFO  (qtp1003579380-9124) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[120 (1674248928708526080)]} 0 0
   [junit4]   2> 522271 INFO  (qtp566054268-9144) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[120 (1674248928719011840)]} 0 0
   [junit4]   2> 522275 INFO  (qtp1003579380-9118) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[121 (1674248928723206144)]} 0 0
   [junit4]   2> 522276 INFO  (qtp566054268-9142) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[121 (1674248928724254720)]} 0 0
   [junit4]   2> 522276 INFO  (qtp1003579380-9119) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[122 (1674248928724254720)]} 0 0
   [junit4]   2> 522280 INFO  (qtp566054268-9145) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[122 (1674248928728449024)]} 0 0
   [junit4]   2> 522280 INFO  (qtp1003579380-9123) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[123 (1674248928728449024)]} 0 0
   [junit4]   2> 522280 INFO  (qtp566054268-9143) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[123 (1674248928728449025)]} 0 0
   [junit4]   2> 522284 INFO  (qtp1003579380-9124) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[124 (1674248928732643328)]} 0 0
   [junit4]   2> 522284 INFO  (qtp566054268-9144) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[124 (1674248928732643328)]} 0 0
   [junit4]   2> 522286 INFO  (qtp1003579380-9118) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[125 (1674248928734740480)]} 0 0
   [junit4]   2> 522287 INFO  (qtp566054268-9142) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[125 (1674248928734740480)]} 0 0
   [junit4]   2> 522287 INFO  (qtp1003579380-9119) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[126 (1674248928735789056)]} 0 0
   [junit4]   2> 522288 INFO  (qtp566054268-9145) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[126 (1674248928736837632)]} 0 0
   [junit4]   2> 522288 INFO  (qtp1003579380-9123) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[127 (1674248928736837632)]} 0 0
   [junit4]   2> 522288 INFO  (qtp566054268-9143) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[127 (1674248928736837633)]} 0 0
   [junit4]   2> 522293 INFO  (qtp1003579380-9124) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[128 (1674248928736837633)]} 0 0
   [junit4]   2> 522294 INFO  (qtp566054268-9144) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[128 (1674248928743129088)]} 0 0
   [junit4]   2> 522295 INFO  (qtp1003579380-9118) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[129 (1674248928744177664)]} 0 0
   [junit4]   2> 522296 INFO  (qtp566054268-9142) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[129 (1674248928745226240)]} 0 0
   [junit4]   2> 522301 INFO  (qtp1003579380-9119) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[130 (1674248928750469120)]} 0 1
   [junit4]   2> 522306 INFO  (qtp566054268-9145) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[130 (1674248928752566272)]} 0 0
   [junit4]   2> 522307 INFO  (qtp1003579380-9123) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[131 (1674248928756760576)]} 0 0
   [junit4]   2> 522308 INFO  (qtp566054268-9143) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[131 (1674248928757809152)]} 0 0
   [junit4]   2> 522309 INFO  (qtp1003579380-9124) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[132 (1674248928758857728)]} 0 0
   [junit4]   2> 522310 INFO  (qtp566054268-9144) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[132 (1674248928758857728)]} 0 0
   [junit4]   2> 522310 INFO  (qtp1003579380-9118) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[133 (1674248928759906304)]} 0 0
   [junit4]   2> 522311 INFO  (qtp566054268-9142) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[133 (1674248928760954880)]} 0 0
   [junit4]   2> 522311 INFO  (qtp1003579380-9119) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[134 (1674248928760954880)]} 0 0
   [junit4]   2> 522312 INFO  (qtp566054268-9145) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[134 (1674248928762003456)]} 0 0
   [junit4]   2> 522316 INFO  (qtp1003579380-9123) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[135 (1674248928766197760)]} 0 0
   [junit4]   2> 522316 INFO  (qtp566054268-9143) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[135 (1674248928766197760)]} 0 0
   [junit4]   2> 522319 INFO  (qtp1003579380-9124) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[136 (1674248928769343488)]} 0 0
   [junit4]   2> 522322 INFO  (qtp566054268-9144) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[136 (1674248928772489216)]} 0 0
   [junit4]   2> 522323 INFO  (qtp1003579380-9118) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[137 (1674248928773537792)]} 0 0
   [junit4]   2> 522323 INFO  (qtp566054268-9142) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[137 (1674248928773537792)]} 0 0
   [junit4]   2> 522323 INFO  (qtp1003579380-9119) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[138 (1674248928773537793)]} 0 0
   [junit4]   2> 522323 INFO  (qtp566054268-9145) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[138 (1674248928773537793)]} 0 0
   [junit4]   2> 522323 INFO  (qtp1003579380-9123) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[139 (1674248928773537794)]} 0 0
   [junit4]   2> 522332 INFO  (qtp566054268-9143) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[139 (1674248928782974976)]} 0 0
   [junit4]   2> 522332 INFO  (qtp1003579380-9124) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[140 (1674248928782974976)]} 0 0
   [junit4]   2> 522336 INFO  (qtp566054268-9144) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[140 (1674248928787169280)]} 0 0
   [junit4]   2> 522336 INFO  (qtp1003579380-9118) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[141 (1674248928787169280)]} 0 0
   [junit4]   2> 522337 INFO  (qtp566054268-9142) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[141 (1674248928788217856)]} 0 0
   [junit4]   2> 522337 INFO  (qtp1003579380-9119) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[142 (1674248928788217856)]} 0 0
   [junit4]   2> 522341 INFO  (qtp566054268-9145) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[142 (1674248928788217857)]} 0 0
   [junit4]   2> 522341 INFO  (qtp1003579380-9123) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[143 (1674248928792412160)]} 0 0
   [junit4]   2> 522341 INFO  (qtp566054268-9143) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[143 (1674248928792412160)]} 0 0
   [junit4]   2> 522344 INFO  (qtp1003579380-9124) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[144 (1674248928792412161)]} 0 0
   [junit4]   2> 522345 INFO  (qtp566054268-9144) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[144 (1674248928796606464)]} 0 0
   [junit4]   2> 522345 INFO  (qtp1003579380-9118) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[145 (1674248928796606464)]} 0 0
   [junit4]   2> 522345 INFO  (qtp566054268-9142) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[145 (1674248928796606465)]} 0 0
   [junit4]   2> 522345 INFO  (qtp1003579380-9119) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[146 (1674248928796606465)]} 0 0
   [junit4]   2> 522345 INFO  (qtp566054268-9145) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[146 (1674248928796606466)]} 0 0
   [junit4]   2> 522345 INFO  (qtp1003579380-9123) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[147 (1674248928796606466)]} 0 0
   [junit4]   2> 522345 INFO  (qtp566054268-9143) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[147 (1674248928796606467)]} 0 0
   [junit4]   2> 522349 INFO  (qtp1003579380-9124) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[148 (1674248928800800768)]} 0 0
   [junit4]   2> 522349 INFO  (qtp566054268-9144) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[148 (1674248928800800768)]} 0 0
   [junit4]   2> 522349 INFO  (qtp1003579380-9118) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[149 (1674248928800800769)]} 0 0
   [junit4]   2> 522349 INFO  (qtp566054268-9142) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[149 (1674248928800800769)]} 0 0
   [junit4]   2> 522349 INFO  (qtp1003579380-9119) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[500 (1674248928800800770)]} 0 0
   [junit4]   2> 522353 INFO  (qtp566054268-9145) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[500 (1674248928800800770)]} 0 0
   [junit4]   2> 522354 INFO  (qtp1003579380-9123) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[501 (1674248928804995072)]} 0 0
   [junit4]   2> 522354 INFO  (qtp566054268-9143) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[501 (1674248928806043648)]} 0 0
   [junit4]   2> 522354 INFO  (qtp1003579380-9124) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[502 (1674248928806043648)]} 0 0
   [junit4]   2> 522354 INFO  (qtp566054268-9144) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[502 (1674248928806043649)]} 0 0
   [junit4]   2> 522354 INFO  (qtp1003579380-9118) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[503 (1674248928806043649)]} 0 0
   [junit4]   2> 522354 INFO  (qtp566054268-9142) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[503 (1674248928806043650)]} 0 0
   [junit4]   2> 522358 INFO  (qtp1003579380-9119) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[504 (1674248928809189376)]} 0 0
   [junit4]   2> 522358 INFO  (qtp566054268-9145) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[504 (1674248928810237952)]} 0 0
   [junit4]   2> 522358 INFO  (qtp1003579380-9123) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[505 (1674248928810237952)]} 0 0
   [junit4]   2> 522361 INFO  (qtp566054268-9143) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[505 (1674248928813383680)]} 0 0
   [junit4]   2> 522361 INFO  (qtp1003579380-9124) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[506 (1674248928813383680)]} 0 0
   [junit4]   2> 522362 INFO  (qtp566054268-9144) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[506 (1674248928814432256)]} 0 0
   [junit4]   2> 522375 INFO  (qtp1003579380-9118) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[507 (1674248928828063744)]} 0 11
   [junit4]   2> 522375 INFO  (qtp566054268-9142) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[507 (1674248928828063744)]} 0 0
   [junit4]   2> 522384 INFO  (qtp1003579380-9119) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[508 (1674248928837500928)]} 0 0
   [junit4]   2> 522384 INFO  (qtp566054268-9145) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[508 (1674248928837500928)]} 0 0
   [junit4]   2> 522387 INFO  (qtp1003579380-9123) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[509 (1674248928840646656)]} 0 0
   [junit4]   2> 522388 INFO  (qtp566054268-9143) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[509 (1674248928841695232)]} 0 0
   [junit4]   2> 522388 INFO  (qtp1003579380-9124) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[510 (1674248928841695232)]} 0 0
   [junit4]   2> 522388 INFO  (qtp566054268-9144) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[510 (1674248928841695233)]} 0 0
   [junit4]   2> 522402 INFO  (qtp1003579380-9118) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[511 (1674248928856375296)]} 0 0
   [junit4]   2> 522406 INFO  (qtp566054268-9142) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[511 (1674248928860569600)]} 0 0
   [junit4]   2> 522410 INFO  (qtp1003579380-9119) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[512 (1674248928864763904)]} 0 0
   [junit4]   2> 522415 INFO  (qtp566054268-9145) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[512 (1674248928864763904)]} 0 0
   [junit4]   2> 522415 INFO  (qtp1003579380-9123) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[513 (1674248928870006784)]} 0 0
   [junit4]   2> 522417 INFO  (qtp566054268-9143) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[513 (1674248928872103936)]} 0 0
   [junit4]   2> 522417 INFO  (qtp1003579380-9124) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[514 (1674248928872103936)]} 0 0
   [junit4]   2> 522418 INFO  (qtp566054268-9144) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[514 (1674248928873152512)]} 0 0
   [junit4]   2> 522419 INFO  (qtp1003579380-9118) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[515 (1674248928874201088)]} 0 0
   [junit4]   2> 522423 INFO  (qtp566054268-9142) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[515 (1674248928878395392)]} 0 0
   [junit4]   2> 522432 INFO  (qtp1003579380-9119) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[516 (1674248928887832576)]} 0 0
   [junit4]   2> 522432 INFO  (qtp566054268-9145) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[516 (1674248928887832576)]} 0 0
   [junit4]   2> 522435 INFO  (qtp1003579380-9123) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[517 (1674248928890978304)]} 0 0
   [junit4]   2> 522436 INFO  (qtp566054268-9143) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[517 (1674248928892026880)]} 0 0
   [junit4]   2> 522438 INFO  (qtp1003579380-9124) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[518 (1674248928894124032)]} 0 0
   [junit4]   2> 522439 INFO  (qtp566054268-9144) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[518 (1674248928895172608)]} 0 0
   [junit4]   2> 522441 INFO  (qtp1003579380-9118) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[519 (1674248928897269760)]} 0 0
   [junit4]   2> 522442 INFO  (qtp566054268-9142) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[519 (1674248928898318336)]} 0 0
   [junit4]   2> 522443 INFO  (qtp1003579380-9119) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[520 (1674248928899366912)]} 0 0
   [junit4]   2> 522444 INFO  (qtp566054268-9145) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[520 (1674248928900415488)]} 0 0
   [junit4]   2> 522445 INFO  (qtp1003579380-9123) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[521 (1674248928901464064)]} 0 0
   [junit4]   2> 522446 INFO  (qtp566054268-9143) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[521 (1674248928902512640)]} 0 0
   [junit4]   2> 522447 INFO  (qtp1003579380-9124) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[522 (1674248928903561216)]} 0 0
   [junit4]   2> 522448 INFO  (qtp566054268-9144) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[522 (1674248928904609792)]} 0 0
   [junit4]   2> 522448 INFO  (qtp1003579380-9118) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[523 (1674248928904609792)]} 0 0
   [junit4]   2> 522448 INFO  (qtp566054268-9142) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[523 (1674248928904609793)]} 0 0
   [junit4]   2> 522448 INFO  (qtp1003579380-9119) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[524 (1674248928904609793)]} 0 0
   [junit4]   2> 522453 INFO  (qtp566054268-9145) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[524 (1674248928908804096)]} 0 0
   [junit4]   2> 522455 INFO  (qtp1003579380-9123) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[525 (1674248928910901248)]} 0 0
   [junit4]   2> 522456 INFO  (qtp566054268-9143) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[525 (1674248928912998400)]} 0 0
   [junit4]   2> 522458 INFO  (qtp1003579380-9124) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[526 (1674248928915095552)]} 0 0
   [junit4]   2> 522459 INFO  (qtp566054268-9144) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[526 (1674248928916144128)]} 0 0
   [junit4]   2> 522459 INFO  (qtp1003579380-9118) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[527 (1674248928916144128)]} 0 0
   [junit4]   2> 522461 INFO  (qtp566054268-9142) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[527 (1674248928918241280)]} 0 0
   [junit4]   2> 522461 INFO  (qtp1003579380-9119) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[528 (1674248928918241280)]} 0 0
   [junit4]   2> 522462 INFO  (qtp566054268-9145) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[528 (1674248928919289856)]} 0 0
   [junit4]   2> 522462 INFO  (qtp1003579380-9123) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[529 (1674248928919289856)]} 0 0
   [junit4]   2> 522463 INFO  (qtp566054268-9143) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[529 (1674248928920338432)]} 0 0
   [junit4]   2> 522463 INFO  (qtp1003579380-9124) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[530 (1674248928920338432)]} 0 0
   [junit4]   2> 522463 INFO  (qtp566054268-9144) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[530 (1674248928920338433)]} 0 0
   [junit4]   2> 522464 INFO  (qtp1003579380-9118) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[531 (1674248928921387008)]} 0 0
   [junit4]   2> 522464 INFO  (qtp566054268-9142) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[531 (1674248928921387008)]} 0 0
   [junit4]   2> 522465 INFO  (qtp1003579380-9119) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[532 (1674248928922435584)]} 0 0
   [junit4]   2> 522465 INFO  (qtp566054268-9145) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[532 (1674248928922435584)]} 0 0
   [junit4]   2> 522466 INFO  (qtp1003579380-9123) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[533 (1674248928923484160)]} 0 0
   [junit4]   2> 522466 INFO  (qtp566054268-9143) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[533 (1674248928923484160)]} 0 0
   [junit4]   2> 522467 INFO  (qtp1003579380-9124) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[534 (1674248928924532736)]} 0 0
   [junit4]   2> 522467 INFO  (qtp566054268-9144) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[534 (1674248928924532736)]} 0 0
   [junit4]   2> 522468 INFO  (qtp1003579380-9118) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[535 (1674248928925581312)]} 0 0
   [junit4]   2> 522468 INFO  (qtp566054268-9142) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/update 
params={wt=javabin&version=2}{add=[535 (1674248928925581312)]} 0 0
   [junit4]   2> 522469 INFO  (qtp1003579380-9119) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/wk path=/upda

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

registry=solr.jetty tag=null
   [junit4]   2> 527813 INFO  (closeThreadPool-5807-thread-4) [     ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@2f16b95: rootName = null, 
domain = solr.jetty, service url = null, agent id = null] for registry 
solr.jetty/com.codahale.metrics.MetricRegistry@78472a1f
   [junit4]   2> 527828 INFO  (closeThreadPool-5807-thread-2) [     ] 
o.e.j.s.AbstractConnector Stopped ServerConnector@185b8f9f{HTTP/1.1, (http/1.1, 
h2c)}{127.0.0.1:0}
   [junit4]   2> 527829 INFO  (closeThreadPool-5807-thread-4) [     ] 
o.e.j.s.AbstractConnector Stopped ServerConnector@717aa2d3{HTTP/1.1, (http/1.1, 
h2c)}{127.0.0.1:0}
   [junit4]   2> 527829 INFO  (closeThreadPool-5807-thread-2) [     ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@6eb18498{/wk,null,UNAVAILABLE}
   [junit4]   2> 527829 INFO  (closeThreadPool-5807-thread-4) [     ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@2e17fd51{/wk,null,UNAVAILABLE}
   [junit4]   2> 527829 INFO  (closeThreadPool-5807-thread-2) [     ] 
o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 527840 INFO  (closeThreadPool-5807-thread-4) [     ] 
o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=TestDistributedGrouping -Dtests.method=test 
-Dtests.seed=B64F89FCE2B82CE4 -Dtests.slow=true -Dtests.locale=ce-RU 
-Dtests.timezone=America/Atka -Dtests.asserts=true 
-Dtests.file.encoding=US-ASCII
   [junit4] ERROR   18.3s J4 | TestDistributedGrouping.test <<<
   [junit4]    > Throwable #1: 
org.apache.solr.client.solrj.impl.BaseHttpSolrClient$RemoteSolrException: Error 
from server at http://127.0.0.1:52134/wk/collection1: 
org.apache.solr.client.solrj.SolrServerException: Time allowed to handle this 
request exceeded:[http://[::1]:4/wk, http://[::1]:6/wk, http://[::1]:8/wk]
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([B64F89FCE2B82CE4:3E1BB6264C44411C]: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:210)
   [junit4]    >        at 
org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:1004)
   [junit4]    >        at 
org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:1019)
   [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 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   [junit4]    >        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
   [junit4]    >        at 
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   [junit4]    >        at 
java.base/java.lang.reflect.Method.invoke(Method.java:566)
   [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.base/java.lang.Thread.run(Thread.java:834)
   [junit4]   2> NOTE: leaving temporary files on disk at: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J4\temp\solr.TestDistributedGrouping_B64F89FCE2B82CE4-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene86): 
{other_tl1=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)),
 
SubjectTerms_mfacet=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)),
 range_facet_l_dv=PostingsFormat(name=MockRandom), 
n_l1=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)), 
multiDefault=PostingsFormat(name=Direct), 
intDefault=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)),
 n_td1=PostingsFormat(name=Direct), 
n_d1=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)), 
n_f1=PostingsFormat(name=Direct), 
range_facet_l=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)),
 b_n_tdt1=PostingsFormat(name=MockRandom), n_tl1=PostingsFormat(name=Direct), 
a_n_tdt1=PostingsFormat(name=Direct), a_s=PostingsFormat(name=Asserting), 
n_tf1=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)), 
a_t=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)), 
id=PostingsFormat(name=MockRandom), text=PostingsFormat(name=Asserting), 
oddField_s1=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)),
 a_idv=PostingsFormat(name=Asserting), 
timestamp=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)),
 
_root_=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)), 
n_dt1=PostingsFormat(name=Direct), 
a_i1=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)), 
n_ti1=PostingsFormat(name=MockRandom), rnd_b=PostingsFormat(name=MockRandom), 
foo_b=PostingsFormat(name=Asserting), 
n_tdt1=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)), 
foo_d=PostingsFormat(name=MockRandom), id_i1=PostingsFormat(name=Direct), 
range_facet_i_dv=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)),
 foo_f=PostingsFormat(name=Asserting)}, 
docValues:{range_facet_l_dv=DocValuesFormat(name=Asserting), 
_version_=DocValuesFormat(name=Lucene80), 
a_b_dvo=DocValuesFormat(name=Lucene80), 
a_s_dvo=DocValuesFormat(name=Asserting), 
range_facet_i_dv=DocValuesFormat(name=Lucene80), 
intDvoDefault=DocValuesFormat(name=Asserting), 
a_idv=DocValuesFormat(name=Asserting), 
timestamp=DocValuesFormat(name=Lucene80)}, maxPointsInLeafNode=442, 
maxMBSortInHeap=5.982731778799207, 
sim=Asserting(RandomSimilarity(queryNorm=false): {}), locale=ce-RU, 
timezone=America/Atka
   [junit4]   2> NOTE: Windows 10 10.0 amd64/AdoptOpenJDK 11.0.6 
(64-bit)/cpus=6,threads=1,free=146217272,total=403701760
   [junit4]   2> NOTE: All tests run in this JVM: 
[CrossCollectionJoinQueryTest, HdfsBasicDistributedZkTest, TestHdfsUpdateLog, 
TestCoreBackup, DeleteReplicaTest, XmlInterpolationTest, 
EmbeddedSolrNoSerializeTest, TestTolerantUpdateProcessorCloud, 
HdfsUnloadDistributedZkTest, TestHighlightDedupGrouping, 
SignatureUpdateProcessorFactoryTest, TestReload, UpdateParamsTest, 
UUIDFieldTest, SearchHandlerTest, TestSolrConfigHandlerConcurrent, 
SolrCoreMetricManagerTest, TestConfigSetProperties, LeaderTragicEventTest, 
TestConfigSetsAPIZkFailure, FieldMutatingUpdateProcessorTest, 
IndexSizeEstimatorTest, TestPseudoReturnFields, 
ChaosMonkeyNothingIsSafeWithPullReplicasTest, CachingDirectoryFactoryTest, 
ForceLeaderWithTlogReplicasTest, TestGeoJSONResponseWriter, 
CdcrRequestHandlerTest, CloneFieldUpdateProcessorFactoryTest, FuzzySearchTest, 
TestWordDelimiterFilterFactory, MissingSegmentRecoveryTest, 
CreateCollectionCleanupTest, TestXmlQParserPlugin, TestFieldCache, 
AliasIntegrationTest, TestDynamicFieldCollectionResource, 
SubstringBytesRefFilterTest, TestSizeLimitedDistributedMap, 
DocumentBuilderTest, MetricsHandlerTest, TestExactSharedStatsCache, 
HdfsCollectionsAPIDistributedZkTest, ParsingFieldUpdateProcessorsTest, 
TestDelegationWithHadoopAuth, ShardsWhitelistTest, TestStreamBody, 
CircularListTest, TestManagedSchemaThreadSafety, TestLockTree, 
TestLMDirichletSimilarityFactory, TestHttpShardHandlerFactory, 
WordBreakSolrSpellCheckerTest, TestSolrFieldCacheBean, 
TestPullReplicaErrorHandling, TestCloudJSONFacetSKG, TestSmileRequest, 
SampleTest, ShowFileRequestHandlerTest, TestCollationField, 
TestImplicitCoreProperties, SolrIndexSearcherTest, 
TestFuzzyAnalyzedSuggestions, BasicAuthIntegrationTest, TestCloudRecovery2, 
PeerSyncWithLeaderAndIndexFingerprintCachingTest, SynonymTokenizerTest, 
CacheHeaderTest, TestEmbeddedSolrServerSchemaAPI, ResourceLoaderTest, 
TestRawResponseWriter, CustomTermsComponentTest, CurrencyFieldTypeTest, 
UUIDUpdateProcessorFallbackTest, TestScoreJoinQPScore, 
PhrasesIdentificationComponentTest, AddBlockUpdateTest, SaslZkACLProviderTest, 
TestHashPartitioner, ZookeeperReadAPITest, SolrRrdBackendFactoryTest, 
SolrLogAuditLoggerPluginTest, TestChildDocTransformerHierarchy, TestRangeQuery, 
ProtectedTermFilterFactoryTest, BadCopyFieldTest, 
TestSchemalessBufferedUpdates, CursorPagingTest, DisMaxRequestHandlerTest, 
TestCursorMarkWithoutUniqueKey, TestDistributedGrouping]
   [junit4] Completed [338/868 (1!)] on J4 in 18.40s, 1 test, 1 error <<< 
FAILURES!

[...truncated 53742 lines...]
[repro] Jenkins log URL: 
https://jenkins.thetaphi.de/job/Lucene-Solr-master-Windows/9191/consoleText

[repro] Revision: 6752111be82681e9f97d7c092d8a0652623bbcee

[repro] Ant options: "-Dargs=-XX:-UseCompressedOops -XX:+UseParallelGC"

[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 2468 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5 
-Dtests.class="*.TestDistributedGrouping" -Dtests.showOutput=onerror 
"-Dargs=-XX:-UseCompressedOops -XX:+UseParallelGC" 
-Dtests.seed=B64F89FCE2B82CE4 -Dtests.slow=true -Dtests.locale=ce-RU 
-Dtests.timezone=America/Atka -Dtests.asserts=true 
-Dtests.file.encoding=US-ASCII

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

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

Reply via email to