Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Linux/2273/
Java: 32bit/jdk1.8.0_172 -client -XX:+UseSerialGC

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

Error Message:
Expected to find shardAddress in the up shard info: 
{error=org.apache.solr.client.solrj.SolrServerException: Time allowed to handle 
this request exceeded,trace=org.apache.solr.client.solrj.SolrServerException: 
Time allowed to handle this request exceeded  at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:460)
  at 
org.apache.solr.handler.component.HttpShardHandlerFactory.makeLoadBalancedRequest(HttpShardHandlerFactory.java:279)
  at 
org.apache.solr.handler.component.HttpShardHandler.lambda$submit$0(HttpShardHandler.java:175)
  at java.util.concurrent.FutureTask.run(FutureTask.java:266)  at 
java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)  at 
java.util.concurrent.FutureTask.run(FutureTask.java:266)  at 
com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:176)
  at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209)
  at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) 
 at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) 
 at java.lang.Thread.run(Thread.java:748) ,time=12}

Stack Trace:
java.lang.AssertionError: Expected to find shardAddress in the up shard info: 
{error=org.apache.solr.client.solrj.SolrServerException: Time allowed to handle 
this request exceeded,trace=org.apache.solr.client.solrj.SolrServerException: 
Time allowed to handle this request exceeded
        at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:460)
        at 
org.apache.solr.handler.component.HttpShardHandlerFactory.makeLoadBalancedRequest(HttpShardHandlerFactory.java:279)
        at 
org.apache.solr.handler.component.HttpShardHandler.lambda$submit$0(HttpShardHandler.java:175)
        at java.util.concurrent.FutureTask.run(FutureTask.java:266)
        at 
java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
        at java.util.concurrent.FutureTask.run(FutureTask.java:266)
        at 
com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:176)
        at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209)
        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
        at java.lang.Thread.run(Thread.java:748)
,time=12}
        at 
__randomizedtesting.SeedInfo.seed([CE529A2E7A9C3BDA:4606A5F4D4605622]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.assertTrue(Assert.java:43)
        at 
org.apache.solr.TestDistributedSearch.comparePartialResponses(TestDistributedSearch.java:1192)
        at 
org.apache.solr.TestDistributedSearch.queryPartialResults(TestDistributedSearch.java:1133)
        at 
org.apache.solr.TestDistributedSearch.test(TestDistributedSearch.java:993)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsRepeatStatement.callStatement(BaseDistributedSearchTestCase.java:1034)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:983)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.lang.Thread.run(Thread.java:748)




Build Log:
[...truncated 13869 lines...]
   [junit4] Suite: org.apache.solr.TestDistributedSearch
   [junit4]   2> 1555261 INFO  
