Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Solaris/494/
Java: 64bit/jdk1.8.0 -XX:-UseCompressedOops -XX:+UseG1GC

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:273)
  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:188)
  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=4}

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:273)
        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:188)
        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=4}
        at 
__randomizedtesting.SeedInfo.seed([1100A2614CAEB74A:99549DBBE252DAB2]: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:1191)
        at 
org.apache.solr.TestDistributedSearch.queryPartialResults(TestDistributedSearch.java:1132)
        at 
org.apache.solr.TestDistributedSearch.test(TestDistributedSearch.java:992)
        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:1019)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:968)
        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 1792 lines...]
   [junit4] JVM J1: stdout was not empty, see: 
/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/build/core/test/temp/junit4-J1-20180315_063234_2841402207062093229839.sysout
   [junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
   [junit4] codec: FastDecompressionCompressingStoredFields, pf: 
LuceneFixedGap, dvf: Lucene70
   [junit4] <<< JVM J1: EOF ----

[...truncated 11000 lines...]
   [junit4] Suite: org.apache.solr.TestDistributedSearch
   [junit4]   2> Creating dataDir: 
/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_1100A2614CAEB74A-001/init-core-data-001
   [junit4]   2> 811421 WARN  
(SUITE-TestDistributedSearch-seed#[1100A2614CAEB74A]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=21 numCloses=21
   [junit4]   2> 811421 INFO  
(SUITE-TestDistributedSearch-seed#[1100A2614CAEB74A]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 811423 INFO  
(SUITE-TestDistributedSearch-seed#[1100A2614CAEB74A]-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> 811423 INFO  
(SUITE-TestDistributedSearch-seed#[1100A2614CAEB74A]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 811423 INFO  
(SUITE-TestDistributedSearch-seed#[1100A2614CAEB74A]-worker) [    ] 
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /ets/
   [junit4]   2> 811623 INFO  
(TEST-TestDistributedSearch.test-seed#[1100A2614CAEB74A]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_1100A2614CAEB74A-001/tempDir-001/control/cores/collection1
   [junit4]   2> 811624 INFO  
(TEST-TestDistributedSearch.test-seed#[1100A2614CAEB74A]) [    ] o.e.j.s.Server 
jetty-9.4.8.v20171121, build timestamp: 2017-11-21T16:27:37-05:00, git hash: 
82b8fb23f757335bb3329d540ce37a2a2615f0a8
   [junit4]   2> 811624 INFO  
(TEST-TestDistributedSearch.test-seed#[1100A2614CAEB74A]) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 811624 INFO  
(TEST-TestDistributedSearch.test-seed#[1100A2614CAEB74A]) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 811625 INFO  
(TEST-TestDistributedSearch.test-seed#[1100A2614CAEB74A]) [    ] 
o.e.j.s.session Scavenging every 600000ms
   [junit4]   2> 811625 INFO  
(TEST-TestDistributedSearch.test-seed#[1100A2614CAEB74A]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@51fc5d76{/ets,null,AVAILABLE}
   [junit4]   2> 811625 INFO  
(TEST-TestDistributedSearch.test-seed#[1100A2614CAEB74A]) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@e5815dd{HTTP/1.1,[http/1.1]}{127.0.0.1:51281}
   [junit4]   2> 811626 INFO  
(TEST-TestDistributedSearch.test-seed#[1100A2614CAEB74A]) [    ] o.e.j.s.Server 
Started @814199ms
   [junit4]   2> 811626 INFO  
(TEST-TestDistributedSearch.test-seed#[1100A2614CAEB74A]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/ets, 
hostPort=51281, 
coreRootDirectory=/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_1100A2614CAEB74A-001/tempDir-001/control/cores}
   [junit4]   2> 811626 ERROR 
(TEST-TestDistributedSearch.test-seed#[1100A2614CAEB74A]) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 811626 INFO  
(TEST-TestDistributedSearch.test-seed#[1100A2614CAEB74A]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
7.4.0
   [junit4]   2> 811626 INFO  
(TEST-TestDistributedSearch.test-seed#[1100A2614CAEB74A]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 811626 INFO  
(TEST-TestDistributedSearch.test-seed#[1100A2614CAEB74A]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 811626 INFO  
(TEST-TestDistributedSearch.test-seed#[1100A2614CAEB74A]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-03-15T07:01:06.683Z
   [junit4]   2> 811627 INFO  
(TEST-TestDistributedSearch.test-seed#[1100A2614CAEB74A]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_1100A2614CAEB74A-001/tempDir-001/control/solr.xml
   [junit4]   2> 811631 INFO  
(TEST-TestDistributedSearch.test-seed#[1100A2614CAEB74A]) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay 
is ignored
   [junit4]   2> 811631 INFO  
(TEST-TestDistributedSearch.test-seed#[1100A2614CAEB74A]) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 811632 INFO  
(TEST-TestDistributedSearch.test-seed#[1100A2614CAEB74A]) [    ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@2da6e5e2, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 811675 INFO  
(TEST-TestDistributedSearch.test-seed#[1100A2614CAEB74A]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2da6e5e2
   [junit4]   2> 811682 INFO  
(TEST-TestDistributedSearch.test-seed#[1100A2614CAEB74A]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2da6e5e2
   [junit4]   2> 811682 INFO  
(TEST-TestDistributedSearch.test-seed#[1100A2614CAEB74A]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2da6e5e2
   [junit4]   2> 811683 INFO  
(TEST-TestDistributedSearch.test-seed#[1100A2614CAEB74A]) [    ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_1100A2614CAEB74A-001/tempDir-001/control/cores
   [junit4]   2> 811683 INFO  
(TEST-TestDistributedSearch.test-seed#[1100A2614CAEB74A]) [    ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 811684 INFO  (coreLoadExecutor-2996-thread-1) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 811685 INFO  (coreLoadExecutor-2996-thread-1) [    
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, 
from paths: 
[/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1/lib,
 
/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 811736 INFO  (coreLoadExecutor-2996-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.4.0
   [junit4]   2> 811752 INFO  (coreLoadExecutor-2996-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 811846 INFO  (coreLoadExecutor-2996-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 811853 INFO  (coreLoadExecutor-2996-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from configset 
/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1,
 trusted=true
   [junit4]   2> 811853 INFO  (coreLoadExecutor-2996-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@2da6e5e2
   [junit4]   2> 811853 INFO  (coreLoadExecutor-2996-thread-1) [    
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 811853 INFO  (coreLoadExecutor-2996-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1],
 
dataDir=[/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_1100A2614CAEB74A-001/tempDir-001/control/cores/collection1/data/]
   [junit4]   2> 811854 INFO  (coreLoadExecutor-2996-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=24, maxMergeAtOnceExplicit=18, maxMergedSegmentMB=79.0615234375, 
floorSegmentMB=1.740234375, forceMergeDeletesPctAllowed=13.462939348061614, 
segmentsPerTier=19.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.6902458209418335
   [junit4]   2> 811927 INFO  (coreLoadExecutor-2996-thread-1) [    
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 811928 INFO  (coreLoadExecutor-2996-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 811929 INFO  (coreLoadExecutor-2996-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 811929 INFO  (coreLoadExecutor-2996-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 811930 INFO  (coreLoadExecutor-2996-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=21, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.35741961889174767]
   [junit4]   2> 811930 INFO  (coreLoadExecutor-2996-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@261fba1d[collection1] main]
   [junit4]   2> 811930 INFO  (coreLoadExecutor-2996-thread-1) [    
x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 812001 INFO  (coreLoadExecutor-2996-thread-1) [    
x:collection1] o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 812074 INFO  (coreLoadExecutor-2996-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 812078 INFO  
(searcherExecutor-2997-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 812083 INFO  
(searcherExecutor-2997-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 812083 INFO  
(searcherExecutor-2997-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 812083 INFO  (coreLoadExecutor-2996-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1594986087988592640
   [junit4]   2> 812083 INFO  
(searcherExecutor-2997-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 812084 INFO  
(searcherExecutor-2997-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 812084 INFO  
(searcherExecutor-2997-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 812085 INFO  
(searcherExecutor-2997-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 812085 INFO  
(searcherExecutor-2997-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 812085 INFO  
(searcherExecutor-2997-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 812087 INFO  
(searcherExecutor-2997-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@261fba1d[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 812280 INFO  
(TEST-TestDistributedSearch.test-seed#[1100A2614CAEB74A]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_1100A2614CAEB74A-001/tempDir-001/shard0/cores/collection1
   [junit4]   2> 812281 INFO  
(TEST-TestDistributedSearch.test-seed#[1100A2614CAEB74A]) [    ] o.e.j.s.Server 
jetty-9.4.8.v20171121, build timestamp: 2017-11-21T16:27:37-05:00, git hash: 
82b8fb23f757335bb3329d540ce37a2a2615f0a8
   [junit4]   2> 812282 INFO  
(TEST-TestDistributedSearch.test-seed#[1100A2614CAEB74A]) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 812282 INFO  
(TEST-TestDistributedSearch.test-seed#[1100A2614CAEB74A]) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 812282 INFO  
(TEST-TestDistributedSearch.test-seed#[1100A2614CAEB74A]) [    ] 
o.e.j.s.session Scavenging every 600000ms
   [junit4]   2> 812283 INFO  
(TEST-TestDistributedSearch.test-seed#[1100A2614CAEB74A]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@691d86{/ets,null,AVAILABLE}
   [junit4]   2> 812283 INFO  
(TEST-TestDistributedSearch.test-seed#[1100A2614CAEB74A]) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@3d85a4f1{HTTP/1.1,[http/1.1]}{127.0.0.1:41443}
   [junit4]   2> 812283 INFO  
(TEST-TestDistributedSearch.test-seed#[1100A2614CAEB74A]) [    ] o.e.j.s.Server 
Started @814857ms
   [junit4]   2> 812283 INFO  
(TEST-TestDistributedSearch.test-seed#[1100A2614CAEB74A]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/ets, 
hostPort=41443, 
coreRootDirectory=/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_1100A2614CAEB74A-001/tempDir-001/shard0/cores}
   [junit4]   2> 812284 ERROR 
(TEST-TestDistributedSearch.test-seed#[1100A2614CAEB74A]) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 812284 INFO  
(TEST-TestDistributedSearch.test-seed#[1100A2614CAEB74A]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
7.4.0
   [junit4]   2> 812284 INFO  
(TEST-TestDistributedSearch.test-seed#[1100A2614CAEB74A]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 812284 INFO  
(TEST-TestDistributedSearch.test-seed#[1100A2614CAEB74A]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 812284 INFO  
(TEST-TestDistributedSearch.test-seed#[1100A2614CAEB74A]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-03-15T07:01:07.341Z
   [junit4]   2> 812284 INFO  
(TEST-TestDistributedSearch.test-seed#[1100A2614CAEB74A]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_1100A2614CAEB74A-001/tempDir-001/shard0/solr.xml
   [junit4]   2> 812288 INFO  
(TEST-TestDistributedSearch.test-seed#[1100A2614CAEB74A]) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay 
is ignored
   [junit4]   2> 812288 INFO  
(TEST-TestDistributedSearch.test-seed#[1100A2614CAEB74A]) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 812289 INFO  
(TEST-TestDistributedSearch.test-seed#[1100A2614CAEB74A]) [    ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@2da6e5e2, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 812329 INFO  
(TEST-TestDistributedSearch.test-seed#[1100A2614CAEB74A]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2da6e5e2
   [junit4]   2> 812341 INFO  
(TEST-TestDistributedSearch.test-seed#[1100A2614CAEB74A]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2da6e5e2
   [junit4]   2> 812341 INFO  
(TEST-TestDistributedSearch.test-seed#[1100A2614CAEB74A]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2da6e5e2
   [junit4]   2> 812343 INFO  
(TEST-TestDistributedSearch.test-seed#[1100A2614CAEB74A]) [    ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_1100A2614CAEB74A-001/tempDir-001/shard0/cores
   [junit4]   2> 812343 INFO  
(TEST-TestDistributedSearch.test-seed#[1100A2614CAEB74A]) [    ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 812344 INFO  (coreLoadExecutor-3007-thread-1) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 812345 INFO  (coreLoadExecutor-3007-thread-1) [    
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, 
from paths: 
[/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1/lib,
 
/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 812383 INFO  (coreLoadExecutor-3007-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.4.0
   [junit4]   2> 812406 INFO  (coreLoadExecutor-3007-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 812515 INFO  (coreLoadExecutor-3007-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 812525 INFO  (coreLoadExecutor-3007-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from configset 
/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1,
 trusted=true
   [junit4]   2> 812526 INFO  (coreLoadExecutor-3007-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@2da6e5e2
   [junit4]   2> 812526 INFO  (coreLoadExecutor-3007-thread-1) [    
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 812526 INFO  (coreLoadExecutor-3007-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1],
 
dataDir=[/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_1100A2614CAEB74A-001/tempDir-001/shard0/cores/collection1/data/]
   [junit4]   2> 812528 INFO  (coreLoadExecutor-3007-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=24, maxMergeAtOnceExplicit=18, maxMergedSegmentMB=79.0615234375, 
floorSegmentMB=1.740234375, forceMergeDeletesPctAllowed=13.462939348061614, 
segmentsPerTier=19.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.6902458209418335
   [junit4]   2> 812601 INFO  (coreLoadExecutor-3007-thread-1) [    
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 812601 INFO  (coreLoadExecutor-3007-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 812604 INFO  (coreLoadExecutor-3007-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 812604 INFO  (coreLoadExecutor-3007-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 812605 INFO  (coreLoadExecutor-3007-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=21, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.35741961889174767]
   [junit4]   2> 812606 INFO  (coreLoadExecutor-3007-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@5b3560da[collection1] main]
   [junit4]   2> 812606 INFO  (coreLoadExecutor-3007-thread-1) [    
x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 812620 INFO  (coreLoadExecutor-3007-thread-1) [    
x:collection1] o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 812696 INFO  (coreLoadExecutor-3007-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 812696 INFO  
(searcherExecutor-3008-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 812696 INFO  (coreLoadExecutor-3007-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1594986088631369728
   [junit4]   2> 812697 INFO  
(searcherExecutor-3008-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 812697 INFO  
(searcherExecutor-3008-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 812697 INFO  
(searcherExecutor-3008-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 812697 INFO  
(searcherExecutor-3008-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 812697 INFO  
(searcherExecutor-3008-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 812697 INFO  
(searcherExecutor-3008-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 812698 INFO  
(searcherExecutor-3008-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 812698 INFO  
(searcherExecutor-3008-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 812699 INFO  
(searcherExecutor-3008-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@5b3560da[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 812699 INFO  
(TEST-TestDistributedSearch.test-seed#[1100A2614CAEB74A]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting test
   [junit4]   2> 812704 INFO  (qtp1787773126-9145) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{deleteByQuery=*:* (-1594986088637661184)} 0 2
   [junit4]   2> 812709 INFO  (qtp1283414720-9161) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{deleteByQuery=*:* (-1594986088643952640)} 0 1
   [junit4]   2> 812714 INFO  (qtp1787773126-9148) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[1 (1594986088647098368)]} 0 3
   [junit4]   2> 812716 INFO  (qtp1283414720-9163) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[1 (1594986088651292672)]} 0 1
   [junit4]   2> 812717 INFO  (qtp1787773126-9150) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[2 (1594986088653389824)]} 0 0
   [junit4]   2> 812719 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[2 (1594986088654438400)]} 0 0
   [junit4]   2> 812720 INFO  (qtp1787773126-9148) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[3 (1594986088656535552)]} 0 0
   [junit4]   2> 812721 INFO  (qtp1283414720-9163) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[3 (1594986088657584128)]} 0 0
   [junit4]   2> 812722 INFO  (qtp1787773126-9150) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[4 (1594986088658632704)]} 0 0
   [junit4]   2> 812723 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[4 (1594986088659681280)]} 0 0
   [junit4]   2> 812724 INFO  (qtp1787773126-9148) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[5 (1594986088660729856)]} 0 0
   [junit4]   2> 812725 INFO  (qtp1283414720-9163) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[5 (1594986088661778432)]} 0 0
   [junit4]   2> 812726 INFO  (qtp1787773126-9150) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[6 (1594986088662827008)]} 0 0
   [junit4]   2> 812728 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[6 (1594986088663875584)]} 0 0
   [junit4]   2> 812729 INFO  (qtp1787773126-9148) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[7 (1594986088664924160)]} 0 0
   [junit4]   2> 812730 INFO  (qtp1283414720-9163) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[7 (1594986088665972736)]} 0 0
   [junit4]   2> 812731 INFO  (qtp1787773126-9150) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[8 (1594986088667021312)]} 0 0
   [junit4]   2> 812732 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[8 (1594986088668069888)]} 0 0
   [junit4]   2> 812733 INFO  (qtp1787773126-9148) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[9 (1594986088670167040)]} 0 0
   [junit4]   2> 812734 INFO  (qtp1283414720-9163) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[9 (1594986088671215616)]} 0 0
   [junit4]   2> 812735 INFO  (qtp1787773126-9150) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1594986088672264192,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 812735 INFO  (qtp1787773126-9150) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@33c87267 
commitCommandVersion:1594986088672264192
   [junit4]   2> 812741 INFO  (qtp1787773126-9150) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@63ae7b47[collection1] main]
   [junit4]   2> 812742 INFO  (qtp1787773126-9150) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 812744 INFO  
(searcherExecutor-2997-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@63ae7b47[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.4.0):c9)))}
   [junit4]   2> 812744 INFO  (qtp1787773126-9150) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 9
   [junit4]   2> 812745 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1594986088682749952,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 812745 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@78d6a74d 
commitCommandVersion:1594986088682749952
   [junit4]   2> 812774 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@553777ee[collection1] main]
   [junit4]   2> 812775 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 812776 INFO  
(searcherExecutor-3008-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@553777ee[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.4.0):c9)))}
   [junit4]   2> 812776 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 31
   [junit4]   2> 812779 INFO  (qtp1787773126-9148) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[10 (1594986088716304384)]} 0 1
   [junit4]   2> 812781 INFO  (qtp1283414720-9163) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[10 (1594986088719450112)]} 0 1
   [junit4]   2> 812783 INFO  (qtp1787773126-9150) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[11 (1594986088721547264)]} 0 1
   [junit4]   2> 812784 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[11 (1594986088722595840)]} 0 0
   [junit4]   2> 812785 INFO  (qtp1787773126-9148) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[12 (1594986088724692992)]} 0 0
   [junit4]   2> 812786 INFO  (qtp1283414720-9163) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[12 (1594986088725741568)]} 0 0
   [junit4]   2> 812787 INFO  (qtp1787773126-9150) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[13 (1594986088726790144)]} 0 0
   [junit4]   2> 812788 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[13 (1594986088727838720)]} 0 0
   [junit4]   2> 812789 INFO  (qtp1787773126-9148) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[1001 (1594986088728887296)]} 0 0
   [junit4]   2> 812790 INFO  (qtp1283414720-9163) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[1001 (1594986088729935872)]} 0 0
   [junit4]   2> 812791 INFO  (qtp1787773126-9150) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[14 (1594986088730984448)]} 0 0
   [junit4]   2> 812792 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[14 (1594986088732033024)]} 0 0
   [junit4]   2> 812793 INFO  (qtp1787773126-9148) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[15 (1594986088732033024)]} 0 0
   [junit4]   2> 812793 INFO  (qtp1283414720-9163) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[15 (1594986088733081600)]} 0 0
   [junit4]   2> 812794 INFO  (qtp1787773126-9150) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[16 (1594986088734130176)]} 0 0
   [junit4]   2> 812795 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[16 (1594986088735178752)]} 0 0
   [junit4]   2> 812796 INFO  (qtp1787773126-9148) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[17 (1594986088735178752)]} 0 0
   [junit4]   2> 812796 INFO  (qtp1283414720-9163) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[17 (1594986088736227328)]} 0 0
   [junit4]   2> 812797 INFO  (qtp1787773126-9150) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[100 (1594986088737275904)]} 0 0
   [junit4]   2> 812798 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[100 (1594986088738324480)]} 0 0
   [junit4]   2> 812799 INFO  (qtp1787773126-9148) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[101 (1594986088739373056)]} 0 0
   [junit4]   2> 812800 INFO  (qtp1283414720-9163) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[101 (1594986088739373056)]} 0 0
   [junit4]   2> 812800 INFO  (qtp1787773126-9150) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[102 (1594986088740421632)]} 0 0
   [junit4]   2> 812801 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[102 (1594986088741470208)]} 0 0
   [junit4]   2> 812802 INFO  (qtp1787773126-9148) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[103 (1594986088742518784)]} 0 0
   [junit4]   2> 812803 INFO  (qtp1283414720-9163) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[103 (1594986088742518784)]} 0 0
   [junit4]   2> 812803 INFO  (qtp1787773126-9150) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[104 (1594986088743567360)]} 0 0
   [junit4]   2> 812804 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[104 (1594986088744615936)]} 0 0
   [junit4]   2> 812805 INFO  (qtp1787773126-9148) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[105 (1594986088745664512)]} 0 0
   [junit4]   2> 812806 INFO  (qtp1283414720-9163) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[105 (1594986088746713088)]} 0 0
   [junit4]   2> 812807 INFO  (qtp1787773126-9150) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[106 (1594986088747761664)]} 0 0
   [junit4]   2> 812807 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[106 (1594986088747761664)]} 0 0
   [junit4]   2> 812807 INFO  (qtp1787773126-9148) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[107 (1594986088747761665)]} 0 0
   [junit4]   2> 812811 INFO  (qtp1283414720-9163) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[107 (1594986088747761665)]} 0 4
   [junit4]   2> 812812 INFO  (qtp1787773126-9150) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[108 (1594986088753004544)]} 0 0
   [junit4]   2> 812812 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[108 (1594986088753004544)]} 0 0
   [junit4]   2> 812813 INFO  (qtp1787773126-9148) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[109 (1594986088754053120)]} 0 0
   [junit4]   2> 812814 INFO  (qtp1283414720-9163) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[109 (1594986088755101696)]} 0 0
   [junit4]   2> 812814 INFO  (qtp1787773126-9150) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[110 (1594986088755101696)]} 0 0
   [junit4]   2> 812815 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[110 (1594986088756150272)]} 0 0
   [junit4]   2> 812816 INFO  (qtp1787773126-9148) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[111 (1594986088757198848)]} 0 0
   [junit4]   2> 812817 INFO  (qtp1283414720-9163) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[111 (1594986088757198848)]} 0 0
   [junit4]   2> 812817 INFO  (qtp1787773126-9150) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[112 (1594986088758247424)]} 0 0
   [junit4]   2> 812818 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[112 (1594986088759296000)]} 0 0
   [junit4]   2> 812819 INFO  (qtp1787773126-9148) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[113 (1594986088759296000)]} 0 0
   [junit4]   2> 812819 INFO  (qtp1283414720-9163) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[113 (1594986088760344576)]} 0 0
   [junit4]   2> 812820 INFO  (qtp1787773126-9150) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[114 (1594986088761393152)]} 0 0
   [junit4]   2> 812821 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[114 (1594986088762441728)]} 0 0
   [junit4]   2> 812822 INFO  (qtp1787773126-9148) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[115 (1594986088762441728)]} 0 0
   [junit4]   2> 812822 INFO  (qtp1283414720-9163) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[115 (1594986088763490304)]} 0 0
   [junit4]   2> 812823 INFO  (qtp1787773126-9150) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[116 (1594986088764538880)]} 0 0
   [junit4]   2> 812824 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[116 (1594986088765587456)]} 0 0
   [junit4]   2> 812825 INFO  (qtp1787773126-9148) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[117 (1594986088765587456)]} 0 0
   [junit4]   2> 812825 INFO  (qtp1283414720-9163) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[117 (1594986088766636032)]} 0 0
   [junit4]   2> 812826 INFO  (qtp1787773126-9150) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[118 (1594986088767684608)]} 0 0
   [junit4]   2> 812826 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[118 (1594986088767684608)]} 0 0
   [junit4]   2> 812827 INFO  (qtp1787773126-9148) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[119 (1594986088768733184)]} 0 0
   [junit4]   2> 812828 INFO  (qtp1283414720-9163) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[119 (1594986088769781760)]} 0 0
   [junit4]   2> 812828 INFO  (qtp1787773126-9150) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[120 (1594986088769781760)]} 0 0
   [junit4]   2> 812829 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[120 (1594986088770830336)]} 0 0
   [junit4]   2> 812830 INFO  (qtp1787773126-9148) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[121 (1594986088770830336)]} 0 0
   [junit4]   2> 812830 INFO  (qtp1283414720-9163) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[121 (1594986088771878912)]} 0 0
   [junit4]   2> 812831 INFO  (qtp1787773126-9150) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[122 (1594986088772927488)]} 0 0
   [junit4]   2> 812832 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[122 (1594986088772927488)]} 0 0
   [junit4]   2> 812833 INFO  (qtp1787773126-9148) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[123 (1594986088775024640)]} 0 0
   [junit4]   2> 812834 INFO  (qtp1283414720-9163) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[123 (1594986088776073216)]} 0 0
   [junit4]   2> 812835 INFO  (qtp1787773126-9150) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[124 (1594986088777121792)]} 0 0
   [junit4]   2> 812836 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[124 (1594986088778170368)]} 0 0
   [junit4]   2> 812837 INFO  (qtp1787773126-9148) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[125 (1594986088779218944)]} 0 0
   [junit4]   2> 812838 INFO  (qtp1283414720-9163) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[125 (1594986088780267520)]} 0 0
   [junit4]   2> 812839 INFO  (qtp1787773126-9150) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[126 (1594986088781316096)]} 0 0
   [junit4]   2> 812840 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[126 (1594986088782364672)]} 0 0
   [junit4]   2> 812841 INFO  (qtp1787773126-9148) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[127 (1594986088783413248)]} 0 0
   [junit4]   2> 812842 INFO  (qtp1283414720-9163) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[127 (1594986088784461824)]} 0 0
   [junit4]   2> 812843 INFO  (qtp1787773126-9150) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[128 (1594986088785510400)]} 0 0
   [junit4]   2> 812844 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[128 (1594986088786558976)]} 0 0
   [junit4]   2> 812845 INFO  (qtp1787773126-9148) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[129 (1594986088787607552)]} 0 0
   [junit4]   2> 812846 INFO  (qtp1283414720-9163) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[129 (1594986088788656128)]} 0 0
   [junit4]   2> 812847 INFO  (qtp1787773126-9150) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[130 (1594986088789704704)]} 0 0
   [junit4]   2> 812848 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[130 (1594986088790753280)]} 0 0
   [junit4]   2> 812849 INFO  (qtp1787773126-9148) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[131 (1594986088791801856)]} 0 0
   [junit4]   2> 812850 INFO  (qtp1283414720-9163) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[131 (1594986088792850432)]} 0 0
   [junit4]   2> 812851 INFO  (qtp1787773126-9150) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[132 (1594986088792850432)]} 0 0
   [junit4]   2> 812852 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[132 (1594986088793899008)]} 0 0
   [junit4]   2> 812853 INFO  (qtp1787773126-9148) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[133 (1594986088794947584)]} 0 0
   [junit4]   2> 812854 INFO  (qtp1283414720-9163) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[133 (1594986088795996160)]} 0 0
   [junit4]   2> 812854 INFO  (qtp1787773126-9150) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[134 (1594986088797044736)]} 0 0
   [junit4]   2> 812862 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[134 (1594986088805433344)]} 0 0
   [junit4]   2> 812863 INFO  (qtp1787773126-9148) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[135 (1594986088806481920)]} 0 0
   [junit4]   2> 812864 INFO  (qtp1283414720-9163) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[135 (1594986088807530496)]} 0 0
   [junit4]   2> 812865 INFO  (qtp1787773126-9150) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[136 (1594986088808579072)]} 0 0
   [junit4]   2> 812866 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[136 (1594986088809627648)]} 0 0
   [junit4]   2> 812868 INFO  (qtp1787773126-9148) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[137 (1594986088810676224)]} 0 0
   [junit4]   2> 812869 INFO  (qtp1283414720-9163) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[137 (1594986088811724800)]} 0 0
   [junit4]   2> 812869 INFO  (qtp1787773126-9150) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[138 (1594986088812773376)]} 0 0
   [junit4]   2> 812870 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[138 (1594986088813821952)]} 0 0
   [junit4]   2> 812871 INFO  (qtp1787773126-9148) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[139 (1594986088814870528)]} 0 0
   [junit4]   2> 812872 INFO  (qtp1283414720-9163) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[139 (1594986088815919104)]} 0 0
   [junit4]   2> 812873 INFO  (qtp1787773126-9150) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[140 (1594986088816967680)]} 0 0
   [junit4]   2> 812874 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[140 (1594986088818016256)]} 0 0
   [junit4]   2> 812875 INFO  (qtp1787773126-9148) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[141 (1594986088819064832)]} 0 0
   [junit4]   2> 812877 INFO  (qtp1283414720-9163) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[141 (1594986088820113408)]} 0 0
   [junit4]   2> 812878 INFO  (qtp1787773126-9150) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[142 (1594986088822210560)]} 0 0
   [junit4]   2> 812881 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[142 (1594986088823259136)]} 0 2
   [junit4]   2> 812885 INFO  (qtp1787773126-9148) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[143 (1594986088828502016)]} 0 1
   [junit4]   2> 812887 INFO  (qtp1283414720-9163) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[143 (1594986088830599168)]} 0 0
   [junit4]   2> 812888 INFO  (qtp1787773126-9150) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[144 (1594986088832696320)]} 0 0
   [junit4]   2> 812890 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[144 (1594986088834793472)]} 0 0
   [junit4]   2> 812892 INFO  (qtp1787773126-9148) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[145 (1594986088836890624)]} 0 0
   [junit4]   2> 812893 INFO  (qtp1283414720-9163) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[145 (1594986088837939200)]} 0 0
   [junit4]   2> 812894 INFO  (qtp1787773126-9150) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[146 (1594986088838987776)]} 0 0
   [junit4]   2> 812896 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[146 (1594986088841084928)]} 0 0
   [junit4]   2> 812898 INFO  (qtp1787773126-9148) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[147 (1594986088842133504)]} 0 0
   [junit4]   2> 812898 INFO  (qtp1283414720-9163) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[147 (1594986088843182080)]} 0 0
   [junit4]   2> 812899 INFO  (qtp1787773126-9150) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[148 (1594986088844230656)]} 0 0
   [junit4]   2> 812900 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[148 (1594986088844230656)]} 0 0
   [junit4]   2> 812900 INFO  (qtp1787773126-9148) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[149 (1594986088845279232)]} 0 0
   [junit4]   2> 812901 INFO  (qtp1283414720-9163) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={wt=javabin&version=2}{add=[149 (1594986088846327808)]} 0 0
   [junit4]   2> 812901 INFO  (qtp1787773126-9150) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1594986088846327808,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 812901 INFO  (qtp1787773126-9150) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@33c87267 
