Build: https://jenkins.thetaphi.de/job/Lucene-Solr-8.x-Windows/1465/
Java: 64bit/jdk-12.0.2 -XX:+UseCompressedOops -XX:+UseG1GC

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

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

Stack Trace:
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error 
from server at https://127.0.0.1:61271/collection1: 
org.apache.solr.client.solrj.SolrServerException: Time allowed to handle this 
request exceeded:[https://[::1]:4, https://[::1]:8, https://[::1]:6]
        at 
__randomizedtesting.SeedInfo.seed([5EBB5B932D563ED6:D6EF644983AA532E]:0)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:681)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:266)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:248)
        at 
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:214)
        at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:1003)
        at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:1018)
        at 
org.apache.solr.BaseDistributedSearchTestCase.queryServer(BaseDistributedSearchTestCase.java:625)
        at 
org.apache.solr.TestDistributedGrouping.simpleQuery(TestDistributedGrouping.java:455)
        at 
org.apache.solr.TestDistributedGrouping.test(TestDistributedGrouping.java:443)
        at 
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:567)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsRepeatStatement.callStatement(BaseDistributedSearchTestCase.java:1117)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:1061)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.base/java.lang.Thread.run(Thread.java:835)




Build Log:
[...truncated 15097 lines...]
   [junit4] Suite: org.apache.solr.TestDistributedGrouping
   [junit4]   2> 1338719 INFO  