(SUITE-TestDistributedSearch-seed#[CE529A2E7A9C3BDA]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> Creating dataDir: 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_CE529A2E7A9C3BDA-001/init-core-data-001
   [junit4]   2> 1555261 WARN  
(SUITE-TestDistributedSearch-seed#[CE529A2E7A9C3BDA]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=1 numCloses=1
   [junit4]   2> 1555262 INFO  
(SUITE-TestDistributedSearch-seed#[CE529A2E7A9C3BDA]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 1555263 INFO  
(SUITE-TestDistributedSearch-seed#[CE529A2E7A9C3BDA]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: 
@org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl=https://issues.apache.org/jira/browse/SOLR-9061)
   [junit4]   2> 1555263 INFO  
(SUITE-TestDistributedSearch-seed#[CE529A2E7A9C3BDA]-worker) [    ] 
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: 
/jhlig/m
   [junit4]   2> 1555364 INFO  
(TEST-TestDistributedSearch.test-seed#[CE529A2E7A9C3BDA]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_CE529A2E7A9C3BDA-001/tempDir-001/control/cores/collection1
   [junit4]   2> 1555366 INFO  
(TEST-TestDistributedSearch.test-seed#[CE529A2E7A9C3BDA]) [    ] o.e.j.s.Server 
jetty-9.4.11.v20180605; built: 2018-06-05T18:24:03.829Z; git: 
d5fc0523cfa96bfebfbda19606cad384d772f04c; jvm 1.8.0_172-b11
   [junit4]   2> 1555367 INFO  
(TEST-TestDistributedSearch.test-seed#[CE529A2E7A9C3BDA]) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1555367 INFO  
(TEST-TestDistributedSearch.test-seed#[CE529A2E7A9C3BDA]) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1555367 INFO  
(TEST-TestDistributedSearch.test-seed#[CE529A2E7A9C3BDA]) [    ] 
o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 1555368 INFO  
(TEST-TestDistributedSearch.test-seed#[CE529A2E7A9C3BDA]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@3873ad{/jhlig/m,null,AVAILABLE}
   [junit4]   2> 1555383 INFO  
(TEST-TestDistributedSearch.test-seed#[CE529A2E7A9C3BDA]) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@1b4cb09{HTTP/1.1,[http/1.1]}{127.0.0.1:43311}
   [junit4]   2> 1555383 INFO  
(TEST-TestDistributedSearch.test-seed#[CE529A2E7A9C3BDA]) [    ] o.e.j.s.Server 
Started @1555421ms
   [junit4]   2> 1555384 INFO  
(TEST-TestDistributedSearch.test-seed#[CE529A2E7A9C3BDA]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/jhlig/m, 
hostPort=43311, 
coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_CE529A2E7A9C3BDA-001/tempDir-001/control/cores}
   [junit4]   2> 1555384 ERROR 
(TEST-TestDistributedSearch.test-seed#[CE529A2E7A9C3BDA]) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1555384 INFO  
(TEST-TestDistributedSearch.test-seed#[CE529A2E7A9C3BDA]) [    ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1555384 INFO  
(TEST-TestDistributedSearch.test-seed#[CE529A2E7A9C3BDA]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
7.5.0
   [junit4]   2> 1555384 INFO  
(TEST-TestDistributedSearch.test-seed#[CE529A2E7A9C3BDA]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 1555384 INFO  
(TEST-TestDistributedSearch.test-seed#[CE529A2E7A9C3BDA]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1555384 INFO  
(TEST-TestDistributedSearch.test-seed#[CE529A2E7A9C3BDA]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-07-06T19:43:55.686Z
   [junit4]   2> 1555385 INFO  
(TEST-TestDistributedSearch.test-seed#[CE529A2E7A9C3BDA]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_CE529A2E7A9C3BDA-001/tempDir-001/control/solr.xml
   [junit4]   2> 1555389 INFO  
(TEST-TestDistributedSearch.test-seed#[CE529A2E7A9C3BDA]) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay 
is ignored
   [junit4]   2> 1555389 INFO  
(TEST-TestDistributedSearch.test-seed#[CE529A2E7A9C3BDA]) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 1555391 INFO  
(TEST-TestDistributedSearch.test-seed#[CE529A2E7A9C3BDA]) [    ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@97ade7, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 1557233 INFO  
(TEST-TestDistributedSearch.test-seed#[CE529A2E7A9C3BDA]) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 1557233 INFO  
(TEST-TestDistributedSearch.test-seed#[CE529A2E7A9C3BDA]) [    ] 
o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history 
in memory.
   [junit4]   2> 1557248 INFO  
(TEST-TestDistributedSearch.test-seed#[CE529A2E7A9C3BDA]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@97ade7
   [junit4]   2> 1557258 INFO  
(TEST-TestDistributedSearch.test-seed#[CE529A2E7A9C3BDA]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@97ade7
   [junit4]   2> 1557258 INFO  
(TEST-TestDistributedSearch.test-seed#[CE529A2E7A9C3BDA]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@97ade7
   [junit4]   2> 1557260 INFO  
(TEST-TestDistributedSearch.test-seed#[CE529A2E7A9C3BDA]) [    ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_CE529A2E7A9C3BDA-001/tempDir-001/control/cores
   [junit4]   2> 1557260 INFO  
(TEST-TestDistributedSearch.test-seed#[CE529A2E7A9C3BDA]) [    ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 1557266 INFO  (coreLoadExecutor-4735-thread-1) [    
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, 
from paths: 
[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/lib,
 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1557308 INFO  (coreLoadExecutor-4735-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.5.0
   [junit4]   2> 1557343 INFO  (coreLoadExecutor-4735-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1557437 INFO  (coreLoadExecutor-4735-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1557447 INFO  (coreLoadExecutor-4735-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from configset 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1,
 trusted=true
   [junit4]   2> 1557448 INFO  (coreLoadExecutor-4735-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@97ade7
   [junit4]   2> 1557448 INFO  (coreLoadExecutor-4735-thread-1) [    
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 1557448 INFO  (coreLoadExecutor-4735-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_CE529A2E7A9C3BDA-001/tempDir-001/control/cores/collection1/data/]
   [junit4]   2> 1557451 INFO  (coreLoadExecutor-4735-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=17, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=1.0]
   [junit4]   2> 1557518 INFO  (coreLoadExecutor-4735-thread-1) [    
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1557518 INFO  (coreLoadExecutor-4735-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 1557519 INFO  (coreLoadExecutor-4735-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1557519 INFO  (coreLoadExecutor-4735-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1557520 INFO  (coreLoadExecutor-4735-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: 
minMergeSize=0, mergeFactor=10, maxMergeSize=1679387207, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.1]
   [junit4]   2> 1557521 INFO  (coreLoadExecutor-4735-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@d5616c[collection1] 
main]
   [junit4]   2> 1557522 INFO  (coreLoadExecutor-4735-thread-1) [    
x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1557543 INFO  (coreLoadExecutor-4735-thread-1) [    
x:collection1] o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 1557630 INFO  (coreLoadExecutor-4735-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 1557630 INFO  (coreLoadExecutor-4735-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1605271539345784832
   [junit4]   2> 1557630 INFO  
(searcherExecutor-4736-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1557631 INFO  
(searcherExecutor-4736-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1557631 INFO  
(searcherExecutor-4736-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1557631 INFO  
(searcherExecutor-4736-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 1557631 INFO  
(searcherExecutor-4736-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1557631 INFO  
(searcherExecutor-4736-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1557632 INFO  
(searcherExecutor-4736-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1557632 INFO  
(searcherExecutor-4736-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 1557632 INFO  
(searcherExecutor-4736-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 1557634 INFO  
(searcherExecutor-4736-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@d5616c[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1557732 INFO  
(TEST-TestDistributedSearch.test-seed#[CE529A2E7A9C3BDA]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_CE529A2E7A9C3BDA-001/tempDir-001/shard0/cores/collection1
   [junit4]   2> 1557733 INFO  
(TEST-TestDistributedSearch.test-seed#[CE529A2E7A9C3BDA]) [    ] o.e.j.s.Server 
jetty-9.4.11.v20180605; built: 2018-06-05T18:24:03.829Z; git: 
d5fc0523cfa96bfebfbda19606cad384d772f04c; jvm 1.8.0_172-b11
   [junit4]   2> 1557737 INFO  
(TEST-TestDistributedSearch.test-seed#[CE529A2E7A9C3BDA]) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1557737 INFO  
(TEST-TestDistributedSearch.test-seed#[CE529A2E7A9C3BDA]) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1557737 INFO  
(TEST-TestDistributedSearch.test-seed#[CE529A2E7A9C3BDA]) [    ] 
o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 1557737 INFO  
(TEST-TestDistributedSearch.test-seed#[CE529A2E7A9C3BDA]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@34a893{/jhlig/m,null,AVAILABLE}
   [junit4]   2> 1557738 INFO  
(TEST-TestDistributedSearch.test-seed#[CE529A2E7A9C3BDA]) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@1c19ba{HTTP/1.1,[http/1.1]}{127.0.0.1:44037}
   [junit4]   2> 1557738 INFO  
(TEST-TestDistributedSearch.test-seed#[CE529A2E7A9C3BDA]) [    ] o.e.j.s.Server 
Started @1557775ms
   [junit4]   2> 1557738 INFO  
(TEST-TestDistributedSearch.test-seed#[CE529A2E7A9C3BDA]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/jhlig/m, 
hostPort=44037, 
coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_CE529A2E7A9C3BDA-001/tempDir-001/shard0/cores}
   [junit4]   2> 1557738 ERROR 
(TEST-TestDistributedSearch.test-seed#[CE529A2E7A9C3BDA]) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1557738 INFO  
(TEST-TestDistributedSearch.test-seed#[CE529A2E7A9C3BDA]) [    ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1557738 INFO  
(TEST-TestDistributedSearch.test-seed#[CE529A2E7A9C3BDA]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
7.5.0
   [junit4]   2> 1557738 INFO  
(TEST-TestDistributedSearch.test-seed#[CE529A2E7A9C3BDA]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 1557738 INFO  
(TEST-TestDistributedSearch.test-seed#[CE529A2E7A9C3BDA]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1557738 INFO  
(TEST-TestDistributedSearch.test-seed#[CE529A2E7A9C3BDA]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-07-06T19:43:58.040Z
   [junit4]   2> 1557739 INFO  
(TEST-TestDistributedSearch.test-seed#[CE529A2E7A9C3BDA]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_CE529A2E7A9C3BDA-001/tempDir-001/shard0/solr.xml
   [junit4]   2> 1557742 INFO  
(TEST-TestDistributedSearch.test-seed#[CE529A2E7A9C3BDA]) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay 
is ignored
   [junit4]   2> 1557742 INFO  
(TEST-TestDistributedSearch.test-seed#[CE529A2E7A9C3BDA]) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 1557743 INFO  
(TEST-TestDistributedSearch.test-seed#[CE529A2E7A9C3BDA]) [    ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@97ade7, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 1559524 INFO  
(TEST-TestDistributedSearch.test-seed#[CE529A2E7A9C3BDA]) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 1559525 INFO  
(TEST-TestDistributedSearch.test-seed#[CE529A2E7A9C3BDA]) [    ] 
o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history 
in memory.
   [junit4]   2> 1559549 INFO  
(TEST-TestDistributedSearch.test-seed#[CE529A2E7A9C3BDA]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@97ade7
   [junit4]   2> 1559576 INFO  
(TEST-TestDistributedSearch.test-seed#[CE529A2E7A9C3BDA]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@97ade7
   [junit4]   2> 1559577 INFO  
(TEST-TestDistributedSearch.test-seed#[CE529A2E7A9C3BDA]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@97ade7
   [junit4]   2> 1559579 INFO  
(TEST-TestDistributedSearch.test-seed#[CE529A2E7A9C3BDA]) [    ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_CE529A2E7A9C3BDA-001/tempDir-001/shard0/cores
   [junit4]   2> 1559579 INFO  
(TEST-TestDistributedSearch.test-seed#[CE529A2E7A9C3BDA]) [    ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 1559579 INFO  (coreLoadExecutor-4749-thread-1) [    
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, 
from paths: 
[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/lib,
 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1559611 INFO  (coreLoadExecutor-4749-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.5.0
   [junit4]   2> 1559631 INFO  (coreLoadExecutor-4749-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1559744 INFO  (coreLoadExecutor-4749-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1559756 INFO  (coreLoadExecutor-4749-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from configset 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1,
 trusted=true
   [junit4]   2> 1559756 INFO  (coreLoadExecutor-4749-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@97ade7
   [junit4]   2> 1559757 INFO  (coreLoadExecutor-4749-thread-1) [    
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 1559757 INFO  (coreLoadExecutor-4749-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_CE529A2E7A9C3BDA-001/tempDir-001/shard0/cores/collection1/data/]
   [junit4]   2> 1559759 INFO  (coreLoadExecutor-4749-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=17, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=1.0]
   [junit4]   2> 1559819 INFO  (coreLoadExecutor-4749-thread-1) [    
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1559819 INFO  (coreLoadExecutor-4749-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 1559820 INFO  (coreLoadExecutor-4749-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1559820 INFO  (coreLoadExecutor-4749-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1559821 INFO  (coreLoadExecutor-4749-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: 
minMergeSize=0, mergeFactor=10, maxMergeSize=1679387207, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.1]
   [junit4]   2> 1559822 INFO  (coreLoadExecutor-4749-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1f8038a[collection1] 
main]
   [junit4]   2> 1559823 INFO  (coreLoadExecutor-4749-thread-1) [    
x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1559841 INFO  (coreLoadExecutor-4749-thread-1) [    
x:collection1] o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 1559925 INFO  (coreLoadExecutor-4749-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 1559925 INFO  
(searcherExecutor-4750-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1559925 INFO  (coreLoadExecutor-4749-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1605271541752266752
   [junit4]   2> 1559925 INFO  
(searcherExecutor-4750-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1559925 INFO  
(searcherExecutor-4750-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1559925 INFO  
(searcherExecutor-4750-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 1559926 INFO  
(searcherExecutor-4750-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1559926 INFO  
(searcherExecutor-4750-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1559926 INFO  
(searcherExecutor-4750-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1559926 INFO  
(searcherExecutor-4750-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 1559927 INFO  
(searcherExecutor-4750-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 1559928 INFO  
(TEST-TestDistributedSearch.test-seed#[CE529A2E7A9C3BDA]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting test
   [junit4]   2> 1559929 INFO  
(searcherExecutor-4750-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@1f8038a[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1559932 INFO  (qtp12396988-14966) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{deleteByQuery=*:* (-1605271541757509632)} 0 1
   [junit4]   2> 1559936 INFO  (qtp32750226-14986) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{deleteByQuery=*:* (-1605271541761703936)} 0 1
   [junit4]   2> 1559940 INFO  (qtp12396988-14960) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[1 (1605271541765898240)]} 0 2
   [junit4]   2> 1559960 INFO  (qtp32750226-14980) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[1 (1605271541769043968)]} 0 19
   [junit4]   2> 1559963 INFO  (qtp12396988-14965) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[2 (1605271541791064064)]} 0 1
   [junit4]   2> 1559965 INFO  (qtp32750226-14985) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[2 (1605271541793161216)]} 0 1
   [junit4]   2> 1559968 INFO  (qtp12396988-14964) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[3 (1605271541796306944)]} 0 1
   [junit4]   2> 1559970 INFO  (qtp32750226-14984) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[3 (1605271541798404096)]} 0 1
   [junit4]   2> 1559973 INFO  (qtp12396988-14965) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[4 (1605271541801549824)]} 0 1
   [junit4]   2> 1559975 INFO  (qtp32750226-14985) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[4 (1605271541803646976)]} 0 1
   [junit4]   2> 1559978 INFO  (qtp12396988-14964) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[5 (1605271541806792704)]} 0 1
   [junit4]   2> 1559980 INFO  (qtp32750226-14984) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[5 (1605271541808889856)]} 0 1
   [junit4]   2> 1559983 INFO  (qtp12396988-14965) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[6 (1605271541812035584)]} 0 1
   [junit4]   2> 1559985 INFO  (qtp32750226-14985) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[6 (1605271541814132736)]} 0 0
   [junit4]   2> 1559987 INFO  (qtp12396988-14964) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[7 (1605271541816229888)]} 0 1
   [junit4]   2> 1559989 INFO  (qtp32750226-14984) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[7 (1605271541818327040)]} 0 1
   [junit4]   2> 1559991 INFO  (qtp12396988-14965) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[8 (1605271541820424192)]} 0 1
   [junit4]   2> 1559993 INFO  (qtp32750226-14985) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[8 (1605271541822521344)]} 0 1
   [junit4]   2> 1559996 INFO  (qtp12396988-14964) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[9 (1605271541825667072)]} 0 1
   [junit4]   2> 1559998 INFO  (qtp32750226-14984) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[9 (1605271541827764224)]} 0 0
   [junit4]   2> 1559999 INFO  (qtp12396988-14965) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1605271541829861376,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1559999 INFO  (qtp12396988-14965) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@15408ed 
commitCommandVersion:1605271541829861376
   [junit4]   2> 1560014 INFO  (qtp12396988-14965) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@11db65b[collection1] main]
   [junit4]   2> 1560015 INFO  (qtp12396988-14965) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1560017 INFO  
(searcherExecutor-4736-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@11db65b[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.5.0):C9)))}
   [junit4]   2> 1560018 INFO  (qtp12396988-14965) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 19
   [junit4]   2> 1560020 INFO  (qtp32750226-14985) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1605271541851881472,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1560020 INFO  (qtp32750226-14985) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@1341aaa 
commitCommandVersion:1605271541851881472
   [junit4]   2> 1560031 INFO  (qtp32750226-14985) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@210d34[collection1] main]
   [junit4]   2> 1560031 INFO  (qtp32750226-14985) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1560033 INFO  
(searcherExecutor-4750-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@210d34[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.5.0):C9)))}
   [junit4]   2> 1560033 INFO  (qtp32750226-14985) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 13
   [junit4]   2> 1560037 INFO  (qtp12396988-14964) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[10 (1605271541867610112)]} 0 3
   [junit4]   2> 1560041 INFO  (qtp32750226-14984) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[10 (1605271541871804416)]} 0 2
   [junit4]   2> 1560043 INFO  (qtp12396988-14965) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[11 (1605271541875998720)]} 0 1
   [junit4]   2> 1560045 INFO  (qtp32750226-14985) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[11 (1605271541878095872)]} 0 1
   [junit4]   2> 1560047 INFO  (qtp12396988-14964) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[12 (1605271541880193024)]} 0 0
   [junit4]   2> 1560049 INFO  (qtp32750226-14984) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[12 (1605271541881241600)]} 0 0
   [junit4]   2> 1560051 INFO  (qtp12396988-14965) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[13 (1605271541883338752)]} 0 0
   [junit4]   2> 1560053 INFO  (qtp32750226-14985) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[13 (1605271541885435904)]} 0 0
   [junit4]   2> 1560055 INFO  (qtp12396988-14964) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[1001 (1605271541887533056)]} 0 1
   [junit4]   2> 1560057 INFO  (qtp32750226-14984) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[1001 (1605271541889630208)]} 0 1
   [junit4]   2> 1560060 INFO  (qtp12396988-14965) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[14 (1605271541892775936)]} 0 1
   [junit4]   2> 1560062 INFO  (qtp32750226-14985) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[14 (1605271541894873088)]} 0 0
   [junit4]   2> 1560063 INFO  (qtp12396988-14964) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[15 (1605271541896970240)]} 0 0
   [junit4]   2> 1560065 INFO  (qtp32750226-14984) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[15 (1605271541898018816)]} 0 0
   [junit4]   2> 1560067 INFO  (qtp12396988-14965) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[16 (1605271541900115968)]} 0 0
   [junit4]   2> 1560068 INFO  (qtp32750226-14985) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[16 (1605271541902213120)]} 0 0
   [junit4]   2> 1560070 INFO  (qtp12396988-14964) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[17 (1605271541903261696)]} 0 1
   [junit4]   2> 1560073 INFO  (qtp32750226-14984) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[17 (1605271541906407424)]} 0 1
   [junit4]   2> 1560074 INFO  (qtp12396988-14965) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[100 (1605271541908504576)]} 0 0
   [junit4]   2> 1560076 INFO  (qtp32750226-14985) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[100 (1605271541910601728)]} 0 0
   [junit4]   2> 1560078 INFO  (qtp12396988-14964) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[101 (1605271541911650304)]} 0 0
   [junit4]   2> 1560080 INFO  (qtp32750226-14984) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[101 (1605271541913747456)]} 0 0
   [junit4]   2> 1560082 INFO  (qtp12396988-14965) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[102 (1605271541915844608)]} 0 0
   [junit4]   2> 1560084 INFO  (qtp32750226-14985) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[102 (1605271541917941760)]} 0 1
   [junit4]   2> 1560086 INFO  (qtp12396988-14964) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[103 (1605271541920038912)]} 0 0
   [junit4]   2> 1560088 INFO  (qtp32750226-14984) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[103 (1605271541922136064)]} 0 0
   [junit4]   2> 1560090 INFO  (qtp12396988-14965) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[104 (1605271541925281792)]} 0 0
   [junit4]   2> 1560092 INFO  (qtp32750226-14985) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[104 (1605271541927378944)]} 0 0
   [junit4]   2> 1560094 INFO  (qtp12396988-14964) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[105 (1605271541929476096)]} 0 0
   [junit4]   2> 1560096 INFO  (qtp32750226-14984) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[105 (1605271541930524672)]} 0 0
   [junit4]   2> 1560100 INFO  (qtp12396988-14965) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[106 (1605271541934718976)]} 0 0
   [junit4]   2> 1560102 INFO  (qtp32750226-14985) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[106 (1605271541936816128)]} 0 1
   [junit4]   2> 1560104 INFO  (qtp12396988-14964) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[107 (1605271541939961856)]} 0 0
   [junit4]   2> 1560106 INFO  (qtp32750226-14984) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[107 (1605271541941010432)]} 0 0
   [junit4]   2> 1560108 INFO  (qtp12396988-14965) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[108 (1605271541944156160)]} 0 0
   [junit4]   2> 1560110 INFO  (qtp32750226-14985) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[108 (1605271541945204736)]} 0 0
   [junit4]   2> 1560112 INFO  (qtp12396988-14964) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[109 (1605271541947301888)]} 0 0
   [junit4]   2> 1560114 INFO  (qtp32750226-14984) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[109 (1605271541949399040)]} 0 0
   [junit4]   2> 1560116 INFO  (qtp12396988-14965) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[110 (1605271541951496192)]} 0 0
   [junit4]   2> 1560118 INFO  (qtp32750226-14985) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[110 (1605271541953593344)]} 0 0
   [junit4]   2> 1560125 INFO  (qtp12396988-14964) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[111 (1605271541960933376)]} 0 1
   [junit4]   2> 1560128 INFO  (qtp32750226-14985) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[111 (1605271541964079104)]} 0 0
   [junit4]   2> 1560130 INFO  (qtp12396988-14965) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[112 (1605271541966176256)]} 0 1
   [junit4]   2> 1560132 INFO  (qtp32750226-14985) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[112 (1605271541968273408)]} 0 0
   [junit4]   2> 1560134 INFO  (qtp12396988-14964) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[113 (1605271541971419136)]} 0 1
   [junit4]   2> 1560137 INFO  (qtp32750226-14984) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[113 (1605271541973516288)]} 0 0
   [junit4]   2> 1560139 INFO  (qtp12396988-14965) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[114 (1605271541975613440)]} 0 1
   [junit4]   2> 1560141 INFO  (qtp32750226-14985) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[114 (1605271541978759168)]} 0 0
   [junit4]   2> 1560144 INFO  (qtp12396988-14964) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[115 (1605271541980856320)]} 0 1
   [junit4]   2> 1560146 INFO  (qtp32750226-14984) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[115 (1605271541982953472)]} 0 0
   [junit4]   2> 1560148 INFO  (qtp12396988-14965) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[116 (1605271541985050624)]} 0 1
   [junit4]   2> 1560150 INFO  (qtp32750226-14985) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[116 (1605271541988196352)]} 0 0
   [junit4]   2> 1560152 INFO  (qtp12396988-14964) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[117 (1605271541989244928)]} 0 0
   [junit4]   2> 1560154 INFO  (qtp32750226-14985) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[117 (1605271541991342080)]} 0 0
   [junit4]   2> 1560156 INFO  (qtp12396988-14965) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[118 (1605271541993439232)]} 0 0
   [junit4]   2> 1560158 INFO  (qtp32750226-14984) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[118 (1605271541995536384)]} 0 0
   [junit4]   2> 1560160 INFO  (qtp12396988-14965) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[119 (1605271541997633536)]} 0 0
   [junit4]   2> 1560162 INFO  (qtp32750226-14985) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[119 (1605271541999730688)]} 0 0
   [junit4]   2> 1560164 INFO  (qtp12396988-14964) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[120 (1605271542001827840)]} 0 0
   [junit4]   2> 1560165 INFO  (qtp32750226-14984) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[120 (1605271542003924992)]} 0 0
   [junit4]   2> 1560168 INFO  (qtp12396988-14965) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[121 (1605271542006022144)]} 0 0
   [junit4]   2> 1560171 INFO  (qtp32750226-14985) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[121 (1605271542008119296)]} 0 1
   [junit4]   2> 1560173 INFO  (qtp12396988-14964) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[122 (1605271542011265024)]} 0 0
   [junit4]   2> 1560174 INFO  (qtp32750226-14984) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[122 (1605271542013362176)]} 0 0
   [junit4]   2> 1560176 INFO  (qtp12396988-14965) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[123 (1605271542014410752)]} 0 0
   [junit4]   2> 1560178 INFO  (qtp32750226-14985) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[123 (1605271542016507904)]} 0 1
   [junit4]   2> 1560179 INFO  (qtp12396988-14964) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[124 (1605271542018605056)]} 0 0
   [junit4]   2> 1560182 INFO  (qtp32750226-14984) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[124 (1605271542020702208)]} 0 0
   [junit4]   2> 1560183 INFO  (qtp12396988-14964) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[125 (1605271542022799360)]} 0 0
   [junit4]   2> 1560184 INFO  (qtp32750226-14985) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[125 (1605271542023847936)]} 0 0
   [junit4]   2> 1560186 INFO  (qtp12396988-14965) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[126 (1605271542025945088)]} 0 0
   [junit4]   2> 1560188 INFO  (qtp32750226-14984) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[126 (1605271542026993664)]} 0 0
   [junit4]   2> 1560190 INFO  (qtp12396988-14964) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[127 (1605271542029090816)]} 0 0
   [junit4]   2> 1560192 INFO  (qtp32750226-14985) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[127 (1605271542031187968)]} 0 0
   [junit4]   2> 1560193 INFO  (qtp12396988-14965) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[128 (1605271542033285120)]} 0 0
   [junit4]   2> 1560195 INFO  (qtp32750226-14984) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[128 (1605271542034333696)]} 0 0
   [junit4]   2> 1560196 INFO  (qtp12396988-14964) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[129 (1605271542036430848)]} 0 0
   [junit4]   2> 1560198 INFO  (qtp32750226-14984) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[129 (1605271542038528000)]} 0 0
   [junit4]   2> 1560200 INFO  (qtp12396988-14965) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[130 (1605271542040625152)]} 0 0
   [junit4]   2> 1560202 INFO  (qtp32750226-14985) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[130 (1605271542042722304)]} 0 0
   [junit4]   2> 1560203 INFO  (qtp12396988-14964) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[131 (1605271542043770880)]} 0 0
   [junit4]   2> 1560205 INFO  (qtp32750226-14985) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[131 (1605271542044819456)]} 0 0
   [junit4]   2> 1560207 INFO  (qtp12396988-14965) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[132 (1605271542046916608)]} 0 0
   [junit4]   2> 1560208 INFO  (qtp32750226-14984) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[132 (1605271542049013760)]} 0 0
   [junit4]   2> 1560210 INFO  (qtp12396988-14964) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[133 (1605271542051110912)]} 0 0
   [junit4]   2> 1560212 INFO  (qtp32750226-14984) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[133 (1605271542052159488)]} 0 0
   [junit4]   2> 1560213 INFO  (qtp12396988-14965) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[134 (1605271542054256640)]} 0 0
   [junit4]   2> 1560215 INFO  (qtp32750226-14985) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[134 (1605271542055305216)]} 0 0
   [junit4]   2> 1560216 INFO  (qtp12396988-14964) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[135 (1605271542057402368)]} 0 0
   [junit4]   2> 1560218 INFO  (qtp32750226-14984) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[135 (1605271542058450944)]} 0 0
   [junit4]   2> 1560219 INFO  (qtp12396988-14965) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[136 (1605271542060548096)]} 0 0
   [junit4]   2> 1560220 INFO  (qtp32750226-14984) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[136 (1605271542061596672)]} 0 0
   [junit4]   2> 1560222 INFO  (qtp12396988-14964) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[137 (1605271542062645248)]} 0 0
   [junit4]   2> 1560223 INFO  (qtp32750226-14984) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[137 (1605271542064742400)]} 0 0
   [junit4]   2> 1560225 INFO  (qtp12396988-14965) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[138 (1605271542066839552)]} 0 0
   [junit4]   2> 1560226 INFO  (qtp32750226-14985) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[138 (1605271542067888128)]} 0 0
   [junit4]   2> 1560228 INFO  (qtp12396988-14964) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[139 (1605271542068936704)]} 0 0
   [junit4]   2> 1560229 INFO  (qtp32750226-14984) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[139 (1605271542069985280)]} 0 0
   [junit4]   2> 1560230 INFO  (qtp12396988-14965) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[140 (1605271542072082432)]} 0 0
   [junit4]   2> 1560232 INFO  (qtp32750226-14985) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[140 (1605271542073131008)]} 0 0
   [junit4]   2> 1560233 INFO  (qtp12396988-14965) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[141 (1605271542074179584)]} 0 0
   [junit4]   2> 1560234 INFO  (qtp32750226-14984) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[141 (1605271542076276736)]} 0 0
   [junit4]   2> 1560235 INFO  (qtp12396988-14964) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[142 (1605271542077325312)]} 0 0
   [junit4]   2> 1560236 INFO  (qtp32750226-14985) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[142 (1605271542078373888)]} 0 0
   [junit4]   2> 1560237 INFO  (qtp12396988-14965) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[143 (1605271542079422464)]} 0 0
   [junit4]   2> 1560238 INFO  (qtp32750226-14984) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[143 (1605271542080471040)]} 0 0
   [junit4]   2> 1560240 INFO  (qtp12396988-14964) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[144 (1605271542081519616)]} 0 0
   [junit4]   2> 1560241 INFO  (qtp32750226-14985) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[144 (1605271542082568192)]} 0 0
   [junit4]   2> 1560242 INFO  (qtp12396988-14965) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[145 (1605271542084665344)]} 0 0
   [junit4]   2> 1560243 INFO  (qtp32750226-14984) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[145 (1605271542085713920)]} 0 0
   [junit4]   2> 1560244 INFO  (qtp12396988-14964) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[146 (1605271542086762496)]} 0 0
   [junit4]   2> 1560245 INFO  (qtp32750226-14985) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[146 (1605271542087811072)]} 0 0
   [junit4]   2> 1560247 INFO  (qtp12396988-14965) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[147 (1605271542088859648)]} 0 0
   [junit4]   2> 1560248 INFO  (qtp32750226-14984) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[147 (1605271542089908224)]} 0 0
   [junit4]   2> 1560249 INFO  (qtp12396988-14964) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[148 (1605271542090956800)]} 0 0
   [junit4]   2> 1560250 INFO  (qtp32750226-14985) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[148 (1605271542093053952)]} 0 0
   [junit4]   2> 1560251 INFO  (qtp12396988-14965) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[149 (1605271542094102528)]} 0 0
   [junit4]   2> 1560253 INFO  (qtp32750226-14984) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={wt=javabin&version=2}{add=[149 (1605271542095151104)]} 0 0
   [junit4]   2> 1560254 INFO  (qtp12396988-14964) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1605271542097248256,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1560254 INFO  (qtp12396988-14964) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@15408ed 