commitCommandVersion:1594986088846327808
   [junit4]   2> 812909 INFO  (qtp1787773126-9150) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@20c8b2d0[collection1] main]
   [junit4]   2> 812909 INFO  (qtp1787773126-9150) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 812910 INFO  
(searcherExecutor-2997-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@20c8b2d0[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.4.0):c9)
 Uninverting(_1(7.4.0):c59)))}
   [junit4]   2> 812911 INFO  (qtp1787773126-9150) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 9
   [junit4]   2> 812911 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1594986088856813568,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 812911 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@78d6a74d 
commitCommandVersion:1594986088856813568
   [junit4]   2> 812918 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@54eb91c6[collection1] main]
   [junit4]   2> 812918 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 812920 INFO  
(searcherExecutor-3008-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@54eb91c6[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.4.0):c9)
 Uninverting(_1(7.4.0):c59)))}
   [junit4]   2> 812920 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/ets path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 9
   [junit4]   2> 812922 INFO  (qtp1787773126-9148) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching parameter cannot be 
negative
   [junit4]   2> 812922 INFO  (qtp1787773126-9148) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={q=*&distrib=false&start=-1&wt=javabin&version=2} status=400 QTime=0
   [junit4]   2> 812923 INFO  (qtp1787773126-9150) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching parameter cannot be 