(SUITE-TestDistributedGrouping-seed#[5EBB5B932D563ED6]-worker) [     ] 
o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to 
test-framework derived value of 
'C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\server\solr\configsets\_default\conf'
   [junit4]   2> 1338719 INFO  
(SUITE-TestDistributedGrouping-seed#[5EBB5B932D563ED6]-worker) [     ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 1338719 INFO  
(SUITE-TestDistributedGrouping-seed#[5EBB5B932D563ED6]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Created dataDir: 
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J4\temp\solr.TestDistributedGrouping_5EBB5B932D563ED6-001\data-dir-103-001
   [junit4]   2> 1338719 WARN  
(SUITE-TestDistributedGrouping-seed#[5EBB5B932D563ED6]-worker) [     ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=6 numCloses=6
   [junit4]   2> 1338719 INFO  
(SUITE-TestDistributedGrouping-seed#[5EBB5B932D563ED6]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) 
w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 1338721 INFO  
(SUITE-TestDistributedGrouping-seed#[5EBB5B932D563ED6]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: 
@org.apache.solr.util.RandomizeSSL(reason="", value=0.0/0.0, ssl=0.0/0.0, 
clientAuth=0.0/0.0)
   [junit4]   2> 1338722 INFO  
(SUITE-TestDistributedGrouping-seed#[5EBB5B932D563ED6]-worker) [     ] 
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /
   [junit4]   2> 1339745 INFO  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J4\temp\solr.TestDistributedGrouping_5EBB5B932D563ED6-001\tempDir-001\control\cores\collection1
   [junit4]   2> 1339751 WARN  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, 
break even is size 23
   [junit4]   2> 1339751 INFO  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 1339751 INFO  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
   [junit4]   2> 1339751 INFO  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git: 
a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 12.0.2+10
   [junit4]   2> 1339751 INFO  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1339751 INFO  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1339753 INFO  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 1339753 INFO  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@5debf254{/,null,AVAILABLE}
   [junit4]   2> 1339754 INFO  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.e.j.s.AbstractConnector Started ServerConnector@6a03ebf9{ssl, (ssl, alpn, 
http/1.1, h2)}{127.0.0.1:61256}
   [junit4]   2> 1339754 INFO  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.e.j.s.Server Started @1341041ms
   [junit4]   2> 1339754 INFO  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, hostPort=61256, 
coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J4\temp\solr.TestDistributedGrouping_5EBB5B932D563ED6-001\tempDir-001\control\cores}
   [junit4]   2> 1339755 ERROR 
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1339755 INFO  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1339755 INFO  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.7.0
   [junit4]   2> 1339755 INFO  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 1339755 INFO  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: 
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr
   [junit4]   2> 1339755 INFO  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2020-08-03T04:43:22.128681Z
   [junit4]   2> 1339755 INFO  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J4\temp\solr.TestDistributedGrouping_5EBB5B932D563ED6-001\tempDir-001\control\solr.xml
   [junit4]   2> 1339758 INFO  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay 
is ignored
   [junit4]   2> 1339758 INFO  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 1339759 INFO  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@474600eb, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 1339935 INFO  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
   [junit4]   2> 1339937 WARN  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@3a137273[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1339937 WARN  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@3a137273[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1339941 WARN  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@62ddd4a3[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1339941 WARN  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@62ddd4a3[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1339942 WARN  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
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> 1339964 INFO  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 1339964 INFO  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history 
in memory.
   [junit4]   2> 1339987 INFO  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@474600eb
   [junit4]   2> 1339995 INFO  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@474600eb
   [junit4]   2> 1339995 INFO  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@474600eb
   [junit4]   2> 1339997 INFO  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J4\temp\solr.TestDistributedGrouping_5EBB5B932D563ED6-001\tempDir-001\control\cores
   [junit4]   2> 1339997 INFO  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 1340010 INFO  (coreLoadExecutor-8412-thread-1) [    
x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.7.0
   [junit4]   2> 1340030 INFO  (coreLoadExecutor-8412-thread-1) [    
x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from configset 
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\core\src\test-files\solr\collection1,
 trusted=true
   [junit4]   2> 1340036 INFO  (coreLoadExecutor-8412-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema Schema name=test
   [junit4]   2> 1340095 INFO  (coreLoadExecutor-8412-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field 
id
   [junit4]   2> 1340106 INFO  (coreLoadExecutor-8412-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@474600eb
   [junit4]   2> 1340106 INFO  (coreLoadExecutor-8412-thread-1) [    
x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J4\temp\solr.TestDistributedGrouping_5EBB5B932D563ED6-001\tempDir-001\control\cores\collection1],
 
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J4\temp\solr.TestDistributedGrouping_5EBB5B932D563ED6-001\tempDir-001\control\cores\collection1\data\]
   [junit4]   2> 1340107 INFO  (coreLoadExecutor-8412-thread-1) [    
x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=44, maxMergeAtOnceExplicit=43, maxMergedSegmentMB=100.150390625, 
floorSegmentMB=1.5009765625, forceMergeDeletesPctAllowed=29.911729062936498, 
segmentsPerTier=14.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0, 
deletesPctAllowed=34.797430907402116
   [junit4]   2> 1340179 INFO  (coreLoadExecutor-8412-thread-1) [    
x:collection1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1340179 INFO  (coreLoadExecutor-8412-thread-1) [    
x:collection1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 1340182 INFO  (coreLoadExecutor-8412-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1340182 INFO  (coreLoadExecutor-8412-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1340182 INFO  (coreLoadExecutor-8412-thread-1) [    
x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=37, maxMergeAtOnceExplicit=35, maxMergedSegmentMB=63.306640625, 
floorSegmentMB=2.142578125, forceMergeDeletesPctAllowed=8.646141177309254, 
segmentsPerTier=10.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.14365448084527738, deletesPctAllowed=47.3887655627381
   [junit4]   2> 1340182 INFO  (coreLoadExecutor-8412-thread-1) [    
x:collection1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1340193 INFO  (coreLoadExecutor-8412-thread-1) [    
x:collection1 ] o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 1340230 INFO  (coreLoadExecutor-8412-thread-1) [    
x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 1340231 INFO  (coreLoadExecutor-8412-thread-1) [    
x:collection1 ] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1673977976695291904
   [junit4]   2> 1340231 INFO  
(searcherExecutor-8414-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1340232 INFO  
(searcherExecutor-8414-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1340232 INFO  
(searcherExecutor-8414-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1340232 INFO  
(searcherExecutor-8414-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 1340233 INFO  
(searcherExecutor-8414-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1340233 INFO  
(searcherExecutor-8414-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1340233 INFO  
(searcherExecutor-8414-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1340234 INFO  
(searcherExecutor-8414-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 1340234 INFO  
(searcherExecutor-8414-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 1340235 INFO  
(searcherExecutor-8414-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 1340943 INFO  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J4\temp\solr.TestDistributedGrouping_5EBB5B932D563ED6-001\tempDir-001\shard0\cores\collection1
   [junit4]   2> 1340947 WARN  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, 
break even is size 23
   [junit4]   2> 1340947 INFO  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 1340947 INFO  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
   [junit4]   2> 1340947 INFO  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git: 
a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 12.0.2+10
   [junit4]   2> 1340948 INFO  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1340948 INFO  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1340948 INFO  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 1340949 INFO  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@3559f8f2{/,null,AVAILABLE}
   [junit4]   2> 1340950 INFO  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.e.j.s.AbstractConnector Started ServerConnector@6056145{ssl, (ssl, alpn, 
http/1.1, h2)}{127.0.0.1:61271}
   [junit4]   2> 1340950 INFO  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.e.j.s.Server Started @1342237ms
   [junit4]   2> 1340950 INFO  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, hostPort=61271, 
coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J4\temp\solr.TestDistributedGrouping_5EBB5B932D563ED6-001\tempDir-001\shard0\cores}
   [junit4]   2> 1340950 ERROR 
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1340950 INFO  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1340950 INFO  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.7.0
   [junit4]   2> 1340950 INFO  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 1340950 INFO  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: 
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr
   [junit4]   2> 1340951 INFO  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2020-08-03T04:43:23.324679Z
   [junit4]   2> 1340951 INFO  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J4\temp\solr.TestDistributedGrouping_5EBB5B932D563ED6-001\tempDir-001\shard0\solr.xml
   [junit4]   2> 1340953 INFO  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay 
is ignored
   [junit4]   2> 1340953 INFO  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 1340954 INFO  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@474600eb, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 1341154 INFO  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
   [junit4]   2> 1341156 WARN  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@6a32faaa[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1341156 WARN  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@6a32faaa[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1341156 WARN  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@20c388b[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1341156 WARN  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@20c388b[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1341161 WARN  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
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> 1341186 INFO  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 1341186 INFO  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history 
in memory.
   [junit4]   2> 1341208 INFO  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@474600eb
   [junit4]   2> 1341215 INFO  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@474600eb
   [junit4]   2> 1341215 INFO  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@474600eb
   [junit4]   2> 1341217 INFO  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J4\temp\solr.TestDistributedGrouping_5EBB5B932D563ED6-001\tempDir-001\shard0\cores
   [junit4]   2> 1341217 INFO  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 1341226 INFO  (coreLoadExecutor-8430-thread-1) [    
x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.7.0
   [junit4]   2> 1341239 INFO  (coreLoadExecutor-8430-thread-1) [    
x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from configset 
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\core\src\test-files\solr\collection1,
 trusted=true
   [junit4]   2> 1341245 INFO  (coreLoadExecutor-8430-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema Schema name=test
   [junit4]   2> 1341324 INFO  (coreLoadExecutor-8430-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field 
id
   [junit4]   2> 1341336 INFO  (coreLoadExecutor-8430-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@474600eb
   [junit4]   2> 1341336 INFO  (coreLoadExecutor-8430-thread-1) [    
x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J4\temp\solr.TestDistributedGrouping_5EBB5B932D563ED6-001\tempDir-001\shard0\cores\collection1],
 
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J4\temp\solr.TestDistributedGrouping_5EBB5B932D563ED6-001\tempDir-001\shard0\cores\collection1\data\]
   [junit4]   2> 1341337 INFO  (coreLoadExecutor-8430-thread-1) [    
x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=44, maxMergeAtOnceExplicit=43, maxMergedSegmentMB=100.150390625, 
floorSegmentMB=1.5009765625, forceMergeDeletesPctAllowed=29.911729062936498, 
segmentsPerTier=14.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0, 
deletesPctAllowed=34.797430907402116
   [junit4]   2> 1341416 INFO  (coreLoadExecutor-8430-thread-1) [    
x:collection1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1341416 INFO  (coreLoadExecutor-8430-thread-1) [    
x:collection1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 1341418 INFO  (coreLoadExecutor-8430-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1341418 INFO  (coreLoadExecutor-8430-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1341419 INFO  (coreLoadExecutor-8430-thread-1) [    
x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=37, maxMergeAtOnceExplicit=35, maxMergedSegmentMB=63.306640625, 
floorSegmentMB=2.142578125, forceMergeDeletesPctAllowed=8.646141177309254, 
segmentsPerTier=10.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.14365448084527738, deletesPctAllowed=47.3887655627381
   [junit4]   2> 1341420 INFO  (coreLoadExecutor-8430-thread-1) [    
x:collection1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1341432 INFO  (coreLoadExecutor-8430-thread-1) [    
x:collection1 ] o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 1341493 INFO  (coreLoadExecutor-8430-thread-1) [    
x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 1341493 INFO  (coreLoadExecutor-8430-thread-1) [    
x:collection1 ] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1673977978018594816
   [junit4]   2> 1341493 INFO  
(searcherExecutor-8432-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1341493 INFO  
(searcherExecutor-8432-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1341493 INFO  
(searcherExecutor-8432-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1341493 INFO  
(searcherExecutor-8432-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 1341493 INFO  
(searcherExecutor-8432-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1341493 INFO  
(TEST-TestDistributedGrouping.test-seed#[5EBB5B932D563ED6]) [     ] 
o.a.s.SolrTestCaseJ4 ###Starting test
   [junit4]   2> 1341493 INFO  
(searcherExecutor-8432-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1341493 INFO  
(searcherExecutor-8432-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1341493 INFO  
(searcherExecutor-8432-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 1341497 INFO  
(searcherExecutor-8432-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 1341498 INFO  
(searcherExecutor-8432-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 1341520 INFO  (qtp2099591162-13017) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{deleteByQuery=*:* (-1673977978044809216)} 0 2
   [junit4]   2> 1341545 INFO  (qtp2115164775-13038) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{deleteByQuery=*:* (-1673977978064732160)} 0 6
   [junit4]   2> 1341549 INFO  (qtp2099591162-13015) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 2
   [junit4]   2> 1341550 INFO  (qtp2115164775-13036) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 1
   [junit4]   2> 1341557 INFO  (qtp2099591162-13016) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&fl=id,a_i1&group.limit=-1&sort=a_i1+asc,+id+asc&rows=100&wt=javabin&version=2&group.field=a_i1&group=true}
 hits=0 status=0 QTime=4
   [junit4]   2> 1341582 INFO  (qtp2115164775-13036) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={df=text&group.distributed.first=true&distrib=false&fl=id&group.limit=-1&shards.purpose=2048&start=0&sort=a_i1+asc,+id+asc&shard.url=https://127.0.0.1:61271/collection1&rows=100&rid=127.0.0.1-46808&version=2&q=*:*&omitHeader=false&NOW=1596429803930&isShard=true&wt=javabin&group.field=a_i1&group=true}
 status=0 QTime=4
   [junit4]   2> 1341583 INFO  (qtp2115164775-13037) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=https://127.0.0.1:61271/collection1&fl=id,a_i1&group.limit=-1&sort=a_i1+asc,+id+asc&rows=100&wt=javabin&version=2&group.field=a_i1&group=true}
 rid=127.0.0.1-46808 status=0 QTime=24
   [junit4]   2> 1341585 INFO  (qtp2099591162-13013) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&hl=true&fl=id,a_i1&group.limit=-1&sort=a_i1+asc,+id+asc&hl.fl=a_t&rows=100&wt=javabin&version=2&group.field=a_i1&group=true}
 hits=0 status=0 QTime=1
   [junit4]   2> 1343611 INFO  (qtp2115164775-13038) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={df=text&group.distributed.first=true&distrib=false&hl=false&fl=id&group.limit=-1&shards.purpose=2048&start=0&sort=a_i1+asc,+id+asc&shard.url=[::1]:8/|https://127.0.0.1:61271/collection1&rows=100&rid=127.0.0.1-46810&version=2&q=*:*&omitHeader=false&NOW=1596429803959&isShard=true&hl.fl=a_t&wt=javabin&group.field=a_i1&group=true}
 status=0 QTime=0
   [junit4]   2> 1343612 INFO  (qtp2115164775-13035) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=[::1]:8/|https://127.0.0.1:61271/collection1&hl=true&fl=id,a_i1&group.limit=-1&sort=a_i1+asc,+id+asc&hl.fl=a_t&rows=100&wt=javabin&version=2&group.field=a_i1&group=true}
 rid=127.0.0.1-46810 status=0 QTime=2026
   [junit4]   2> 1343612 WARN  (qtp2115164775-13035) [    x:collection1 ] 
o.a.s.c.S.SlowRequest slow: [collection1]  webapp= path=/select 
params={q=*:*&shards=[::1]:8/|https://127.0.0.1:61271/collection1&hl=true&fl=id,a_i1&group.limit=-1&sort=a_i1+asc,+id+asc&hl.fl=a_t&rows=100&wt=javabin&version=2&group.field=a_i1&group=true}
 rid=127.0.0.1-46810 status=0 QTime=2026
   [junit4]   2> 1343613 INFO  (qtp2099591162-13017) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&facet.field=a_t&distrib=false&fl=id,a_i1&group.limit=-1&sort=a_i1+asc,+id+asc&rows=100&facet=true&wt=javabin&version=2&group.field=a_i1&group=true}
 hits=0 status=0 QTime=0
   [junit4]   2> 1343615 INFO  (qtp2115164775-13037) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={facet.field=a_t&df=text&group.distributed.first=true&distrib=false&fl=id&group.limit=-1&shards.purpose=2048&start=0&sort=a_i1+asc,+id+asc&shard.url=https://127.0.0.1:61271/collection1&rows=100&rid=127.0.0.1-46812&version=2&q=*:*&omitHeader=false&NOW=1596429805987&isShard=true&facet=false&wt=javabin&group.field=a_i1&group=true}
 status=0 QTime=0
   [junit4]   2> 1343617 INFO  (qtp2115164775-13038) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={facet.field=a_t&df=text&distrib=false&fl=id&group.limit=-1&shards.purpose=20&start=0&f.a_t.facet.mincount=0&sort=a_i1+asc,+id+asc&shard.url=https://127.0.0.1:61271/collection1&rows=100&rid=127.0.0.1-46812&version=2&group.distributed.second=true&q=*:*&f.a_t.facet.limit=160&omitHeader=false&NOW=1596429805987&isShard=true&facet=true&wt=javabin&group.field=a_i1&group=true}
 status=0 QTime=0
   [junit4]   2> 1343618 INFO  (qtp2115164775-13036) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=https://127.0.0.1:61271/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-46812 status=0 QTime=4
   [junit4]   2> 1343620 INFO  (qtp2099591162-13015) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&stats=true&fl=id,a_i1&group.limit=-1&sort=a_i1+asc,+id+asc&rows=100&wt=javabin&version=2&group.field=a_i1&group=true&stats.field=a_i1}
 hits=0 status=0 QTime=0
   [junit4]   2> 1345643 INFO  (qtp2115164775-13037) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={df=text&group.distributed.first=true&distrib=false&fl=id&group.limit=-1&shards.purpose=2048&start=0&sort=a_i1+asc,+id+asc&shard.url=[::1]:4/|[::1]:8/|https://127.0.0.1:61271/collection1|[::1]:6/&rows=100&rid=127.0.0.1-46814&version=2&q=*:*&stats=false&omitHeader=false&NOW=1596429805993&isShard=true&wt=javabin&group.field=a_i1&group=true&stats.field=a_i1}
 status=0 QTime=0
   [junit4]   2> 1345643 INFO  (qtp2115164775-13038) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={df=text&distrib=false&fl=id&group.limit=-1&shards.purpose=516&start=0&sort=a_i1+asc,+id+asc&shard.url=[::1]:4/|[::1]:8/|https://127.0.0.1:61271/collection1|[::1]:6/&rows=100&rid=127.0.0.1-46814&version=2&group.distributed.second=true&q=*:*&stats=true&omitHeader=false&NOW=1596429805993&isShard=true&wt=javabin&group.field=a_i1&group=true&stats.field=a_i1}
 status=0 QTime=0
   [junit4]   2> 1345644 INFO  (qtp2115164775-13035) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=[::1]:4/|[::1]:8/|https://127.0.0.1:61271/collection1|[::1]:6/&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-46814 status=0 QTime=2023
   [junit4]   2> 1345644 WARN  (qtp2115164775-13035) [    x:collection1 ] 
o.a.s.c.S.SlowRequest slow: [collection1]  webapp= path=/select 
params={q=*:*&shards=[::1]:4/|[::1]:8/|https://127.0.0.1:61271/collection1|[::1]:6/&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-46814 status=0 QTime=2023
   [junit4]   2> 1345645 INFO  (qtp2099591162-13016) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={df=subject&distrib=false&qt=spellCheckCompRH&fl=id,a_i1&group.limit=-1&sort=a_i1+asc,+id+asc&rows=100&version=2&spellcheck.build=true&q=kings&spellcheck=true&wt=javabin&group.field=a_i1&group=true}
 hits=0 status=0 QTime=0
   [junit4]   2> 1345646 INFO  (qtp2115164775-13037) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={df=subject&group.distributed.first=true&distrib=false&qt=spellCheckCompRH&fl=id&group.limit=-1&shards.purpose=2048&start=0&sort=a_i1+asc,+id+asc&shard.url=[::1]:4/|https://127.0.0.1:61271/collection1&rows=100&rid=127.0.0.1-46816&version=2&spellcheck.build=true&q=kings&spellcheck=true&omitHeader=false&NOW=1596429808018&isShard=true&wt=javabin&group.field=a_i1&group=true}
 status=0 QTime=0
   [junit4]   2> 1345646 INFO  (qtp2115164775-13036) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={df=subject&qt=spellCheckCompRH&fl=id,a_i1&group.limit=-1&sort=a_i1+asc,+id+asc&rows=100&version=2&spellcheck.build=true&q=kings&shards=[::1]:4/|https://127.0.0.1:61271/collection1&spellcheck=true&wt=javabin&group.field=a_i1&group=true}
 rid=127.0.0.1-46816 status=0 QTime=1
   [junit4]   2> 1345649 INFO  (qtp2099591162-13013) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={facet.field=a_t&distrib=false&fl=id,a_i1&group.limit=-1&fq=a_s:a&sort=a_i1+asc,+id+asc&rows=100&version=2&q=*:*&group.truncate=true&facet=true&wt=javabin&group.field=a_i1&group=true}
 hits=0 status=0 QTime=2
   [junit4]   2> 1347707 INFO  (qtp2115164775-13035) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={facet.field=a_t&df=text&group.distributed.first=true&distrib=false&fl=id&group.limit=-1&shards.purpose=2048&start=0&fq=a_s:a&sort=a_i1+asc,+id+asc&shard.url=[::1]:6/|https://127.0.0.1:61271/collection1|[::1]:4/|[::1]:8/&rows=100&rid=127.0.0.1-46818&version=2&q=*:*&group.truncate=true&omitHeader=false&NOW=1596429808023&isShard=true&facet=false&wt=javabin&group.field=a_i1&group=true}
 status=0 QTime=0
   [junit4]   2> 1347708 INFO  (qtp2115164775-13037) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=20&fq=a_s:a&shard.url=[::1]:6/|https://127.0.0.1:61271/collection1|[::1]:4/|[::1]:8/&rid=127.0.0.1-46818&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=1596429808023&isShard=true&facet=true}
 status=0 QTime=0
   [junit4]   2> 1347708 INFO  (qtp2115164775-13038) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={facet.field=a_t&fl=id,a_i1&group.limit=-1&fq=a_s:a&sort=a_i1+asc,+id+asc&rows=100&version=2&q=*:*&shards=[::1]:6/|https://127.0.0.1:61271/collection1|[::1]:4/|[::1]:8/&group.truncate=true&facet=true&wt=javabin&group.field=a_i1&group=true}
 rid=127.0.0.1-46818 status=0 QTime=2058
   [junit4]   2> 1347708 WARN  (qtp2115164775-13038) [    x:collection1 ] 
o.a.s.c.S.SlowRequest slow: [collection1]  webapp= path=/select 
params={facet.field=a_t&fl=id,a_i1&group.limit=-1&fq=a_s:a&sort=a_i1+asc,+id+asc&rows=100&version=2&q=*:*&shards=[::1]:6/|https://127.0.0.1:61271/collection1|[::1]:4/|[::1]:8/&group.truncate=true&facet=true&wt=javabin&group.field=a_i1&group=true}
 rid=127.0.0.1-46818 status=0 QTime=2058
   [junit4]   2> 1347715 INFO  (qtp2099591162-13017) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[1 (1673977984537591808)]} 0 4
   [junit4]   2> 1347719 INFO  (qtp2115164775-13036) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[1 (1673977984543883264)]} 0 3
   [junit4]   2> 1347730 INFO  (qtp2099591162-13015) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[2 (1673977984552271872)]} 0 3
   [junit4]   2> 1347732 INFO  (qtp2115164775-13035) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[2 (1673977984559611904)]} 0 1
   [junit4]   2> 1347735 INFO  (qtp2099591162-13016) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[3 (1673977984563806208)]} 0 0
   [junit4]   2> 1347736 INFO  (qtp2115164775-13037) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[3 (1673977984564854784)]} 0 1
   [junit4]   2> 1347741 INFO  (qtp2099591162-13013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[4 (1673977984570097664)]} 0 0
   [junit4]   2> 1347743 INFO  (qtp2115164775-13038) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[4 (1673977984572194816)]} 0 1
   [junit4]   2> 1347746 INFO  (qtp2099591162-13017) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[5 (1673977984572194816)]} 0 0
   [junit4]   2> 1347748 INFO  (qtp2115164775-13036) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[5 (1673977984577437696)]} 0 1
   [junit4]   2> 1347749 INFO  (qtp2099591162-13015) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[6 (1673977984578486272)]} 0 0
   [junit4]   2> 1347752 INFO  (qtp2115164775-13035) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[6 (1673977984580583424)]} 0 1
   [junit4]   2> 1347753 INFO  (qtp2099591162-13016) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[7 (1673977984582680576)]} 0 0
   [junit4]   2> 1347761 INFO  (qtp2115164775-13037) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[7 (1673977984591069184)]} 0 0
   [junit4]   2> 1347763 INFO  (qtp2099591162-13013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[8 (1673977984593166336)]} 0 0
   [junit4]   2> 1347767 INFO  (qtp2115164775-13038) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[8 (1673977984596312064)]} 0 0
   [junit4]   2> 1347769 INFO  (qtp2099591162-13017) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[9 (1673977984598409216)]} 0 0
   [junit4]   2> 1347770 INFO  (qtp2115164775-13036) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[9 (1673977984600506368)]} 0 0
   [junit4]   2> 1347771 INFO  (qtp2099591162-13015) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[10 (1673977984601554944)]} 0 0
   [junit4]   2> 1347772 INFO  (qtp2115164775-13035) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[10 (1673977984602603520)]} 0 0
   [junit4]   2> 1347774 INFO  (qtp2099591162-13016) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[11 (1673977984603652096)]} 0 0
   [junit4]   2> 1347774 INFO  (qtp2115164775-13037) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[11 (1673977984604700672)]} 0 0
   [junit4]   2> 1347775 INFO  (qtp2099591162-13013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[12 (1673977984604700672)]} 0 0
   [junit4]   2> 1347776 INFO  (qtp2115164775-13038) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[12 (1673977984605749248)]} 0 0
   [junit4]   2> 1347778 INFO  (qtp2099591162-13017) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[14 (1673977984607846400)]} 0 0
   [junit4]   2> 1347780 INFO  (qtp2115164775-13036) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[14 (1673977984609943552)]} 0 0
   [junit4]   2> 1347780 INFO  (qtp2099591162-13015) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[15 (1673977984610992128)]} 0 0
   [junit4]   2> 1347781 INFO  (qtp2115164775-13035) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[15 (1673977984612040704)]} 0 0
   [junit4]   2> 1347783 INFO  (qtp2099591162-13016) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[16 (1673977984614137856)]} 0 0
   [junit4]   2> 1347784 INFO  (qtp2115164775-13037) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[16 (1673977984615186432)]} 0 0
   [junit4]   2> 1347787 INFO  (qtp2099591162-13013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[17 (1673977984616235008)]} 0 0
   [junit4]   2> 1347787 INFO  (qtp2115164775-13038) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[17 (1673977984618332160)]} 0 0
   [junit4]   2> 1347787 INFO  (qtp2099591162-13017) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[18 (1673977984618332160)]} 0 1
   [junit4]   2> 1347787 INFO  (qtp2115164775-13036) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[18 (1673977984618332161)]} 0 1
   [junit4]   2> 1347795 INFO  (qtp2099591162-13015) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[19 (1673977984626720768)]} 0 0
   [junit4]   2> 1347799 INFO  (qtp2115164775-13035) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[19 (1673977984629866496)]} 0 1
   [junit4]   2> 1347800 INFO  (qtp2099591162-13016) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[20 (1673977984631963648)]} 0 0
   [junit4]   2> 1347802 INFO  (qtp2115164775-13037) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[20 (1673977984634060800)]} 0 0
   [junit4]   2> 1347803 INFO  (qtp2099591162-13013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[21 (1673977984635109376)]} 0 0
   [junit4]   2> 1347805 INFO  (qtp2115164775-13038) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[21 (1673977984637206528)]} 0 0
   [junit4]   2> 1347808 INFO  (qtp2099591162-13017) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[22 (1673977984639303680)]} 0 1
   [junit4]   2> 1347809 INFO  (qtp2115164775-13036) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[22 (1673977984641400832)]} 0 0
   [junit4]   2> 1347811 INFO  (qtp2099591162-13015) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[23 (1673977984643497984)]} 0 0
   [junit4]   2> 1347813 INFO  (qtp2115164775-13035) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[23 (1673977984644546560)]} 0 0
   [junit4]   2> 1347814 INFO  (qtp2099591162-13016) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[100 (1673977984645595136)]} 0 0
   [junit4]   2> 1347815 INFO  (qtp2115164775-13037) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[100 (1673977984647692288)]} 0 0
   [junit4]   2> 1347817 INFO  (qtp2099591162-13013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[101 (1673977984649789440)]} 0 0
   [junit4]   2> 1347817 INFO  (qtp2115164775-13038) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[101 (1673977984649789440)]} 0 0
   [junit4]   2> 1347819 INFO  (qtp2099591162-13017) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[102 (1673977984649789441)]} 0 0
   [junit4]   2> 1347821 INFO  (qtp2115164775-13036) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[102 (1673977984651886592)]} 0 0
   [junit4]   2> 1347821 INFO  (qtp2099591162-13015) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[103 (1673977984653983744)]} 0 0
   [junit4]   2> 1347823 INFO  (qtp2115164775-13035) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[103 (1673977984653983744)]} 0 0
   [junit4]   2> 1347824 INFO  (qtp2099591162-13016) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[104 (1673977984656080896)]} 0 0
   [junit4]   2> 1347825 INFO  (qtp2115164775-13037) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[104 (1673977984658178048)]} 0 0
   [junit4]   2> 1347826 INFO  (qtp2099591162-13013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[105 (1673977984659226624)]} 0 0
   [junit4]   2> 1347832 INFO  (qtp2115164775-13038) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[105 (1673977984665518080)]} 0 0
   [junit4]   2> 1347832 INFO  (qtp2099591162-13017) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[106 (1673977984665518080)]} 0 1
   [junit4]   2> 1347832 INFO  (qtp2115164775-13036) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[106 (1673977984665518081)]} 0 0
   [junit4]   2> 1347832 INFO  (qtp2099591162-13015) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[107 (1673977984665518081)]} 0 0
   [junit4]   2> 1347832 INFO  (qtp2115164775-13035) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[107 (1673977984665518082)]} 0 1
   [junit4]   2> 1347832 INFO  (qtp2099591162-13016) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[108 (1673977984665518082)]} 0 0
   [junit4]   2> 1347846 INFO  (qtp2115164775-13037) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[108 (1673977984680198144)]} 0 0
   [junit4]   2> 1347846 INFO  (qtp2099591162-13013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[109 (1673977984680198144)]} 0 0
   [junit4]   2> 1347846 INFO  (qtp2115164775-13038) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[109 (1673977984680198145)]} 0 0
   [junit4]   2> 1347852 INFO  (qtp2099591162-13017) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[110 (1673977984686489600)]} 0 0
   [junit4]   2> 1347855 INFO  (qtp2115164775-13036) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[110 (1673977984686489600)]} 0 0
   [junit4]   2> 1347864 INFO  (qtp2099591162-13015) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[111 (1673977984699072512)]} 0 1
   [junit4]   2> 1347872 INFO  (qtp2115164775-13035) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[111 (1673977984707461120)]} 0 0
   [junit4]   2> 1347872 INFO  (qtp2099591162-13016) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[112 (1673977984707461120)]} 0 0
   [junit4]   2> 1347876 INFO  (qtp2115164775-13037) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[112 (1673977984707461121)]} 0 0
   [junit4]   2> 1347876 INFO  (qtp2099591162-13013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[113 (1673977984711655424)]} 0 0
   [junit4]   2> 1347876 INFO  (qtp2115164775-13038) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[113 (1673977984711655424)]} 0 0
   [junit4]   2> 1347880 INFO  (qtp2099591162-13017) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[114 (1673977984714801152)]} 0 0
   [junit4]   2> 1347884 INFO  (qtp2115164775-13036) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[114 (1673977984720044032)]} 0 0
   [junit4]   2> 1347884 INFO  (qtp2099591162-13015) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[115 (1673977984720044032)]} 0 0
   [junit4]   2> 1347888 INFO  (qtp2115164775-13035) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[115 (1673977984720044033)]} 0 0
   [junit4]   2> 1347888 INFO  (qtp2099591162-13016) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[116 (1673977984724238336)]} 0 0
   [junit4]   2> 1347888 INFO  (qtp2115164775-13037) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[116 (1673977984724238336)]} 0 0
   [junit4]   2> 1347888 INFO  (qtp2099591162-13013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[117 (1673977984724238337)]} 0 0
   [junit4]   2> 1347897 INFO  (qtp2115164775-13038) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[117 (1673977984733675520)]} 0 0
   [junit4]   2> 1347897 INFO  (qtp2099591162-13017) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[118 (1673977984733675520)]} 0 0
   [junit4]   2> 1347900 INFO  (qtp2115164775-13036) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[118 (1673977984736821248)]} 0 0
   [junit4]   2> 1347900 INFO  (qtp2099591162-13015) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[119 (1673977984736821248)]} 0 1
   [junit4]   2> 1347904 INFO  (qtp2115164775-13035) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[119 (1673977984741015552)]} 0 0
   [junit4]   2> 1347904 INFO  (qtp2099591162-13016) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[120 (1673977984741015552)]} 0 0
   [junit4]   2> 1347908 INFO  (qtp2115164775-13037) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[120 (1673977984745209856)]} 0 0
   [junit4]   2> 1347908 INFO  (qtp2099591162-13013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[121 (1673977984745209856)]} 0 0
   [junit4]   2> 1347908 INFO  (qtp2115164775-13038) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[121 (1673977984745209857)]} 0 0
   [junit4]   2> 1347912 INFO  (qtp2099591162-13017) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[122 (1673977984749404160)]} 0 0
   [junit4]   2> 1347915 INFO  (qtp2115164775-13036) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[122 (1673977984751501312)]} 0 0
   [junit4]   2> 1347917 INFO  (qtp2099591162-13015) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[123 (1673977984753598464)]} 0 0
   [junit4]   2> 1347918 INFO  (qtp2115164775-13035) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[123 (1673977984754647040)]} 0 0
   [junit4]   2> 1347922 INFO  (qtp2099591162-13016) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[124 (1673977984758841344)]} 0 0
   [junit4]   2> 1347924 INFO  (qtp2115164775-13037) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[124 (1673977984760938496)]} 0 0
   [junit4]   2> 1347928 INFO  (qtp2099591162-13013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[125 (1673977984766181376)]} 0 1
   [junit4]   2> 1347931 INFO  (qtp2115164775-13038) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[125 (1673977984766181376)]} 0 0
   [junit4]   2> 1347931 INFO  (qtp2099591162-13017) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[126 (1673977984769327104)]} 0 1
   [junit4]   2> 1347931 INFO  (qtp2115164775-13036) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[126 (1673977984769327104)]} 0 0
   [junit4]   2> 1347936 INFO  (qtp2099591162-13015) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[127 (1673977984774569984)]} 0 1
   [junit4]   2> 1347937 INFO  (qtp2115164775-13035) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[127 (1673977984775618560)]} 0 0
   [junit4]   2> 1347941 INFO  (qtp2099591162-13016) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[128 (1673977984779812864)]} 0 0
   [junit4]   2> 1347942 INFO  (qtp2115164775-13037) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[128 (1673977984780861440)]} 0 0
   [junit4]   2> 1347949 INFO  (qtp2099591162-13013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[129 (1673977984787152896)]} 0 5
   [junit4]   2> 1347951 INFO  (qtp2115164775-13038) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[129 (1673977984789250048)]} 0 1
   [junit4]   2> 1347951 INFO  (qtp2099591162-13017) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[130 (1673977984790298624)]} 0 0
   [junit4]   2> 1347954 INFO  (qtp2115164775-13036) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[130 (1673977984793444352)]} 0 0
   [junit4]   2> 1347958 INFO  (qtp2099591162-13015) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[131 (1673977984797638656)]} 0 1
   [junit4]   2> 1347961 INFO  (qtp2115164775-13035) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[131 (1673977984799735808)]} 0 1
   [junit4]   2> 1347963 INFO  (qtp2099591162-13016) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[132 (1673977984800784384)]} 0 0
   [junit4]   2> 1347965 INFO  (qtp2115164775-13037) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[132 (1673977984803930112)]} 0 0
   [junit4]   2> 1347965 INFO  (qtp2099591162-13013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[133 (1673977984804978688)]} 0 0
   [junit4]   2> 1347968 INFO  (qtp2115164775-13038) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[133 (1673977984807075840)]} 0 1
   [junit4]   2> 1347971 INFO  (qtp2099591162-13017) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[134 (1673977984810221568)]} 0 1
   [junit4]   2> 1347972 INFO  (qtp2115164775-13036) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[134 (1673977984812318720)]} 0 1
   [junit4]   2> 1347975 INFO  (qtp2099591162-13015) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[135 (1673977984815464448)]} 0 1
   [junit4]   2> 1347980 INFO  (qtp2115164775-13035) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[135 (1673977984820707328)]} 0 0
   [junit4]   2> 1347982 INFO  (qtp2099591162-13016) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[136 (1673977984821755904)]} 0 0
   [junit4]   2> 1347983 INFO  (qtp2115164775-13037) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[136 (1673977984822804480)]} 0 0
   [junit4]   2> 1347984 INFO  (qtp2099591162-13013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[137 (1673977984824901632)]} 0 0
   [junit4]   2> 1347986 INFO  (qtp2115164775-13038) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[137 (1673977984826998784)]} 0 0
   [junit4]   2> 1347989 INFO  (qtp2099591162-13017) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[138 (1673977984829095936)]} 0 1
   [junit4]   2> 1347992 INFO  (qtp2115164775-13036) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[138 (1673977984831193088)]} 0 0
   [junit4]   2> 1347996 INFO  (qtp2099591162-13015) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[139 (1673977984835387392)]} 0 0
   [junit4]   2> 1347999 INFO  (qtp2115164775-13035) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[139 (1673977984837484544)]} 0 1
   [junit4]   2> 1348002 INFO  (qtp2099591162-13016) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[140 (1673977984842727424)]} 0 0
   [junit4]   2> 1348008 INFO  (qtp2115164775-13037) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[140 (1673977984844824576)]} 0 5
   [junit4]   2> 1348012 INFO  (qtp2099591162-13013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[141 (1673977984854261760)]} 0 0
   [junit4]   2> 1348015 INFO  (qtp2115164775-13038) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[141 (1673977984857407488)]} 0 0
   [junit4]   2> 1348017 INFO  (qtp2099591162-13017) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[142 (1673977984859504640)]} 0 0
   [junit4]   2> 1348018 INFO  (qtp2115164775-13036) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[142 (1673977984860553216)]} 0 0
   [junit4]   2> 1348019 INFO  (qtp2099591162-13015) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[143 (1673977984861601792)]} 0 0
   [junit4]   2> 1348019 INFO  (qtp2115164775-13035) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[143 (1673977984861601792)]} 0 0
   [junit4]   2> 1348024 INFO  (qtp2099591162-13016) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[144 (1673977984866844672)]} 0 0
   [junit4]   2> 1348033 INFO  (qtp2115164775-13037) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[144 (1673977984876281856)]} 0 0
   [junit4]   2> 1348035 INFO  (qtp2099591162-13013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[145 (1673977984878379008)]} 0 0
   [junit4]   2> 1348036 INFO  (qtp2115164775-13038) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[145 (1673977984879427584)]} 0 0
   [junit4]   2> 1348039 INFO  (qtp2099591162-13017) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[146 (1673977984879427584)]} 0 0
   [junit4]   2> 1348044 INFO  (qtp2115164775-13036) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[146 (1673977984887816192)]} 0 0
   [junit4]   2> 1348048 INFO  (qtp2099591162-13015) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[147 (1673977984892010496)]} 0 0
   [junit4]   2> 1348050 INFO  (qtp2115164775-13035) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[147 (1673977984894107648)]} 0 0
   [junit4]   2> 1348051 INFO  (qtp2099591162-13016) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[148 (1673977984895156224)]} 0 0
   [junit4]   2> 1348053 INFO  (qtp2115164775-13037) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[148 (1673977984897253376)]} 0 0
   [junit4]   2> 1348056 INFO  (qtp2099591162-13013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[149 (1673977984900399104)]} 0 0
   [junit4]   2> 1348058 INFO  (qtp2115164775-13038) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[149 (1673977984902496256)]} 0 0
   [junit4]   2> 1348058 INFO  (qtp2099591162-13017) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[500 (1673977984902496256)]} 0 0
   [junit4]   2> 1348058 INFO  (qtp2115164775-13036) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[500 (1673977984902496257)]} 0 0
   [junit4]   2> 1348064 INFO  (qtp2099591162-13015) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[501 (1673977984908787712)]} 0 0
   [junit4]   2> 1348064 INFO  (qtp2115164775-13035) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[501 (1673977984908787712)]} 0 0
   [junit4]   2> 1348064 INFO  (qtp2099591162-13016) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[502 (1673977984908787713)]} 0 0
   [junit4]   2> 1348068 INFO  (qtp2115164775-13037) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[502 (1673977984912982016)]} 0 0
   [junit4]   2> 1348070 INFO  (qtp2099591162-13013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[503 (1673977984914030592)]} 0 0
   [junit4]   2> 1348071 INFO  (qtp2115164775-13038) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[503 (1673977984915079168)]} 0 0
   [junit4]   2> 1348071 INFO  (qtp2099591162-13017) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[504 (1673977984916127744)]} 0 0
   [junit4]   2> 1348073 INFO  (qtp2115164775-13036) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[504 (1673977984918224896)]} 0 0
   [junit4]   2> 1348075 INFO  (qtp2099591162-13015) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[505 (1673977984919273472)]} 0 0
   [junit4]   2> 1348081 INFO  (qtp2115164775-13035) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[505 (1673977984921370624)]} 0 4
   [junit4]   2> 1348084 INFO  (qtp2099591162-13016) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[506 (1673977984929759232)]} 0 0
   [junit4]   2> 1348084 INFO  (qtp2115164775-13037) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[506 (1673977984929759232)]} 0 0
   [junit4]   2> 1348084 INFO  (qtp2099591162-13013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[507 (1673977984929759233)]} 0 0
   [junit4]   2> 1348088 INFO  (qtp2115164775-13038) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[507 (1673977984933953536)]} 0 0
   [junit4]   2> 1348093 INFO  (qtp2099591162-13017) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[508 (1673977984936050688)]} 0 4
   [junit4]   2> 1348095 INFO  (qtp2115164775-13036) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[508 (1673977984940244992)]} 0 0
   [junit4]   2> 1348097 INFO  (qtp2099591162-13015) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[509 (1673977984942342144)]} 0 0
   [junit4]   2> 1348098 INFO  (qtp2115164775-13035) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[509 (1673977984944439296)]} 0 0
   [junit4]   2> 1348100 INFO  (qtp2099591162-13016) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[510 (1673977984944439296)]} 0 0
   [junit4]   2> 1348101 INFO  (qtp2115164775-13037) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[510 (1673977984947585024)]} 0 0
   [junit4]   2> 1348102 INFO  (qtp2099591162-13013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[511 (1673977984948633600)]} 0 0
   [junit4]   2> 1348104 INFO  (qtp2115164775-13038) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[511 (1673977984950730752)]} 0 0
   [junit4]   2> 1348105 INFO  (qtp2099591162-13017) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[512 (1673977984951779328)]} 0 0
   [junit4]   2> 1348109 INFO  (qtp2115164775-13036) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[512 (1673977984955973632)]} 0 0
   [junit4]   2> 1348112 INFO  (qtp2099591162-13015) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[513 (1673977984959119360)]} 0 0
   [junit4]   2> 1348115 INFO  (qtp2115164775-13035) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[513 (1673977984962265088)]} 0 0
   [junit4]   2> 1348121 INFO  (qtp2099591162-13016) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[514 (1673977984967507968)]} 0 0
   [junit4]   2> 1348124 INFO  (qtp2115164775-13037) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[514 (1673977984971702272)]} 0 0
   [junit4]   2> 1348126 INFO  (qtp2099591162-13013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[515 (1673977984972750848)]} 0 0
   [junit4]   2> 1348128 INFO  (qtp2115164775-13038) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[515 (1673977984973799424)]} 0 0
   [junit4]   2> 1348129 INFO  (qtp2099591162-13017) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[516 (1673977984976945152)]} 0 0
   [junit4]   2> 1348131 INFO  (qtp2115164775-13036) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[516 (1673977984977993728)]} 0 0
   [junit4]   2> 1348134 INFO  (qtp2099591162-13015) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[517 (1673977984982188032)]} 0 0
   [junit4]   2> 1348135 INFO  (qtp2115164775-13035) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[517 (1673977984983236608)]} 0 0
   [junit4]   2> 1348138 INFO  (qtp2099591162-13016) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[518 (1673977984986382336)]} 0 0
   [junit4]   2> 1348140 INFO  (qtp2115164775-13037) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[518 (1673977984988479488)]} 0 0
   [junit4]   2> 1348141 INFO  (qtp2099591162-13013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[519 (1673977984989528064)]} 0 0
   [junit4]   2> 1348141 INFO  (qtp2115164775-13038) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[519 (1673977984989528064)]} 0 0
   [junit4]   2> 1348143 INFO  (qtp2099591162-13017) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[520 (1673977984991625216)]} 0 0
   [junit4]   2> 1348145 INFO  (qtp2115164775-13036) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[520 (1673977984993722368)]} 0 0
   [junit4]   2> 1348148 INFO  (qtp2099591162-13015) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[521 (1673977984996868096)]} 0 0
   [junit4]   2> 1348157 INFO  (qtp2115164775-13035) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[521 (1673977985006305280)]} 0 0
   [junit4]   2> 1348160 INFO  (qtp2099591162-13016) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[522 (1673977985009451008)]} 0 0
   [junit4]   2> 1348163 INFO  (qtp2115164775-13037) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[522 (1673977985012596736)]} 0 0
   [junit4]   2> 1348169 INFO  (qtp2099591162-13013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[523 (1673977985017839616)]} 0 0
   [junit4]   2> 1348171 INFO  (qtp2115164775-13038) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[523 (1673977985018888192)]} 0 0
   [junit4]   2> 1348172 INFO  (qtp2099591162-13017) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[524 (1673977985022033920)]} 0 0
   [junit4]   2> 1348172 INFO  (qtp2115164775-13036) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[524 (1673977985022033920)]} 0 0
   [junit4]   2> 1348174 INFO  (qtp2099591162-13015) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[525 (1673977985024131072)]} 0 0
   [junit4]   2> 1348180 INFO  (qtp2115164775-13035) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[525 (1673977985030422528)]} 0 0
   [junit4]   2> 1348188 INFO  (qtp2099591162-13016) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[526 (1673977985038811136)]} 0 0
   [junit4]   2> 1348189 INFO  (qtp2115164775-13037) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[526 (1673977985039859712)]} 0 0
   [junit4]   2> 1348191 INFO  (qtp2099591162-13013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[527 (1673977985041956864)]} 0 0
   [junit4]   2> 1348199 INFO  (qtp2115164775-13038) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[527 (1673977985048248320)]} 0 1
   [junit4]   2> 1348200 INFO  (qtp2099591162-13017) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[528 (1673977985051394048)]} 0 0
   [junit4]   2> 1348204 INFO  (qtp2115164775-13036) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[528 (1673977985055588352)]} 0 0
   [junit4]   2> 1348204 INFO  (qtp2099591162-13015) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[529 (1673977985055588352)]} 0 0
   [junit4]   2> 1348204 INFO  (qtp2115164775-13035) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[529 (1673977985055588353)]} 0 0
   [junit4]   2> 1348204 INFO  (qtp2099591162-13016) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[530 (1673977985055588353)]} 0 0
   [junit4]   2> 1348204 INFO  (qtp2115164775-13037) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[530 (1673977985055588354)]} 0 0
   [junit4]   2> 1348212 INFO  (qtp2099591162-13013) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[531 (1673977985063976960)]} 0 0
   [junit4]   2> 1348212 INFO  (qtp2115164775-13038) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[531 (1673977985063976960)]} 0 0
   [junit4]   2> 1348212 INFO  (qtp2099591162-13017) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[532 (1673977985063976961)]} 0 0
   [junit4]   2> 1348220 INFO  (qtp2115164775-13036) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp

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