commitCommandVersion:1605271542097248256
   [junit4]   2> 1560269 INFO  (qtp12396988-14964) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@6df676[collection1] main]
   [junit4]   2> 1560270 INFO  (qtp12396988-14964) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1560271 INFO  
(searcherExecutor-4736-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@6df676[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.5.0):C9)
 Uninverting(_1(7.5.0):C59)))}
   [junit4]   2> 1560272 INFO  (qtp12396988-14964) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 18
   [junit4]   2> 1560273 INFO  (qtp32750226-14985) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1605271542117171200,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1560273 INFO  (qtp32750226-14985) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@1341aaa 
commitCommandVersion:1605271542117171200
   [junit4]   2> 1560283 INFO  (qtp32750226-14985) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@4209f8[collection1] main]
   [junit4]   2> 1560284 INFO  (qtp32750226-14985) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1560285 INFO  
(searcherExecutor-4750-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@4209f8[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.5.0):C9)
 Uninverting(_1(7.5.0):C59)))}
   [junit4]   2> 1560286 INFO  (qtp32750226-14985) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/jhlig/m path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 13
   [junit4]   2> 1560287 ERROR (qtp12396988-14965) [    x:collection1] 
o.a.s.h.RequestHandlerBase org.apache.solr.common.SolrException: For input 
string: "non_numeric_value"
   [junit4]   2>        at 