negative
   [junit4]   2> 812923 INFO  (qtp1787773126-9150) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={q=*&distrib=false&start=0&rows=-1&wt=javabin&version=2} status=400 
QTime=0
   [junit4]   2> 812924 INFO  (qtp1787773126-9148) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={q=*:*&distrib=false&sort=n_ti1+desc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 812928 INFO  (qtp1283414720-9166) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_ti1+desc&shard.url=http://127.0.0.1:41443/ets/collection1&rows=10&version=2&q=*:*&NOW=1521097267982&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 812933 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1521097267982&ids=100,111,12,13,113,5,149,127,7,108&isShard=true&shard.url=http://127.0.0.1:41443/ets/collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 812938 INFO  (qtp1283414720-9163) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={q=*:*&shards=http://127.0.0.1:41443/ets/collection1&sort=n_ti1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=13
   [junit4]   2> 812943 INFO  (qtp1787773126-9150) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={q=*:*&distrib=false&sort=n_ti1+asc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 812947 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets 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:41443/ets/collection1|[ff01::083]:33332/ets&rows=10&version=2&q=*:*&NOW=1521097268002&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 812948 INFO  (qtp1283414720-9168) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1521097268002&ids=121,1,3,114,147,126,148,6,109,142&isShard=true&shard.url=http://127.0.0.1:41443/ets/collection1|[ff01::083]:33332/ets&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 812955 INFO  (qtp1283414720-9166) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={q=*:*&shards=http://127.0.0.1:41443/ets/collection1|[ff01::083]:33332/ets&sort=n_ti1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=9
   [junit4]   2> 812957 INFO  (qtp1787773126-9148) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={q=*:*&distrib=false&sort=n_f1+desc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 812959 INFO  (qtp1283414720-9166) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets 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:41443/ets/collection1|[ff01::114]:33332/ets&rows=10&version=2&q=*:*&NOW=1521097268015&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 812960 INFO  (qtp1283414720-9168) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1521097268015&ids=121,101,2,123,102,125,15,116,7,131&isShard=true&shard.url=http://127.0.0.1:41443/ets/collection1|[ff01::114]:33332/ets&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 812968 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={q=*:*&shards=http://127.0.0.1:41443/ets/collection1|[ff01::114]:33332/ets&sort=n_f1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=10
   [junit4]   2> 812969 INFO  (qtp1787773126-9150) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={q=*:*&distrib=false&sort=n_f1+asc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 812972 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets 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:41443/ets/collection1|[ff01::083]:33332/ets|[ff01::114]:33332/ets|[ff01::213]:33332/ets&rows=10&version=2&q=*:*&NOW=1521097268028&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 812974 INFO  (qtp1283414720-9168) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1521097268028&ids=135,136,147,114,104,17,105,107,9,120&isShard=true&shard.url=http://127.0.0.1:41443/ets/collection1|[ff01::083]:33332/ets|[ff01::114]:33332/ets|[ff01::213]:33332/ets&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 812979 INFO  (qtp1283414720-9166) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={q=*:*&shards=http://127.0.0.1:41443/ets/collection1|[ff01::083]:33332/ets|[ff01::114]:33332/ets|[ff01::213]:33332/ets&sort=n_f1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=8
   [junit4]   2> 812980 INFO  (qtp1787773126-9148) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={q=*:*&distrib=false&sort=n_tf1+desc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 812982 INFO  (qtp1283414720-9166) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets 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:41443/ets/collection1|[ff01::213]:33332/ets&rows=10&version=2&q=*:*&NOW=1521097268039&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 812986 INFO  (qtp1283414720-9168) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1521097268039&ids=111,100,145,14,3,147,137,116,127,1001&isShard=true&shard.url=http://127.0.0.1:41443/ets/collection1|[ff01::213]:33332/ets&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 812993 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={q=*:*&shards=http://127.0.0.1:41443/ets/collection1|[ff01::213]:33332/ets&sort=n_tf1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=11
   [junit4]   2> 812995 INFO  (qtp1787773126-9150) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={q=*:*&distrib=false&sort=n_tf1+asc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 813007 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_tf1+asc&shard.url=[ff01::213]:33332/ets|[ff01::083]:33332/ets|http://127.0.0.1:41443/ets/collection1&rows=10&version=2&q=*:*&NOW=1521097268053&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 813008 INFO  (qtp1283414720-9168) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1521097268053&ids=110,101,135,102,15,139,7,128,118,9&isShard=true&shard.url=[ff01::213]:33332/ets|[ff01::083]:33332/ets|http://127.0.0.1:41443/ets/collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 813009 INFO  (qtp1283414720-9166) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={q=*:*&shards=[ff01::213]:33332/ets|[ff01::083]:33332/ets|http://127.0.0.1:41443/ets/collection1&sort=n_tf1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=13
   [junit4]   2> 813010 INFO  (qtp1787773126-9148) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={q=*:*&distrib=false&sort=n_d1+desc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 813012 INFO  (qtp1283414720-9166) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_d1+desc&shard.url=http://127.0.0.1:41443/ets/collection1&rows=10&version=2&q=*:*&NOW=1521097268068&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 813013 INFO  (qtp1283414720-9168) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1521097268068&ids=12,134,3,14,102,114,5,17,139,108&isShard=true&shard.url=http://127.0.0.1:41443/ets/collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 813013 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={q=*:*&shards=http://127.0.0.1:41443/ets/collection1&sort=n_d1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=2
   [junit4]   2> 813014 INFO  (qtp1787773126-9150) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={q=*:*&distrib=false&sort=n_d1+asc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 813017 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_d1+asc&shard.url=[ff01::114]:33332/ets|http://127.0.0.1:41443/ets/collection1|[ff01::083]:33332/ets|[ff01::213]:33332/ets&rows=10&version=2&q=*:*&NOW=1521097268072&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 813018 INFO  (qtp1283414720-9168) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1521097268072&ids=143,111,147,15,126,138,149,7,8,9&isShard=true&shard.url=[ff01::114]:33332/ets|http://127.0.0.1:41443/ets/collection1|[ff01::083]:33332/ets|[ff01::213]:33332/ets&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 813019 INFO  (qtp1283414720-9166) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={q=*:*&shards=[ff01::114]:33332/ets|http://127.0.0.1:41443/ets/collection1|[ff01::083]:33332/ets|[ff01::213]:33332/ets&sort=n_d1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=3
   [junit4]   2> 813019 INFO  (qtp1787773126-9148) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={q=*:*&distrib=false&sort=n_td1+desc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 813021 INFO  (qtp1283414720-9166) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_td1+desc&shard.url=[ff01::083]:33332/ets|[ff01::114]:33332/ets|[ff01::213]:33332/ets|http://127.0.0.1:41443/ets/collection1&rows=10&version=2&q=*:*&NOW=1521097268078&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 813022 INFO  (qtp1283414720-9168) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1521097268078&ids=110,145,3,114,125,136,104,126,17,128&isShard=true&shard.url=[ff01::083]:33332/ets|[ff01::114]:33332/ets|[ff01::213]:33332/ets|http://127.0.0.1:41443/ets/collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 813024 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={q=*:*&shards=[ff01::083]:33332/ets|[ff01::114]:33332/ets|[ff01::213]:33332/ets|http://127.0.0.1:41443/ets/collection1&sort=n_td1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=3
   [junit4]   2> 813025 INFO  (qtp1787773126-9146) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={q=*:*&distrib=false&sort=n_td1+asc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 813027 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_td1+asc&shard.url=http://127.0.0.1:41443/ets/collection1&rows=10&version=2&q=*:*&NOW=1521097268083&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 813028 INFO  (qtp1283414720-9168) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1521097268083&ids=132,112,113,124,5,6,138,149,119,109&isShard=true&shard.url=http://127.0.0.1:41443/ets/collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 813029 INFO  (qtp1283414720-9166) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={q=*:*&shards=http://127.0.0.1:41443/ets/collection1&sort=n_td1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=3
   [junit4]   2> 813030 INFO  (qtp1787773126-9150) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={q=*:*&distrib=false&sort=n_l1+desc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 813032 INFO  (qtp1283414720-9166) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_l1+desc&shard.url=[ff01::114]:33332/ets|[ff01::083]:33332/ets|http://127.0.0.1:41443/ets/collection1&rows=10&version=2&q=*:*&NOW=1521097268089&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 813034 INFO  (qtp1283414720-9168) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1521097268089&ids=110,124,135,114,137,17,1001,8,107,141&isShard=true&shard.url=[ff01::114]:33332/ets|[ff01::083]:33332/ets|http://127.0.0.1:41443/ets/collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 813034 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={q=*:*&shards=[ff01::114]:33332/ets|[ff01::083]:33332/ets|http://127.0.0.1:41443/ets/collection1&sort=n_l1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=2
   [junit4]   2> 813036 INFO  (qtp1787773126-9146) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={q=*:*&distrib=false&sort=n_l1+asc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 813038 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_l1+asc&shard.url=http://127.0.0.1:41443/ets/collection1&rows=10&version=2&q=*:*&NOW=1521097268094&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 813039 INFO  (qtp1283414720-9168) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1521097268094&ids=11,121,111,103,6,138,117,118,129,140&isShard=true&shard.url=http://127.0.0.1:41443/ets/collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 813040 INFO  (qtp1283414720-9166) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={q=*:*&shards=http://127.0.0.1:41443/ets/collection1&sort=n_l1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=3
   [junit4]   2> 813041 INFO  (qtp1787773126-9150) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={q=*:*&distrib=false&sort=n_tl1+desc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 813044 INFO  (qtp1283414720-9166) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_tl1+desc&shard.url=http://127.0.0.1:41443/ets/collection1&rows=10&version=2&q=*:*&NOW=1521097268100&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 813045 INFO  (qtp1283414720-9168) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1521097268100&ids=121,133,111,144,14,113,105,128,141,120&isShard=true&shard.url=http://127.0.0.1:41443/ets/collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 813046 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={q=*:*&shards=http://127.0.0.1:41443/ets/collection1&sort=n_tl1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=3
   [junit4]   2> 813047 INFO  (qtp1787773126-9146) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={q=*:*&distrib=false&sort=n_tl1+asc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 813049 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_tl1+asc&shard.url=http://127.0.0.1:41443/ets/collection1|[ff01::213]:33332/ets|[ff01::083]:33332/ets&rows=10&version=2&q=*:*&NOW=1521097268105&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 813051 INFO  (qtp1283414720-9168) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1521097268105&ids=1,145,134,4,147,103,126,138,9,130&isShard=true&shard.url=http://127.0.0.1:41443/ets/collection1|[ff01::213]:33332/ets|[ff01::083]:33332/ets&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 813052 INFO  (qtp1283414720-9166) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={q=*:*&shards=http://127.0.0.1:41443/ets/collection1|[ff01::213]:33332/ets|[ff01::083]:33332/ets&sort=n_tl1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=3
   [junit4]   2> 813053 INFO  (qtp1787773126-9150) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={q=*:*&distrib=false&sort=n_dt1+desc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 813056 INFO  (qtp1283414720-9166) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_dt1+desc&shard.url=[ff01::114]:33332/ets|[ff01::083]:33332/ets|http://127.0.0.1:41443/ets/collection1&rows=10&version=2&q=*:*&NOW=1521097268112&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 813058 INFO  (qtp1283414720-9168) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1521097268112&ids=13,146,135,148,149,106,118,9,130,142&isShard=true&shard.url=[ff01::114]:33332/ets|[ff01::083]:33332/ets|http://127.0.0.1:41443/ets/collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 813059 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={q=*:*&shards=[ff01::114]:33332/ets|[ff01::083]:33332/ets|http://127.0.0.1:41443/ets/collection1&sort=n_dt1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=3
   [junit4]   2> 813060 INFO  (qtp1787773126-9146) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={q=*:*&distrib=false&sort=n_dt1+asc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 813062 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_dt1+asc&shard.url=[ff01::213]:33332/ets|http://127.0.0.1:41443/ets/collection1&rows=10&version=2&q=*:*&NOW=1521097268118&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 813063 INFO  (qtp1283414720-9168) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1521097268118&ids=121,11,1,112,123,15,147,139,141,131&isShard=true&shard.url=[ff01::213]:33332/ets|http://127.0.0.1:41443/ets/collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 813064 INFO  (qtp1283414720-9166) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={q=*:*&shards=[ff01::213]:33332/ets|http://127.0.0.1:41443/ets/collection1&sort=n_dt1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=2
   [junit4]   2> 813065 INFO  (qtp1787773126-9150) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={q=*:*&distrib=false&sort=n_tdt1+desc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 813066 INFO  (qtp1283414720-9166) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_tdt1+desc&shard.url=[ff01::083]:33332/ets|[ff01::114]:33332/ets|[ff01::213]:33332/ets|http://127.0.0.1:41443/ets/collection1&rows=10&version=2&q=*:*&NOW=1521097268122&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 813067 INFO  (qtp1283414720-9168) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1521097268122&ids=143,1,102,103,127,8,107,108,140,131&isShard=true&shard.url=[ff01::083]:33332/ets|[ff01::114]:33332/ets|[ff01::213]:33332/ets|http://127.0.0.1:41443/ets/collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 813068 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={q=*:*&shards=[ff01::083]:33332/ets|[ff01::114]:33332/ets|[ff01::213]:33332/ets|http://127.0.0.1:41443/ets/collection1&sort=n_tdt1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=2
   [junit4]   2> 813069 INFO  (qtp1787773126-9146) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={q=*:*&distrib=false&sort=n_tdt1+asc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 813072 INFO  (qtp1283414720-9165) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_tdt1+asc&shard.url=http://127.0.0.1:41443/ets/collection1|[ff01::213]:33332/ets&rows=10&version=2&q=*:*&NOW=1521097268127&isShard=true&wt=javabin}
 hits=68 status=0 QTime=1
   [junit4]   2> 813073 INFO  (qtp1283414720-9168) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1521097268127&ids=13,145,3,125,136,5,148,117,130,10&isShard=true&shard.url=http://127.0.0.1:41443/ets/collection1|[ff01::213]:33332/ets&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 813074 INFO  (qtp1283414720-9166) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={q=*:*&shards=http://127.0.0.1:41443/ets/collection1|[ff01::213]:33332/ets&sort=n_tdt1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=3
   [junit4]   2> 813076 INFO  (qtp1787773126-9150) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={q=*:*&distrib=false&sort=a_i1+desc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 813077 INFO  (qtp1283414720-9166) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/ets path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=a_i1+desc&shard.url=http://127.0.0.1:41443/ets/collection1&rows=10&version=2&q=*:*&NOW=1521097268134&isShard=true&;

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

rMetricManager Closing metric reporters for registry=solr.core.collection1, 
tag=63000775
   [junit4]   2> 841450 INFO  (coreCloseExecutor-3054-thread-1) [    
x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@34df5a84: rootName = null, 
domain = solr.core.collection1, service url = null, agent id = null] for 
registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@50eb233
   [junit4]   2> 841460 INFO  
(TEST-TestDistributedSearch.test-seed#[1100A2614CAEB74A]) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@1cd5ab6c{/ets,null,UNAVAILABLE}
   [junit4]   2> 841461 INFO  
(TEST-TestDistributedSearch.test-seed#[1100A2614CAEB74A]) [    ] 
o.e.j.s.session Stopped scavenging
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=TestDistributedSearch -Dtests.method=test 
-Dtests.seed=1100A2614CAEB74A -Dtests.slow=true -Dtests.locale=es 
-Dtests.timezone=America/Port-au-Prince -Dtests.asserts=true 
-Dtests.file.encoding=ISO-8859-1
   [junit4] FAILURE 30.0s J1 | 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:273)
   [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:188)
   [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=4}
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([1100A2614CAEB74A:99549DBBE252DAB2]:0)
   [junit4]    >        at 
org.apache.solr.TestDistributedSearch.comparePartialResponses(TestDistributedSearch.java:1191)
   [junit4]    >        at 
org.apache.solr.TestDistributedSearch.queryPartialResults(TestDistributedSearch.java:1132)
   [junit4]    >        at 
org.apache.solr.TestDistributedSearch.test(TestDistributedSearch.java:992)
   [junit4]    >        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsRepeatStatement.callStatement(BaseDistributedSearchTestCase.java:1019)
   [junit4]    >        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:968)
   [junit4]    >        at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_1100A2614CAEB74A-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): 
{severity=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
 
foo_sev_enum=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
 SubjectTerms_mfacet=PostingsFormat(name=Memory), 
multiDefault=PostingsFormat(name=Direct), rnd_b=FST50, 
a_s=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
 oddField_s=FST50, lowerfilt1and2=PostingsFormat(name=Direct), 
a_t=PostingsFormat(name=Direct), 
foo_b=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
 lowerfilt=PostingsFormat(name=Direct), id=FST50, 
text=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128)))},
 docValues:{other_tl1=DocValuesFormat(name=Memory), 
range_facet_l_dv=DocValuesFormat(name=Asserting), 
n_l1=DocValuesFormat(name=Lucene70), a_n_tdt=DocValuesFormat(name=Direct), 
intDefault=DocValuesFormat(name=Memory), n_td1=DocValuesFormat(name=Memory), 
n_d1=DocValuesFormat(name=Lucene70), 
range_facet_l=DocValuesFormat(name=Lucene70), 
n_f1=DocValuesFormat(name=Memory), n_tl1=DocValuesFormat(name=Memory), 
n_tf1=DocValuesFormat(name=Lucene70), 
intDvoDefault=DocValuesFormat(name=Asserting), 
timestamp=DocValuesFormat(name=Lucene70), 
severity=DocValuesFormat(name=Direct), 
foo_sev_enum=DocValuesFormat(name=Direct), n_dt1=DocValuesFormat(name=Memory), 
a_i1=DocValuesFormat(name=Lucene70), b_n_tdt=DocValuesFormat(name=Memory), 
n_ti1=DocValuesFormat(name=Asserting), _version_=DocValuesFormat(name=Memory), 
n_tdt1=DocValuesFormat(name=Memory), id_i1=DocValuesFormat(name=Memory), 
foo_d=DocValuesFormat(name=Asserting), 
range_facet_i_dv=DocValuesFormat(name=Lucene70), 
foo_f=DocValuesFormat(name=Direct)}, maxPointsInLeafNode=1622, 
maxMBSortInHeap=7.245197627528521, sim=RandomSimilarity(queryNorm=false): {}, 
locale=es, timezone=America/Port-au-Prince
   [junit4]   2> NOTE: SunOS 5.11 amd64/Oracle Corporation 1.8.0_162 
(64-bit)/cpus=3,threads=1,free=115136672,total=536870912
   [junit4]   2> NOTE: All tests run in this JVM: 
[TestInPlaceUpdatesStandalone, TestStressInPlaceUpdates, 
TestFreeTextSuggestions, TestStressVersions, StressHdfsTest, 
DocExpirationUpdateProcessorFactoryTest, TestPHPSerializedResponseWriter, 
FullSolrCloudDistribCmdsTest, BadCopyFieldTest, BufferStoreTest, OverseerTest, 
TestCoreAdminApis, TermVectorComponentTest, TestZkAclsWithHadoopAuth, 
ShardRoutingTest, NoCacheHeaderTest, HdfsCollectionsAPIDistributedZkTest, 
TestNamedUpdateProcessors, DateRangeFieldTest, 
AtomicUpdateProcessorFactoryTest, CdcrReplicationDistributedZkTest, 
TestFieldCacheSort, ReplicationFactorTest, 
PeerSyncWithIndexFingerprintCachingTest, TestLMDirichletSimilarityFactory, 
SolrCloudReportersTest, FileBasedSpellCheckerTest, ReplaceNodeNoTargetTest, 
TestNodeAddedTrigger, PeerSyncTest, DebugComponentTest, TestHdfsUpdateLog, 
TestUpdate, TestNumericRangeQuery64, IndexSchemaTest, 
ClassificationUpdateProcessorFactoryTest, TestNonDefinedSimilarityFactory, 
TestTrackingShardHandlerFactory, HdfsChaosMonkeySafeLeaderTest, 
ConnectionManagerTest, HighlighterConfigTest, PrimitiveFieldTypeTest, 
SimplePostToolTest, TestLRUCache, SolrCLIZkUtilsTest, 
TestSubQueryTransformerCrossCore, TestLegacyFieldCache, 
FieldAnalysisRequestHandlerTest, TestPointFields, 
ParsingFieldUpdateProcessorsTest, NotRequiredUniqueKeyTest, 
SpellCheckCollatorTest, TestDocBasedVersionConstraints, 
TestBackupRepositoryFactory, DistanceUnitsTest, TestFastWriter, 
ResponseLogComponentTest, TestLocalFSCloudBackupRestore, 
TestComplexPhraseLeadingWildcard, TestMacros, ClusterStateTest, 
HdfsDirectoryFactoryTest, TestReversedWildcardFilterFactory, ZkStateReaderTest, 
DOMUtilTest, HighlighterMaxOffsetTest, ExplicitHLLTest, DirectoryFactoryTest, 
OutOfBoxZkACLAndCredentialsProvidersTest, TestLegacyNumericRangeQueryBuilder, 
ShufflingReplicaListTransformerTest, HdfsBasicDistributedZkTest, 
TestCollectionsAPIViaSolrCloudCluster, TestFieldCacheVsDocValues, 
TokenizerChainTest, MetricTriggerTest, TestNestedDocsSort, UUIDFieldTest, 
TestDistribIDF, TestTrieFacet, TestQueryWrapperFilter, 
TestGeoJSONResponseWriter, TestDynamicLoading, BadIndexSchemaTest, 
TestManagedSynonymFilterFactory, ClassificationUpdateProcessorTest, 
DocumentAnalysisRequestHandlerTest, TestCustomSort, 
TestDistributedStatsComponentCardinality, TestScoreJoinQPScore, 
DirectUpdateHandlerTest, RollingRestartTest, PrimUtilsTest, TestReqParamsAPI, 
DistanceFunctionTest, LargeFieldTest, DocValuesTest, 
DistributedSuggestComponentTest, DistribDocExpirationUpdateProcessorTest, 
TestSolrCloudWithSecureImpersonation, ZkShardTermsTest, TestRandomDVFaceting, 
CloudMLTQParserTest, CollectionReloadTest, TestBlendedInfixSuggestions, 
SmileWriterTest, TestDFRSimilarityFactory, TestStressRecovery, 
TestChildDocTransformer, CloudExitableDirectoryReaderTest, RulesTest, 
TestSizeLimitedDistributedMap, TestAtomicUpdateErrorCases, 
TestIndexingPerformance, TestSchemaResource, TestSolrIndexConfig, 
TestConfigReload, TestRawResponseWriter, SolrCmdDistributorTest, 
TestDocumentBuilder, DistributedQueueTest, TestHalfAndHalfDocValues, 
TestDistribDocBasedVersion, TestDistributedSearch]
   [junit4] Completed [213/783 (1!)] on J1 in 30.06s, 1 test, 1 failure <<< 
FAILURES!

[...truncated 51578 lines...]
[repro] Jenkins log URL: 
https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Solaris/494/consoleText

[repro] Revision: 02425b27316caf389554ebf5fe333915cb420289

[repro] Ant options: "-Dargs=-XX:-UseCompressedOops -XX:+UseG1GC"
[repro] Repro line:  ant test  -Dtestcase=TestDistributedSearch 
-Dtests.method=test -Dtests.seed=1100A2614CAEB74A -Dtests.slow=true 
-Dtests.locale=es -Dtests.timezone=America/Port-au-Prince -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 3331 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5 
-Dtests.class="*.TestDistributedSearch" -Dtests.showOutput=onerror 
"-Dargs=-XX:-UseCompressedOops -XX:+UseG1GC" -Dtests.seed=1100A2614CAEB74A 
-Dtests.slow=true -Dtests.locale=es -Dtests.timezone=America/Port-au-Prince 
-Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1

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

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

Reply via email to