Build: https://jenkins.thetaphi.de/job/Lucene-Solr-8.x-Linux/4854/
Java: 64bit/jdk-13.0.2 -XX:-UseCompressedOops -XX:+UseParallelGC

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

Error Message:
Error from server at https://127.0.0.1:35143/kdby/i/collection1: 
org.apache.solr.client.solrj.SolrServerException: 
java.lang.ArithmeticException: / by zero

Stack Trace:
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error 
from server at https://127.0.0.1:35143/kdby/i/collection1: 
org.apache.solr.client.solrj.SolrServerException: 
java.lang.ArithmeticException: / by zero
        at 
__randomizedtesting.SeedInfo.seed([74AC1D7E2A30F763:FCF822A484CC9A9B]:0)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:681)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:266)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:248)
        at 
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:214)
        at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:1003)
        at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:1018)
        at 
org.apache.solr.BaseDistributedSearchTestCase.queryServer(BaseDistributedSearchTestCase.java:625)
        at 
org.apache.solr.BaseDistributedSearchTestCase.query(BaseDistributedSearchTestCase.java:677)
        at 
org.apache.solr.BaseDistributedSearchTestCase.query(BaseDistributedSearchTestCase.java:655)
        at 
org.apache.solr.BaseDistributedSearchTestCase.query(BaseDistributedSearchTestCase.java:634)
        at 
org.apache.solr.TestDistributedMissingSort.testSortMissingLast(TestDistributedMissingSort.java:175)
        at 
org.apache.solr.TestDistributedMissingSort.test(TestDistributedMissingSort.java:43)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.base/java.lang.reflect.Method.invoke(Method.java:567)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsRepeatStatement.callStatement(BaseDistributedSearchTestCase.java:1117)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:1061)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at org.junit.rules.RunRules.evaluate(RunRules.java:20)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at org.junit.rules.RunRules.evaluate(RunRules.java:20)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at org.junit.rules.RunRules.evaluate(RunRules.java:20)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at org.junit.rules.RunRules.evaluate(RunRules.java:20)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.base/java.lang.Thread.run(Thread.java:830)




Build Log:
[...truncated 14867 lines...]
   [junit4] Suite: org.apache.solr.TestDistributedMissingSort
   [junit4]   2> 427487 INFO  