org.apache.solr.common.params.SolrParams.getInt(SolrParams.java:236)
   [junit4]   2>        at 
org.apache.solr.search.QParser.getSortSpec(QParser.java:270)
   [junit4]   2>        at 
org.apache.solr.handler.component.QueryComponent.prepare(QueryComponent.java:187)
   [junit4]   2>        at 
org.apache.solr.handler.component.SearchHandler.handleRequestBody(SearchHandler.java:272)
   [junit4]   2>        at 
org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:199)
   [junit4]   2>        at 
org.apache.solr.core.SolrCore.execute(SolrCore.java:2541)
   [junit4]   2>        at 
org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:709)
   [junit4]   2>        at 
org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:515)
   [junit4]   2>        at 
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:377)
   [junit4]   2>        at 
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:323)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1642)
   [junit4]   2>        at 
org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:139)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1642)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:533)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:255)
   [junit4]   2>        at 
org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:1595)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:255)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1317)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:203)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:473)
   [junit4]   2>        at 
org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:1564)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:201)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1219)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:144)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:724)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:132)
   [junit4]   2>        at 
org.eclipse.jetty.server.Server.handle(Server.java:531)
   [junit4]   2>        at 
org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:352)
   [junit4]   2>        at 
org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:260)
   [junit4]   2>        at 