pdateHandler2 Committing on IndexWriter.close()  ... SKIPPED (unnecessary).
   [junit4]   2> 1350771 INFO  (coreCloseExecutor-8444-thread-1) [     ] 
o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close()  ... SKIPPED 
(unnecessary).
   [junit4]   2> 1350825 INFO  (closeThreadPool-8438-thread-2) [     ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node 
tag=null
   [junit4]   2> 1350825 INFO  (closeThreadPool-8438-thread-2) [     ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@5c29f14c: rootName = null, 
domain = solr.node, service url = null, agent id = null] for registry 
solr.node/com.codahale.metrics.MetricRegistry@45e989ae
   [junit4]   2> 1350825 INFO  (closeThreadPool-8438-thread-4) [     ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node 
tag=null
   [junit4]   2> 1350825 INFO  (closeThreadPool-8438-thread-4) [     ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@11b7a748: rootName = null, 
domain = solr.node, service url = null, agent id = null] for registry 
solr.node/com.codahale.metrics.MetricRegistry@1b2a144
   [junit4]   2> 1350825 INFO  (closeThreadPool-8438-thread-2) [     ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm 
tag=null
   [junit4]   2> 1350825 INFO  (closeThreadPool-8438-thread-2) [     ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@1b2c185b: rootName = null, 
domain = solr.jvm, service url = null, agent id = null] for registry 
solr.jvm/com.codahale.metrics.MetricRegistry@78571d58
   [junit4]   2> 1350825 INFO  (closeThreadPool-8438-thread-2) [     ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty 
tag=null
   [junit4]   2> 1350825 INFO  (closeThreadPool-8438-thread-2) [     ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@391356e3: rootName = null, 
domain = solr.jetty, service url = null, agent id = null] for registry 
solr.jetty/com.codahale.metrics.MetricRegistry@21679023
   [junit4]   2> 1350842 INFO  (closeThreadPool-8438-thread-4) [     ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm 
tag=null
   [junit4]   2> 1350852 INFO  (closeThreadPool-8438-thread-4) [     ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@796116be: rootName = null, 
domain = solr.jvm, service url = null, agent id = null] for registry 
solr.jvm/com.codahale.metrics.MetricRegistry@78571d58
   [junit4]   2> 1350904 INFO  (closeThreadPool-8438-thread-4) [     ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty 
tag=null
   [junit4]   2> 1350904 INFO  (closeThreadPool-8438-thread-4) [     ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@190ed3e5: rootName = null, 
domain = solr.jetty, service url = null, agent id = null] for registry 
solr.jetty/com.codahale.metrics.MetricRegistry@21679023
   [junit4]   2> 1350907 INFO  (closeThreadPool-8438-thread-2) [     ] 
o.e.j.s.AbstractConnector Stopped ServerConnector@6a03ebf9{ssl, (ssl, alpn, 
http/1.1, h2)}{127.0.0.1:0}
   [junit4]   2> 1350924 INFO  (closeThreadPool-8438-thread-2) [     ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@5debf254{/,null,UNAVAILABLE}
   [junit4]   2> 1350935 INFO  (closeThreadPool-8438-thread-2) [     ] 
o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 1350956 INFO  (closeThreadPool-8438-thread-4) [     ] 
o.e.j.s.AbstractConnector Stopped ServerConnector@6056145{ssl, (ssl, alpn, 
http/1.1, h2)}{127.0.0.1:0}
   [junit4]   2> 1350959 INFO  (closeThreadPool-8438-thread-4) [     ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@3559f8f2{/,null,UNAVAILABLE}
   [junit4]   2> 1350961 INFO  (closeThreadPool-8438-thread-4) [     ] 
o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=TestDistributedGrouping -Dtests.method=test 
-Dtests.seed=5EBB5B932D563ED6 -Dtests.slow=true -Dtests.locale=fo 
-Dtests.timezone=Pacific/Funafuti -Dtests.asserts=true 
-Dtests.file.encoding=ISO-8859-1
   [junit4] ERROR   12.3s J4 | TestDistributedGrouping.test <<<
   [junit4]    > Throwable #1: 
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error 
from server at https://127.0.0.1:61271/collection1: 
org.apache.solr.client.solrj.SolrServerException: Time allowed to handle this 
request exceeded:[https://[::1]:4, https://[::1]:8, https://[::1]:6]
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([5EBB5B932D563ED6:D6EF644983AA532E]:0)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:681)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:266)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:248)
   [junit4]    >        at 
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:214)
   [junit4]    >        at 
org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:1003)
   [junit4]    >        at 
org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:1018)
   [junit4]    >        at 
org.apache.solr.BaseDistributedSearchTestCase.queryServer(BaseDistributedSearchTestCase.java:625)
   [junit4]    >        at 
org.apache.solr.TestDistributedGrouping.simpleQuery(TestDistributedGrouping.java:455)
   [junit4]    >        at 
org.apache.solr.TestDistributedGrouping.test(TestDistributedGrouping.java:443)
   [junit4]    >        at 
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:567)
   [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:835)
   [junit4]   2> NOTE: leaving temporary files on disk at: 
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J4\temp\solr.TestDistributedGrouping_5EBB5B932D563ED6-001
   [junit4]   2> NOTE: test params are: 
codec=FastCompressingStoredFieldsData(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=FAST,
 chunkSize=16166, maxDocsPerChunk=3, blockShift=3), 
termVectorsFormat=CompressingTermVectorsFormat(compressionMode=FAST, 
chunkSize=16166, blockSize=3)), sim=Asserting(RandomSimilarity(queryNorm=true): 
{}), locale=fo, timezone=Pacific/Funafuti
   [junit4]   2> NOTE: Windows 10 10.0 amd64/AdoptOpenJDK 12.0.2 
(64-bit)/cpus=6,threads=1,free=152848728,total=339738624
   [junit4]   2> NOTE: All tests run in this JVM: [LoggingHandlerTest, 
ConnectionManagerTest, TestSolrJacksonAnnotation, DynamicMapsTest, 
ProtectedTermFilterFactoryTest, TestRangeQuery, TestSolrDeletionPolicy1, 
TestUseDocValuesAsStored, AutoScalingHandlerTest, 
HttpPartitionWithTlogReplicasTest, TestTrackingShardHandlerFactory, 
IndexSizeTriggerMixedBoundsTest, SolrCoreTest, TestReload, Tagger2Test, 
TestSimNodeAddedTrigger, DistribDocExpirationUpdateProcessorTest, 
DistributedFacetPivotSmallAdvancedTest, TestSurroundQueryParser, 
TestDynamicLoadingUrl, RuleEngineTest, IndexBasedSpellCheckerTest, 
TestStressLiveNodes, SolrCmdDistributorTest, ChaosMonkeyNothingIsSafeTest, 
TestMultiWordSynonyms, DocExpirationUpdateProcessorFactoryTest, 
TestLocalFSCloudBackupRestore, TestManagedSchema, BlockDirectoryTest, 
TestSmileRequest, LeaderFailureAfterFreshStartTest, TriggerIntegrationTest, 
TestExclusionRuleCollectionAccess, HdfsThreadLeakTest, TestWriterPerf, 
TestLRUStatsCache, TestSimDistributedQueue, AliasIntegrationTest, 
TestBinaryResponseWriter, V2ApiIntegrationTest, TestConfigsApi, 
ShardRoutingCustomTest, BadComponentTest, PropertiesRequestHandlerTest, 
HdfsNNFailoverTest, SimplePostToolTest, SimpleCollectionCreateDeleteTest, 
CdcrOpsAndBoundariesTest, BlockJoinFacetDistribTest, 
OutOfBoxZkACLAndCredentialsProvidersTest, TestLegacyTerms, TestJsonRequest, 
TestConfigReload, TestPseudoReturnFields, DirectUpdateHandlerTest, 
TestCloudManagedSchema, ClassificationUpdateProcessorTest, 
TestUnifiedSolrHighlighter, TestHighlightDedupGrouping, 
MetricsHistoryWithAuthIntegrationTest, TestMiniSolrCloudClusterSSL, 
TestEmbeddedSolrServerSchemaAPI, TestCloudJSONFacetSKG, FullHLLTest, 
ForceLeaderTest, TestDistributedGrouping]
   [junit4] Completed [464/917 (1!)] on J4 in 12.32s, 1 test, 1 error <<< 
FAILURES!

[...truncated 49019 lines...]
[repro] Jenkins log URL: 
https://jenkins.thetaphi.de/job/Lucene-Solr-8.x-Windows/1465/consoleText

[repro] Revision: 7b12849282898780b9a94546d23e325f5b8be6bb

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

[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 3473 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5 
-Dtests.class="*.TestDistributedGrouping" -Dtests.showOutput=onerror 
"-Dargs=-XX:+UseCompressedOops -XX:+UseG1GC" -Dtests.seed=5EBB5B932D563ED6 
-Dtests.slow=true -Dtests.locale=fo -Dtests.timezone=Pacific/Funafuti 
-Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1

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

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

Reply via email to