(SUITE-TestDistributedMissingSort-seed#[74AC1D7E2A30F763]-worker) [     ] 
o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to 
test-framework derived value of 
'/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/server/solr/configsets/_default/conf'
   [junit4]   2> 427487 INFO  
(SUITE-TestDistributedMissingSort-seed#[74AC1D7E2A30F763]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Created dataDir: 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J2/temp/solr.TestDistributedMissingSort_74AC1D7E2A30F763-001/data-dir-79-001
   [junit4]   2> 427487 WARN  
(SUITE-TestDistributedMissingSort-seed#[74AC1D7E2A30F763]-worker) [     ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=1 numCloses=1
   [junit4]   2> 427487 INFO  
(SUITE-TestDistributedMissingSort-seed#[74AC1D7E2A30F763]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 427488 INFO  
(SUITE-TestDistributedMissingSort-seed#[74AC1D7E2A30F763]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: 
@org.apache.solr.util.RandomizeSSL(reason="", value=0.0/0.0, ssl=0.0/0.0, 
clientAuth=0.0/0.0)
   [junit4]   2> 427488 INFO  
(SUITE-TestDistributedMissingSort-seed#[74AC1D7E2A30F763]-worker) [     ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 427488 INFO  
(SUITE-TestDistributedMissingSort-seed#[74AC1D7E2A30F763]-worker) [     ] 
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /kdby/i
   [junit4]   2> 427582 INFO  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J2/temp/solr.TestDistributedMissingSort_74AC1D7E2A30F763-001/tempDir-001/control/cores/collection1
   [junit4]   2> 427584 INFO  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 427584 INFO  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
   [junit4]   2> 427584 INFO  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.e.j.s.Server jetty-9.4.32.v20200930; built: 2020-09-30T16:16:37.804Z; git: 
de97d26f7bd222a0e16831e353d702a7a422f711; jvm 13.0.2+8
   [junit4]   2> 427585 INFO  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 427585 INFO  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 427585 INFO  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 427585 INFO  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@16da4baa{/kdby/i,null,AVAILABLE}
   [junit4]   2> 427586 INFO  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.e.j.s.AbstractConnector Started ServerConnector@36d135d9{ssl, (ssl, alpn, 
http/1.1, h2)}{127.0.0.1:45623}
   [junit4]   2> 427586 INFO  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.e.j.s.Server Started @427611ms
   [junit4]   2> 427586 INFO  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{schema=schema-distributed-missing-sort.xml, hostContext=/kdby/i, 
hostPort=45623, 
coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J2/temp/solr.TestDistributedMissingSort_74AC1D7E2A30F763-001/tempDir-001/control/cores}
   [junit4]   2> 427586 ERROR 
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 427586 INFO  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 427586 INFO  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.8.0
   [junit4]   2> 427586 INFO  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 427586 INFO  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr
   [junit4]   2> 427586 INFO  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2020-10-31T11:32:32.515665Z
   [junit4]   2> 427586 INFO  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J2/temp/solr.TestDistributedMissingSort_74AC1D7E2A30F763-001/tempDir-001/control/solr.xml
   [junit4]   2> 427588 INFO  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay 
is ignored
   [junit4]   2> 427588 INFO  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 427589 INFO  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@432ca8d6, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 427612 INFO  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
   [junit4]   2> 427613 WARN  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@4a4738c[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 427613 WARN  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@4a4738c[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 427614 WARN  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@4b8c5d30[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 427614 WARN  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@4b8c5d30[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 427615 WARN  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
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> 427621 INFO  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 427621 INFO  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history 
in memory.
   [junit4]   2> 427631 INFO  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@432ca8d6
   [junit4]   2> 427637 INFO  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@432ca8d6
   [junit4]   2> 427637 INFO  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@432ca8d6
   [junit4]   2> 427638 INFO  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J2/temp/solr.TestDistributedMissingSort_74AC1D7E2A30F763-001/tempDir-001/control/cores
   [junit4]   2> 427638 INFO  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 427642 INFO  (coreLoadExecutor-5710-thread-1) [    
x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.8.0
   [junit4]   2> 427658 INFO  (coreLoadExecutor-5710-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema Schema name=test-distributed-missing-sort
   [junit4]   2> 427662 INFO  (coreLoadExecutor-5710-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema Loaded schema 
test-distributed-missing-sort/1.6 with uniqueid field id
   [junit4]   2> 427662 INFO  (coreLoadExecutor-5710-thread-1) [    
x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from configset 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1,
 trusted=true
   [junit4]   2> 427663 INFO  (coreLoadExecutor-5710-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@432ca8d6
   [junit4]   2> 427663 INFO  (coreLoadExecutor-5710-thread-1) [    
x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J2/temp/solr.TestDistributedMissingSort_74AC1D7E2A30F763-001/tempDir-001/control/cores/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J2/temp/solr.TestDistributedMissingSort_74AC1D7E2A30F763-001/tempDir-001/control/cores/collection1/data/]
   [junit4]   2> 427663 INFO  (coreLoadExecutor-5710-thread-1) [    
x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=21, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.24594773439931555]
   [junit4]   2> 427694 INFO  (coreLoadExecutor-5710-thread-1) [    
x:collection1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 427694 INFO  (coreLoadExecutor-5710-thread-1) [    
x:collection1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 427695 INFO  (coreLoadExecutor-5710-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 427695 INFO  (coreLoadExecutor-5710-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 427695 INFO  (coreLoadExecutor-5710-thread-1) [    
x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=18, maxMergeAtOnceExplicit=18, maxMergedSegmentMB=45.10546875, 
floorSegmentMB=0.865234375, forceMergeDeletesPctAllowed=5.583252951334963, 
segmentsPerTier=22.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.41583609520660425, deletesPctAllowed=46.076174037173615
   [junit4]   2> 427696 INFO  (coreLoadExecutor-5710-thread-1) [    
x:collection1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 427698 INFO  (coreLoadExecutor-5710-thread-1) [    
x:collection1 ] o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 427707 INFO  (coreLoadExecutor-5710-thread-1) [    
x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 427707 INFO  (coreLoadExecutor-5710-thread-1) [    
x:collection1 ] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1682066849279246336
   [junit4]   2> 427708 INFO  
(searcherExecutor-5712-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 427708 INFO  
(searcherExecutor-5712-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 427708 INFO  
(searcherExecutor-5712-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 427708 INFO  
(searcherExecutor-5712-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 427708 INFO  
(searcherExecutor-5712-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 427709 INFO  
(searcherExecutor-5712-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 427709 INFO  
(searcherExecutor-5712-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 427709 INFO  
(searcherExecutor-5712-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 427709 INFO  
(searcherExecutor-5712-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 427710 INFO  
(searcherExecutor-5712-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 427802 INFO  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J2/temp/solr.TestDistributedMissingSort_74AC1D7E2A30F763-001/tempDir-001/shard0/cores/collection1
   [junit4]   2> 427803 INFO  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 427803 INFO  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
   [junit4]   2> 427803 INFO  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.e.j.s.Server jetty-9.4.32.v20200930; built: 2020-09-30T16:16:37.804Z; git: 
de97d26f7bd222a0e16831e353d702a7a422f711; jvm 13.0.2+8
   [junit4]   2> 427804 INFO  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 427804 INFO  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 427804 INFO  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 427804 INFO  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@58c7a374{/kdby/i,null,AVAILABLE}
   [junit4]   2> 427805 INFO  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.e.j.s.AbstractConnector Started ServerConnector@1c3fde3{ssl, (ssl, alpn, 
http/1.1, h2)}{127.0.0.1:40141}
   [junit4]   2> 427805 INFO  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.e.j.s.Server Started @427830ms
   [junit4]   2> 427805 INFO  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{schema=schema-distributed-missing-sort.xml, hostContext=/kdby/i, 
hostPort=40141, 
coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J2/temp/solr.TestDistributedMissingSort_74AC1D7E2A30F763-001/tempDir-001/shard0/cores}
   [junit4]   2> 427805 ERROR 
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 427805 INFO  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 427805 INFO  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.8.0
   [junit4]   2> 427805 INFO  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 427805 INFO  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr
   [junit4]   2> 427805 INFO  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2020-10-31T11:32:32.734921Z
   [junit4]   2> 427805 INFO  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J2/temp/solr.TestDistributedMissingSort_74AC1D7E2A30F763-001/tempDir-001/shard0/solr.xml
   [junit4]   2> 427811 INFO  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay 
is ignored
   [junit4]   2> 427811 INFO  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 427812 INFO  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@432ca8d6, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 427905 INFO  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
   [junit4]   2> 427906 WARN  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@29659b63[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 427906 WARN  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@29659b63[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 427907 WARN  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@6a4cba7d[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 427907 WARN  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@6a4cba7d[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 427908 WARN  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
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> 427916 INFO  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 427916 INFO  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history 
in memory.
   [junit4]   2> 427931 INFO  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@432ca8d6
   [junit4]   2> 427939 INFO  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@432ca8d6
   [junit4]   2> 427939 INFO  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@432ca8d6
   [junit4]   2> 427940 INFO  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J2/temp/solr.TestDistributedMissingSort_74AC1D7E2A30F763-001/tempDir-001/shard0/cores
   [junit4]   2> 427940 INFO  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 427943 INFO  (coreLoadExecutor-5729-thread-1) [    
x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.8.0
   [junit4]   2> 427961 INFO  (coreLoadExecutor-5729-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema Schema name=test-distributed-missing-sort
   [junit4]   2> 427966 INFO  (coreLoadExecutor-5729-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema Loaded schema 
test-distributed-missing-sort/1.6 with uniqueid field id
   [junit4]   2> 427966 INFO  (coreLoadExecutor-5729-thread-1) [    
x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from configset 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1,
 trusted=true
   [junit4]   2> 427966 INFO  (coreLoadExecutor-5729-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@432ca8d6
   [junit4]   2> 427967 INFO  (coreLoadExecutor-5729-thread-1) [    
x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J2/temp/solr.TestDistributedMissingSort_74AC1D7E2A30F763-001/tempDir-001/shard0/cores/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J2/temp/solr.TestDistributedMissingSort_74AC1D7E2A30F763-001/tempDir-001/shard0/cores/collection1/data/]
   [junit4]   2> 427968 INFO  (coreLoadExecutor-5729-thread-1) [    
x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=21, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.24594773439931555]
   [junit4]   2> 428005 INFO  (coreLoadExecutor-5729-thread-1) [    
x:collection1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 428005 INFO  (coreLoadExecutor-5729-thread-1) [    
x:collection1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 428006 INFO  (coreLoadExecutor-5729-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 428006 INFO  (coreLoadExecutor-5729-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 428006 INFO  (coreLoadExecutor-5729-thread-1) [    
x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=18, maxMergeAtOnceExplicit=18, maxMergedSegmentMB=45.10546875, 
floorSegmentMB=0.865234375, forceMergeDeletesPctAllowed=5.583252951334963, 
segmentsPerTier=22.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.41583609520660425, deletesPctAllowed=46.076174037173615
   [junit4]   2> 428007 INFO  (coreLoadExecutor-5729-thread-1) [    
x:collection1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 428009 INFO  (coreLoadExecutor-5729-thread-1) [    
x:collection1 ] o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 428018 INFO  (coreLoadExecutor-5729-thread-1) [    
x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 428018 INFO  (coreLoadExecutor-5729-thread-1) [    
x:collection1 ] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1682066849605353472
   [junit4]   2> 428018 INFO  
(searcherExecutor-5731-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 428019 INFO  
(searcherExecutor-5731-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 428019 INFO  
(searcherExecutor-5731-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 428019 INFO  
(searcherExecutor-5731-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 428019 INFO  
(searcherExecutor-5731-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 428019 INFO  
(searcherExecutor-5731-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 428019 INFO  
(TEST-TestDistributedMissingSort.test-seed#[74AC1D7E2A30F763]) [     ] 
o.a.s.SolrTestCaseJ4 ###Starting test
   [junit4]   2> 428019 INFO  
(searcherExecutor-5731-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 428019 INFO  
(searcherExecutor-5731-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 428020 INFO  
(searcherExecutor-5731-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 428020 INFO  
(searcherExecutor-5731-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 428026 INFO  (qtp2055991899-10731) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{deleteByQuery=*:* (-1682066849612693504)} 0 0
   [junit4]   2> 428031 INFO  (qtp768002302-10734) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{deleteByQuery=*:* (-1682066849618984960)} 0 0
   [junit4]   2> 428032 INFO  (qtp2055991899-10733) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[1 (1682066849620033536)]} 0 0
   [junit4]   2> 428033 INFO  (qtp768002302-10736) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[1 (1682066849621082112)]} 0 0
   [junit4]   2> 428033 INFO  (qtp2055991899-10731) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[2 (1682066849621082112)]} 0 0
   [junit4]   2> 428034 INFO  (qtp768002302-10734) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[2 (1682066849622130688)]} 0 0
   [junit4]   2> 428034 INFO  (qtp2055991899-10733) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[3 (1682066849622130688)]} 0 0
   [junit4]   2> 428034 INFO  (qtp768002302-10736) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[3 (1682066849622130689)]} 0 0
   [junit4]   2> 428034 INFO  (qtp2055991899-10731) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[4 (1682066849622130689)]} 0 0
   [junit4]   2> 428035 INFO  (qtp768002302-10734) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[4 (1682066849623179264)]} 0 0
   [junit4]   2> 428035 INFO  (qtp2055991899-10733) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[5 (1682066849623179264)]} 0 0
   [junit4]   2> 428035 INFO  (qtp768002302-10736) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[5 (1682066849623179265)]} 0 0
   [junit4]   2> 428035 INFO  (qtp2055991899-10731) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[6 (1682066849623179265)]} 0 0
   [junit4]   2> 428036 INFO  (qtp768002302-10734) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[6 (1682066849624227840)]} 0 0
   [junit4]   2> 428036 INFO  (qtp2055991899-10733) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[7 (1682066849624227840)]} 0 0
   [junit4]   2> 428036 INFO  (qtp768002302-10736) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[7 (1682066849624227841)]} 0 0
   [junit4]   2> 428036 INFO  (qtp2055991899-10731) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[8 (1682066849624227841)]} 0 0
   [junit4]   2> 428037 INFO  (qtp768002302-10734) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[8 (1682066849625276416)]} 0 0
   [junit4]   2> 428037 INFO  (qtp2055991899-10733) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[9 (1682066849625276416)]} 0 0
   [junit4]   2> 428037 INFO  (qtp768002302-10736) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[9 (1682066849625276417)]} 0 0
   [junit4]   2> 428042 INFO  
(searcherExecutor-5712-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 428042 INFO  (qtp2055991899-10731) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 4
   [junit4]   2> 428047 INFO  
(searcherExecutor-5731-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 428047 INFO  (qtp768002302-10734) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 4
   [junit4]   2> 428049 INFO  (qtp2055991899-10733) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[10 (1682066849636810752)]} 0 0
   [junit4]   2> 428049 INFO  (qtp768002302-10736) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[10 (1682066849637859328)]} 0 0
   [junit4]   2> 428050 INFO  (qtp2055991899-10731) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[11 (1682066849638907904)]} 0 0
   [junit4]   2> 428050 INFO  (qtp768002302-10734) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[11 (1682066849638907904)]} 0 0
   [junit4]   2> 428050 INFO  (qtp2055991899-10733) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[12 (1682066849638907905)]} 0 0
   [junit4]   2> 428050 INFO  (qtp768002302-10736) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[12 (1682066849638907905)]} 0 0
   [junit4]   2> 428051 INFO  (qtp2055991899-10731) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[13 (1682066849639956480)]} 0 0
   [junit4]   2> 428051 INFO  (qtp768002302-10734) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[13 (1682066849639956480)]} 0 0
   [junit4]   2> 428051 INFO  (qtp2055991899-10733) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[14 (1682066849639956481)]} 0 0
   [junit4]   2> 428051 INFO  (qtp768002302-10736) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[14 (1682066849639956481)]} 0 0
   [junit4]   2> 428052 INFO  (qtp2055991899-10731) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[15 (1682066849641005056)]} 0 0
   [junit4]   2> 428052 INFO  (qtp768002302-10734) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[15 (1682066849641005056)]} 0 0
   [junit4]   2> 428052 INFO  (qtp2055991899-10733) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[16 (1682066849641005057)]} 0 0
   [junit4]   2> 428052 INFO  (qtp768002302-10736) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[16 (1682066849641005057)]} 0 0
   [junit4]   2> 428053 INFO  (qtp2055991899-10731) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[17 (1682066849642053632)]} 0 0
   [junit4]   2> 428053 INFO  (qtp768002302-10734) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[17 (1682066849642053632)]} 0 0
   [junit4]   2> 428053 INFO  (qtp2055991899-10733) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[100 (1682066849642053633)]} 0 0
   [junit4]   2> 428053 INFO  (qtp768002302-10736) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[100 (1682066849642053633)]} 0 0
   [junit4]   2> 428054 INFO  (qtp2055991899-10731) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[101 (1682066849643102208)]} 0 0
   [junit4]   2> 428054 INFO  (qtp768002302-10734) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[101 (1682066849643102208)]} 0 0
   [junit4]   2> 428054 INFO  (qtp2055991899-10733) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[102 (1682066849643102209)]} 0 0
   [junit4]   2> 428054 INFO  (qtp768002302-10736) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[102 (1682066849643102209)]} 0 0
   [junit4]   2> 428055 INFO  (qtp2055991899-10731) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[103 (1682066849643102210)]} 0 0
   [junit4]   2> 428055 INFO  (qtp768002302-10734) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[103 (1682066849644150784)]} 0 0
   [junit4]   2> 428055 INFO  (qtp2055991899-10733) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[104 (1682066849644150784)]} 0 0
   [junit4]   2> 428055 INFO  (qtp768002302-10736) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[104 (1682066849644150785)]} 0 0
   [junit4]   2> 428056 INFO  (qtp2055991899-10731) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[105 (1682066849644150785)]} 0 0
   [junit4]   2> 428056 INFO  (qtp768002302-10734) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[105 (1682066849645199360)]} 0 0
   [junit4]   2> 428056 INFO  (qtp2055991899-10733) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[106 (1682066849645199360)]} 0 0
   [junit4]   2> 428056 INFO  (qtp768002302-10736) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[106 (1682066849645199361)]} 0 0
   [junit4]   2> 428056 INFO  (qtp2055991899-10731) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[107 (1682066849645199361)]} 0 0
   [junit4]   2> 428057 INFO  (qtp768002302-10734) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[107 (1682066849646247936)]} 0 0
   [junit4]   2> 428057 INFO  (qtp2055991899-10733) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[108 (1682066849646247936)]} 0 0
   [junit4]   2> 428057 INFO  (qtp768002302-10736) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[108 (1682066849646247937)]} 0 0
   [junit4]   2> 428057 INFO  (qtp2055991899-10731) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[109 (1682066849646247937)]} 0 0
   [junit4]   2> 428058 INFO  (qtp768002302-10734) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[109 (1682066849647296512)]} 0 0
   [junit4]   2> 428058 INFO  (qtp2055991899-10733) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[110 (1682066849647296512)]} 0 0
   [junit4]   2> 428058 INFO  (qtp768002302-10736) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[110 (1682066849647296513)]} 0 0
   [junit4]   2> 428058 INFO  (qtp2055991899-10731) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[111 (1682066849647296513)]} 0 0
   [junit4]   2> 428059 INFO  (qtp768002302-10734) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[111 (1682066849648345088)]} 0 0
   [junit4]   2> 428059 INFO  (qtp2055991899-10733) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[112 (1682066849648345088)]} 0 0
   [junit4]   2> 428059 INFO  (qtp768002302-10736) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[112 (1682066849648345089)]} 0 0
   [junit4]   2> 428059 INFO  (qtp2055991899-10731) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[113 (1682066849648345089)]} 0 0
   [junit4]   2> 428060 INFO  (qtp768002302-10734) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[113 (1682066849649393664)]} 0 0
   [junit4]   2> 428060 INFO  (qtp2055991899-10733) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[114 (1682066849649393664)]} 0 0
   [junit4]   2> 428060 INFO  (qtp768002302-10736) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[114 (1682066849649393665)]} 0 0
   [junit4]   2> 428060 INFO  (qtp2055991899-10731) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[115 (1682066849649393665)]} 0 0
   [junit4]   2> 428060 INFO  (qtp768002302-10734) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[115 (1682066849649393666)]} 0 0
   [junit4]   2> 428061 INFO  (qtp2055991899-10733) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[116 (1682066849650442240)]} 0 0
   [junit4]   2> 428061 INFO  (qtp768002302-10736) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[116 (1682066849650442240)]} 0 0
   [junit4]   2> 428061 INFO  (qtp2055991899-10731) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[117 (1682066849650442241)]} 0 0
   [junit4]   2> 428061 INFO  (qtp768002302-10734) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[117 (1682066849650442241)]} 0 0
   [junit4]   2> 428062 INFO  (qtp2055991899-10733) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[118 (1682066849651490816)]} 0 0
   [junit4]   2> 428062 INFO  (qtp768002302-10736) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[118 (1682066849651490816)]} 0 0
   [junit4]   2> 428062 INFO  (qtp2055991899-10731) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[119 (1682066849651490817)]} 0 0
   [junit4]   2> 428062 INFO  (qtp768002302-10734) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[119 (1682066849651490817)]} 0 0
   [junit4]   2> 428063 INFO  (qtp2055991899-10733) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[120 (1682066849651490818)]} 0 0
   [junit4]   2> 428063 INFO  (qtp768002302-10736) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[120 (1682066849652539392)]} 0 0
   [junit4]   2> 428063 INFO  (qtp2055991899-10731) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[121 (1682066849652539392)]} 0 0
   [junit4]   2> 428063 INFO  (qtp768002302-10734) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[121 (1682066849652539393)]} 0 0
   [junit4]   2> 428063 INFO  (qtp2055991899-10733) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[122 (1682066849652539393)]} 0 0
   [junit4]   2> 428064 INFO  (qtp768002302-10736) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[122 (1682066849653587968)]} 0 0
   [junit4]   2> 428064 INFO  (qtp2055991899-10731) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[123 (1682066849653587968)]} 0 0
   [junit4]   2> 428064 INFO  (qtp768002302-10734) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[123 (1682066849653587969)]} 0 0
   [junit4]   2> 428065 INFO  (qtp2055991899-10733) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[124 (1682066849654636544)]} 0 0
   [junit4]   2> 428065 INFO  (qtp768002302-10736) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[124 (1682066849654636544)]} 0 0
   [junit4]   2> 428065 INFO  (qtp2055991899-10731) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[125 (1682066849654636545)]} 0 0
   [junit4]   2> 428066 INFO  (qtp768002302-10734) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[125 (1682066849655685120)]} 0 0
   [junit4]   2> 428066 INFO  (qtp2055991899-10733) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[126 (1682066849655685120)]} 0 0
   [junit4]   2> 428066 INFO  (qtp768002302-10736) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[126 (1682066849655685121)]} 0 0
   [junit4]   2> 428066 INFO  (qtp2055991899-10731) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[127 (1682066849655685121)]} 0 0
   [junit4]   2> 428067 INFO  (qtp768002302-10734) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[127 (1682066849655685122)]} 0 0
   [junit4]   2> 428067 INFO  (qtp2055991899-10733) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[128 (1682066849656733696)]} 0 0
   [junit4]   2> 428067 INFO  (qtp768002302-10736) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[128 (1682066849656733696)]} 0 0
   [junit4]   2> 428067 INFO  (qtp2055991899-10731) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[129 (1682066849656733697)]} 0 0
   [junit4]   2> 428067 INFO  (qtp768002302-10734) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[129 (1682066849656733697)]} 0 0
   [junit4]   2> 428068 INFO  (qtp2055991899-10733) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[130 (1682066849657782272)]} 0 0
   [junit4]   2> 428068 INFO  (qtp768002302-10736) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[130 (1682066849657782272)]} 0 0
   [junit4]   2> 428068 INFO  (qtp2055991899-10731) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[131 (1682066849657782273)]} 0 0
   [junit4]   2> 428068 INFO  (qtp768002302-10734) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[131 (1682066849657782273)]} 0 0
   [junit4]   2> 428069 INFO  (qtp2055991899-10733) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[132 (1682066849658830848)]} 0 0
   [junit4]   2> 428069 INFO  (qtp768002302-10736) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[132 (1682066849658830848)]} 0 0
   [junit4]   2> 428069 INFO  (qtp2055991899-10731) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[133 (1682066849658830849)]} 0 0
   [junit4]   2> 428069 INFO  (qtp768002302-10734) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[133 (1682066849658830849)]} 0 0
   [junit4]   2> 428070 INFO  (qtp2055991899-10733) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[134 (1682066849659879424)]} 0 0
   [junit4]   2> 428070 INFO  (qtp768002302-10736) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[134 (1682066849659879424)]} 0 0
   [junit4]   2> 428070 INFO  (qtp2055991899-10731) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[135 (1682066849659879425)]} 0 0
   [junit4]   2> 428071 INFO  (qtp768002302-10734) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[135 (1682066849660928000)]} 0 0
   [junit4]   2> 428071 INFO  (qtp2055991899-10733) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[136 (1682066849660928000)]} 0 0
   [junit4]   2> 428071 INFO  (qtp768002302-10736) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[136 (1682066849660928001)]} 0 0
   [junit4]   2> 428072 INFO  (qtp2055991899-10731) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[137 (1682066849661976576)]} 0 0
   [junit4]   2> 428072 INFO  (qtp768002302-10734) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[137 (1682066849661976576)]} 0 0
   [junit4]   2> 428072 INFO  (qtp2055991899-10733) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[138 (1682066849661976577)]} 0 0
   [junit4]   2> 428072 INFO  (qtp768002302-10736) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[138 (1682066849661976577)]} 0 0
   [junit4]   2> 428073 INFO  (qtp2055991899-10731) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[139 (1682066849663025152)]} 0 0
   [junit4]   2> 428073 INFO  (qtp768002302-10734) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[139 (1682066849663025152)]} 0 0
   [junit4]   2> 428073 INFO  (qtp2055991899-10733) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[140 (1682066849663025153)]} 0 0
   [junit4]   2> 428073 INFO  (qtp768002302-10736) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[140 (1682066849663025153)]} 0 0
   [junit4]   2> 428074 INFO  (qtp2055991899-10731) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[141 (1682066849664073728)]} 0 0
   [junit4]   2> 428074 INFO  (qtp768002302-10734) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[141 (1682066849664073728)]} 0 0
   [junit4]   2> 428074 INFO  (qtp2055991899-10733) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[142 (1682066849664073729)]} 0 0
   [junit4]   2> 428074 INFO  (qtp768002302-10736) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[142 (1682066849664073729)]} 0 0
   [junit4]   2> 428074 INFO  (qtp2055991899-10731) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[143 (1682066849664073730)]} 0 0
   [junit4]   2> 428075 INFO  (qtp768002302-10734) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[143 (1682066849665122304)]} 0 0
   [junit4]   2> 428075 INFO  (qtp2055991899-10733) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[144 (1682066849665122304)]} 0 0
   [junit4]   2> 428075 INFO  (qtp768002302-10736) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[144 (1682066849665122305)]} 0 0
   [junit4]   2> 428075 INFO  (qtp2055991899-10731) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[145 (1682066849665122305)]} 0 0
   [junit4]   2> 428076 INFO  (qtp768002302-10734) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[145 (1682066849666170880)]} 0 0
   [junit4]   2> 428076 INFO  (qtp2055991899-10733) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[146 (1682066849666170880)]} 0 0
   [junit4]   2> 428076 INFO  (qtp768002302-10736) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[146 (1682066849666170881)]} 0 0
   [junit4]   2> 428076 INFO  (qtp2055991899-10731) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[147 (1682066849666170881)]} 0 0
   [junit4]   2> 428076 INFO  (qtp768002302-10734) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[147 (1682066849666170882)]} 0 0
   [junit4]   2> 428077 INFO  (qtp2055991899-10733) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[148 (1682066849667219456)]} 0 0
   [junit4]   2> 428077 INFO  (qtp768002302-10736) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[148 (1682066849667219456)]} 0 0
   [junit4]   2> 428077 INFO  (qtp2055991899-10731) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[149 (1682066849667219457)]} 0 0
   [junit4]   2> 428077 INFO  (qtp768002302-10734) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={wt=javabin&version=2}{add=[149 (1682066849667219457)]} 0 0
   [junit4]   2> 428082 INFO  