org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:281)
   [junit4]   2>        at 
org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:102)
   [junit4]   2>        at 
org.eclipse.jetty.io.ChannelEndPoint$2.run(ChannelEndPoint.java:118)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.runTask(EatWhatYouKill.java:333)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:310)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.tryProduce(EatWhatYouKill.java:168)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.run(EatWhatYouKill.java:126)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:366)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:762)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:680)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> Caused by: java.lang.NumberFormatException: For input string: 
"non_numeric_value"
   [junit4]   2>        at 
java.lang.NumberFormatException.forInputString(NumberFormatException.java:65)
   [junit4]   2>        at java.lang.Integer.parseInt(Integer.java:580)
   [junit4]   2>        at java.lang.Integer.valueOf(Integer.java:766)
   [junit4]   2>        at 
org.apache.solr.common.params.SolrParams.getInt(SolrParams.java:233)
   [junit4]   2>        ... 39 more
   [junit4]   2> 
   [junit4]   2> 1560288 INFO  (qtp12396988-14965) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/jhlig/m path=/select 
params={q=*&distrib=false&start=non_numeric_value&wt=javabin&version=2} 
status=400 QTime=1
   [junit4]   2> 1560289 INFO  (qtp12396988-14964) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching parameter cannot be 
negative
   [junit4]   2> 1560289 INFO  (qtp12396988-14964) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/jhlig/m path=/select 
params={q=*&distrib=false&start=-1&wt=javabin&version=2} status=400 QTime=0
   [junit4]   2> 1560290 INFO  (qtp12396988-14965) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching parameter cannot be 
negative
   [junit4]   2> 1560290 INFO  (qtp12396988-14965) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/jhlig/m path=/select 
params={q=*&distrib=false&start=0&rows=-1&wt=javabin&version=2} status=400 
QTime=0
   [junit4]   2> 1560291 ERROR (qtp12396988-14964) [    x:collection1] 
o.a.s.h.RequestHandlerBase org.apache.solr.common.SolrException: For input 
string: "non_numeric_value"
   [junit4]   2>        at 
org.apache.solr.common.params.SolrParams.getInt(SolrParams.java:236)
   [junit4]   2>        at 
org.apache.solr.search.QParser.getSortSpec(QParser.java:273)
   [junit4]   2>        at 
