You are viewing a plain text version of this content. The canonical link for it is here.
Posted to builds@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2020/09/21 04:30:44 UTC

[JENKINS] Lucene-Solr-8.x-Windows (64bit/jdk-15) - Build # 1652 - Still Unstable!

Build: https://jenkins.thetaphi.de/job/Lucene-Solr-8.x-Windows/1652/
Java: 64bit/jdk-15 -XX:+UseCompressedOops -XX:+UseSerialGC

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

Error Message:
Captured an uncaught exception in thread: Thread[id=7790, name=httpShardExecutor-4807-thread-10, state=RUNNABLE, group=TGRP-TestDistributedSearch]

Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=7790, name=httpShardExecutor-4807-thread-10, state=RUNNABLE, group=TGRP-TestDistributedSearch]
Caused by: java.util.concurrent.RejectedExecutionException: Task java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask@51235544[Not completed, task = java.util.concurrent.Executors$RunnableAdapter@5bdb3e34[Wrapped task = org.eclipse.jetty.util.SocketAddressResolver$Async$$Lambda$685/0x00000008011e4450@551ccb3f]] rejected from java.util.concurrent.ScheduledThreadPoolExecutor@35bd1ca5[Terminated, pool size = 0, active threads = 0, queued tasks = 0, completed tasks = 0]
	at __randomizedtesting.SeedInfo.seed([22225CEB145B3733]:0)
	at java.base/java.util.concurrent.ThreadPoolExecutor$AbortPolicy.rejectedExecution(ThreadPoolExecutor.java:2057)
	at java.base/java.util.concurrent.ThreadPoolExecutor.reject(ThreadPoolExecutor.java:827)
	at java.base/java.util.concurrent.ScheduledThreadPoolExecutor.delayedExecute(ScheduledThreadPoolExecutor.java:340)
	at java.base/java.util.concurrent.ScheduledThreadPoolExecutor.schedule(ScheduledThreadPoolExecutor.java:562)
	at org.eclipse.jetty.util.thread.ScheduledExecutorScheduler.schedule(ScheduledExecutorScheduler.java:122)
	at org.eclipse.jetty.util.SocketAddressResolver$Async.lambda$resolve$1(SocketAddressResolver.java:157)
	at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:218)
	at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130)
	at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:630)
	at java.base/java.lang.Thread.run(Thread.java:832)