(searcherExecutor-5712-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 428082 INFO  (qtp2055991899-10733) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 4
   [junit4]   2> 428088 INFO  
(searcherExecutor-5731-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 428089 INFO  (qtp768002302-10736) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/kdby/i path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 5
   [junit4]   2> 428090 INFO  (qtp2055991899-10731) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={q=*:*&distrib=false&sort=one_i1_ml+desc&rows=13&wt=javabin&version=2} 
hits=67 status=0 QTime=0
   [junit4]   2> 428109 INFO  (qtp768002302-10736) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=one_i1_ml+desc&shard.url=[::1]:8/kdby/i|[::1]:4/kdby/i|[::1]:6/kdby/i|https://127.0.0.1:40141/kdby/i/collection1&rows=13&rid=127.0.0.1-76452&version=2&q=*:*&omitHeader=false&NOW=1604143953019&isShard=true&wt=javabin}
 hits=67 status=0 QTime=0
   [junit4]   2> 428111 INFO  (qtp768002302-10736) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={df=text&distrib=false&shards.purpose=64&shard.url=[::1]:8/kdby/i|[::1]:4/kdby/i|[::1]:6/kdby/i|https://127.0.0.1:40141/kdby/i/collection1&rows=13&rid=127.0.0.1-76452&version=2&q=*:*&omitHeader=false&NOW=1604143953019&ids=11,12,13,1,2,3,4,5,6,7,8,9,10&isShard=true&wt=javabin}
 status=0 QTime=0
   [junit4]   2> 428111 INFO  (qtp768002302-10734) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={q=*:*&shards=[::1]:8/kdby/i|[::1]:4/kdby/i|[::1]:6/kdby/i|https://127.0.0.1:40141/kdby/i/collection1&sort=one_i1_ml+desc&rows=13&wt=javabin&version=2}
 rid=127.0.0.1-76452 hits=67 status=0 QTime=20
   [junit4]   2> 428112 INFO  (qtp2055991899-10733) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={q=*:*&distrib=false&sort=one_i1_ml+asc&rows=13&wt=javabin&version=2} 
hits=67 status=0 QTime=0
   [junit4]   2> 428113 INFO  (qtp768002302-10734) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=one_i1_ml+asc&shard.url=https://127.0.0.1:40141/kdby/i/collection1|[::1]:4/kdby/i|[::1]:8/kdby/i&rows=13&rid=127.0.0.1-76454&version=2&q=*:*&omitHeader=false&NOW=1604143953042&isShard=true&wt=javabin}
 hits=67 status=0 QTime=0
   [junit4]   2> 428114 INFO  (qtp768002302-10734) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={df=text&distrib=false&shards.purpose=64&shard.url=https://127.0.0.1:40141/kdby/i/collection1|[::1]:4/kdby/i|[::1]:8/kdby/i&rows=13&rid=127.0.0.1-76454&version=2&q=*:*&omitHeader=false&NOW=1604143953042&ids=11,12,13,1,2,3,4,5,6,7,8,9,10&isShard=true&wt=javabin}
 status=0 QTime=0
   [junit4]   2> 428114 INFO  (qtp768002302-10736) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={q=*:*&shards=https://127.0.0.1:40141/kdby/i/collection1|[::1]:4/kdby/i|[::1]:8/kdby/i&sort=one_i1_ml+asc&rows=13&wt=javabin&version=2}
 rid=127.0.0.1-76454 hits=67 status=0 QTime=1
   [junit4]   2> 428115 INFO  (qtp2055991899-10731) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={q=*:*&distrib=false&sort=one_i1_ml+desc,+id_i+asc&rows=200&wt=javabin&version=2}
 hits=67 status=0 QTime=0
   [junit4]   2> 428117 INFO  (qtp768002302-10736) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=one_i1_ml+desc,+id_i+asc&shard.url=[::1]:4/kdby/i|https://127.0.0.1:40141/kdby/i/collection1|[::1]:6/kdby/i&rows=200&rid=127.0.0.1-76456&version=2&q=*:*&omitHeader=false&NOW=1604143953045&isShard=true&wt=javabin}
 hits=67 status=0 QTime=0
   [junit4]   2> 428118 INFO  (qtp768002302-10736) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={df=text&distrib=false&shards.purpose=64&shard.url=[::1]:4/kdby/i|https://127.0.0.1:40141/kdby/i/collection1|[::1]:6/kdby/i&rows=200&rid=127.0.0.1-76456&version=2&q=*:*&omitHeader=false&NOW=1604143953045&ids=110,111,112,113,114,115,116,117,118,119,10,11,12,13,14,15,16,17,120,121,122,1,123,2,124,3,125,4,126,5,127,6,128,7,129,8,9,130,131,132,133,134,135,136,137,138,139,140,141,142,143,144,100,145,101,146,102,147,103,148,104,149,105,106,107,108,109&isShard=true&wt=javabin}
 status=0 QTime=0
   [junit4]   2> 428119 INFO  (qtp768002302-10734) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={q=*:*&shards=[::1]:4/kdby/i|https://127.0.0.1:40141/kdby/i/collection1|[::1]:6/kdby/i&sort=one_i1_ml+desc,+id_i+asc&rows=200&wt=javabin&version=2}
 rid=127.0.0.1-76456 hits=67 status=0 QTime=3
   [junit4]   2> 428120 INFO  (qtp2055991899-10733) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={q=*:*&distrib=false&sort=one_i1_ml+asc,+id_i+desc&rows=200&wt=javabin&version=2}
 hits=67 status=0 QTime=0
   [junit4]   2> 428122 INFO  (qtp768002302-10734) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=one_i1_ml+asc,+id_i+desc&shard.url=[::1]:8/kdby/i|[::1]:6/kdby/i|[::1]:4/kdby/i|https://127.0.0.1:40141/kdby/i/collection1&rows=200&rid=127.0.0.1-76458&version=2&q=*:*&omitHeader=false&NOW=1604143953050&isShard=true&wt=javabin}
 hits=67 status=0 QTime=0
   [junit4]   2> 428123 INFO  (qtp768002302-10734) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={df=text&distrib=false&shards.purpose=64&shard.url=[::1]:8/kdby/i|[::1]:6/kdby/i|[::1]:4/kdby/i|https://127.0.0.1:40141/kdby/i/collection1&rows=200&rid=127.0.0.1-76458&version=2&q=*:*&omitHeader=false&NOW=1604143953050&ids=110,111,112,113,114,115,116,117,118,119,10,11,12,13,14,15,16,17,120,121,122,1,123,2,124,3,125,4,126,5,127,6,128,7,129,8,9,130,131,132,133,134,135,136,137,138,139,140,141,142,143,100,144,101,145,102,146,103,147,104,148,105,149,106,107,108,109&isShard=true&wt=javabin}
 status=0 QTime=0
   [junit4]   2> 428124 INFO  (qtp768002302-10736) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={q=*:*&shards=[::1]:8/kdby/i|[::1]:6/kdby/i|[::1]:4/kdby/i|https://127.0.0.1:40141/kdby/i/collection1&sort=one_i1_ml+asc,+id_i+desc&rows=200&wt=javabin&version=2}
 rid=127.0.0.1-76458 hits=67 status=0 QTime=2
   [junit4]   2> 428125 INFO  (qtp2055991899-10731) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={q=*:*&distrib=false&sort=three_l1_ml+desc&rows=13&wt=javabin&version=2} 
hits=67 status=0 QTime=0
   [junit4]   2> 428126 INFO  (qtp768002302-10736) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=three_l1_ml+desc&shard.url=[::1]:4/kdby/i|https://127.0.0.1:40141/kdby/i/collection1&rows=13&rid=127.0.0.1-76460&version=2&q=*:*&omitHeader=false&NOW=1604143953054&isShard=true&wt=javabin}
 hits=67 status=0 QTime=0
   [junit4]   2> 428127 INFO  (qtp768002302-10736) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={df=text&distrib=false&shards.purpose=64&shard.url=[::1]:4/kdby/i|https://127.0.0.1:40141/kdby/i/collection1&rows=13&rid=127.0.0.1-76460&version=2&q=*:*&omitHeader=false&NOW=1604143953054&ids=11,12,13,1,2,3,4,5,6,7,8,9,10&isShard=true&wt=javabin}
 status=0 QTime=0
   [junit4]   2> 428127 INFO  (qtp768002302-10734) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={q=*:*&shards=[::1]:4/kdby/i|https://127.0.0.1:40141/kdby/i/collection1&sort=three_l1_ml+desc&rows=13&wt=javabin&version=2}
 rid=127.0.0.1-76460 hits=67 status=0 QTime=1
   [junit4]   2> 428128 INFO  (qtp2055991899-10733) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={q=*:*&distrib=false&sort=three_l1_ml+asc&rows=13&wt=javabin&version=2} 
hits=67 status=0 QTime=0
   [junit4]   2> 428128 INFO  (qtp768002302-10734) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=three_l1_ml+asc&shard.url=[::1]:4/kdby/i|https://127.0.0.1:40141/kdby/i/collection1|[::1]:8/kdby/i|[::1]:6/kdby/i&rows=13&rid=127.0.0.1-76462&version=2&q=*:*&omitHeader=false&NOW=1604143953057&isShard=true&wt=javabin}
 hits=67 status=0 QTime=0
   [junit4]   2> 428129 INFO  (qtp768002302-10734) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={df=text&distrib=false&shards.purpose=64&shard.url=[::1]:4/kdby/i|https://127.0.0.1:40141/kdby/i/collection1|[::1]:8/kdby/i|[::1]:6/kdby/i&rows=13&rid=127.0.0.1-76462&version=2&q=*:*&omitHeader=false&NOW=1604143953057&ids=11,12,13,1,2,3,4,5,6,7,8,9,10&isShard=true&wt=javabin}
 status=0 QTime=0
   [junit4]   2> 428129 INFO  (qtp768002302-10736) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={q=*:*&shards=[::1]:4/kdby/i|https://127.0.0.1:40141/kdby/i/collection1|[::1]:8/kdby/i|[::1]:6/kdby/i&sort=three_l1_ml+asc&rows=13&wt=javabin&version=2}
 rid=127.0.0.1-76462 hits=67 status=0 QTime=1
   [junit4]   2> 428130 INFO  (qtp2055991899-10731) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={q=*:*&distrib=false&sort=three_l1_ml+desc,+id_i+asc&rows=200&wt=javabin&version=2}
 hits=67 status=0 QTime=0
   [junit4]   2> 428131 INFO  (qtp768002302-10736) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=three_l1_ml+desc,+id_i+asc&shard.url=https://127.0.0.1:40141/kdby/i/collection1&rows=200&rid=127.0.0.1-76464&version=2&q=*:*&omitHeader=false&NOW=1604143953060&isShard=true&wt=javabin}
 hits=67 status=0 QTime=0
   [junit4]   2> 428132 INFO  (qtp768002302-10736) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={df=text&distrib=false&shards.purpose=64&shard.url=https://127.0.0.1:40141/kdby/i/collection1&rows=200&rid=127.0.0.1-76464&version=2&q=*:*&omitHeader=false&NOW=1604143953060&ids=110,111,112,113,114,115,116,117,118,119,10,11,12,13,14,15,16,17,120,121,122,1,123,2,124,3,125,4,126,5,127,6,128,7,129,8,9,130,131,132,133,134,135,136,137,138,139,140,141,142,143,144,100,145,101,146,102,147,103,148,104,149,105,106,107,108,109&isShard=true&wt=javabin}
 status=0 QTime=0
   [junit4]   2> 428132 INFO  (qtp768002302-10734) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={q=*:*&shards=https://127.0.0.1:40141/kdby/i/collection1&sort=three_l1_ml+desc,+id_i+asc&rows=200&wt=javabin&version=2}
 rid=127.0.0.1-76464 hits=67 status=0 QTime=1
   [junit4]   2> 428133 INFO  (qtp2055991899-10733) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={q=*:*&distrib=false&sort=three_l1_ml+asc,+id_i+desc&rows=200&wt=javabin&version=2}
 hits=67 status=0 QTime=0
   [junit4]   2> 428135 INFO  (qtp768002302-10734) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=three_l1_ml+asc,+id_i+desc&shard.url=https://127.0.0.1:40141/kdby/i/collection1|[::1]:8/kdby/i|[::1]:6/kdby/i&rows=200&rid=127.0.0.1-76466&version=2&q=*:*&omitHeader=false&NOW=1604143953063&isShard=true&wt=javabin}
 hits=67 status=0 QTime=0
   [junit4]   2> 428140 INFO  (qtp768002302-10734) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={df=text&distrib=false&shards.purpose=64&shard.url=https://127.0.0.1:40141/kdby/i/collection1|[::1]:8/kdby/i|[::1]:6/kdby/i&rows=200&rid=127.0.0.1-76466&version=2&q=*:*&omitHeader=false&NOW=1604143953063&ids=110,111,112,113,114,115,116,117,118,119,10,11,12,13,14,15,16,17,120,121,122,1,123,2,124,3,125,4,126,5,127,6,128,7,129,8,9,130,131,132,133,134,135,136,137,138,139,140,141,142,143,100,144,101,145,102,146,103,147,104,148,105,149,106,107,108,109&isShard=true&wt=javabin}
 status=0 QTime=5
   [junit4]   2> 428142 INFO  (qtp768002302-10736) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={q=*:*&shards=https://127.0.0.1:40141/kdby/i/collection1|[::1]:8/kdby/i|[::1]:6/kdby/i&sort=three_l1_ml+asc,+id_i+desc&rows=200&wt=javabin&version=2}
 rid=127.0.0.1-76466 hits=67 status=0 QTime=7
   [junit4]   2> 428143 INFO  (qtp2055991899-10731) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={q=*:*&distrib=false&sort=five_s1_ml+desc&rows=13&wt=javabin&version=2} 
hits=67 status=0 QTime=0
   [junit4]   2> 428144 INFO  (qtp768002302-10736) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=five_s1_ml+desc&shard.url=[::1]:8/kdby/i|https://127.0.0.1:40141/kdby/i/collection1|[::1]:4/kdby/i|[::1]:6/kdby/i&rows=13&rid=127.0.0.1-76468&version=2&q=*:*&omitHeader=false&NOW=1604143953073&isShard=true&wt=javabin}
 hits=67 status=0 QTime=0
   [junit4]   2> 428145 INFO  (qtp768002302-10736) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={df=text&distrib=false&shards.purpose=64&shard.url=[::1]:8/kdby/i|https://127.0.0.1:40141/kdby/i/collection1|[::1]:4/kdby/i|[::1]:6/kdby/i&rows=13&rid=127.0.0.1-76468&version=2&q=*:*&omitHeader=false&NOW=1604143953073&ids=11,12,13,1,2,3,4,5,6,7,8,9,10&isShard=true&wt=javabin}
 status=0 QTime=0
   [junit4]   2> 428145 INFO  (qtp768002302-10734) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={q=*:*&shards=[::1]:8/kdby/i|https://127.0.0.1:40141/kdby/i/collection1|[::1]:4/kdby/i|[::1]:6/kdby/i&sort=five_s1_ml+desc&rows=13&wt=javabin&version=2}
 rid=127.0.0.1-76468 hits=67 status=0 QTime=1
   [junit4]   2> 428146 INFO  (qtp2055991899-10733) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={q=*:*&distrib=false&sort=five_s1_ml+asc&rows=13&wt=javabin&version=2} 
hits=67 status=0 QTime=0
   [junit4]   2> 428147 INFO  (qtp768002302-10734) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=five_s1_ml+asc&shard.url=https://127.0.0.1:40141/kdby/i/collection1|[::1]:4/kdby/i|[::1]:8/kdby/i&rows=13&rid=127.0.0.1-76470&version=2&q=*:*&omitHeader=false&NOW=1604143953076&isShard=true&wt=javabin}
 hits=67 status=0 QTime=0
   [junit4]   2> 428149 INFO  (qtp768002302-10734) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={df=text&distrib=false&shards.purpose=64&shard.url=https://127.0.0.1:40141/kdby/i/collection1|[::1]:4/kdby/i|[::1]:8/kdby/i&rows=13&rid=127.0.0.1-76470&version=2&q=*:*&omitHeader=false&NOW=1604143953076&ids=11,12,13,1,2,3,4,5,6,7,8,9,10&isShard=true&wt=javabin}
 status=0 QTime=0
   [junit4]   2> 428152 INFO  (qtp768002302-10736) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={q=*:*&shards=https://127.0.0.1:40141/kdby/i/collection1|[::1]:4/kdby/i|[::1]:8/kdby/i&sort=five_s1_ml+asc&rows=13&wt=javabin&version=2}
 rid=127.0.0.1-76470 hits=67 status=0 QTime=5
   [junit4]   2> 428153 INFO  (qtp2055991899-10731) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={q=*:*&distrib=false&sort=five_s1_ml+desc,+id_i+asc&rows=200&wt=javabin&version=2}
 hits=67 status=0 QTime=0
   [junit4]   2> 428155 INFO  (qtp768002302-10736) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=five_s1_ml+desc,+id_i+asc&shard.url=[::1]:8/kdby/i|https://127.0.0.1:40141/kdby/i/collection1&rows=200&rid=127.0.0.1-76472&version=2&q=*:*&omitHeader=false&NOW=1604143953084&isShard=true&wt=javabin}
 hits=67 status=0 QTime=0
   [junit4]   2> 428156 INFO  (qtp768002302-10736) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={df=text&distrib=false&shards.purpose=64&shard.url=[::1]:8/kdby/i|https://127.0.0.1:40141/kdby/i/collection1&rows=200&rid=127.0.0.1-76472&version=2&q=*:*&omitHeader=false&NOW=1604143953084&ids=110,111,112,113,114,115,116,117,118,119,10,11,12,13,14,15,16,17,120,121,122,1,123,2,124,3,125,4,126,5,127,6,128,7,129,8,9,130,131,132,133,134,135,136,137,138,139,140,141,142,143,144,100,145,101,146,102,147,103,148,104,149,105,106,107,108,109&isShard=true&wt=javabin}
 status=0 QTime=0
   [junit4]   2> 428157 INFO  (qtp768002302-10734) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={q=*:*&shards=[::1]:8/kdby/i|https://127.0.0.1:40141/kdby/i/collection1&sort=five_s1_ml+desc,+id_i+asc&rows=200&wt=javabin&version=2}
 rid=127.0.0.1-76472 hits=67 status=0 QTime=2
   [junit4]   2> 428158 INFO  (qtp2055991899-10733) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={q=*:*&distrib=false&sort=five_s1_ml+asc,+id_i+desc&rows=200&wt=javabin&version=2}
 hits=67 status=0 QTime=0
   [junit4]   2> 428160 INFO  (qtp768002302-10734) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=five_s1_ml+asc,+id_i+desc&shard.url=https://127.0.0.1:40141/kdby/i/collection1&rows=200&rid=127.0.0.1-76474&version=2&q=*:*&omitHeader=false&NOW=1604143953088&isShard=true&wt=javabin}
 hits=67 status=0 QTime=0
   [junit4]   2> 428161 INFO  (qtp768002302-10734) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={df=text&distrib=false&shards.purpose=64&shard.url=https://127.0.0.1:40141/kdby/i/collection1&rows=200&rid=127.0.0.1-76474&version=2&q=*:*&omitHeader=false&NOW=1604143953088&ids=110,111,112,113,114,115,116,117,118,119,10,11,12,13,14,15,16,17,120,121,122,1,123,2,124,3,125,4,126,5,127,6,128,7,129,8,9,130,131,132,133,134,135,136,137,138,139,140,141,142,143,100,144,101,145,102,146,103,147,104,148,105,149,106,107,108,109&isShard=true&wt=javabin}
 status=0 QTime=0
   [junit4]   2> 428161 INFO  (qtp768002302-10736) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={q=*:*&shards=https://127.0.0.1:40141/kdby/i/collection1&sort=five_s1_ml+asc,+id_i+desc&rows=200&wt=javabin&version=2}
 rid=127.0.0.1-76474 hits=67 status=0 QTime=2
   [junit4]   2> 428162 INFO  (qtp2055991899-10731) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={q=*:*&distrib=false&sort=two_i1_mf+desc,+id_i+asc&rows=200&wt=javabin&version=2}
 hits=67 status=0 QTime=0
   [junit4]   2> 428167 INFO  (qtp768002302-10736) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=two_i1_mf+desc,+id_i+asc&shard.url=[::1]:8/kdby/i|[::1]:4/kdby/i|[::1]:6/kdby/i|https://127.0.0.1:40141/kdby/i/collection1&rows=200&rid=127.0.0.1-76476&version=2&q=*:*&omitHeader=false&NOW=1604143953092&isShard=true&wt=javabin}
 hits=67 status=0 QTime=0
   [junit4]   2> 428168 INFO  (qtp768002302-10736) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={df=text&distrib=false&shards.purpose=64&shard.url=[::1]:8/kdby/i|[::1]:4/kdby/i|[::1]:6/kdby/i|https://127.0.0.1:40141/kdby/i/collection1&rows=200&rid=127.0.0.1-76476&version=2&q=*:*&omitHeader=false&NOW=1604143953092&ids=110,111,112,113,114,115,116,117,118,119,10,11,12,13,14,15,16,17,120,121,1,122,2,123,3,124,4,125,5,126,6,127,7,128,8,129,9,130,131,132,133,134,135,136,137,138,139,140,141,142,143,144,100,145,101,146,102,147,103,148,104,149,105,106,107,108,109&isShard=true&wt=javabin}
 status=0 QTime=0
   [junit4]   2> 428168 INFO  (qtp768002302-10734) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={q=*:*&shards=[::1]:8/kdby/i|[::1]:4/kdby/i|[::1]:6/kdby/i|https://127.0.0.1:40141/kdby/i/collection1&sort=two_i1_mf+desc,+id_i+asc&rows=200&wt=javabin&version=2}
 rid=127.0.0.1-76476 hits=67 status=0 QTime=5
   [junit4]   2> 428169 INFO  (qtp2055991899-10733) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={q=*:*&distrib=false&sort=two_i1_mf+asc,+id_i+desc&rows=200&wt=javabin&version=2}
 hits=67 status=0 QTime=0
   [junit4]   2> 428171 INFO  (qtp768002302-10734) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=two_i1_mf+asc,+id_i+desc&shard.url=[::1]:4/kdby/i|[::1]:8/kdby/i|https://127.0.0.1:40141/kdby/i/collection1|[::1]:6/kdby/i&rows=200&rid=127.0.0.1-76478&version=2&q=*:*&omitHeader=false&NOW=1604143953099&isShard=true&wt=javabin}
 hits=67 status=0 QTime=0
   [junit4]   2> 428172 INFO  (qtp768002302-10734) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={df=text&distrib=false&shards.purpose=64&shard.url=[::1]:4/kdby/i|[::1]:8/kdby/i|https://127.0.0.1:40141/kdby/i/collection1|[::1]:6/kdby/i&rows=200&rid=127.0.0.1-76478&version=2&q=*:*&omitHeader=false&NOW=1604143953099&ids=110,111,112,113,114,115,116,117,118,119,10,11,12,13,14,15,16,17,120,121,1,122,2,123,3,124,4,125,5,126,6,127,7,128,8,129,9,130,131,132,133,134,135,136,137,138,139,140,141,142,143,100,144,101,145,102,146,103,147,104,148,105,149,106,107,108,109&isShard=true&wt=javabin}
 status=0 QTime=0
   [junit4]   2> 428173 INFO  (qtp768002302-10736) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={q=*:*&shards=[::1]:4/kdby/i|[::1]:8/kdby/i|https://127.0.0.1:40141/kdby/i/collection1|[::1]:6/kdby/i&sort=two_i1_mf+asc,+id_i+desc&rows=200&wt=javabin&version=2}
 rid=127.0.0.1-76478 hits=67 status=0 QTime=2
   [junit4]   2> 428174 INFO  (qtp2055991899-10731) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={q=*:*&distrib=false&sort=four_l1_mf+desc,+id_i+asc&rows=200&wt=javabin&version=2}
 hits=67 status=0 QTime=0
   [junit4]   2> 428176 INFO  (qtp768002302-10736) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=four_l1_mf+desc,+id_i+asc&shard.url=https://127.0.0.1:40141/kdby/i/collection1|[::1]:8/kdby/i|[::1]:4/kdby/i|[::1]:6/kdby/i&rows=200&rid=127.0.0.1-76480&version=2&q=*:*&omitHeader=false&NOW=1604143953104&isShard=true&wt=javabin}
 hits=67 status=0 QTime=0
   [junit4]   2> 428177 INFO  (qtp768002302-10736) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={df=text&distrib=false&shards.purpose=64&shard.url=https://127.0.0.1:40141/kdby/i/collection1|[::1]:8/kdby/i|[::1]:4/kdby/i|[::1]:6/kdby/i&rows=200&rid=127.0.0.1-76480&version=2&q=*:*&omitHeader=false&NOW=1604143953104&ids=110,111,112,113,114,115,116,117,118,119,10,11,12,13,14,15,16,17,120,121,1,122,2,123,3,124,4,125,5,126,6,127,7,128,8,129,9,130,131,132,133,134,135,136,137,138,139,140,141,142,143,144,100,145,101,146,102,147,103,148,104,149,105,106,107,108,109&isShard=true&wt=javabin}
 status=0 QTime=0
   [junit4]   2> 428178 INFO  (qtp768002302-10734) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={q=*:*&shards=https://127.0.0.1:40141/kdby/i/collection1|[::1]:8/kdby/i|[::1]:4/kdby/i|[::1]:6/kdby/i&sort=four_l1_mf+desc,+id_i+asc&rows=200&wt=javabin&version=2}
 rid=127.0.0.1-76480 hits=67 status=0 QTime=3
   [junit4]   2> 428179 INFO  (qtp2055991899-10733) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={q=*:*&distrib=false&sort=four_l1_mf+asc,+id_i+desc&rows=200&wt=javabin&version=2}
 hits=67 status=0 QTime=0
   [junit4]   2> 428181 INFO  (qtp768002302-10734) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/kdby/i path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=four_l1_mf+asc,+id_i+desc&shard.url=[::1]:4/kdby/i|[::1]:8/kdby/i|https://127.0.0.1:40141/kdby/i/collection1|[::1]:6/kdby/i&rows=200&rid=127.0.0.1-76482&version=2&q=*:*&omitHeader=false&NOW=1604143953109&isShard=true&wt=javabin}
 hits=67 status=0 QTime=0
   

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

Stopped o.e.j.s.ServletContextHandler@83dc401{/kdby/i,null,STOPPED}
   [junit4]   2> 429506 INFO  (closeThreadPool-5805-thread-1) [     ] 
o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 429508 INFO  (coreCloseExecutor-5814-thread-1) [     ] 
o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close()  ... SKIPPED 
(unnecessary).
   [junit4]   2> 429517 INFO  (closeThreadPool-5805-thread-4) [     ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node 
tag=null
   [junit4]   2> 429517 INFO  (closeThreadPool-5805-thread-4) [     ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@70cff94d: rootName = null, 
domain = solr.node, service url = null, agent id = null] for registry 
solr.node/com.codahale.metrics.MetricRegistry@68552c6c
   [junit4]   2> 429520 INFO  (closeThreadPool-5805-thread-4) [     ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm 
tag=null
   [junit4]   2> 429520 INFO  (closeThreadPool-5805-thread-4) [     ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@6b25a638: rootName = null, 
domain = solr.jvm, service url = null, agent id = null] for registry 
solr.jvm/com.codahale.metrics.MetricRegistry@40c598eb
   [junit4]   2> 429522 INFO  (closeThreadPool-5805-thread-4) [     ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty 
tag=null
   [junit4]   2> 429522 INFO  (closeThreadPool-5805-thread-4) [     ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@2bbd0df: rootName = null, 
domain = solr.jetty, service url = null, agent id = null] for registry 
solr.jetty/com.codahale.metrics.MetricRegistry@527ec726
   [junit4]   2> 429525 INFO  (closeThreadPool-5805-thread-4) [     ] 
o.e.j.s.AbstractConnector Stopped ServerConnector@676ee32e{ssl, (ssl, alpn, 
http/1.1, h2)}{127.0.0.1:0}
   [junit4]   2> 429525 INFO  (closeThreadPool-5805-thread-4) [     ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@acae716{/kdby/i,null,STOPPED}
   [junit4]   2> 429525 INFO  (closeThreadPool-5805-thread-4) [     ] 
o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=TestDistributedMissingSort -Dtests.method=test 
-Dtests.seed=74AC1D7E2A30F763 -Dtests.multiplier=3 -Dtests.slow=true 
-Dtests.locale=en-UG -Dtests.timezone=America/Merida -Dtests.asserts=true 
-Dtests.file.encoding=US-ASCII
   [junit4] ERROR   2.04s J2 | TestDistributedMissingSort.test <<<
   [junit4]    > Throwable #1: 
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error 
from server at https://127.0.0.1:35143/kdby/i/collection1: 
org.apache.solr.client.solrj.SolrServerException: 
java.lang.ArithmeticException: / by zero
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([74AC1D7E2A30F763:FCF822A484CC9A9B]:0)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:681)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:266)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:248)
   [junit4]    >        at 
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:214)
   [junit4]    >        at 
org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:1003)
   [junit4]    >        at 
org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:1018)
   [junit4]    >        at 
org.apache.solr.BaseDistributedSearchTestCase.queryServer(BaseDistributedSearchTestCase.java:625)
   [junit4]    >        at 
org.apache.solr.BaseDistributedSearchTestCase.query(BaseDistributedSearchTestCase.java:677)
   [junit4]    >        at 
org.apache.solr.BaseDistributedSearchTestCase.query(BaseDistributedSearchTestCase.java:655)
   [junit4]    >        at 
org.apache.solr.BaseDistributedSearchTestCase.query(BaseDistributedSearchTestCase.java:634)
   [junit4]    >        at 
org.apache.solr.TestDistributedMissingSort.testSortMissingLast(TestDistributedMissingSort.java:175)
   [junit4]    >        at 
org.apache.solr.TestDistributedMissingSort.test(TestDistributedMissingSort.java:43)
   [junit4]    >        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   [junit4]    >        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
   [junit4]    >        at 
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   [junit4]    >        at 
java.base/java.lang.reflect.Method.invoke(Method.java:567)
   [junit4]    >        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsRepeatStatement.callStatement(BaseDistributedSearchTestCase.java:1117)
   [junit4]    >        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:1061)
   [junit4]    >        at java.base/java.lang.Thread.run(Thread.java:830)
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J2/temp/solr.TestDistributedMissingSort_74AC1D7E2A30F763-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene87): 
{six_s1_mf=PostingsFormat(name=Asserting), 
rnd_b=PostingsFormat(name=Asserting), SubjectTerms_mfacet=Lucene84, 
foo_b=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)), 
id=PostingsFormat(name=Asserting), 
five_s1_ml=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84))},
 docValues:{two_i1_mf=DocValuesFormat(name=Direct), 
one_i1_ml=DocValuesFormat(name=Direct), n_l1=DocValuesFormat(name=Lucene80), 
n_dt1=DocValuesFormat(name=Lucene80), n_td1=DocValuesFormat(name=Lucene80), 
n_d1=DocValuesFormat(name=Lucene80), n_f1=DocValuesFormat(name=Lucene80), 
n_ti1=DocValuesFormat(name=Asserting), n_tl1=DocValuesFormat(name=Lucene80), 
id_i=DocValuesFormat(name=Direct), _version_=DocValuesFormat(name=Lucene80), 
n_tf1=DocValuesFormat(name=Lucene80), n_tdt1=DocValuesFormat(name=Lucene80), 
foo_d=DocValuesFormat(name=Asserting), 
three_l1_ml=DocValuesFormat(name=Lucene80), foo_f=DocValuesFormat(name=Direct), 
four_l1_mf=DocValuesFormat(name=Lucene80)}, maxPointsInLeafNode=2046, 
maxMBSortInHeap=6.553148565396194, 
sim=Asserting(RandomSimilarity(queryNorm=false): {}), locale=en-UG, 
timezone=America/Merida
   [junit4]   2> NOTE: Linux 5.4.0-52-generic amd64/AdoptOpenJDK 13.0.2 
(64-bit)/cpus=16,threads=1,free=144568736,total=527433728
   [junit4]   2> NOTE: All tests run in this JVM: [TestFunctionQuery, 
SolrCoreCheckLockOnStartupTest, HttpSolrCallGetCoreTest, IndexSchemaTest, 
BlockJoinFacetDistribTest, TestDistributedGrouping, TestRemoteStreaming, 
JSONWriterTest, RandomizedTaggerTest, TestShortCircuitedRequests, 
MetricsHistoryHandlerTest, SuggestComponentTest, TestSimDistributedQueue, 
TestFieldTypeResource, IgnoreCommitOptimizeUpdateProcessorFactoryTest, 
TestLegacyFieldReuse, ConfigureRecoveryStrategyTest, HdfsDirectoryTest, 
FacetPivotSmallTest, TestSearcherReuse, TestBlobHandler, 
AtomicUpdateRemovalJavabinTest, AnalyticsMergeStrategyTest, 
TestHdfsCloudBackupRestore, TestCaffeineCache, CoreAdminHandlerTest, 
SplitHandlerTest, DistribJoinFromCollectionTest, TestHttpServletCarrier, 
TriggerEventQueueTest, HdfsThreadLeakTest, HdfsCollectionsAPIDistributedZkTest, 
TestEmbeddedSolrServerConstructors, TestSimNodeLostTrigger, 
TestNumericTokenStream, TestSolrCoreParser, V2StandaloneTest, 
TestInPlaceUpdatesDistrib, TestDynamicFieldNamesIndexCorrectly, 
TestLuceneMatchVersion, TestCorePropertiesReload, 
NodeLostTriggerIntegrationTest, CircularListTest, TemplateUpdateProcessorTest, 
DeleteNodeTest, TestSubQueryTransformerCrossCore, TransactionLogTest, 
ChaosMonkeyNothingIsSafeWithPullReplicasTest, TestJoin, 
TestConfigSetsAPIZkFailure, MoveReplicaTest, TestMultiWordSynonyms, 
DirectUpdateHandlerTest, RangeFacetCloudTest, 
DistributedQueryComponentCustomSortTest, LeaderElectionTest, 
CloneFieldUpdateProcessorFactoryTest, ReturnFieldsTest, 
TestQuerySenderListener, ShardRoutingCustomTest, SolrMetricManagerTest, 
TestTolerantUpdateProcessorRandomCloud, TestTermsQParserPlugin, 
TestFieldCacheSort, AutoScalingHandlerTest, OverseerStatusTest, 
TestManagedSchemaAPI, IndexSizeTriggerSizeEstimationTest, DocValuesMissingTest, 
HdfsChaosMonkeySafeLeaderTest, TestSafeXMLParsing, HighlighterConfigTest, 
NumberUtilsTest, TestRealTimeGet, SolrIndexMetricsTest, BasicFunctionalityTest, 
CursorPagingTest, EchoParamsTest, MinimalSchemaTest, OutputWriterTest, 
SampleTest, SolrInfoBeanTest, SolrTestCaseJ4Test, TestDistributedMissingSort]
   [junit4] Completed [401/921 (1!)] on J2 in 2.26s, 1 test, 1 error <<< 
FAILURES!

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

[repro] Revision: 5b79ad3d64638556b04528bd941be3e41fc66a3a

[repro] Ant options: "-Dargs=-XX:-UseCompressedOops -XX:+UseParallelGC"
[repro] Repro line:  ant test  -Dtestcase=TestDistributedMissingSort 
-Dtests.method=test -Dtests.seed=74AC1D7E2A30F763 -Dtests.multiplier=3 
-Dtests.slow=true -Dtests.locale=en-UG -Dtests.timezone=America/Merida 
-Dtests.asserts=true -Dtests.file.encoding=US-ASCII

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

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

[...truncated 3455 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5 
-Dtests.class="*.TestDistributedMissingSort" -Dtests.showOutput=onerror 
"-Dargs=-XX:-UseCompressedOops -XX:+UseParallelGC" 
-Dtests.seed=74AC1D7E2A30F763 -Dtests.multiplier=3 -Dtests.slow=true 
-Dtests.locale=en-UG -Dtests.timezone=America/Merida -Dtests.asserts=true 
-Dtests.file.encoding=US-ASCII

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

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

Reply via email to