org.apache.solr.handler.component.QueryComponent.prepare(QueryComponent.java:187)
   [junit4]   2>        at 
org.apache.solr.handler.component.SearchHandler.handleRequestBody(SearchHandler.java:272)
   [junit4]   2>        at 
org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:199)
   [junit4]   2>        at 
org.apache.solr.core.SolrCore.execute(SolrCore.java:2541)
   [junit4]   2>        at 
org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:709)
   [junit4]   2>        at 
org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:515)
   [junit4]   2>        at 
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:377)
   [junit4]   2>        at 
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:323)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1642)
   [junit4]   2>        at 
org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:139)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1642)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:533)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:255)
   [junit4]   2>        at 
org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:1595)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:255)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1317)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:203)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:473)
   [junit4]   2>        at 
org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:1564)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:201)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1219)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:144)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:724)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:132)
   [junit4]   2>        at 
org.eclipse.jetty.server.Server.handle(Server.java:531)
   [junit4]   2>        at 
org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:352)
   [junit4]   2>        at 
org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:260)
   [junit4]   2>        at 
org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:281)
   [junit4]   2>        at 
org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:102)
   [junit4]   2>        at 
org.eclipse.jetty.io.ChannelEndPoint$2.run(ChannelEndPoint.java:118)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.runTask(EatWhatYouKill.java:333)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:310)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.tryProduce(EatWhatYouKill.java:168)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.run(EatWhatYouKill.java:126)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:366)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:762)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:680)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> Caused by: java.lang.NumberFormatException: For input string: 
"non_numeric_value"
   [junit4]   2>        at 
java.lang.NumberFormatException.forInputString(NumberFormatException.java:65)
   [junit4]   2>        at java.lang.Integer.parseInt(Integer.java:580)
   [junit4]   2>        at java.lang.Integer.valueOf(Integer.java:766)
   [junit4]   2>        at 
org.apache.solr.common.params.SolrParams.getInt(SolrParams.java:233)
   [junit4]   2>        ... 39 more
   [junit4]   2> 
   [junit4]   2> 1560292 INFO  (qtp12396988-14964) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/jhlig/m path=/select 
params={q=*&distrib=false&rows=non_numeric_value&wt=javabin&version=2} 
status=400 QTime=1
   [junit4]   2> 1560294 INFO  (qtp12396988-14965) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/jhlig/m path=/select 