Build Log:
[...truncated 15075 lines...]
   [junit4] Suite: org.apache.solr.TestDistributedSearch
   [junit4]   2> 756474 INFO  (SUITE-TestDistributedSearch-seed#[22225CEB145B3733]-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> 756474 INFO  (SUITE-TestDistributedSearch-seed#[22225CEB145B3733]-worker) [     ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 756476 INFO  (SUITE-TestDistributedSearch-seed#[22225CEB145B3733]-worker) [     ] o.a.s.SolrTestCaseJ4 Created dataDir: C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J3\temp\solr.TestDistributedSearch_22225CEB145B3733-001\data-dir-84-001
   [junit4]   2> 756476 WARN  (SUITE-TestDistributedSearch-seed#[22225CEB145B3733]-worker) [     ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=1 numCloses=1
   [junit4]   2> 756476 INFO  (SUITE-TestDistributedSearch-seed#[22225CEB145B3733]-worker) [     ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 756478 INFO  (SUITE-TestDistributedSearch-seed#[22225CEB145B3733]-worker) [     ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl="https://issues.apache.org/jira/browse/SOLR-9061")
   [junit4]   2> 756479 INFO  (SUITE-TestDistributedSearch-seed#[22225CEB145B3733]-worker) [     ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /
   [junit4]   2> 757511 INFO  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.a.s.SolrTestCaseJ4 Writing core.properties file to C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J3\temp\solr.TestDistributedSearch_22225CEB145B3733-001\tempDir-001\control\cores\collection1
   [junit4]   2> 757515 WARN  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23
   [junit4]   2> 757515 INFO  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 757515 INFO  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
   [junit4]   2> 757515 INFO  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git: a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 15+36-1562
   [junit4]   2> 757517 INFO  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 757517 INFO  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 757518 INFO  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 757518 INFO  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@a806059{/,null,AVAILABLE}
   [junit4]   2> 757518 INFO  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.e.j.s.AbstractConnector Started ServerConnector@1ab62ccf{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:49324}
   [junit4]   2> 757518 INFO  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.e.j.s.Server Started @774571ms
   [junit4]   2> 757518 INFO  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, hostPort=49324, coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J3\temp\solr.TestDistributedSearch_22225CEB145B3733-001\tempDir-001\control\cores}
   [junit4]   2> 757518 ERROR (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 757518 INFO  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 757518 INFO  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 8.7.0
   [junit4]   2> 757518 INFO  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on port null
   [junit4]   2> 757518 INFO  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr
   [junit4]   2> 757518 INFO  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2020-09-21T03:52:01.152924700Z
   [junit4]   2> 757518 INFO  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J3\temp\solr.TestDistributedSearch_22225CEB145B3733-001\tempDir-001\control\solr.xml
   [junit4]   2> 757526 INFO  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
   [junit4]   2> 757528 INFO  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 757531 INFO  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@6ee39cc7, but no JMX reporters were configured - adding default JMX reporter.
   [junit4]   2> 757677 INFO  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
   [junit4]   2> 757677 WARN  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@5acd3dcc[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 757677 WARN  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@5acd3dcc[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 757683 WARN  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@13478b9b[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 757685 WARN  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@13478b9b[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 757685 WARN  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] 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> 757714 INFO  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
   [junit4]   2> 757714 INFO  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
   [junit4]   2> 757734 INFO  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6ee39cc7
   [junit4]   2> 757743 INFO  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6ee39cc7
   [junit4]   2> 757743 INFO  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6ee39cc7
   [junit4]   2> 757744 INFO  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J3\temp\solr.TestDistributedSearch_22225CEB145B3733-001\tempDir-001\control\cores
   [junit4]   2> 757744 INFO  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 757766 INFO  (coreLoadExecutor-4645-thread-1) [    x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.7.0
   [junit4]   2> 757801 INFO  (coreLoadExecutor-4645-thread-1) [    x:collection1 ] o.a.s.s.IndexSchema Schema name=test
   [junit4]   2> 757886 INFO  (coreLoadExecutor-4645-thread-1) [    x:collection1 ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 757898 INFO  (coreLoadExecutor-4645-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> 757898 INFO  (coreLoadExecutor-4645-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@6ee39cc7
   [junit4]   2> 757898 INFO  (coreLoadExecutor-4645-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\J3\temp\solr.TestDistributedSearch_22225CEB145B3733-001\tempDir-001\control\cores\collection1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J3\temp\solr.TestDistributedSearch_22225CEB145B3733-001\tempDir-001\control\cores\collection1\data\]
   [junit4]   2> 757898 INFO  (coreLoadExecutor-4645-thread-1) [    x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=19, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.4221689560788421]
   [junit4]   2> 757979 INFO  (coreLoadExecutor-4645-thread-1) [    x:collection1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 757979 INFO  (coreLoadExecutor-4645-thread-1) [    x:collection1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 757985 INFO  (coreLoadExecutor-4645-thread-1) [    x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 757985 INFO  (coreLoadExecutor-4645-thread-1) [    x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 757985 INFO  (coreLoadExecutor-4645-thread-1) [    x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=43, maxMergeAtOnceExplicit=11, maxMergedSegmentMB=75.7294921875, floorSegmentMB=0.7724609375, forceMergeDeletesPctAllowed=12.593384380189573, segmentsPerTier=19.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.2094027286267804, deletesPctAllowed=49.86666246813054
   [junit4]   2> 757987 INFO  (coreLoadExecutor-4645-thread-1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 757997 INFO  (coreLoadExecutor-4645-thread-1) [    x:collection1 ] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 758054 INFO  (coreLoadExecutor-4645-thread-1) [    x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 758054 INFO  (coreLoadExecutor-4645-thread-1) [    x:collection1 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1678413997474316288
   [junit4]   2> 758055 INFO  (searcherExecutor-4647-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 758056 INFO  (searcherExecutor-4647-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 758056 INFO  (searcherExecutor-4647-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 758056 INFO  (searcherExecutor-4647-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
   [junit4]   2> 758056 INFO  (searcherExecutor-4647-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 758056 INFO  (searcherExecutor-4647-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 758056 INFO  (searcherExecutor-4647-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 758056 INFO  (searcherExecutor-4647-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 758060 INFO  (searcherExecutor-4647-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 758060 INFO  (searcherExecutor-4647-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 758801 INFO  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.a.s.SolrTestCaseJ4 Writing core.properties file to C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J3\temp\solr.TestDistributedSearch_22225CEB145B3733-001\tempDir-001\shard0\cores\collection1
   [junit4]   2> 758804 WARN  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23
   [junit4]   2> 758804 INFO  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 758804 INFO  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
   [junit4]   2> 758804 INFO  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git: a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 15+36-1562
   [junit4]   2> 758805 INFO  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 758805 INFO  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 758805 INFO  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 758805 INFO  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@4e0be871{/,null,AVAILABLE}
   [junit4]   2> 758807 INFO  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.e.j.s.AbstractConnector Started ServerConnector@709c3aca{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:49368}
   [junit4]   2> 758807 INFO  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.e.j.s.Server Started @775954ms
   [junit4]   2> 758807 INFO  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, hostPort=49368, coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J3\temp\solr.TestDistributedSearch_22225CEB145B3733-001\tempDir-001\shard0\cores}
   [junit4]   2> 758807 ERROR (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 758807 INFO  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 758807 INFO  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 8.7.0
   [junit4]   2> 758807 INFO  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on port null
   [junit4]   2> 758807 INFO  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr
   [junit4]   2> 758807 INFO  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2020-09-21T03:52:02.441219Z
   [junit4]   2> 758807 INFO  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J3\temp\solr.TestDistributedSearch_22225CEB145B3733-001\tempDir-001\shard0\solr.xml
   [junit4]   2> 758808 INFO  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
   [junit4]   2> 758808 INFO  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 758808 INFO  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@6ee39cc7, but no JMX reporters were configured - adding default JMX reporter.
   [junit4]   2> 758896 INFO  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
   [junit4]   2> 758897 WARN  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@c1d3ea8[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 758898 WARN  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@c1d3ea8[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 758901 WARN  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@33cb6647[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 758901 WARN  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@33cb6647[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 758901 WARN  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] 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> 758933 INFO  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
   [junit4]   2> 758933 INFO  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
   [junit4]   2> 758953 INFO  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6ee39cc7
   [junit4]   2> 758961 INFO  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6ee39cc7
   [junit4]   2> 758961 INFO  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6ee39cc7
   [junit4]   2> 758963 INFO  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J3\temp\solr.TestDistributedSearch_22225CEB145B3733-001\tempDir-001\shard0\cores
   [junit4]   2> 758963 INFO  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 758981 INFO  (coreLoadExecutor-4663-thread-1) [    x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.7.0
   [junit4]   2> 759010 INFO  (coreLoadExecutor-4663-thread-1) [    x:collection1 ] o.a.s.s.IndexSchema Schema name=test
   [junit4]   2> 759125 INFO  (coreLoadExecutor-4663-thread-1) [    x:collection1 ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 759139 INFO  (coreLoadExecutor-4663-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> 759139 INFO  (coreLoadExecutor-4663-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@6ee39cc7
   [junit4]   2> 759139 INFO  (coreLoadExecutor-4663-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\J3\temp\solr.TestDistributedSearch_22225CEB145B3733-001\tempDir-001\shard0\cores\collection1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J3\temp\solr.TestDistributedSearch_22225CEB145B3733-001\tempDir-001\shard0\cores\collection1\data\]
   [junit4]   2> 759142 INFO  (coreLoadExecutor-4663-thread-1) [    x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=19, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.4221689560788421]
   [junit4]   2> 759230 INFO  (coreLoadExecutor-4663-thread-1) [    x:collection1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 759232 INFO  (coreLoadExecutor-4663-thread-1) [    x:collection1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 759234 INFO  (coreLoadExecutor-4663-thread-1) [    x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 759234 INFO  (coreLoadExecutor-4663-thread-1) [    x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 759234 INFO  (coreLoadExecutor-4663-thread-1) [    x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=43, maxMergeAtOnceExplicit=11, maxMergedSegmentMB=75.7294921875, floorSegmentMB=0.7724609375, forceMergeDeletesPctAllowed=12.593384380189573, segmentsPerTier=19.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.2094027286267804, deletesPctAllowed=49.86666246813054
   [junit4]   2> 759235 INFO  (coreLoadExecutor-4663-thread-1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 759246 INFO  (coreLoadExecutor-4663-thread-1) [    x:collection1 ] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 759336 INFO  (coreLoadExecutor-4663-thread-1) [    x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 759336 INFO  (coreLoadExecutor-4663-thread-1) [    x:collection1 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1678413998818590720
   [junit4]   2> 759338 INFO  (searcherExecutor-4665-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 759339 INFO  (searcherExecutor-4665-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 759339 INFO  (searcherExecutor-4665-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 759339 INFO  (searcherExecutor-4665-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
   [junit4]   2> 759341 INFO  (TEST-TestDistributedSearch.test-seed#[22225CEB145B3733]) [     ] o.a.s.SolrTestCaseJ4 ###Starting test
   [junit4]   2> 759343 INFO  (searcherExecutor-4665-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 759343 INFO  (searcherExecutor-4665-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 759343 INFO  (qtp1291891511-7467) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{deleteByQuery=*:* (-1678413998825930752)} 0 1
   [junit4]   2> 759343 INFO  (searcherExecutor-4665-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 759346 INFO  (searcherExecutor-4665-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 759346 INFO  (searcherExecutor-4665-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 759366 INFO  (searcherExecutor-4665-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 759368 INFO  (qtp67232980-7488) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{deleteByQuery=*:* (-1678413998830125056)} 0 23
   [junit4]   2> 759372 INFO  (qtp1291891511-7468) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[1 (1678413998852145152)]} 0 2
   [junit4]   2> 759375 INFO  (qtp67232980-7490) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[1 (1678413998859485184)]} 0 1
   [junit4]   2> 759384 INFO  (qtp1291891511-7468) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[2 (1678413998867873792)]} 0 1
   [junit4]   2> 759386 INFO  (qtp67232980-7489) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[2 (1678413998868922368)]} 0 1
   [junit4]   2> 759386 INFO  (qtp1291891511-7469) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[3 (1678413998871019520)]} 0 0
   [junit4]   2> 759390 INFO  (qtp67232980-7487) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[3 (1678413998875213824)]} 0 1
   [junit4]   2> 759392 INFO  (qtp1291891511-7466) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[4 (1678413998877310976)]} 0 0
   [junit4]   2> 759394 INFO  (qtp67232980-7488) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[4 (1678413998877310976)]} 0 1
   [junit4]   2> 759398 INFO  (qtp1291891511-7467) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[5 (1678413998882553856)]} 0 3
   [junit4]   2> 759403 INFO  (qtp67232980-7490) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[5 (1678413998888845312)]} 0 1
   [junit4]   2> 759405 INFO  (qtp1291891511-7468) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[6 (1678413998890942464)]} 0 0
   [junit4]   2> 759405 INFO  (qtp67232980-7489) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[6 (1678413998890942464)]} 0 0
   [junit4]   2> 759411 INFO  (qtp1291891511-7469) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[7 (1678413998897233920)]} 0 0
   [junit4]   2> 759412 INFO  (qtp67232980-7487) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[7 (1678413998898282496)]} 0 0
   [junit4]   2> 759413 INFO  (qtp1291891511-7466) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[8 (1678413998899331072)]} 0 0
   [junit4]   2> 759415 INFO  (qtp67232980-7488) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[8 (1678413998900379648)]} 0 0
   [junit4]   2> 759415 INFO  (qtp1291891511-7467) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[9 (1678413998901428224)]} 0 0
   [junit4]   2> 759416 INFO  (qtp67232980-7490) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[9 (1678413998902476800)]} 0 0
   [junit4]   2> 759456 INFO  (searcherExecutor-4647-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 759460 INFO  (qtp1291891511-7468) [    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 46
   [junit4]   2> 759476 INFO  (searcherExecutor-4665-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 759479 INFO  (qtp67232980-7489) [    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 15
   [junit4]   2> 759482 INFO  (qtp1291891511-7469) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[10 (1678413998969585664)]} 0 3
   [junit4]   2> 759486 INFO  (qtp67232980-7487) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[10 (1678413998975877120)]} 0 2
   [junit4]   2> 759489 INFO  (qtp1291891511-7466) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[11 (1678413998975877120)]} 0 0
   [junit4]   2> 759489 INFO  (qtp67232980-7488) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[11 (1678413998979022848)]} 0 0
   [junit4]   2> 759497 INFO  (qtp1291891511-7467) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[12 (1678413998983217152)]} 0 3
   [junit4]   2> 759501 INFO  (qtp67232980-7490) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[12 (1678413998989508608)]} 0 1
   [junit4]   2> 759502 INFO  (qtp1291891511-7468) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[13 (1678413998992654336)]} 0 0
   [junit4]   2> 759506 INFO  (qtp67232980-7489) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[13 (1678413998994751488)]} 0 0
   [junit4]   2> 759508 INFO  (qtp1291891511-7469) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[1001 (1678413998998945792)]} 0 1
   [junit4]   2> 759509 INFO  (qtp67232980-7487) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[1001 (1678413998999994368)]} 0 0
   [junit4]   2> 759509 INFO  (qtp1291891511-7466) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[14 (1678413998999994368)]} 0 0
   [junit4]   2> 759512 INFO  (qtp67232980-7488) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[14 (1678413998999994369)]} 0 0
   [junit4]   2> 759512 INFO  (qtp1291891511-7467) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[15 (1678413999003140096)]} 0 0
   [junit4]   2> 759512 INFO  (qtp67232980-7490) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[15 (1678413999003140096)]} 0 0
   [junit4]   2> 759512 INFO  (qtp1291891511-7468) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[16 (1678413999003140097)]} 0 0
   [junit4]   2> 759515 INFO  (qtp67232980-7489) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[16 (1678413999006285824)]} 0 0
   [junit4]   2> 759515 INFO  (qtp1291891511-7469) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[17 (1678413999006285824)]} 0 0
   [junit4]   2> 759517 INFO  (qtp67232980-7487) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[17 (1678413999007334400)]} 0 0
   [junit4]   2> 759517 INFO  (qtp1291891511-7466) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[100 (1678413999008382976)]} 0 0
   [junit4]   2> 759518 INFO  (qtp67232980-7488) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[100 (1678413999009431552)]} 0 0
   [junit4]   2> 759520 INFO  (qtp1291891511-7467) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[101 (1678413999010480128)]} 0 0
   [junit4]   2> 759520 INFO  (qtp67232980-7490) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[101 (1678413999011528704)]} 0 0
   [junit4]   2> 759520 INFO  (qtp1291891511-7468) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[102 (1678413999011528704)]} 0 0
   [junit4]   2> 759520 INFO  (qtp67232980-7489) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[102 (1678413999011528705)]} 0 0
   [junit4]   2> 759521 INFO  (qtp1291891511-7469) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[103 (1678413999012577280)]} 0 0
   [junit4]   2> 759522 INFO  (qtp67232980-7487) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[103 (1678413999013625856)]} 0 0
   [junit4]   2> 759523 INFO  (qtp1291891511-7466) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[104 (1678413999013625856)]} 0 0
   [junit4]   2> 759523 INFO  (qtp67232980-7488) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[104 (1678413999014674432)]} 0 0
   [junit4]   2> 759523 INFO  (qtp1291891511-7467) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[105 (1678413999014674432)]} 0 0
   [junit4]   2> 759523 INFO  (qtp67232980-7490) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[105 (1678413999014674433)]} 0 0
   [junit4]   2> 759526 INFO  (qtp1291891511-7468) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[106 (1678413999017820160)]} 0 0
   [junit4]   2> 759526 INFO  (qtp67232980-7489) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[106 (1678413999017820160)]} 0 0
   [junit4]   2> 759527 INFO  (qtp1291891511-7469) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[107 (1678413999018868736)]} 0 0
   [junit4]   2> 759528 INFO  (qtp67232980-7487) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[107 (1678413999019917312)]} 0 0
   [junit4]   2> 759528 INFO  (qtp1291891511-7466) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[108 (1678413999019917312)]} 0 0
   [junit4]   2> 759530 INFO  (qtp67232980-7488) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[108 (1678413999020965888)]} 0 0
   [junit4]   2> 759531 INFO  (qtp1291891511-7467) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[109 (1678413999023063040)]} 0 0
   [junit4]   2> 759531 INFO  (qtp67232980-7490) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[109 (1678413999023063040)]} 0 0
   [junit4]   2> 759534 INFO  (qtp1291891511-7468) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[110 (1678413999023063041)]} 0 4
   [junit4]   2> 759538 INFO  (qtp67232980-7489) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[110 (1678413999029354496)]} 0 0
   [junit4]   2> 759538 INFO  (qtp1291891511-7469) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[111 (1678413999030403072)]} 0 0
   [junit4]   2> 759540 INFO  (qtp67232980-7487) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[111 (1678413999032500224)]} 0 0
   [junit4]   2> 759542 INFO  (qtp1291891511-7466) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[112 (1678413999034597376)]} 0 0
   [junit4]   2> 759543 INFO  (qtp67232980-7488) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[112 (1678413999035645952)]} 0 0
   [junit4]   2> 759544 INFO  (qtp1291891511-7467) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[113 (1678413999036694528)]} 0 0
   [junit4]   2> 759545 INFO  (qtp67232980-7490) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[113 (1678413999037743104)]} 0 0
   [junit4]   2> 759548 INFO  (qtp1291891511-7468) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[114 (1678413999039840256)]} 0 0
   [junit4]   2> 759548 INFO  (qtp67232980-7489) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[114 (1678413999040888832)]} 0 0
   [junit4]   2> 759549 INFO  (qtp1291891511-7469) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[115 (1678413999041937408)]} 0 0
   [junit4]   2> 759550 INFO  (qtp67232980-7487) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[115 (1678413999042985984)]} 0 0
   [junit4]   2> 759552 INFO  (qtp1291891511-7466) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[116 (1678413999044034560)]} 0 0
   [junit4]   2> 759553 INFO  (qtp67232980-7488) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[116 (1678413999046131712)]} 0 0
   [junit4]   2> 759555 INFO  (qtp1291891511-7467) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[117 (1678413999047180288)]} 0 0
   [junit4]   2> 759557 INFO  (qtp67232980-7490) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[117 (1678413999049277440)]} 0 0
   [junit4]   2> 759558 INFO  (qtp1291891511-7468) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[118 (1678413999050326016)]} 0 0
   [junit4]   2> 759559 INFO  (qtp67232980-7489) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[118 (1678413999051374592)]} 0 0
   [junit4]   2> 759559 INFO  (qtp1291891511-7469) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[119 (1678413999052423168)]} 0 0
   [junit4]   2> 759559 INFO  (qtp67232980-7487) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[119 (1678413999052423168)]} 0 0
   [junit4]   2> 759559 INFO  (qtp1291891511-7466) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[120 (1678413999052423169)]} 0 0
   [junit4]   2> 759559 INFO  (qtp67232980-7488) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[120 (1678413999052423169)]} 0 0
   [junit4]   2> 759567 INFO  (qtp1291891511-7467) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[121 (1678413999059763200)]} 0 0
   [junit4]   2> 759567 INFO  (qtp67232980-7490) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[121 (1678413999060811776)]} 0 0
   [junit4]   2> 759568 INFO  (qtp1291891511-7468) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[122 (1678413999061860352)]} 0 0
   [junit4]   2> 759569 INFO  (qtp67232980-7489) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[122 (1678413999062908928)]} 0 0
   [junit4]   2> 759570 INFO  (qtp1291891511-7469) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[123 (1678413999063957504)]} 0 0
   [junit4]   2> 759571 INFO  (qtp67232980-7487) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[123 (1678413999065006080)]} 0 0
   [junit4]   2> 759571 INFO  (qtp1291891511-7466) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[124 (1678413999065006080)]} 0 0
   [junit4]   2> 759571 INFO  (qtp67232980-7488) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[124 (1678413999065006081)]} 0 0
   [junit4]   2> 759571 INFO  (qtp1291891511-7467) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[125 (1678413999065006081)]} 0 0
   [junit4]   2> 759573 INFO  (qtp67232980-7490) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[125 (1678413999065006082)]} 0 0
   [junit4]   2> 759573 INFO  (qtp1291891511-7468) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[126 (1678413999067103232)]} 0 0
   [junit4]   2> 759574 INFO  (qtp67232980-7489) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[126 (1678413999068151808)]} 0 0
   [junit4]   2> 759574 INFO  (qtp1291891511-7469) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[127 (1678413999068151808)]} 0 0
   [junit4]   2> 759578 INFO  (qtp67232980-7487) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[127 (1678413999072346112)]} 0 0
   [junit4]   2> 759578 INFO  (qtp1291891511-7466) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[128 (1678413999072346112)]} 0 0
   [junit4]   2> 759580 INFO  (qtp67232980-7488) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[128 (1678413999074443264)]} 0 0
   [junit4]   2> 759580 INFO  (qtp1291891511-7467) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[129 (1678413999074443264)]} 0 0
   [junit4]   2> 759580 INFO  (qtp67232980-7490) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[129 (1678413999074443265)]} 0 0
   [junit4]   2> 759582 INFO  (qtp1291891511-7468) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[130 (1678413999076540416)]} 0 0
   [junit4]   2> 759582 INFO  (qtp67232980-7489) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[130 (1678413999076540416)]} 0 0
   [junit4]   2> 759584 INFO  (qtp1291891511-7469) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[131 (1678413999078637568)]} 0 0
   [junit4]   2> 759584 INFO  (qtp67232980-7487) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[131 (1678413999078637568)]} 0 0
   [junit4]   2> 759585 INFO  (qtp1291891511-7466) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[132 (1678413999079686144)]} 0 0
   [junit4]   2> 759586 INFO  (qtp67232980-7488) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[132 (1678413999079686144)]} 0 0
   [junit4]   2> 759586 INFO  (qtp1291891511-7467) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[133 (1678413999080734720)]} 0 0
   [junit4]   2> 759586 INFO  (qtp67232980-7490) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[133 (1678413999080734720)]} 0 0
   [junit4]   2> 759588 INFO  (qtp1291891511-7468) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[134 (1678413999082831872)]} 0 0
   [junit4]   2> 759589 INFO  (qtp67232980-7489) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[134 (1678413999083880448)]} 0 0
   [junit4]   2> 759591 INFO  (qtp1291891511-7469) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[135 (1678413999085977600)]} 0 0
   [junit4]   2> 759591 INFO  (qtp67232980-7487) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[135 (1678413999085977600)]} 0 0
   [junit4]   2> 759593 INFO  (qtp1291891511-7466) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[136 (1678413999088074752)]} 0 2
   [junit4]   2> 759597 INFO  (qtp67232980-7488) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[136 (1678413999091220480)]} 0 0
   [junit4]   2> 759597 INFO  (qtp1291891511-7467) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[137 (1678413999092269056)]} 0 0
   [junit4]   2> 759599 INFO  (qtp67232980-7490) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[137 (1678413999092269056)]} 0 0
   [junit4]   2> 759599 INFO  (qtp1291891511-7468) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[138 (1678413999094366208)]} 0 0
   [junit4]   2> 759600 INFO  (qtp67232980-7489) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[138 (1678413999095414784)]} 0 0
   [junit4]   2> 759601 INFO  (qtp1291891511-7469) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[139 (1678413999096463360)]} 0 0
   [junit4]   2> 759602 INFO  (qtp67232980-7487) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[139 (1678413999097511936)]} 0 0
   [junit4]   2> 759602 INFO  (qtp1291891511-7466) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[140 (1678413999097511936)]} 0 0
   [junit4]   2> 759604 INFO  (qtp67232980-7488) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[140 (1678413999099609088)]} 0 0
   [junit4]   2> 759604 INFO  (qtp1291891511-7467) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[141 (1678413999099609088)]} 0 0
   [junit4]   2> 759604 INFO  (qtp67232980-7490) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[141 (1678413999099609089)]} 0 0
   [junit4]   2> 759604 INFO  (qtp1291891511-7468) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[142 (1678413999099609089)]} 0 0
   [junit4]   2> 759606 INFO  (qtp67232980-7489) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[142 (1678413999101706240)]} 0 0
   [junit4]   2> 759606 INFO  (qtp1291891511-7469) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[143 (1678413999101706240)]} 0 0
   [junit4]   2> 759607 INFO  (qtp67232980-7487) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[143 (1678413999101706241)]} 0 0
   [junit4]   2> 759607 INFO  (qtp1291891511-7466) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[144 (1678413999102754816)]} 0 0
   [junit4]   2> 759607 INFO  (qtp67232980-7488) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[144 (1678413999102754816)]} 0 0
   [junit4]   2> 759608 INFO  (qtp1291891511-7467) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[145 (1678413999103803392)]} 0 0
   [junit4]   2> 759609 INFO  (qtp67232980-7490) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[145 (1678413999103803392)]} 0 0
   [junit4]   2> 759610 INFO  (qtp1291891511-7468) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[146 (1678413999105900544)]} 0 0
   [junit4]   2> 759610 INFO  (qtp67232980-7489) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[146 (1678413999105900544)]} 0 0
   [junit4]   2> 759611 INFO  (qtp1291891511-7469) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[147 (1678413999106949120)]} 0 0
   [junit4]   2> 759611 INFO  (qtp67232980-7487) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[147 (1678413999106949120)]} 0 0
   [junit4]   2> 759612 INFO  (qtp1291891511-7466) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[148 (1678413999106949121)]} 0 0
   [junit4]   2> 759612 INFO  (qtp67232980-7488) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[148 (1678413999107997696)]} 0 0
   [junit4]   2> 759614 INFO  (qtp1291891511-7467) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[149 (1678413999109046272)]} 0 0
   [junit4]   2> 759615 INFO  (qtp67232980-7490) [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[149 (1678413999111143424)]} 0 0
   [junit4]   2> 759630 INFO  (searcherExecutor-4647-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 759630 INFO  (qtp1291891511-7468) [    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 16
   [junit4]   2> 759639 INFO  (searcherExecutor-4665-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 759640 INFO  (qtp67232980-7489) [    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 9
   [junit4]   2> 759640 ERROR (qtp1291891511-7469) [    x:collection1 ] o.a.s.h.RequestHandlerBase org.apache.solr.common.SolrException: For input string: "non_numeric_value"
   [junit4]   2> 	at org.apache.solr.common.params.SolrParams.getInt(SolrParams.java:236)
   [junit4]   2> 	at org.apache.solr.search.QParser.getSortSpec(QParser.java:271)
   [junit4]   2> 	at org.apache.solr.handler.component.QueryComponent.prepare(QueryComponent.java:189)
   [junit4]   2> 	at org.apache.solr.handler.component.SearchHandler.handleRequestBody(SearchHandler.java:309)
   [junit4]   2> 	at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:214)
   [junit4]   2> 	at org.apache.solr.core.SolrCore.execute(SolrCore.java:2612)
   [junit4]   2> 	at org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:812)
   [junit4]   2> 	at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:588)
   [junit4]   2> 	at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:415)
   [junit4]   2> 	at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:345)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1604)
   [junit4]   2> 	at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:166)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1604)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:545)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:233)
   [junit4]   2> 	at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:1610)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:233)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1300)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:188)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:485)
   [junit4]   2> 	at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:1580)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:186)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1215)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127)
   [junit4]   2> 	at org.eclipse.jetty.rewrite.handler.RewriteHandler.handle(RewriteHandler.java:322)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:767)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127)
   [junit4]   2> 	at org.eclipse.jetty.server.Server.handle(Server.java:500)
   [junit4]   2> 	at org.eclipse.jetty.server.HttpChannel.lambda$handle$1(HttpChannel.java:383)
   [junit4]   2> 	at org.eclipse.jetty.server.HttpChannel.dispatch(HttpChannel.java:547)
   [junit4]   2> 	at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:375)
   [junit4]   2> 	at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:273)
   [junit4]   2> 	at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:311)
   [junit4]   2> 	at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:103)
   [junit4]   2> 	at org.eclipse.jetty.io.ChannelEndPoint$2.run(ChannelEndPoint.java:117)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:806)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:938)
   [junit4]   2> 	at java.base/java.lang.Thread.run(Thread.java:832)
   [junit4]   2> Caused by: java.lang.NumberFormatException: For input string: "non_numeric_value"
   [junit4]   2> 	at java.base/java.lang.NumberFormatException.forInputString(NumberFormatException.java:68)
   [junit4]   2> 	at java.base/java.lang.Integer.parseInt(Integer.java:652)
   [junit4]   2> 	at java.base/java.lang.Integer.valueOf(Integer.java:983)
   [junit4]   2> 	at org.apache.solr.common.params.SolrParams.getInt(SolrParams.java:233)
   [junit4]   2> 	... 38 more
   [junit4]   2> 
   [junit4]   2> 759640 INFO  (qtp1291891511-7469) [    x:collection1 ] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*&distrib=false&start=non_numeric_value&wt=javabin&version=2} status=400 QTime=0
   [junit4]   2> 759640 INFO  (qtp1291891511-7469) [    x:collection1 ] o.a.s.h.RequestHandlerBase Ignoring exception matching parameter cannot be negative
   [junit4]   2> 759640 INFO  (qtp1291891511-7469) [    x:collection1 ] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*&distrib=false&start=-1&wt=javabin&version=2} status=400 QTime=0
   [junit4]   2> 759640 INFO  (qtp1291891511-7469) [    x:collection1 ] o.a.s.h.RequestHandlerBase Ignoring exception matching parameter cannot be negative
   [junit4]   2> 759640 INFO  (qtp1291891511-7469) [    x:collection1 ] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*&distrib=false&start=0&rows=-1&wt=javabin&version=2} status=400 QTime=0
   [junit4]   2> 759644 ERROR (qtp1291891511-7469) [    x:collection1 ] o.a.s.h.RequestHandlerBase org.apache.solr.common.SolrException: For input string: "non_numeric_value"
   [junit4]   2> 	at org.apache.solr.common.params.SolrParams.getInt(SolrParams.java:236)
   [junit4]   2> 	at org.apache.solr.search.QParser.getSortSpec(QParser.java:274)
   [junit4]   2> 	at org.apache.solr.handler.component.QueryComponent.prepare(QueryComponent.java:189)
   [junit4]   2> 	at org.apache.solr.handler.component.SearchHandler.handleRequestBody(SearchHandler.java:309)
   [junit4]   2> 	at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:214)
   [junit4]   2> 	at org.apache.solr.core.SolrCore.execute(SolrCore.java:2612)
   [junit4]   2> 	at org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:812)
   [junit4]   2> 	at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:588)
   [junit4]   2> 	at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:415)
   [junit4]   2> 	at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:345)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1604)
   [junit4]   2> 	at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:166)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1604)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:545)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:233)
   [junit4]   2> 	at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:1610)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:233)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1300)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:188)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:485)
   [junit4]   2> 	at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:1580)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:186)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1215)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127)
   [junit4]   2> 	at org.eclipse.jetty.rewrite.handler.RewriteHandler.handle(RewriteHandler.java:322)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:767)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127)
   [junit4]   2> 	at org.eclipse.jetty.server.Server.handle(Server.java:500)
   [junit4]   2> 	at org.eclipse.jetty.server.HttpChannel.lambda$handle$1(HttpChannel.java:383)
   [junit4]   2> 	at org.eclipse.jetty.server.HttpChannel.dispatch(HttpChannel.java:547)
   [junit4]   2> 	at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:375)
   [junit4]   2> 	at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:273)
   [junit4]   2> 	at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:311)
   [junit4]   2> 	at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:103)
   [junit4]   2> 	at org.eclipse.jetty.io.ChannelEndPoint$2.run(ChannelEndPoint.java:117)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:806)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:938)
   [junit4]   2> 	at java.base/java.lang.Thread.run(Thread.java:832)
   [junit4]   2> Caused by: java.lang.NumberFormatException: For input string: "non_numeric_value"
   [junit4]   2> 	at java.base/java.lang.NumberFormatException.forInputString(NumberFormatException.java:68)
   [junit4]   2> 	at java.base/java.lang.Integer.parseInt(Integer.java:652)
   [junit4]   2> 	at java.base/java.lang.Integer.valueOf(Integer.java:983)
   [junit4]   2> 	at org.apache.solr.common.params.SolrParams.getInt(SolrParams.java:233)
   [junit4]   2> 	... 38 more
   [junit4]   2> 
   [junit4]   2> 759644 INFO  (qtp1291891511-7469) [    x:collection1 ] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*&distrib=false&rows=non_numeric_value&wt=javabin&version=2} status=400 QTime=0
   [junit4]   2> 759645 INFO  (qtp1291891511-7469) [    x:collection1 ] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&sort=n_ti1+desc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 759652 INFO  (qtp67232980-7490) [    x:collection1 ] o.a.s.c.S.Request [collection1]  webapp= path=/select params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_ti1+desc&shard.url=http://127.0.0.1:49368/collection1&rid=127.0.0.1-29744&rows=10&version=2&q=*:*&omitHeader=false&NOW=1600660323279&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 759654 INFO  (qtp67232980-7488) [    x:collection1 ] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&df=text&distrib=false&omitHeader=false&shards.purpose=64&NOW=1600660323279&ids=12,113,146,103,114,138,7,139,107,120&isShard=true&shard.url=http://127.0.0.1:49368/collection1&rid=127.0.0.1-29744&wt=javabin&version=2} status=0 QTime=1
   [junit4]   2> 759658 INFO  (qtp67232980-7487) [    x:collection1 ] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&shards=http://127.0.0.1:49368/collection1&sort=n_ti1+desc&wt=javabin&version=2} rid=127.0.0.1-29744 hits=68 status=0 QTime=13
   [junit4]   2> 759661 INFO  (qtp1291891511-7466) [    x:collection1 ] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&sort=n_ti1+asc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 759668 INFO  (qtp67232980-7490) [    x:collection1 ] o.a.s.c.S.Request [collection1]  webapp= path=/select params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_ti1+asc&shard.url=http://127.0.0.1:49368/collection1|[::1]:8/&rid=127.0.0.1-29746&rows=10&version=2&q=*:*&omitHeader=false&NOW=1600660323300&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 759671 INFO  (qtp67232980-7488) [    x:collection1 ] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&df=text&distrib=false&omitHeader=false&shards.purpose=64&NOW=1600660323300&ids=143,111,1,13,14,125,16,148,1001,142&isShard=true&shard.url=http://127.0.0.1:49368/collection1|[::1]:8/&rid=127.0.0.1-29746&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 759672 INFO  (qtp67232980-7489) [    x:collection1 ] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&shards=http://127.0.0.1:49368/collection1|[::1]:8/&sort=n_ti1+asc&wt=javabin&version=2} rid=127.0.0.1-29746 hits=68 status=0 QTime=6
   [junit4]   2> 759674 INFO  (qtp1291891511-7467) [    x:collection1 ] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&sort=n_f1+desc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 763337 INFO  (qtp67232980-7490) [    x:collection1 ] o.a.s.c.S.Request [collection1]  webapp= path=/select params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_f1+desc&shard.url=[::1]:4/|[::1]:6/|http://127.0.0.1:49368/collection1|[::1]:8/&rid=127.0.0.1-29748&rows=10&version=2&q=*:*&omitHeader=false&NOW=1600660323310&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 763339 INFO  (qtp67232980-7488) [    x:collection1 ] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&df=text&distrib=false&omitHeader=false&shards.purpose=64&NOW=1600660323310&ids=132,111,100,133,104,5,105,128,1001,142&isShard=true&shard.url=[::1]:4/|[::1]:6/|http://127.0.0.1:49368/collection1|[::1]:8/&rid=127.0.0.1-29748&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 763339 INFO  (qtp67232980-7487) [    x:collection1 ] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&shards=[::1]:4/|[::1]:6/|http://127.0.0.1:49368/collection1|[::1]:8/&sort=n_f1+desc&wt=javabin&version=2} rid=127.0.0.1-29748 hits=68 status=0 QTime=4069
   [junit4]   2> 763339 WARN  (qtp67232980-7487) [    x:collection1 ] o.a.s.c.S.SlowRequest slow: [collection1]  webapp= path=/select params={q=*:*&shards=[::1]:4/|[::1]:6/|http://127.0.0.1:49368/collection1|[::1]:8/&sort=n_f1+desc&wt=javabin&version=2} rid=127.0.0.1-29748 hits=68 status=0 QTime=4069
   [junit4]   2> 763341 INFO  (qtp1291891511-7468) [    x:collection1 ] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&sort=n_f1+asc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 765191 INFO  (qtp67232980-7490) [    x:collection1 ] o.a.s.c.S.Request [collection1]  webapp= path=/select params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_f1+asc&shard.url=[::1]:4/|[::1]:8/|http://127.0.0.1:49368/collection1&rid=127.0.0.1-29750&rows=10&version=2&q=*:*&omitHeader=false&NOW=1600660326977&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 765192 INFO  (qtp67232980-7488) [    x:collection1 ] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&df=text&distrib=false&omitHeader=false&shards.purpose=64&NOW=1600660326977&ids=122,134,124,114,103,148,115,106,141,131&isShard=true&shard.url=[::1]:4/|[::1]:8/|http://127.0.0.1:49368/collection1&rid=127.0.0.1-29750&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 765193 INFO  (qtp67232980-7489) [    x:collection1 ] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&shards=[::1]:4/|[::1]:8/|http://127.0.0.1:49368/collection1&sort=n_f1+asc&wt=javabin&version=2} rid=127.0.0.1-29750 hits=68 status=0 QTime=2056
   [junit4]   2> 765193 WARN  (qtp67232980-7489) [    x:collection1 ] o.a.s.c.S.SlowRequest slow: [collection1]  webapp= path=/select params={q=*:*&shards=[::1]:4/|[::1]:8/|http://127.0.0.1:49368/collection1&sort=n_f1+asc&wt=javabin&version=2} rid=127.0.0.1-29750 hits=68 status=0 QTime=2056
   [junit4]   2> 765195 INFO  (qtp1291891511-7469) [    x:collection1 ] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&sort=n_tf1+desc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 765197 INFO  (qtp67232980-7490) [    x:collection1 ] o.a.s.c.S.Request [collection1]  webapp= path=/select params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_tf1+desc&shard.url=[::1]:6/|[::1]:8/|[::1]:4/|http://127.0.0.1:49368/collection1&rid=127.0.0.1-29752&rows=10&version=2&q=*:*&omitHeader=false&NOW=1600660328830&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 765199 INFO  (qtp67232980-7488) [    x:collection1 ] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&df=text&distrib=false&omitHeader=false&shards.purpose=64&NOW=1600660328830&ids=132,11,111,1,123,113,139,128,8,9&isShard=true&shard.url=[::1]:6/|[::1]:8/|[::1]:4/|http://127.0.0.1:49368/collection1&rid=127.0.0.1-29752&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 765199 INFO  (qtp67232980-7487) [    x:collection1 ] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&shards=[::1]:6/|[::1]:8/|[::1]:4/|http://127.0.0.1:49368/collection1&sort=n_tf1+desc&wt=javabin&version=2} rid=127.0.0.1-29752 hits=68 status=0 QTime=3
   [junit4]   2> 765200 INFO  (qtp1291891511-7466) [    x:collection1 ] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&sort=n_tf1+asc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 765202 INFO  (qtp67232980-7490) [    x:collection1 ] o.a.s.c.S.Request [collection1]  webapp= path=/select params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_tf1+asc&shard.url=http://127.0.0.1:49368/collection1|[::1]:4/|[::1]:6/|[::1]:8/&rid=127.0.0.1-29754&rows=10&version=2&q=*:*&omitHeader=false&NOW=1600660328835&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 765203 INFO  (qtp67232980-7488) [    x:collection1 ] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&df=text&distrib=false&omitHeader=false&shards.purpose=64&NOW=1600660328835&ids=100,2,124,136,147,125,1001,7,108,120&isShard=true&shard.url=http://127.0.0.1:49368/collection1|[::1]:4/|[::1]:6/|[::1]:8/&rid=127.0.0.1-29754&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 765204 INFO  (qtp67232980-7489) [    x:collection1 ] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&shards=http://127.0.0.1:49368/collection1|[::1]:4/|[::1]:6/|[::1]:8/&sort=n_tf1+asc&wt=javabin&version=2} rid=127.0.0.1-29754 hits=68 status=0 QTime=2
   [junit4]   2> 765204 INFO  (qtp1291891511-7467) [    x:collection1 ] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&sort=n_d1+desc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 765206 INFO  (qtp67232980-7490) [    x:collection1 ] o.a.s.c.S.Request [collection1]  webapp= path=/select params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_d1+desc&shard.url=http://127.0.0.1:49368/collection1|[::1]:8/&rid=127.0.0.1-29756&rows=10&version=2&q=*:*&omitHeader=false&NOW=1600660328839&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 765207 INFO  (qtp67232980-7488) [    x:collection1 ] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&df=text&distrib=false&omitHeader=false&shards.purpose=64&NOW=1600660328839&ids=121,100,134,13,102,5,116,106,8,119&isShard=true&shard.url=http://127.0.0.1:49368/collection1|[::1]:8/&rid=127.0.0.1-29756&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 765207 INFO  (qtp67232980-7487) [    x:collection1 ] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&shards=http://127.0.0.1:49368/collection1|[::1]:8/&sort=n_d1+desc&wt=javabin&version=2} rid=127.0.0.1-29756 hits=68 status=0 QTime=2
   [junit4]   2> 765207 INFO  (qtp1291891511-7468) [    x:collection1 ] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&sort=n_d1+asc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 765207 INFO  (qtp67232980-7490) [    x:collection1 ] o.a.s.c.S.Request [collection1]  webapp= path=/select params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_d1+asc&shard.url=http://127.0.0.1:49368/collection1&rid=127.0.0.1-29758&rows=10&version=2&q=*:*&omitHeader=false&NOW=1600660328841&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 765211 INFO  (qtp67232980-7488) [    x:collection1 ] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&df=text&distrib=false&omitHeader=false&shards.purpose=64&NOW=1600660328841&ids=143,12,2,124,4,117,139,141,130,131&isShard=true&shard.url=http://127.0.0.1:49368/collection1&rid=127.0.0.1-29758&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 765211 INFO  (qtp67232980-7489) [    x:collection1 ] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&shards=http://127.0.0.1:49368/collection1&sort=n_d1+asc&wt=javabin&version=2} rid=127.0.0.1-29758 hits=68 status=0 QTime=2
   [junit4]   2> 765214 INFO  (qtp1291891511-7469) [    x:collection1 ] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&sort=n_td1+desc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 765215 INFO  (qtp67232980-7490) [    x:collection1 ] o.a.s.c.S.Request [collection1]  webapp= path=/select params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_td1+desc&shard.url=http://127.0.0.1:49368/collection1&rid=127.0.0.1-29760&rows=10&version=2&q=*:*&omitHeader=false&NOW=1600660328848&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 765215 INFO  (qtp67232980-7488) [    x:collection1 ] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&df=text&distrib=false&omitHeader=false&shards.purpose=64&NOW=1600660328848&ids=143,1,123,147,127,6,117,7,118,142&isShard=true&shard.url=http://127.0.0.1:49368/collection1&rid=127.0.0.1-29760&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 765215 INFO  (qtp67232980-7487) [    x:collection1 ] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&shards=http://127.0.0.1:49368/collection1&sort=n_td1+desc&wt=javabin&version=2} rid=127.0.0.1-29760 hits=68 status=0 QTime=2
   [junit4]   2> 765218 INFO  (qtp1291891511-7466) [    x:collection1 ] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&sort=n_td1+asc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 765218 INFO  (qtp67232980-7490) [    x:collection1 ] o.a.s.c.S.Request [collection1]  webapp= path=/select params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_td1+asc&shard.url=http://127.0.0.1:49368/collection1|[::1]:6/|[::1]:4/|[::1]:8/&rid=127.0.0.1-29762&rows=10&version=2&q=*:*&omitHeader=false&NOW=1600660328852&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 765218 INFO  (qtp67232980-7488) [    x:collection1 ] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&df=text&distrib=false&omitHeader=false&shards.purpose=64&NOW=1600660328852&ids=144,13,146,125,5,116,138,8,141,10&isShard=true&shard.url=http://127.0.0.1:49368/collection1|[::1]:6/|[::1]:4/|[::1]:8/&rid=127.0.0.1-29762&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 765218 INFO  (qtp67232980-7489) [    x:collection1 ] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&shards=http://127.0.0.1:49368/collection1|[::1]:6/|[::1]:4/|[::1]:8/&sort=n_td1+asc&wt=javabin&version=2} rid=127.0.0.1-29762 hits=68 status=0 QTime=3
   [junit4]   2> 765223 INFO  (qtp1291891511-7467) [    x:collection1 ] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&sort=n_l1+desc&wt=javabin&version=2} hits=68 status=0 QTime=1
   [junit4]   2> 765225 INFO  (qtp67232980-7490) [    x:collection1 ] o.a.s.c.S.Request [collection1]  webapp= path=/select params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_l1+desc&shard.url=[::1]:4/|[::1]:8/|http://127.0.0.1:49368/collection1|[::1]:6/&rid=127.0.0.1-29764&rows=10&version=2&q=*:*&omitHeader=false&NOW=1600660328857&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 765226 INFO  (qtp67232980-7488) [    x:collection1 ] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&df=text&distrib=false&omitHeader=false&shards.purpose=64&NOW=1600660328857&ids=133,122,144,2,124,125,116,139,142,10&isShard=true&shard.url=[::1]:4/|[::1]:8/|http://127.0.0.1:49368/collection1|[::1]:6/&rid=127.0.0.1-29764&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 765226 INFO  (qtp67232980-7487) [    x:collection1 ] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&shards=[::1]:4/|[::1]:8/|http://127.0.0.1:49368/collection1|[::1]:6/&sort=n_l1+desc&wt=javabin&version=2} rid=127.0.0.1-29764 hits=68 status=0 QTime=3
   [junit4]   2> 765227 INFO  (qtp1291891511-7468) [    x:collection1 ] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&sort=n_l1+asc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 765228 INFO  (qtp67232980-7490) [    x:collection1 ] o.a.s.c.S.Request [collection1]  webapp= path=/select params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_l1+asc&shard.url=http://127.0.0.1:49368/collection1|[::1]:4/|[::1]:6/&rid=127.0.0.1-29766&rows=10&version=2&q=*:*&omitHeader=false&NOW=1600660328861&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 765229 INFO  (qtp67232980-7488) [    x:collection1 ] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&df=text&distrib=false&omitHeader=false&shards.purpose=64&NOW=1600660328861&ids=11,112,113,146,4,104,137,106,1001,120&isShard=true&shard.url=http://127.0.0.1:49368/collection1|[::1]:4/|[::1]:6/&rid=127.0.0.1-29766&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 765229 INFO  (qtp67232980-7489) [    x:collection1 ] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&shards=http://127.0.0.1:49368/collection1|[::1]:4/|[::1]:6/&sort=n_l1+asc&wt=javabin&version=2} rid=127.0.0.1-29766 hits=68 status=0 QTime=2
   [junit4]   2> 765231 INFO  (qtp1291891511-7469) [    x:collection1 ] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&sort=n_tl1+desc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 765232 INFO  (qtp67232980-7490) [    x:collection1 ] o.a.s.c.S.Request [collection1]  webapp= path=/select params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_tl1+desc&shard.url=[::1]:8/|http://127.0.0.1:49368/collection1|[::1]:6/&rid=127.0.0.1-29768&rows=10&version=2&q=*:*&omitHeader=false&NOW=1600660328865&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 765233 INFO  (qtp67232980-7488) [    x:collection1 ] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&df=text&distrib=false&omitHeader=false&shards.purpose=64&NOW=1600660328865&ids=122,112,101,125,136,114,5,1001,128,109&isShard=true&shard.url=[::1]:8/|http://127.0.0.1:49368/collection1|[::1]:6/&rid=127.0.0.1-29768&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 765234 INFO  (qtp67232980-7487) [    x:collection1 ] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&shards=[::1]:8/|http://127.0.0.1:49368/collection1|[::1]:6/&sort=n_tl1+desc&wt=javabin&version=2} rid=127.0.0.1-29768 hits=68 status=0 QTime=2
   [junit4]   2> 765235 INFO  (qtp1291891511-7466) [    x:collection1 ] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&sort=n_tl1+asc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 765237 INFO  (qtp67232980-7490) [    x:collection1 ] o.a.s.c.S.Request [collection1]  webapp= path=/select params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_tl1+asc&shard.url=http://127.0.0.1:49368/collection1&rid=127.0.0.1-29770&rows=10&version=2&q=*:*&omitHeader=false&NOW=1600660328869&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 765237 INFO  (qtp67232980-7488) [    x:collection1 ] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&df=text&distrib=false&omitHeader=false&shards.purpose=64&NOW=1600660328869&ids=111,133,145,134,126,17,127,117,118,10&isShard=true&shard.url=http://127.0.0.1:49368/collection1&rid=127.0.0.1-29770&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 765237 INFO  (qtp67232980-7489) [    x:collection1 ] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&shards=http://127.0.0.1:49368/collection1&sort=n_tl1+asc&wt=javabin&version=2} rid=127.0.0.1-2

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

[junit4]   2> 867595 INFO  (closeThreadPool-4847-thread-8) [     ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@35524126{/,null,UNAVAILABLE}
   [junit4]   2> 867595 INFO  (closeThreadPool-4847-thread-8) [     ] o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestDistributedSearch -Dtests.method=test -Dtests.seed=22225CEB145B3733 -Dtests.slow=true -Dtests.locale=cy -Dtests.timezone=Asia/Bangkok -Dtests.asserts=true -Dtests.file.encoding=UTF-8
   [junit4] ERROR    111s J3 | TestDistributedSearch.test <<<
   [junit4]    > Throwable #1: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=7790, name=httpShardExecutor-4807-thread-10, state=RUNNABLE, group=TGRP-TestDistributedSearch]
   [junit4]    > Caused by: java.util.concurrent.RejectedExecutionException: Task java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask@51235544[Not completed, task = java.util.concurrent.Executors$RunnableAdapter@5bdb3e34[Wrapped task = org.eclipse.jetty.util.SocketAddressResolver$Async$$Lambda$685/0x00000008011e4450@551ccb3f]] rejected from java.util.concurrent.ScheduledThreadPoolExecutor@35bd1ca5[Terminated, pool size = 0, active threads = 0, queued tasks = 0, completed tasks = 0]
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([22225CEB145B3733]:0)
   [junit4]    > 	at java.base/java.util.concurrent.ThreadPoolExecutor$AbortPolicy.rejectedExecution(ThreadPoolExecutor.java:2057)
   [junit4]    > 	at java.base/java.util.concurrent.ThreadPoolExecutor.reject(ThreadPoolExecutor.java:827)
   [junit4]    > 	at java.base/java.util.concurrent.ScheduledThreadPoolExecutor.delayedExecute(ScheduledThreadPoolExecutor.java:340)
   [junit4]    > 	at java.base/java.util.concurrent.ScheduledThreadPoolExecutor.schedule(ScheduledThreadPoolExecutor.java:562)
   [junit4]    > 	at org.eclipse.jetty.util.thread.ScheduledExecutorScheduler.schedule(ScheduledExecutorScheduler.java:122)
   [junit4]    > 	at org.eclipse.jetty.util.SocketAddressResolver$Async.lambda$resolve$1(SocketAddressResolver.java:157)
   [junit4]    > 	at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:218)
   [junit4]    > 	at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130)
   [junit4]    > 	at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:630)
   [junit4]    > 	at java.base/java.lang.Thread.run(Thread.java:832)Throwable #2: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=7789, name=httpShardExecutor-4807-thread-9, state=RUNNABLE, group=TGRP-TestDistributedSearch]
   [junit4]    > Caused by: java.util.concurrent.RejectedExecutionException: Task java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask@70bf9cd6[Not completed, task = java.util.concurrent.Executors$RunnableAdapter@7a47f7a6[Wrapped task = org.eclipse.jetty.util.SocketAddressResolver$Async$$Lambda$685/0x00000008011e4450@7480169e]] rejected from java.util.concurrent.ScheduledThreadPoolExecutor@35bd1ca5[Terminated, pool size = 0, active threads = 0, queued tasks = 0, completed tasks = 0]
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([22225CEB145B3733]:0)
   [junit4]    > 	at java.base/java.util.concurrent.ThreadPoolExecutor$AbortPolicy.rejectedExecution(ThreadPoolExecutor.java:2057)
   [junit4]    > 	at java.base/java.util.concurrent.ThreadPoolExecutor.reject(ThreadPoolExecutor.java:827)
   [junit4]    > 	at java.base/java.util.concurrent.ScheduledThreadPoolExecutor.delayedExecute(ScheduledThreadPoolExecutor.java:340)
   [junit4]    > 	at java.base/java.util.concurrent.ScheduledThreadPoolExecutor.schedule(ScheduledThreadPoolExecutor.java:562)
   [junit4]    > 	at org.eclipse.jetty.util.thread.ScheduledExecutorScheduler.schedule(ScheduledExecutorScheduler.java:122)
   [junit4]    > 	at org.eclipse.jetty.util.SocketAddressResolver$Async.lambda$resolve$1(SocketAddressResolver.java:157)
   [junit4]    > 	at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:218)
   [junit4]    > 	at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130)
   [junit4]    > 	at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:630)
   [junit4]    > 	at java.base/java.lang.Thread.run(Thread.java:832)
   [junit4]   2> 867595 INFO  (SUITE-TestDistributedSearch-seed#[22225CEB145B3733]-worker) [     ] o.a.s.SolrTestCaseJ4 ------------------------------------------------------- Done waiting for tracked resources to be released
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene87): {severity=FST50, foo_sev_enum=FST50, SubjectTerms_mfacet=PostingsFormat(name=MockRandom), multiDefault=Lucene84, _root_=PostingsFormat(name=MockRandom), rnd_b=PostingsFormat(name=LuceneVarGapDocFreqInterval), a_s=FST50, oddField_s=PostingsFormat(name=LuceneVarGapDocFreqInterval), lowerfilt1and2=Lucene84, a_t=Lucene84, foo_b=FST50, lowerfilt=Lucene84, id=PostingsFormat(name=LuceneVarGapDocFreqInterval), text=FST50}, docValues:{other_tl1=DocValuesFormat(name=Lucene80), range_facet_l_dv=DocValuesFormat(name=Lucene80), n_l1=DocValuesFormat(name=Direct), a_n_tdt=DocValuesFormat(name=Asserting), intDefault=DocValuesFormat(name=Lucene80), n_td1=DocValuesFormat(name=Lucene80), n_d1=DocValuesFormat(name=Direct), range_facet_l=DocValuesFormat(name=Direct), n_f1=DocValuesFormat(name=Lucene80), n_tl1=DocValuesFormat(name=Lucene80), n_tf1=DocValuesFormat(name=Direct), intDvoDefault=DocValuesFormat(name=Lucene80), timestamp=DocValuesFormat(name=Direct), severity=DocValuesFormat(name=Asserting), foo_sev_enum=DocValuesFormat(name=Asserting), n_dt1=DocValuesFormat(name=Lucene80), b_n_tdt=DocValuesFormat(name=Lucene80), n_ti1=DocValuesFormat(name=Lucene80), _version_=DocValuesFormat(name=Lucene80), n_tdt1=DocValuesFormat(name=Lucene80), id_i1=DocValuesFormat(name=Lucene80), foo_d=DocValuesFormat(name=Lucene80), range_facet_i_dv=DocValuesFormat(name=Direct), foo_f=DocValuesFormat(name=Asserting), a_i_ni_p=DocValuesFormat(name=Direct)}, maxPointsInLeafNode=1686, maxMBSortInHeap=7.343119552997616, sim=Asserting(RandomSimilarity(queryNorm=false): {}), locale=cy, timezone=Asia/Bangkok
   [junit4]   2> NOTE: Windows 10 10.0 amd64/Oracle Corporation 15 (64-bit)/cpus=6,threads=2,free=116239664,total=294019072
   [junit4]   2> NOTE: All tests run in this JVM: [SolrIndexMetricsTest, TestHttpShardHandlerFactory, ZkStateWriterTest, HdfsChaosMonkeyNothingIsSafeTest, DistribCursorPagingTest, TestNestedUpdateProcessor, DirectSolrConnectionTest, TestSimScenario, TestSimpleTrackingShardHandler, TestApiFramework, RankQParserPluginTest, ClusterStateUpdateTest, ConfigSetsAPITest, SolrCLIZkUtilsTest, CrossCollectionJoinQueryTest, MoveReplicaHDFSTest, TestOmitPositions, TestHttpServletCarrier, TestDistribIDF, TestSimpleTextCodec, TestManagedResource, TestReversedWildcardFilterFactory, TestStressThreadBackup, ZkCLITest, TestCursorMarkWithoutUniqueKey, TestSort, TestRebalanceLeaders, TestHdfsBackupRestoreCore, ZookeeperReadAPITest, RestartWhileUpdatingTest, TestNRTOpen, CurrencyFieldTypeTest, UninvertDocValuesMergePolicyTest, TestDelegationWithHadoopAuth, PathHierarchyTokenizerFactoryTest, BigEndianAscendingWordSerializerTest, TestBlobHandler, ScheduledTriggerTest, ResourceLoaderTest, TestScoreJoinQPScore, SystemCollectionCompatTest, DocValuesTest, MaxSizeAutoCommitTest, AnalyticsMergeStrategyTest, TestPayloadCheckQParserPlugin, TestComplexPhraseLeadingWildcard, ShowFileRequestHandlerTest, AlternateDirectoryTest, TestRTGBase, TestChildDocTransformerHierarchy, TestRestoreCore, SubstringBytesRefFilterTest, TestSimComputePlanAction, TestValueSourceCache, HLLUtilTest, TestPerFieldSimilarity, SolrPluginUtilsTest, TestSortableTextField, TestPullReplica, TestCloudPhrasesIdentificationComponent, TestSearcherReuse, TestEmbeddedSolrServerConstructors, TermVectorComponentDistributedTest, CustomTermsComponentTest, ConfigureRecoveryStrategyTest, LargeFieldTest, DocValuesNotIndexedTest, TestLegacyFieldCache, IgnoreCommitOptimizeUpdateProcessorFactoryTest, TestMinHashQParser, UniqFieldsUpdateProcessorFactoryTest, TestTestInjection, JSONWriterTest, TestFieldTypeResource, TestInitQParser, HttpPartitionTest, SortByFunctionTest, AnalysisErrorHandlingTest, DistributedFacetPivotLargeTest, SolrRrdBackendFactoryTest, TestFieldCacheReopen, HdfsDirectoryTest, TestSimGenericDistributedQueue, HdfsDirectoryFactoryTest, TestRTimerTree, SpellCheckCollatorWithCollapseTest, HdfsRestartWhileUpdatingTest, TestBM25SimilarityFactory, TestIBSimilarityFactory, EchoParamsTest, MinimalSchemaTest, OutputWriterTest, TestDistributedSearch]
   [junit4] Completed [470/919 (1!)] on J3 in 111.71s, 1 test, 1 error <<< FAILURES!

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

[repro] Revision: 798b6198558033796e748a50411f6dd85e0242cb

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

[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]       TestDistributedSearch
[repro] ant compile-test

[...truncated 3476 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5 -Dtests.class="*.TestDistributedSearch" -Dtests.showOutput=onerror "-Dargs=-XX:+UseCompressedOops -XX:+UseSerialGC" -Dtests.seed=22225CEB145B3733 -Dtests.slow=true -Dtests.locale=cy -Dtests.timezone=Asia/Bangkok -Dtests.asserts=true -Dtests.file.encoding=UTF-8

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

[...truncated 98 lines...]