params={q=*:*&distrib=false&sort=n_ti1+desc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 1560301 INFO  (qtp32750226-14981) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/jhlig/m path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_ti1+desc&shard.url=[ff01::213]:33332/jhlig/m|http://127.0.0.1:44037/jhlig/m/collection1&rows=10&version=2&q=*:*&NOW=1530906240599&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1560304 INFO  (qtp32750226-14986) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/jhlig/m path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1530906240599&ids=134,2,135,114,126,105,138,128,7,140&isShard=true&shard.url=[ff01::213]:33332/jhlig/m|http://127.0.0.1:44037/jhlig/m/collection1&wt=javabin&version=2}
 status=0 QTime=1
   [junit4]   2> 1560312 INFO  (qtp32750226-14984) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/jhlig/m path=/select 
params={q=*:*&shards=[ff01::213]:33332/jhlig/m|http://127.0.0.1:44037/jhlig/m/collection1&sort=n_ti1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=15
   [junit4]   2> 1560317 INFO  (qtp12396988-14964) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/jhlig/m path=/select 
params={q=*:*&distrib=false&sort=n_ti1+asc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 1560323 INFO  (qtp32750226-15003) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/jhlig/m path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_ti1+asc&shard.url=http://127.0.0.1:44037/jhlig/m/collection1&rows=10&version=2&q=*:*&NOW=1530906240623&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1560326 INFO  (qtp32750226-14986) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/jhlig/m path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1530906240623&ids=132,12,146,124,102,17,107,129,8,142&isShard=true&shard.url=http://127.0.0.1:44037/jhlig/m/collection1&wt=javabin&version=2}
 status=0 QTime=1
   [junit4]   2> 1560338 INFO  (qtp32750226-14985) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/jhlig/m path=/select 
params={q=*:*&shards=http://127.0.0.1:44037/jhlig/m/collection1&sort=n_ti1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=17
   [junit4]   2> 1560340 INFO  (qtp12396988-14965) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/jhlig/m path=/select 
params={q=*:*&distrib=false&sort=n_f1+desc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 1560353 INFO  (qtp32750226-15003) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/jhlig/m path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_f1+desc&shard.url=http://127.0.0.1:44037/jhlig/m/collection1|[ff01::114]:33332/jhlig/m|[ff01::213]:33332/jhlig/m|[ff01::083]:33332/jhlig/m&rows=10&version=2&q=*:*&NOW=1530906240651&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1560356 INFO  (qtp32750226-14986) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/jhlig/m path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1530906240651&ids=1,133,13,15,125,6,106,117,1001,120&isShard=true&shard.url=http://127.0.0.1:44037/jhlig/m/collection1|[ff01::114]:33332/jhlig/m|[ff01::213]:33332/jhlig/m|[ff01::083]:33332/jhlig/m&wt=javabin&version=2}
 status=0 QTime=1
   [junit4]   2> 1560361 INFO  (qtp32750226-14984) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/jhlig/m path=/select 
params={q=*:*&shards=http://127.0.0.1:44037/jhlig/m/collection1|[ff01::114]:33332/jhlig/m|[ff01::213]:33332/jhlig/m|[ff01::083]:33332/jhlig/m&sort=n_f1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=12
   [junit4]   2> 1560363 INFO  (qtp12396988-14964) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/jhlig/m path=/select 
params={q=*:*&distrib=false&sort=n_f1+asc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 1560366 INFO  (qtp32750226-15003) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/jhlig/m path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_f1+asc&shard.url=http://127.0.0.1:44037/jhlig/m/collection1&rows=10&version=2&q=*:*&NOW=1530906240667&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1560369 INFO  (qtp32750226-15003) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/jhlig/m path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1530906240667&ids=100,147,137,126,5,16,107,8,141,10&isShard=true&shard.url=http://127.0.0.1:44037/jhlig/m/collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1560372 INFO  (qtp32750226-14985) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/jhlig/m path=/select 
params={q=*:*&shards=http://127.0.0.1:44037/jhlig/m/collection1&sort=n_f1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=6
   [junit4]   2> 1560374 INFO  (qtp12396988-14965) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/jhlig/m path=/select 
params={q=*:*&distrib=false&sort=n_tf1+desc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 1560378 INFO  (qtp32750226-14986) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/jhlig/m path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_tf1+desc&shard.url=http://127.0.0.1:44037/jhlig/m/collection1|[ff01::083]:33332/jhlig/m|[ff01::114]:33332/jhlig/m|[ff01::213]:33332/jhlig/m&rows=10&version=2&q=*:*&NOW=1530906240678&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1560381 INFO  (qtp32750226-15003) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/jhlig/m path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1530906240678&ids=2,135,136,104,6,139,7,107,129,9&isShard=true&shard.url=http://127.0.0.1:44037/jhlig/m/collection1|[ff01::083]:33332/jhlig/m|[ff01::114]:33332/jhlig/m|[ff01::213]:33332/jhlig/m&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1560385 INFO  (qtp32750226-14984) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/jhlig/m path=/select 
params={q=*:*&shards=http://127.0.0.1:44037/jhlig/m/collection1|[ff01::083]:33332/jhlig/m|[ff01::114]:33332/jhlig/m|[ff01::213]:33332/jhlig/m&sort=n_tf1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=9
   [junit4]   2> 1560388 INFO  (qtp12396988-14964) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/jhlig/m path=/select 
params={q=*:*&distrib=false&sort=n_tf1+asc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 1560391 INFO  (qtp32750226-14986) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/jhlig/m path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_tf1+asc&shard.url=http://127.0.0.1:44037/jhlig/m/collection1&rows=10&version=2&q=*:*&NOW=1530906240692&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1560393 INFO  (qtp32750226-15003) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/jhlig/m path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1530906240692&ids=11,12,146,124,114,137,116,8,140,131&isShard=true&shard.url=http://127.0.0.1:44037/jhlig/m/collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1560396 INFO  (qtp32750226-14985) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/jhlig/m path=/select 
params={q=*:*&shards=http://127.0.0.1:44037/jhlig/m/collection1&sort=n_tf1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=6
   [junit4]   2> 1560398 INFO  (qtp12396988-14965) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/jhlig/m path=/select 
params={q=*:*&distrib=false&sort=n_d1+desc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 1560407 INFO  (qtp32750226-14986) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/jhlig/m path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_d1+desc&shard.url=[ff01::083]:33332/jhlig/m|[ff01::213]:33332/jhlig/m|[ff01::114]:33332/jhlig/m|http://127.0.0.1:44037/jhlig/m/collection1&rows=10&version=2&q=*:*&NOW=1530906240702&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1560409 INFO  (qtp32750226-15003) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/jhlig/m path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1530906240702&ids=11,110,13,101,146,16,17,149,106,140&isShard=true&shard.url=[ff01::083]:33332/jhlig/m|[ff01::213]:33332/jhlig/m|[ff01::114]:33332/jhlig/m|http://127.0.0.1:44037/jhlig/m/collection1&wt=javabin&version=2}
 status=0 QTime=1
   [junit4]   2> 1560412 INFO  (qtp32750226-14984) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/jhlig/m path=/select 
params={q=*:*&shards=[ff01::083]:33332/jhlig/m|[ff01::213]:33332/jhlig/m|[ff01::114]:33332/jhlig/m|http://127.0.0.1:44037/jhlig/m/collection1&sort=n_d1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=12
   [junit4]   2> 1560415 INFO  (qtp12396988-14964) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/jhlig/m path=/select 
params={q=*:*&distrib=false&sort=n_d1+asc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 1560418 INFO  (qtp32750226-14986) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/jhlig/m path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_d1+asc&shard.url=[ff01::213]:33332/jhlig/m|http://127.0.0.1:44037/jhlig/m/collection1|[ff01::083]:33332/jhlig/m|[ff01::114]:33332/jhlig/m&rows=10&version=2&q=*:*&NOW=1530906240719&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1560420 INFO  (qtp32750226-15003) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/jhlig/m path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1530906240719&ids=143,113,135,125,105,7,128,119,108,131&isShard=true&shard.url=[ff01::213]:33332/jhlig/m|http://127.0.0.1:44037/jhlig/m/collection1|[ff01::083]:33332/jhlig/m|[ff01::114]:33332/jhlig/m&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1560422 INFO  (qtp32750226-14985) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/jhlig/m path=/select 
params={q=*:*&shards=[ff01::213]:33332/jhlig/m|http://127.0.0.1:44037/jhlig/m/collection1|[ff01::083]:33332/jhlig/m|[ff01::114]:33332/jhlig/m&sort=n_d1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=5
   [junit4]   2> 1560423 INFO  (qtp12396988-14965) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/jhlig/m path=/select 
params={q=*:*&distrib=false&sort=n_td1+desc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 1560426 INFO  (qtp32750226-14986) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/jhlig/m path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_td1+desc&shard.url=[ff01::114]:33332/jhlig/m|[ff01::213]:33332/jhlig/m|[ff01::083]:33332/jhlig/m|http://127.0.0.1:44037/jhlig/m/collection1&rows=10&version=2&q=*:*&NOW=1530906240727&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1560428 INFO  (qtp32750226-15003) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/jhlig/m path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1530906240727&ids=12,135,14,114,103,4,5,137,128,119&isShard=true&shard.url=[ff01::114]:33332/jhlig/m|[ff01::213]:33332/jhlig/m|[ff01::083]:33332/jhlig/m|http://127.0.0.1:44037/jhlig/m/collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1560430 INFO  (qtp32750226-14984) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/jhlig/m path=/select 
params={q=*:*&shards=[ff01::114]:33332/jhlig/m|[ff01::213]:33332/jhlig/m|[ff01::083]:33332/jhlig/m|http://127.0.0.1:44037/jhlig/m/collection1&sort=n_td1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=4
   [junit4]   2> 1560431 INFO  (qtp12396988-14964) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/jhlig/m path=/select 
params={q=*:*&distrib=false&sort=n_td1+asc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 1560435 INFO  (qtp32750226-14986) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/jhlig/m path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_td1+asc&shard.url=[ff01::083]:33332/jhlig/m|http://127.0.0.1:44037/jhlig/m/collection1&rows=10&version=2&q=*:*&NOW=1530906240735&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1560437 INFO  (qtp32750226-15003) [    x:collection1] 
o.a.s.c.S.Re

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

Name = null, domain = solr.core.collection1, service url = null, agent id = 
null] for registry solr.core.collection1 / 
com.codahale.metrics.MetricRegistry@6b1e0
   [junit4]   2> 1614191 INFO  
(TEST-TestDistributedSearch.test-seed#[CE529A2E7A9C3BDA]) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@527513{/jhlig/m,null,UNAVAILABLE}
   [junit4]   2> 1614191 INFO  
(TEST-TestDistributedSearch.test-seed#[CE529A2E7A9C3BDA]) [    ] 
o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=TestDistributedSearch -Dtests.method=test 
-Dtests.seed=CE529A2E7A9C3BDA -Dtests.multiplier=3 -Dtests.slow=true 
-Dtests.locale=ar-LB -Dtests.timezone=America/Argentina/ComodRivadavia 
-Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
   [junit4] FAILURE 58.9s J0 | TestDistributedSearch.test <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: Expected to find 
shardAddress in the up shard info: 
{error=org.apache.solr.client.solrj.SolrServerException: Time allowed to handle 
this request exceeded,trace=org.apache.solr.client.solrj.SolrServerException: 
Time allowed to handle this request exceeded
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:460)
   [junit4]    >        at 
org.apache.solr.handler.component.HttpShardHandlerFactory.makeLoadBalancedRequest(HttpShardHandlerFactory.java:279)
   [junit4]    >        at 
org.apache.solr.handler.component.HttpShardHandler.lambda$submit$0(HttpShardHandler.java:175)
   [junit4]    >        at 
java.util.concurrent.FutureTask.run(FutureTask.java:266)
   [junit4]    >        at 
java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
   [junit4]    >        at 
java.util.concurrent.FutureTask.run(FutureTask.java:266)
   [junit4]    >        at 
com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:176)
   [junit4]    >        at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209)
   [junit4]    >        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
   [junit4]    >        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
   [junit4]    >        at java.lang.Thread.run(Thread.java:748)
   [junit4]    > ,time=12}
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([CE529A2E7A9C3BDA:4606A5F4D4605622]:0)
   [junit4]    >        at 
org.apache.solr.TestDistributedSearch.comparePartialResponses(TestDistributedSearch.java:1192)
   [junit4]    >        at 
org.apache.solr.TestDistributedSearch.queryPartialResults(TestDistributedSearch.java:1133)
   [junit4]    >        at 
org.apache.solr.TestDistributedSearch.test(TestDistributedSearch.java:993)
   [junit4]    >        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsRepeatStatement.callStatement(BaseDistributedSearchTestCase.java:1034)
   [junit4]    >        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:983)
   [junit4]    >        at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_CE529A2E7A9C3BDA-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): 
{severity=PostingsFormat(name=Asserting), foo_sev_enum=Lucene50(blocksize=128), 
SubjectTerms_mfacet=PostingsFormat(name=Memory), 
multiDefault=PostingsFormat(name=MockRandom), rnd_b=Lucene50(blocksize=128), 
a_s=PostingsFormat(name=Asserting), oddField_s=PostingsFormat(name=Asserting), 
lowerfilt1and2=PostingsFormat(name=MockRandom), 
a_t=PostingsFormat(name=Memory), foo_b=PostingsFormat(name=Asserting), 
lowerfilt=PostingsFormat(name=MockRandom), id=Lucene50(blocksize=128), 
text=PostingsFormat(name=Asserting)}, 
docValues:{other_tl1=DocValuesFormat(name=Asserting), 
range_facet_l_dv=DocValuesFormat(name=Lucene70), 
n_l1=DocValuesFormat(name=Asserting), a_n_tdt=DocValuesFormat(name=Lucene70), 
intDefault=DocValuesFormat(name=Asserting), 
n_td1=DocValuesFormat(name=Lucene70), n_d1=DocValuesFormat(name=Asserting), 
range_facet_l=DocValuesFormat(name=Asserting), 
n_f1=DocValuesFormat(name=Lucene70), n_tl1=DocValuesFormat(name=Lucene70), 
n_tf1=DocValuesFormat(name=Asserting), 
intDvoDefault=DocValuesFormat(name=Memory), 
timestamp=DocValuesFormat(name=Asserting), 
severity=DocValuesFormat(name=Memory), 
foo_sev_enum=DocValuesFormat(name=Lucene70), 
n_dt1=DocValuesFormat(name=Lucene70), a_i1=DocValuesFormat(name=Asserting), 
b_n_tdt=DocValuesFormat(name=Asserting), n_ti1=DocValuesFormat(name=Lucene70), 
_version_=DocValuesFormat(name=Asserting), 
n_tdt1=DocValuesFormat(name=Asserting), id_i1=DocValuesFormat(name=Lucene70), 
foo_d=DocValuesFormat(name=Lucene70), 
range_facet_i_dv=DocValuesFormat(name=Asserting), 
foo_f=DocValuesFormat(name=Memory)}, maxPointsInLeafNode=1286, 
maxMBSortInHeap=7.682103169855205, sim=RandomSimilarity(queryNorm=true): {}, 
locale=ar-LB, timezone=America/Argentina/ComodRivadavia
   [junit4]   2> NOTE: Linux 4.15.0-24-generic i386/Oracle Corporation 
1.8.0_172 (32-bit)/cpus=8,threads=1,free=126186864,total=323174400
   [junit4]   2> NOTE: All tests run in this JVM: 
[TestCopyFieldCollectionResource, TestSolrQueryResponse, JsonLoaderTest, 
TestSolrCloudWithDelegationTokens, HdfsRecoverLeaseTest, CloudMLTQParserTest, 
CircularListTest, ConcurrentCreateRoutedAliasTest, 
TestRuleBasedAuthorizationPlugin, TestCrossCoreJoin, EnumFieldTest, 
SimpleCollectionCreateDeleteTest, TestLuceneMatchVersion, 
HdfsUnloadDistributedZkTest, TestRequestForwarding, TestGroupingSearch, 
TestApiFramework, TestPseudoReturnFields, CustomCollectionTest, 
ImplicitSnitchTest, ZkNodePropsTest, DeleteShardTest, 
TestBackupRepositoryFactory, TestObjectReleaseTracker, SolrCloudExampleTest, 
BasicDistributedZk2Test, TestAuthenticationFramework, 
IndexBasedSpellCheckerTest, TestTlogReplica, TestSurroundQueryParser, 
SoftAutoCommitTest, SortSpecParsingTest, TestStandardQParsers, 
TriggerCooldownIntegrationTest, TestMultiValuedNumericRangeQuery, 
TestPrepRecovery, SaslZkACLProviderTest, GraphQueryTest, V2StandaloneTest, 
TokenizerChainTest, PreAnalyzedUpdateProcessorTest, 
WordBreakSolrSpellCheckerTest, UUIDUpdateProcessorFallbackTest, 
HdfsAutoAddReplicasIntegrationTest, TestRequestStatusCollectionAPI, 
TestBinaryResponseWriter, TestReloadAndDeleteDocs, 
TestOverriddenPrefixQueryForCustomFieldType, TemplateUpdateProcessorTest, 
SynonymTokenizerTest, DistributedFacetPivotSmallAdvancedTest, 
TestCloudInspectUtil, TestJavabinTupleStreamParser, MetricsConfigTest, 
MetricsHistoryIntegrationTest, TestFieldCacheReopen, SolrGraphiteReporterTest, 
TestClusterStateMutator, TestAnalyzedSuggestions, TestBlobHandler, 
DefaultValueUpdateProcessorTest, TestFieldTypeResource, 
TestNonDefinedSimilarityFactory, TestClusterStateProvider, 
TestEmbeddedSolrServerConstructors, StatsComponentTest, 
SchemaVersionSpecificBehaviorTest, TestFieldCollectionResource, PolyFieldTest, 
TestComponentsName, TestUtils, OverseerModifyCollectionTest, 
TestUniqueKeyFieldResource, TestManagedResourceStorage, TestNRTOpen, 
TestLRUStatsCache, PrimitiveFieldTypeTest, SparseHLLTest, RangeFacetCloudTest, 
TestManagedSynonymGraphFilterFactory, TestLRUCache, 
TestCollationFieldDocValues, DistanceUnitsTest, TestPhraseSuggestions, 
TestDirectoryFactory, CheckHdfsIndexTest, TestSolrJ, FastVectorHighlighterTest, 
TestManagedSchemaAPI, TestNodeAddedTrigger, TestNumericTerms32, 
MaxSizeAutoCommitTest, BigEndianAscendingWordSerializerTest, 
LIROnShardRestartTest, DeleteLastCustomShardedReplicaTest, 
TestSimpleQParserPlugin, TestSweetSpotSimilarityFactory, 
TestSlowCompositeReaderWrapper, TestShortCircuitedRequests, 
NotRequiredUniqueKeyTest, LeaderElectionIntegrationTest, TestDocTermOrds, 
MoveReplicaHDFSFailoverTest, TestLeaderElectionWithEmptyReplica, 
TestJmxIntegration, SignatureUpdateProcessorFactoryTest, 
TestSubQueryTransformerCrossCore, CollectionPropsTest, TaggerTest, 
LeaderFailureAfterFreshStartTest, ReplaceNodeNoTargetTest, TestStressReorder, 
CSVRequestHandlerTest, TestFreeTextSuggestions, AlternateDirectoryTest, 
CreateCollectionCleanupTest, TriLevelCompositeIdRoutingTest, 
TestSolrConfigHandlerConcurrent, TestConfigSetProperties, BufferStoreTest, 
CachingDirectoryFactoryTest, TestSolrCoreProperties, TestSQLHandler, 
TestStressCloudBlindAtomicUpdates, TestPointFields, TestLockTree, 
OpenCloseCoreStressTest, AutoScalingHandlerTest, TestFieldSortValues, 
CursorPagingTest, SearchHandlerTest, RequestLoggingTest, TestMacros, 
TestFieldCacheVsDocValues, EchoParamsTest, MinimalSchemaTest, OutputWriterTest, 
SampleTest, SolrInfoBeanTest, TestDistributedSearch]
   [junit4] Completed [417/821 (1!)] on J0 in 58.96s, 1 test, 1 failure <<< 
FAILURES!

[...truncated 47903 lines...]
[repro] Jenkins log URL: 
https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Linux/2273/consoleText

[repro] Revision: 9a6706ed32646e74fb64a8b2caa05fd6bc7e8a35

[repro] Ant options: "-Dargs=-client -XX:+UseSerialGC"
[repro] Repro line:  ant test  -Dtestcase=TestDistributedSearch 
-Dtests.method=test -Dtests.seed=CE529A2E7A9C3BDA -Dtests.multiplier=3 
-Dtests.slow=true -Dtests.locale=ar-LB 
-Dtests.timezone=America/Argentina/ComodRivadavia -Dtests.asserts=true 
-Dtests.file.encoding=ISO-8859-1

[repro] ant clean

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

[...truncated 3318 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5 
-Dtests.class="*.TestDistributedSearch" -Dtests.showOutput=onerror 
"-Dargs=-client -XX:+UseSerialGC" -Dtests.seed=CE529A2E7A9C3BDA 
-Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=ar-LB 
-Dtests.timezone=America/Argentina/ComodRivadavia -Dtests.asserts=true 
-Dtests.file.encoding=ISO-8859-1

[...truncated 75 lines...]
[repro] Failures:
[repro]   0/5 failed: org.apache.solr.TestDistributedSearch
[repro] Exiting with code 0

[...truncated 40 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org

Reply via email to