[JENKINS] Lucene-Solr-master-Linux (64bit/jdk1.8.0_121) - Build # 19258 - Unstable!

[Policeman Jenkins Server]

Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/19258/
Java: 64bit/jdk1.8.0_121 -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: No live SolrServers 
available to handle this 
request,trace=org.apache.solr.client.solrj.SolrServerException: No live 
SolrServers available to handle this request  at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:416)
  at 
org.apache.solr.handler.component.HttpShardHandlerFactory.makeLoadBalancedRequest(HttpShardHandlerFactory.java:259)
  at 
org.apache.solr.handler.component.HttpShardHandler.lambda$submit$0(HttpShardHandler.java:166)
  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:229)
  at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) 
 at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) 
 at java.lang.Thread.run(Thread.java:745) ,time=2}

Stack Trace:
java.lang.AssertionError: Expected to find shardAddress in the up shard info: 
{error=org.apache.solr.client.solrj.SolrServerException: No live SolrServers 
available to handle this 
request,trace=org.apache.solr.client.solrj.SolrServerException: No live 
SolrServers available to handle this request
        at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:416)
        at 
org.apache.solr.handler.component.HttpShardHandlerFactory.makeLoadBalancedRequest(HttpShardHandlerFactory.java:259)
        at 
org.apache.solr.handler.component.HttpShardHandler.lambda$submit$0(HttpShardHandler.java:166)
        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:229)
        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
        at java.lang.Thread.run(Thread.java:745)
,time=2}
        at 
__randomizedtesting.SeedInfo.seed([EDAA8B0E738FE5AE:65FEB4D4DD738856]: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:1186)
        at 
org.apache.solr.TestDistributedSearch.queryPartialResults(TestDistributedSearch.java:1127)
        at 
org.apache.solr.TestDistributedSearch.test(TestDistributedSearch.java:987)
        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:1713)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsRepeatStatement.callStatement(BaseDistributedSearchTestCase.java:1011)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:960)
        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:916)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
        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:745)




Build Log:
[...truncated 11773 lines...]
   [junit4] Suite: org.apache.solr.TestDistributedSearch
   [junit4]   2> Creating dataDir: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_EDAA8B0E738FE5AE-001/init-core-data-001
   [junit4]   2> 722785 WARN  
(SUITE-TestDistributedSearch-seed#[EDAA8B0E738FE5AE]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=1 numCloses=1
   [junit4]   2> 722785 INFO  
(SUITE-TestDistributedSearch-seed#[EDAA8B0E738FE5AE]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using TrieFields
   [junit4]   2> 722787 INFO  
(SUITE-TestDistributedSearch-seed#[EDAA8B0E738FE5AE]-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> 722787 INFO  
(SUITE-TestDistributedSearch-seed#[EDAA8B0E738FE5AE]-worker) [    ] 
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /
   [junit4]   2> 722859 INFO  
(TEST-TestDistributedSearch.test-seed#[EDAA8B0E738FE5AE]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_EDAA8B0E738FE5AE-001/tempDir-001/control/cores/collection1
   [junit4]   2> 722860 INFO  
(TEST-TestDistributedSearch.test-seed#[EDAA8B0E738FE5AE]) [    ] o.e.j.s.Server 
jetty-9.3.14.v20161028
   [junit4]   2> 722861 INFO  
(TEST-TestDistributedSearch.test-seed#[EDAA8B0E738FE5AE]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@521d750d{/,null,AVAILABLE}
   [junit4]   2> 722863 INFO  
(TEST-TestDistributedSearch.test-seed#[EDAA8B0E738FE5AE]) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@2f350900{HTTP/1.1,[http/1.1]}{127.0.0.1:37683}
   [junit4]   2> 722863 INFO  
(TEST-TestDistributedSearch.test-seed#[EDAA8B0E738FE5AE]) [    ] o.e.j.s.Server 
Started @724739ms
   [junit4]   2> 722863 INFO  
(TEST-TestDistributedSearch.test-seed#[EDAA8B0E738FE5AE]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, hostPort=37683, 
coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_EDAA8B0E738FE5AE-001/tempDir-001/control/cores}
   [junit4]   2> 722863 ERROR 
(TEST-TestDistributedSearch.test-seed#[EDAA8B0E738FE5AE]) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 722864 INFO  
(TEST-TestDistributedSearch.test-seed#[EDAA8B0E738FE5AE]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.0.0
   [junit4]   2> 722864 INFO  
(TEST-TestDistributedSearch.test-seed#[EDAA8B0E738FE5AE]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 722864 INFO  
(TEST-TestDistributedSearch.test-seed#[EDAA8B0E738FE5AE]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 722864 INFO  
(TEST-TestDistributedSearch.test-seed#[EDAA8B0E738FE5AE]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-03-25T18:09:54.274Z
   [junit4]   2> 722864 INFO  
(TEST-TestDistributedSearch.test-seed#[EDAA8B0E738FE5AE]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_EDAA8B0E738FE5AE-001/tempDir-001/control/solr.xml
   [junit4]   2> 722900 INFO  
(TEST-TestDistributedSearch.test-seed#[EDAA8B0E738FE5AE]) [    ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_EDAA8B0E738FE5AE-001/tempDir-001/control/cores
   [junit4]   2> 722900 INFO  
(TEST-TestDistributedSearch.test-seed#[EDAA8B0E738FE5AE]) [    ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 722901 INFO  (coreLoadExecutor-2345-thread-1) [    
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, 
from paths: 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib,
 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 722952 INFO  (coreLoadExecutor-2345-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 722972 INFO  (coreLoadExecutor-2345-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 723062 WARN  (coreLoadExecutor-2345-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] default search field in schema 
is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 723064 INFO  (coreLoadExecutor-2345-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 723070 INFO  (coreLoadExecutor-2345-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from configset 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1
   [junit4]   2> 723070 INFO  (coreLoadExecutor-2345-thread-1) [    
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 723070 INFO  (coreLoadExecutor-2345-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_EDAA8B0E738FE5AE-001/tempDir-001/control/cores/collection1/data/]
   [junit4]   2> 723070 INFO  (coreLoadExecutor-2345-thread-1) [    
x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr 
mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@410f441d
   [junit4]   2> 723071 INFO  (coreLoadExecutor-2345-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=17, maxMergeAtOnceExplicit=17, maxMergedSegmentMB=0.8701171875, 
floorSegmentMB=1.8505859375, forceMergeDeletesPctAllowed=23.82596043119431, 
segmentsPerTier=40.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.215178442078882
   [junit4]   2> 723111 INFO  (coreLoadExecutor-2345-thread-1) [    
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 723111 INFO  (coreLoadExecutor-2345-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 723114 INFO  (coreLoadExecutor-2345-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 723114 INFO  (coreLoadExecutor-2345-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 723114 INFO  (coreLoadExecutor-2345-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=28, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.0]
   [junit4]   2> 723114 INFO  (coreLoadExecutor-2345-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@4309ccfe[collection1] main]
   [junit4]   2> 723115 INFO  (coreLoadExecutor-2345-thread-1) [    
x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 723135 INFO  (coreLoadExecutor-2345-thread-1) [    
x:collection1] o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 723270 INFO  (coreLoadExecutor-2345-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 723270 INFO  
(searcherExecutor-2346-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 723270 INFO  
(searcherExecutor-2346-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 723270 INFO  
(searcherExecutor-2346-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 723270 INFO  
(searcherExecutor-2346-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 723270 INFO  
(searcherExecutor-2346-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 723271 INFO  
(searcherExecutor-2346-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 723271 INFO  
(searcherExecutor-2346-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 723271 INFO  (coreLoadExecutor-2345-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1562866241693024256
   [junit4]   2> 723271 INFO  
(searcherExecutor-2346-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 723271 INFO  
(searcherExecutor-2346-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 723272 INFO  
(searcherExecutor-2346-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@4309ccfe[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 723735 INFO  
(TEST-TestDistributedSearch.test-seed#[EDAA8B0E738FE5AE]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_EDAA8B0E738FE5AE-001/tempDir-001/shard0/cores/collection1
   [junit4]   2> 723736 INFO  
(TEST-TestDistributedSearch.test-seed#[EDAA8B0E738FE5AE]) [    ] o.e.j.s.Server 
jetty-9.3.14.v20161028
   [junit4]   2> 723738 INFO  
(TEST-TestDistributedSearch.test-seed#[EDAA8B0E738FE5AE]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@21e0f1fd{/,null,AVAILABLE}
   [junit4]   2> 723738 INFO  
(TEST-TestDistributedSearch.test-seed#[EDAA8B0E738FE5AE]) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@1f20b27b{HTTP/1.1,[http/1.1]}{127.0.0.1:38748}
   [junit4]   2> 723738 INFO  
(TEST-TestDistributedSearch.test-seed#[EDAA8B0E738FE5AE]) [    ] o.e.j.s.Server 
Started @725614ms
   [junit4]   2> 723738 INFO  
(TEST-TestDistributedSearch.test-seed#[EDAA8B0E738FE5AE]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, hostPort=38748, 
coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_EDAA8B0E738FE5AE-001/tempDir-001/shard0/cores}
   [junit4]   2> 723739 ERROR 
(TEST-TestDistributedSearch.test-seed#[EDAA8B0E738FE5AE]) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 723739 INFO  
(TEST-TestDistributedSearch.test-seed#[EDAA8B0E738FE5AE]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.0.0
   [junit4]   2> 723739 INFO  
(TEST-TestDistributedSearch.test-seed#[EDAA8B0E738FE5AE]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 723739 INFO  
(TEST-TestDistributedSearch.test-seed#[EDAA8B0E738FE5AE]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 723739 INFO  
(TEST-TestDistributedSearch.test-seed#[EDAA8B0E738FE5AE]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-03-25T18:09:55.149Z
   [junit4]   2> 723739 INFO  
(TEST-TestDistributedSearch.test-seed#[EDAA8B0E738FE5AE]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_EDAA8B0E738FE5AE-001/tempDir-001/shard0/solr.xml
   [junit4]   2> 723764 INFO  
(TEST-TestDistributedSearch.test-seed#[EDAA8B0E738FE5AE]) [    ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_EDAA8B0E738FE5AE-001/tempDir-001/shard0/cores
   [junit4]   2> 723764 INFO  
(TEST-TestDistributedSearch.test-seed#[EDAA8B0E738FE5AE]) [    ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 723764 INFO  (coreLoadExecutor-2356-thread-1) [    
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, 
from paths: 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib,
 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 723789 INFO  (coreLoadExecutor-2356-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 723808 INFO  (coreLoadExecutor-2356-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 723905 WARN  (coreLoadExecutor-2356-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] default search field in schema 
is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 723907 INFO  (coreLoadExecutor-2356-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 723913 INFO  (coreLoadExecutor-2356-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from configset 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1
   [junit4]   2> 723913 INFO  (coreLoadExecutor-2356-thread-1) [    
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 723913 INFO  (coreLoadExecutor-2356-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_EDAA8B0E738FE5AE-001/tempDir-001/shard0/cores/collection1/data/]
   [junit4]   2> 723913 INFO  (coreLoadExecutor-2356-thread-1) [    
x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr 
mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@410f441d
   [junit4]   2> 723914 INFO  (coreLoadExecutor-2356-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=17, maxMergeAtOnceExplicit=17, maxMergedSegmentMB=0.8701171875, 
floorSegmentMB=1.8505859375, forceMergeDeletesPctAllowed=23.82596043119431, 
segmentsPerTier=40.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.215178442078882
   [junit4]   2> 723958 INFO  (coreLoadExecutor-2356-thread-1) [    
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 723958 INFO  (coreLoadExecutor-2356-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 723960 INFO  (coreLoadExecutor-2356-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 723960 INFO  (coreLoadExecutor-2356-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 723961 INFO  (coreLoadExecutor-2356-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=28, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.0]
   [junit4]   2> 723961 INFO  (coreLoadExecutor-2356-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@4cc09b70[collection1] main]
   [junit4]   2> 723961 INFO  (coreLoadExecutor-2356-thread-1) [    
x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 723996 INFO  (coreLoadExecutor-2356-thread-1) [    
x:collection1] o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 724071 INFO  (coreLoadExecutor-2356-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 724072 INFO  
(searcherExecutor-2357-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 724072 INFO  
(searcherExecutor-2357-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 724072 INFO  
(searcherExecutor-2357-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 724072 INFO  
(searcherExecutor-2357-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 724072 INFO  
(searcherExecutor-2357-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 724072 INFO  
(searcherExecutor-2357-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 724072 INFO  
(searcherExecutor-2357-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 724073 INFO  
(searcherExecutor-2357-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 724074 INFO  
(searcherExecutor-2357-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 724075 INFO  
(searcherExecutor-2357-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@4cc09b70[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 724075 INFO  (coreLoadExecutor-2356-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1562866242536079360
   [junit4]   2> 724524 INFO  
(TEST-TestDistributedSearch.test-seed#[EDAA8B0E738FE5AE]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting test
   [junit4]   2> 724527 INFO  (qtp1808279424-4790) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{deleteByQuery=*:* (-1562866243008987136)} 0 1
   [junit4]   2> 724531 INFO  (qtp1367312609-4807) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{deleteByQuery=*:* (-1562866243011084288)} 0 3
   [junit4]   2> 724534 INFO  (qtp1808279424-4791) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[1 (1562866243015278592)]} 0 1
   [junit4]   2> 724536 INFO  (qtp1367312609-4808) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[1 (1562866243018424320)]} 0 1
   [junit4]   2> 724537 INFO  (qtp1808279424-4792) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[2 (1562866243019472896)]} 0 0
   [junit4]   2> 724538 INFO  (qtp1367312609-4809) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[2 (1562866243020521472)]} 0 0
   [junit4]   2> 724539 INFO  (qtp1808279424-4785) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[3 (1562866243021570048)]} 0 0
   [junit4]   2> 724540 INFO  (qtp1367312609-4802) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[3 (1562866243022618624)]} 0 0
   [junit4]   2> 724540 INFO  (qtp1808279424-4790) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[4 (1562866243023667200)]} 0 0
   [junit4]   2> 724542 INFO  (qtp1367312609-4807) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[4 (1562866243025764352)]} 0 0
   [junit4]   2> 724543 INFO  (qtp1808279424-4791) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[5 (1562866243026812928)]} 0 0
   [junit4]   2> 724543 INFO  (qtp1367312609-4808) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[5 (1562866243026812928)]} 0 0
   [junit4]   2> 724544 INFO  (qtp1808279424-4792) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[6 (1562866243027861504)]} 0 0
   [junit4]   2> 724545 INFO  (qtp1367312609-4809) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[6 (1562866243028910080)]} 0 0
   [junit4]   2> 724546 INFO  (qtp1808279424-4785) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[7 (1562866243028910080)]} 0 0
   [junit4]   2> 724546 INFO  (qtp1367312609-4802) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[7 (1562866243029958656)]} 0 0
   [junit4]   2> 724547 INFO  (qtp1808279424-4790) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[8 (1562866243031007232)]} 0 0
   [junit4]   2> 724548 INFO  (qtp1367312609-4807) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[8 (1562866243031007232)]} 0 0
   [junit4]   2> 724548 INFO  (qtp1808279424-4791) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[9 (1562866243032055808)]} 0 0
   [junit4]   2> 724549 INFO  (qtp1367312609-4808) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[9 (1562866243033104384)]} 0 0
   [junit4]   2> 724550 INFO  (qtp1808279424-4792) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 724550 INFO  (qtp1808279424-4792) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@4f67f7a8 commitCommandVersion:0
   [junit4]   2> 724610 INFO  (qtp1808279424-4792) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@4cdfd7e9[collection1] main]
   [junit4]   2> 724610 INFO  (qtp1808279424-4792) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 724612 INFO  
(searcherExecutor-2346-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@4cdfd7e9[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C9)))}
   [junit4]   2> 724614 INFO  (qtp1808279424-4792) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 63
   [junit4]   2> 724614 INFO  (qtp1367312609-4809) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 724614 INFO  (qtp1367312609-4809) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@4c1999f7 commitCommandVersion:0
   [junit4]   2> 724624 INFO  (qtp1367312609-4809) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@125917b4[collection1] main]
   [junit4]   2> 724626 INFO  (qtp1367312609-4809) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 724627 INFO  
(searcherExecutor-2357-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@125917b4[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C9)))}
   [junit4]   2> 724627 INFO  (qtp1367312609-4809) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 13
   [junit4]   2> 724630 INFO  (qtp1808279424-4785) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[10 (1562866243115941888)]} 0 2
   [junit4]   2> 724632 INFO  (qtp1367312609-4802) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[10 (1562866243119087616)]} 0 1
   [junit4]   2> 724634 INFO  (qtp1808279424-4790) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[11 (1562866243121184768)]} 0 0
   [junit4]   2> 724635 INFO  (qtp1367312609-4807) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[11 (1562866243122233344)]} 0 0
   [junit4]   2> 724636 INFO  (qtp1808279424-4791) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[12 (1562866243124330496)]} 0 0
   [junit4]   2> 724638 INFO  (qtp1367312609-4808) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[12 (1562866243125379072)]} 0 1
   [junit4]   2> 724638 INFO  (qtp1808279424-4792) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[13 (1562866243126427648)]} 0 0
   [junit4]   2> 724639 INFO  (qtp1367312609-4809) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[13 (1562866243127476224)]} 0 0
   [junit4]   2> 724640 INFO  (qtp1808279424-4785) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[1001 (1562866243128524800)]} 0 0
   [junit4]   2> 724641 INFO  (qtp1367312609-4802) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[1001 (1562866243129573376)]} 0 0
   [junit4]   2> 724642 INFO  (qtp1808279424-4785) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[14 (1562866243130621952)]} 0 0
   [junit4]   2> 724643 INFO  (qtp1367312609-4807) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[14 (1562866243130621952)]} 0 0
   [junit4]   2> 724643 INFO  (qtp1808279424-4791) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[15 (1562866243131670528)]} 0 0
   [junit4]   2> 724644 INFO  (qtp1367312609-4808) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[15 (1562866243132719104)]} 0 0
   [junit4]   2> 724644 INFO  (qtp1808279424-4791) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[16 (1562866243132719104)]} 0 0
   [junit4]   2> 724645 INFO  (qtp1367312609-4809) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[16 (1562866243133767680)]} 0 0
   [junit4]   2> 724646 INFO  (qtp1808279424-4790) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[17 (1562866243134816256)]} 0 0
   [junit4]   2> 724647 INFO  (qtp1367312609-4802) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[17 (1562866243134816256)]} 0 0
   [junit4]   2> 724647 INFO  (qtp1808279424-4785) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[100 (1562866243135864832)]} 0 0
   [junit4]   2> 724648 INFO  (qtp1367312609-4807) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[100 (1562866243136913408)]} 0 0
   [junit4]   2> 724649 INFO  (qtp1808279424-4792) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[101 (1562866243136913408)]} 0 1
   [junit4]   2> 724650 INFO  (qtp1367312609-4808) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[101 (1562866243139010560)]} 0 0
   [junit4]   2> 724650 INFO  (qtp1808279424-4791) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[102 (1562866243139010560)]} 0 0
   [junit4]   2> 724651 INFO  (qtp1367312609-4809) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[102 (1562866243140059136)]} 0 0
   [junit4]   2> 724652 INFO  (qtp1808279424-4790) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[103 (1562866243141107712)]} 0 0
   [junit4]   2> 724652 INFO  (qtp1367312609-4802) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[103 (1562866243141107712)]} 0 0
   [junit4]   2> 724653 INFO  (qtp1808279424-4785) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[104 (1562866243142156288)]} 0 0
   [junit4]   2> 724654 INFO  (qtp1367312609-4807) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[104 (1562866243142156288)]} 0 0
   [junit4]   2> 724654 INFO  (qtp1808279424-4792) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[105 (1562866243143204864)]} 0 0
   [junit4]   2> 724655 INFO  (qtp1367312609-4808) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[105 (1562866243144253440)]} 0 0
   [junit4]   2> 724655 INFO  (qtp1808279424-4791) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[106 (1562866243144253440)]} 0 0
   [junit4]   2> 724656 INFO  (qtp1367312609-4809) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[106 (1562866243145302016)]} 0 0
   [junit4]   2> 724657 INFO  (qtp1808279424-4790) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[107 (1562866243145302016)]} 0 0
   [junit4]   2> 724657 INFO  (qtp1367312609-4802) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[107 (1562866243146350592)]} 0 0
   [junit4]   2> 724658 INFO  (qtp1808279424-4785) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[108 (1562866243147399168)]} 0 0
   [junit4]   2> 724659 INFO  (qtp1367312609-4807) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[108 (1562866243148447744)]} 0 0
   [junit4]   2> 724659 INFO  (qtp1808279424-4792) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[109 (1562866243148447744)]} 0 0
   [junit4]   2> 724660 INFO  (qtp1367312609-4808) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[109 (1562866243149496320)]} 0 0
   [junit4]   2> 724660 INFO  (qtp1808279424-4791) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[110 (1562866243149496320)]} 0 0
   [junit4]   2> 724662 INFO  (qtp1367312609-4809) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[110 (1562866243151593472)]} 0 0
   [junit4]   2> 724663 INFO  (qtp1808279424-4790) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[111 (1562866243151593472)]} 0 0
   [junit4]   2> 724663 INFO  (qtp1367312609-4802) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[111 (1562866243152642048)]} 0 0
   [junit4]   2> 724664 INFO  (qtp1808279424-4785) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[112 (1562866243153690624)]} 0 0
   [junit4]   2> 724665 INFO  (qtp1367312609-4802) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[112 (1562866243153690624)]} 0 0
   [junit4]   2> 724665 INFO  (qtp1808279424-4792) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[113 (1562866243154739200)]} 0 0
   [junit4]   2> 724666 INFO  (qtp1367312609-4808) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[113 (1562866243155787776)]} 0 0
   [junit4]   2> 724667 INFO  (qtp1808279424-4791) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[114 (1562866243156836352)]} 0 0
   [junit4]   2> 724668 INFO  (qtp1367312609-4808) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[114 (1562866243156836352)]} 0 0
   [junit4]   2> 724668 INFO  (qtp1808279424-4791) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[115 (1562866243157884928)]} 0 0
   [junit4]   2> 724669 INFO  (qtp1367312609-4807) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[115 (1562866243158933504)]} 0 0
   [junit4]   2> 724670 INFO  (qtp1808279424-4785) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[116 (1562866243159982080)]} 0 0
   [junit4]   2> 724671 INFO  (qtp1367312609-4807) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[116 (1562866243161030656)]} 0 0
   [junit4]   2> 724672 INFO  (qtp1808279424-4792) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[117 (1562866243162079232)]} 0 0
   [junit4]   2> 724674 INFO  (qtp1367312609-4809) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[117 (1562866243162079232)]} 0 1
   [junit4]   2> 724674 INFO  (qtp1808279424-4790) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[118 (1562866243164176384)]} 0 0
   [junit4]   2> 724675 INFO  (qtp1367312609-4808) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[118 (1562866243165224960)]} 0 0
   [junit4]   2> 724676 INFO  (qtp1808279424-4791) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[119 (1562866243165224960)]} 0 0
   [junit4]   2> 724676 INFO  (qtp1367312609-4802) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[119 (1562866243166273536)]} 0 0
   [junit4]   2> 724677 INFO  (qtp1808279424-4785) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[120 (1562866243167322112)]} 0 0
   [junit4]   2> 724678 INFO  (qtp1367312609-4807) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[120 (1562866243168370688)]} 0 0
   [junit4]   2> 724679 INFO  (qtp1808279424-4785) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[121 (1562866243169419264)]} 0 0
   [junit4]   2> 724680 INFO  (qtp1367312609-4809) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[121 (1562866243170467840)]} 0 0
   [junit4]   2> 724681 INFO  (qtp1808279424-4790) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[122 (1562866243171516416)]} 0 0
   [junit4]   2> 724682 INFO  (qtp1367312609-4808) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[122 (1562866243171516416)]} 0 0
   [junit4]   2> 724683 INFO  (qtp1808279424-4791) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[123 (1562866243172564992)]} 0 0
   [junit4]   2> 724683 INFO  (qtp1367312609-4802) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[123 (1562866243173613568)]} 0 0
   [junit4]   2> 724686 INFO  (qtp1808279424-4791) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[124 (1562866243175710720)]} 0 1
   [junit4]   2> 724687 INFO  (qtp1367312609-4807) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[124 (1562866243176759296)]} 0 0
   [junit4]   2> 724688 INFO  (qtp1808279424-4785) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[125 (1562866243177807872)]} 0 0
   [junit4]   2> 724689 INFO  (qtp1367312609-4809) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[125 (1562866243178856448)]} 0 0
   [junit4]   2> 724690 INFO  (qtp1808279424-4790) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[126 (1562866243179905024)]} 0 0
   [junit4]   2> 724690 INFO  (qtp1367312609-4808) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[126 (1562866243180953600)]} 0 0
   [junit4]   2> 724691 INFO  (qtp1808279424-4792) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[127 (1562866243182002176)]} 0 0
   [junit4]   2> 724691 INFO  (qtp1367312609-4802) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[127 (1562866243182002176)]} 0 0
   [junit4]   2> 724692 INFO  (qtp1808279424-4791) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[128 (1562866243183050752)]} 0 0
   [junit4]   2> 724693 INFO  (qtp1367312609-4807) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[128 (1562866243183050752)]} 0 0
   [junit4]   2> 724693 INFO  (qtp1808279424-4785) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[129 (1562866243184099328)]} 0 0
   [junit4]   2> 724694 INFO  (qtp1367312609-4809) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[129 (1562866243185147904)]} 0 0
   [junit4]   2> 724694 INFO  (qtp1808279424-4790) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[130 (1562866243185147904)]} 0 0
   [junit4]   2> 724695 INFO  (qtp1367312609-4808) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[130 (1562866243186196480)]} 0 0
   [junit4]   2> 724696 INFO  (qtp1808279424-4792) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[131 (1562866243186196480)]} 0 0
   [junit4]   2> 724696 INFO  (qtp1367312609-4802) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[131 (1562866243187245056)]} 0 0
   [junit4]   2> 724698 INFO  (qtp1808279424-4791) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[132 (1562866243189342208)]} 0 0
   [junit4]   2> 724698 INFO  (qtp1367312609-4807) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[132 (1562866243189342208)]} 0 0
   [junit4]   2> 724699 INFO  (qtp1808279424-4785) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[133 (1562866243190390784)]} 0 0
   [junit4]   2> 724700 INFO  (qtp1367312609-4807) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[133 (1562866243191439360)]} 0 0
   [junit4]   2> 724701 INFO  (qtp1808279424-4790) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[134 (1562866243192487936)]} 0 0
   [junit4]   2> 724702 INFO  (qtp1367312609-4808) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[134 (1562866243192487936)]} 0 0
   [junit4]   2> 724702 INFO  (qtp1808279424-4792) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[135 (1562866243193536512)]} 0 0
   [junit4]   2> 724703 INFO  (qtp1367312609-4802) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[135 (1562866243194585088)]} 0 0
   [junit4]   2> 724703 INFO  (qtp1808279424-4791) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[136 (1562866243194585088)]} 0 0
   [junit4]   2> 724704 INFO  (qtp1367312609-4809) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[136 (1562866243195633664)]} 0 0
   [junit4]   2> 724704 INFO  (qtp1808279424-4785) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[137 (1562866243195633664)]} 0 0
   [junit4]   2> 724705 INFO  (qtp1367312609-4807) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[137 (1562866243196682240)]} 0 0
   [junit4]   2> 724706 INFO  (qtp1808279424-4790) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[138 (1562866243196682240)]} 0 0
   [junit4]   2> 724706 INFO  (qtp1367312609-4807) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[138 (1562866243197730816)]} 0 0
   [junit4]   2> 724707 INFO  (qtp1808279424-4792) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[139 (1562866243198779392)]} 0 0
   [junit4]   2> 724708 INFO  (qtp1367312609-4807) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[139 (1562866243198779392)]} 0 0
   [junit4]   2> 724710 INFO  (qtp1808279424-4791) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[140 (1562866243199827968)]} 0 1
   [junit4]   2> 724710 INFO  (qtp1367312609-4809) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[140 (1562866243201925120)]} 0 0
   [junit4]   2> 724712 INFO  (qtp1808279424-4785) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[141 (1562866243202973696)]} 0 0
   [junit4]   2> 724712 INFO  (qtp1367312609-4808) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[141 (1562866243204022272)]} 0 0
   [junit4]   2> 724713 INFO  (qtp1808279424-4790) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[142 (1562866243205070848)]} 0 0
   [junit4]   2> 724714 INFO  (qtp1367312609-4802) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[142 (1562866243206119424)]} 0 0
   [junit4]   2> 724714 INFO  (qtp1808279424-4792) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[143 (1562866243206119424)]} 0 0
   [junit4]   2> 724715 INFO  (qtp1367312609-4807) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[143 (1562866243207168000)]} 0 0
   [junit4]   2> 724715 INFO  (qtp1808279424-4791) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[144 (1562866243207168000)]} 0 0
   [junit4]   2> 724716 INFO  (qtp1367312609-4809) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[144 (1562866243208216576)]} 0 0
   [junit4]   2> 724716 INFO  (qtp1808279424-4785) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[145 (1562866243208216576)]} 0 0
   [junit4]   2> 724717 INFO  (qtp1367312609-4808) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[145 (1562866243209265152)]} 0 0
   [junit4]   2> 724718 INFO  (qtp1808279424-4790) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[146 (1562866243210313728)]} 0 0
   [junit4]   2> 724719 INFO  (qtp1367312609-4802) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[146 (1562866243210313728)]} 0 0
   [junit4]   2> 724719 INFO  (qtp1808279424-4790) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[147 (1562866243211362304)]} 0 0
   [junit4]   2> 724720 INFO  (qtp1367312609-4802) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[147 (1562866243212410880)]} 0 0
   [junit4]   2> 724720 INFO  (qtp1808279424-4791) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[148 (1562866243212410880)]} 0 0
   [junit4]   2> 724722 INFO  (qtp1367312609-4809) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[148 (1562866243213459456)]} 0 0
   [junit4]   2> 724723 INFO  (qtp1808279424-4785) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[149 (1562866243214508032)]} 0 0
   [junit4]   2> 724723 INFO  (qtp1367312609-4808) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[149 (1562866243215556608)]} 0 0
   [junit4]   2> 724724 INFO  (qtp1808279424-4785) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 724724 INFO  (qtp1808279424-4785) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@4f67f7a8 commitCommandVersion:0
   [junit4]   2> 724737 INFO  (qtp1808279424-4785) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@5479005d[collection1] main]
   [junit4]   2> 724737 INFO  (qtp1808279424-4785) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 724742 INFO  
(searcherExecutor-2346-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@5479005d[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C9)
 Uninverting(_1(7.0.0):C59)))}
   [junit4]   2> 724742 INFO  (qtp1808279424-4785) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 18
   [junit4]   2> 724743 INFO  (qtp1367312609-4807) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 724743 INFO  (qtp1367312609-4807) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@4c1999f7 commitCommandVersion:0
   [junit4]   2> 724757 INFO  (qtp1367312609-4807) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@41dfd2a3[collection1] main]
   [junit4]   2> 724758 INFO  (qtp1367312609-4807) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 724759 INFO  
(searcherExecutor-2357-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@41dfd2a3[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C9)
 Uninverting(_1(7.0.0):C59)))}
   [junit4]   2> 724759 INFO  (qtp1367312609-4807) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 16
   [junit4]   2> 724761 INFO  (qtp1808279424-4790) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching parameter cannot be 
negative
   [junit4]   2> 724761 INFO  (qtp1808279424-4790) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*&distrib=false&start=-1&wt=javabin&version=2} status=400 QTime=0
   [junit4]   2> 724761 INFO  (qtp1808279424-4791) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching parameter cannot be 
negative
   [junit4]   2> 724761 INFO  (qtp1808279424-4791) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*&distrib=false&start=0&rows=-1&wt=javabin&version=2} status=400 
QTime=0
   [junit4]   2> 724762 INFO  (qtp1808279424-4792) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&sort=n_ti1+desc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 724775 INFO  (qtp1367312609-4808) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_ti1+desc&shard.url=[ff01::213]:33332/|[ff01::114]:33332/|[ff01::083]:33332/|http://127.0.0.1:38748//collection1&rows=10&version=2&q=*:*&NOW=1490465396174&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 724778 INFO  (qtp1367312609-4807) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1490465396174&ids=132,134,2,125,6,138,139,1001,128,9&isShard=true&shard.url=[ff01::213]:33332/|[ff01::114]:33332/|[ff01::083]:33332/|http://127.0.0.1:38748//collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 724784 INFO  (qtp1367312609-4802) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=[ff01::213]:33332/|[ff01::114]:33332/|[ff01::083]:33332/|http://127.0.0.1:38748//collection1&sort=n_ti1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=19
   [junit4]   2> 724801 INFO  (qtp1808279424-4792) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&sort=n_ti1+asc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 724806 INFO  (qtp1367312609-4803) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_ti1+asc&shard.url=http://127.0.0.1:38748//collection1|[ff01::083]:33332/|[ff01::213]:33332/|[ff01::114]:33332/&rows=10&version=2&q=*:*&NOW=1490465396214&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 724809 INFO  (qtp1367312609-4803) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1490465396214&ids=101,14,135,137,7,8,108,141,142,10&isShard=true&shard.url=http://127.0.0.1:38748//collection1|[ff01::083]:33332/|[ff01::213]:33332/|[ff01::114]:33332/&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 724813 INFO  (qtp1367312609-4809) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=http://127.0.0.1:38748//collection1|[ff01::083]:33332/|[ff01::213]:33332/|[ff01::114]:33332/&sort=n_ti1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=9
   [junit4]   2> 724815 INFO  (qtp1808279424-4790) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&sort=n_f1+desc&wt=javabin&version=2} hits=68 
status=0 QTime=1
   [junit4]   2> 724819 INFO  (qtp1367312609-4802) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_f1+desc&shard.url=http://127.0.0.1:38748//collection1|[ff01::083]:33332/&rows=10&version=2&q=*:*&NOW=1490465396227&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 724821 INFO  (qtp1367312609-4803) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1490465396227&ids=11,132,134,101,14,15,16,117,129,141&isShard=true&shard.url=http://127.0.0.1:38748//collection1|[ff01::083]:33332/&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 724823 INFO  (qtp1367312609-4808) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=http://127.0.0.1:38748//collection1|[ff01::083]:33332/&sort=n_f1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=5
   [junit4]   2> 724824 INFO  (qtp1808279424-4791) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&sort=n_f1+asc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 724826 INFO  (qtp1367312609-4809) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_f1+asc&shard.url=http://127.0.0.1:38748//collection1&rows=10&version=2&q=*:*&NOW=1490465396236&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 724828 INFO  (qtp1367312609-4803) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1490465396236&ids=110,100,124,147,104,108,109,130,10,131&isShard=true&shard.url=http://127.0.0.1:38748//collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 724848 INFO  (qtp1367312609-4807) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=http://127.0.0.1:38748//collection1&sort=n_f1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=22
   [junit4]   2> 724850 INFO  (qtp1808279424-4785) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&sort=n_tf1+desc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 724855 INFO  (qtp1367312609-4808) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_tf1+desc&shard.url=[ff01::114]:33332/|[ff01::083]:33332/|[ff01::213]:33332/|http://127.0.0.1:38748//collection1&rows=10&version=2&q=*:*&NOW=1490465396262&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 724858 INFO  (qtp1367312609-4808) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1490465396262&ids=133,144,145,113,102,114,137,128,107,140&isShard=true&shard.url=[ff01::114]:33332/|[ff01::083]:33332/|[ff01::213]:33332/|http://127.0.0.1:38748//collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 724859 INFO  (qtp1367312609-4802) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=[ff01::114]:33332/|[ff01::083]:33332/|[ff01::213]:33332/|http://127.0.0.1:38748//collection1&sort=n_tf1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=7
   [junit4]   2> 724860 INFO  (qtp1808279424-4792) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&sort=n_tf1+asc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 724863 INFO  (qtp1367312609-4807) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_tf1+asc&shard.url=http://127.0.0.1:38748//collection1|[ff01::213]:33332/|[ff01::114]:33332/|[ff01::083]:33332/&rows=10&version=2&q=*:*&NOW=1490465396272&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 724866 INFO  (qtp1367312609-4808) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1490465396272&ids=12,111,122,112,124,148,5,126,130,142&isShard=true&shard.url=http://127.0.0.1:38748//collection1|[ff01::213]:33332/|[ff01::114]:33332/|[ff01::083]:33332/&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 724871 INFO  (qtp1367312609-4809) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=http://127.0.0.1:38748//collection1|[ff01::213]:33332/|[ff01::114]:33332/|[ff01::083]:33332/&sort=n_tf1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=9
   [junit4]   2> 724873 INFO  (qtp1808279424-4790) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&sort=n_d1+desc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 724876 INFO  (qtp1367312609-4802) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_d1+desc&shard.url=http://127.0.0.1:38748//collection1|[ff01::083]:33332/&rows=10&version=2&q=*:*&NOW=1490465396285&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 724878 INFO  (qtp1367312609-4802) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1490465396285&ids=110,100,134,124,114,15,148,139,128,141&isShard=true&shard.url=http://127.0.0.1:38748//collection1|[ff01::083]:33332/&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 724879 INFO  (qtp1367312609-4803) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=http://127.0.0.1:38748//collection1|[ff01::083]:33332/&sort=n_d1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=4
   [junit4]   2> 724881 INFO  (qtp1808279424-4790) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&sort=n_d1+asc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 724884 INFO  (qtp1367312609-4809) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_d1+asc&shard.url=http://127.0.0.1:38748//collection1|[ff01::114]:33332/|[ff01::083]:33332/&rows=10&version=2&q=*:*&NOW=1490465396293&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 724885 INFO  (qtp1367312609-4802) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1490465396293&ids=144,13,102,113,147,127,17,118,130,142&isShard=true&shard.url=http://127.0.0.1:38748//collection1|[ff01::114]:33332/|[ff01::083]:33332/&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 724887 INFO  (qtp1367312609-4807) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=http://127.0.0.1:38748//collection1|[ff01::114]:33332/|[ff01::083]:33332/&sort=n_d1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=4
   [junit4]   2> 724889 INFO  (qtp1808279424-4785) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&sort=n_td1+desc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 724894 INFO  (qtp1367312609-4802) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_td1+desc&shard.url=[ff01::083]:33332/|http://127.0.0.1:38748//collection1|[ff01::213]:33332/|[ff01::114]:33332/&rows=10&version=2&q=*:*&NOW=1490465396303&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 724896 INFO  (qtp1367312609-4802) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1490465396303&ids=121,114,136,104,105,116,117,107,142,120&isShard=true&shard.url=[ff01::083]:33332/|http://127.0.0.1:38748//collection1|[ff01::213]:33332/|[ff01::114]:33332/&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 724897 INFO  (qtp1367312609-4808) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=[ff01::083]:33332/|http://127.0.0.1:38748//collection1|[ff01::213]:33332/|[ff01::114]:33332/&sort=n_td1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=4
   [junit4]   2> 724898 INFO  (qtp1808279424-4792) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&sort=n_td1+asc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 724902 INFO  (qtp1367312609-4807) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_td1+asc&shard.url=http://127.0.0.1:38748//collection1|[ff01::114]:33332/|[ff01::213]:33332/|[ff01::083]:33332/&rows=10&version=2&q=*:*&NOW=1490465396310&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 724904 INFO  (qtp1367312609-4807) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1490465396310&ids=110,1,133,111,113,1001,128,8,108,130&isShard=true&shard.url=http://127.0.0.1:38748//collection1|[ff01::114]:33332/|[ff01::213]:33332/|[ff01::083]:33332/&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 724905 INFO  (qtp1367312609-4809) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=http://127.0.0.1:38748//collection1|[ff01::114]:33332/|[ff01::213]:33332/|[ff01::083]:33332/&sort=n_td1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=5
   [junit4]   2> 724907 INFO  (qtp1808279424-4791) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&sort=n_l1+desc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 724911 INFO  (qtp1367312609-4809) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_l1+desc&shard.url=[ff01::083]:33332/|[ff01::114]:33332/|http://127.0.0.1:38748//collection1|[ff01::213]:33332/&rows=10&version=2&q=*:*&NOW=1490465396320&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 724914 INFO  (qtp1367312609-4807) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1490465396320&ids=132,143,100,134,14,6,129,9,108,141&isShard=true&shard.url=[ff01::083]:33332/|[ff01::114]:33332/|http://127.0.0.1:38748//collection1|[ff01::213]:33332/&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 724915 INFO  (qtp1367312609-4803) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=[ff01::083]:33332/|[ff01::114]:33332/|http://127.0.0.1:38748//collection1|[ff01::213]:33332/&sort=n_l1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=5
   [junit4]   2> 724917 INFO  (qtp1808279424-4790) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&sort=n_l1+asc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 724922 INFO  (qtp1367312609-4802) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_l1+asc&shard.url=http://127.0.0.1:38748//collection1&rows=10&version=2&q=*:*&NOW=1490465396331&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 724924 INFO  (qtp1367312609-4807) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1490465396331&ids=11,144,13,103,4,148,127,119,109,10&isShard=true&shard.url=http://127.0.0.1:38748//collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 724926 INFO  (qtp1367312609-4808) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=http://127.0.0.1:38748//collection1&sort=n_l1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=5
   [junit4]   2> 724928 INFO  (qtp1808279424-4785) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&sort=n_tl1+desc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 724932 INFO  (qtp1367312609-4803) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_tl1+desc&shard.url=[ff01::083]:33332/|[ff01::114]:33332/|http://127.0.0.1:38748//collection1|[ff01::213]:33332/&rows=10&version=2&q=*:*&NOW=1490465396340&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 724934 INFO  (qtp1367312609-4803) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1490465396340&ids=121,100,147,115,116,129,107,130,120,142&isShard=true&shard.url=[ff01::083]:33332/|[ff01::114]:33332/|http://127.0.0.1:38748//collection1|[ff01::213]:33332/&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 724935 INFO  (qtp1367312609-4809) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=[ff01::083]:33332/|[ff01::114]:33332/|http://127.0.0.1:38748//collection1|[ff01::213]:33332/&sort=n_tl1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=5
   [junit4]   2> 724937 INFO  (qtp1808279424-4785) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&sort=n_tl1+asc&wt=javabin&version=2} hits=68 
status=0 QTime=1
   [junit4]   2> 724940 INFO  (qtp1367312609-4808) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_tl1+asc&shard.url=http://127.0.0.1:38748//collection1|[ff01::213]:33332/|[ff01::083]:33332/|[ff01::114]:33332/&rows=10&version=2&q=*:*&NOW=1490465396349&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 724941 INFO  (qtp1367312609-4803) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1490465396349&ids=12,2,113,135,103,125,118,8,108,109&isShard=true&shard.url=http://127.0.0.1:38748//collection1|[ff01::213]:33332/|[ff01::083]:33332/|[ff01::114]:33332/&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 724942 INFO  (qtp1367312609-4802) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=http://127.0.0.1:38748//collection1|[ff01::213]:33332/|[ff01::083]:33332/|[ff01::114]:33332/&sort=n_tl1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=2
   [junit4]   2> 724943 INFO  (qtp1808279424-4791) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&sort=n_dt1+desc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 724946 INFO  (qtp1367312609-4809) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_dt1+desc&shard.url=http://127.0.0.1:38748//collection1|[ff01::213]:33332/|[ff01::083]:33332/&rows=10&version=2&q=*:*&NOW=1490465396354&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 724947 INFO  (qtp1367312609-4809) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1490465396354&ids=111,134,125,15,126,149,6,107,9,120&isShard=true&shard.url=http://127.0.0.1:38748//collection1|[ff01::213]:33332/|[ff01::083]:33332/&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 724948 INFO  (qtp1367312609-4807) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=http://127.0.0.1:38748//collection1|[ff01::213]:33332/|[ff01::083]:33332/&sort=n_dt1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=3
   [junit4]   2> 724950 INFO  (qtp1808279424-4790) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&sort=n_dt1+asc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 724953 INFO  (qtp1367312609-4802) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_dt1+asc&shard.url=http://127.0.0.1:38748//collection1&rows=10&version=2&q=*:*&NOW=1490465396361&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 724954 INFO  (qtp1367312609-4809) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1490465396361&ids=121,144,100,148,117,106,1001,129,109,141&isShard=true&shard.url=http://127.0.0.1:38748//collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 724955 INFO  (qtp1367312609-4808) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=http://127.0.0.1:38748//collection1&sort=n_dt1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=3
   [junit4]   2> 724957 INFO  (qtp1808279424-4792) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&sort=n_tdt1+desc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 724959 INFO  (qtp1367312609-4809) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_tdt1+desc&shard.url=http://127.0.0.1:38748//collection1|[ff01::114]:33332/|[ff01::213]:33332/&rows=10&version=2&q=*:*&NOW=1490465396368&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 724962 INFO  (qtp1367312609-4809) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1490465396368&ids=1,123,101,135,113,146,126,149,139,129&isShard=true&shard.url=http://127.0.0.1:38748//collection1|[ff01::114]:33332/|[ff01::213]:33332/&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 724963 INFO  (qtp1367312609-4803) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=http://127.0.0.1:38748//collection1|[ff01::114]:33332/|[ff01::213]:33332/&sort=n_tdt1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=5
   [junit4]   2> 724965 INFO  (qtp1808279424-4792) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&sort=n_tdt1+asc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 724970 INFO  (qtp1367312609-4809) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_tdt1+asc&shard.url=[ff01::083]:33332/|http://127.0.0.1:38748//collection1&rows=10&version=2&q=*:*&NOW=1490465396379&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 724972 INFO  (qtp1367312609-4808) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1490465396379&ids=3,147,103,148,104,138,1001,109,130,142&isShard=true&shard.url=[ff01::083]:33332/|http://127.0.0.1:38748//collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 724973 INFO  (qtp1367312609-4802) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=[ff01::083]:33332/|http://127.0.0.1:38748//collection1&sort=n_tdt1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=4
   [junit4]   2> 724975 INFO  (qtp1808279424-4792) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&sort=a_i_p+desc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 724978 INFO  (qtp1367312609-4803) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=a_i_p+desc&shard.url=http://127.0.0.1:38748//collection1&rows=10&version=2&q=*:*&NOW=1490465396387&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 724979 INFO  (qtp1367312609-4808) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1490465396387&ids=1,12,2,13,3,5,7,8,9,10&isShard=true&shard.url=http://127.0.0.1:38748//collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 724980 INFO  (qtp1367312609-4807) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=http://127.0.0.1:38748//collection1&sort=a_i_p+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=3
   [junit4]   2> 724982 INFO  (qtp1808279424-4790) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&sort={!func}testfunc(add(a_i_p,5))+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=0
   [junit4]   2> 724984 INFO  (qtp1367312609-4802) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort={!func}testfunc(add(a_i_p,5))+desc&shard.url=http://127.0.0.1:38748//collection1|[ff01::213]:33332/|[ff01::114]:33332/&rows=10&version=2&q=*:*&NOW=1490465396393&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 724986 INFO  (qtp1367312609-4808) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1490465396393&ids=1,12,2,13,3,5,7,8,9,10&isShard=true&shard.url=http://127.0.0.1:38748//collection1|[ff01::213]:33332/|[ff01::114]:33332/&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 724987 INFO  (qtp1367312609-4809) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=http://127.0.0.1:38748//collection1|[ff01::213]:33332/|[ff01::114]:33332/&sort={!func}testfunc(add(a_i_p,5))+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=4
   [junit4]   2> 724990 INFO  (qtp1808279424-4785) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=a_i_p[*+TO+*]&distrib=false&sort=a_i_p+asc&wt=javabin&version=2} 
hits=13 status=0 QTime=1
   [junit4]   2> 724993 INFO  (qtp1367312609-4808) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=a_i_p+asc&shard.url=http://127.0.0.1:38748//collection1|[ff01::083]:33332/|[ff01::114]:33332/|[ff01::213]:33332/&rows=10&version=2&q=a_i_p[*+TO+*]&NOW=1490465396402&isShard=true&wt=javabin}
 hits=13 status=0 QTime=0
   [junit4]   2> 724995 INFO  (qtp1367312609-4807) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=a_i_p[*+TO+*]&distrib=false&shards.purpose=64&NOW=1490465396402&ids=11,12,1,13,2,3,4,6,7,9&isShard=true&shard.url=http://127.0.0.1:38748//collection1|[ff01::083]:33332/|[ff01::114]:33332/|[ff01::213]:33332/&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 724996 INFO  (qtp1367312609-4803) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=a_i_p[*+TO+*]&shards=http://127.0.0.1:38748//collection1|[ff01::083]:33332/|[ff01::114]:33332/|[ff01::213]:33332/&sort=a_i_p+asc&wt=javabin&version=2}
 hits=13 status=0 QTime=4
   [junit4]   2> 724998 INFO  (qtp1808279424-4785) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&sort=a_i_p+asc,+id+desc&wt=javabin&version=2} 
hits=68 status=0 QTime=0
   [junit4]   2> 725000 INFO  (qtp1367312609-4807) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=a_i_p+asc,+id+desc&shard.url=[ff01::114]:33332/|[ff01::213]:33332/|[ff01::083]:33332/|http://127.0.0.1:38748//collection1&rows=10&version=2&q=*:*&NOW=1490465396409&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 725002 INFO  (qtp1367312609-4807) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1490465396409&ids=11,144,145,146,147,4,148,149,6,1001&isShard=true&shard.url=[ff01::114]:33332/|[ff01::213]:33332/|[ff01::083]:33332/|http://127.0.0.1:38748//collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 725003 INFO  (qtp1367312609-4802) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=[ff01::114]:33332/|[ff01::213]:33332/|[ff01::083]:33332/|http://127.0.0.1:38748//collection1&sort=a_i_p+asc,+id+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=3
   [junit4]   2> 725004 INFO  (qtp1808279424-4785) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&fl=*,score&sort=a_i_p+desc&wt=javabin&version=2} 
hits=68 status=0 QTime=0
   [junit4]   2> 725007 INFO  (qtp1367312609-4803) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={distrib=false&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&sort=a_i_p+desc&shard.url=[ff01::213]:33332/|http://127.0.0.1:38748//collection1&rows=10&version=2&q=*:*&NOW=1490465396415&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 725010 INFO  (qtp1367312609-4807) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&fl=*,score&shards.purpose=64&NOW=1490465396415&ids=1,12,2,13,3,5,7,8,9,10&isShard=true&shard.url=[ff01::213]:33332/|http://127.0.0.1:38748//collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 725011 INFO  (qtp1367312609-4808) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=[ff01::213]:33332/|http://127.0.0.1:38748//collection1&fl=

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

E]) [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=958741402
   [junit4]   2> 747899 INFO  
(TEST-TestDistributedSearch.test-seed#[EDAA8B0E738FE5AE]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 747899 INFO  (coreCloseExecutor-2399-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@1a82dc66
   [junit4]   2> 747971 INFO  (coreCloseExecutor-2399-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=444783718
   [junit4]   2> 747972 INFO  
(TEST-TestDistributedSearch.test-seed#[EDAA8B0E738FE5AE]) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@67a47184{/,null,UNAVAILABLE}
   [junit4]   2> 747975 INFO  
(TEST-TestDistributedSearch.test-seed#[EDAA8B0E738FE5AE]) [    ] 
o.e.j.s.AbstractConnector Stopped 
ServerConnector@2c8af787{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 747975 INFO  
(TEST-TestDistributedSearch.test-seed#[EDAA8B0E738FE5AE]) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1635925809
   [junit4]   2> 747975 INFO  
(TEST-TestDistributedSearch.test-seed#[EDAA8B0E738FE5AE]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 747976 INFO  (coreCloseExecutor-2401-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@2000bff8
   [junit4]   2> 747983 INFO  (coreCloseExecutor-2401-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=536920056
   [junit4]   2> 747988 INFO  
(TEST-TestDistributedSearch.test-seed#[EDAA8B0E738FE5AE]) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@27a2377f{/,null,UNAVAILABLE}
   [junit4]   2> 747992 INFO  
(TEST-TestDistributedSearch.test-seed#[EDAA8B0E738FE5AE]) [    ] 
o.e.j.s.AbstractConnector Stopped 
ServerConnector@5991a4dc{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 747992 INFO  
(TEST-TestDistributedSearch.test-seed#[EDAA8B0E738FE5AE]) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=207776406
   [junit4]   2> 747992 INFO  
(TEST-TestDistributedSearch.test-seed#[EDAA8B0E738FE5AE]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 747992 INFO  (coreCloseExecutor-2403-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@60cbf758
   [junit4]   2> 747997 INFO  (coreCloseExecutor-2403-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=1623979864
   [junit4]   2> 747998 INFO  
(TEST-TestDistributedSearch.test-seed#[EDAA8B0E738FE5AE]) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@14276cc2{/,null,UNAVAILABLE}
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=TestDistributedSearch -Dtests.method=test 
-Dtests.seed=EDAA8B0E738FE5AE -Dtests.multiplier=3 -Dtests.slow=true 
-Dtests.locale=es-PR -Dtests.timezone=BET -Dtests.asserts=true 
-Dtests.file.encoding=UTF-8
   [junit4] FAILURE 25.2s J0 | TestDistributedSearch.test <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: Expected to find 
shardAddress in the up shard info: 
{error=org.apache.solr.client.solrj.SolrServerException: No live SolrServers 
available to handle this 
request,trace=org.apache.solr.client.solrj.SolrServerException: No live 
SolrServers available to handle this request
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:416)
   [junit4]    >        at 
org.apache.solr.handler.component.HttpShardHandlerFactory.makeLoadBalancedRequest(HttpShardHandlerFactory.java:259)
   [junit4]    >        at 
org.apache.solr.handler.component.HttpShardHandler.lambda$submit$0(HttpShardHandler.java:166)
   [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:229)
   [junit4]    >        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
   [junit4]    >        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
   [junit4]    >        at java.lang.Thread.run(Thread.java:745)
   [junit4]    > ,time=2}
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([EDAA8B0E738FE5AE:65FEB4D4DD738856]:0)
   [junit4]    >        at 
org.apache.solr.TestDistributedSearch.comparePartialResponses(TestDistributedSearch.java:1186)
   [junit4]    >        at 
org.apache.solr.TestDistributedSearch.queryPartialResults(TestDistributedSearch.java:1127)
   [junit4]    >        at 
org.apache.solr.TestDistributedSearch.test(TestDistributedSearch.java:987)
   [junit4]    >        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsRepeatStatement.callStatement(BaseDistributedSearchTestCase.java:1011)
   [junit4]    >        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:960)
   [junit4]    >        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 748003 INFO  
(SUITE-TestDistributedSearch-seed#[EDAA8B0E738FE5AE]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_EDAA8B0E738FE5AE-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): 
{other_tl1=PostingsFormat(name=MockRandom), 
range_facet_l_dv=PostingsFormat(name=Asserting), 
SubjectTerms_mfacet=PostingsFormat(name=MockRandom), 
n_l1=PostingsFormat(name=LuceneVarGapDocFreqInterval), 
a_n_tdt=PostingsFormat(name=LuceneFixedGap), 
multiDefault=PostingsFormat(name=LuceneVarGapDocFreqInterval), 
intDefault=PostingsFormat(name=MockRandom), 
n_td1=PostingsFormat(name=MockRandom), 
n_d1=PostingsFormat(name=LuceneVarGapDocFreqInterval), 
n_f1=PostingsFormat(name=MockRandom), 
range_facet_l=PostingsFormat(name=LuceneVarGapDocFreqInterval), 
n_tl1=PostingsFormat(name=MockRandom), a_s=PostingsFormat(name=LuceneFixedGap), 
oddField_s=PostingsFormat(name=Asserting), 
n_tf1=PostingsFormat(name=LuceneVarGapDocFreqInterval), 
lowerfilt1and2=PostingsFormat(name=LuceneVarGapDocFreqInterval), 
a_t=PostingsFormat(name=LuceneVarGapDocFreqInterval), 
lowerfilt=PostingsFormat(name=LuceneVarGapDocFreqInterval), 
id=PostingsFormat(name=Asserting), text=PostingsFormat(name=LuceneFixedGap), 
timestamp=PostingsFormat(name=LuceneVarGapDocFreqInterval), 
severity=PostingsFormat(name=LuceneFixedGap), 
foo_sev_enum=PostingsFormat(name=LuceneFixedGap), 
n_dt1=PostingsFormat(name=MockRandom), b_n_tdt=PostingsFormat(name=MockRandom), 
n_ti1=PostingsFormat(name=Asserting), rnd_b=PostingsFormat(name=Asserting), 
foo_b=PostingsFormat(name=LuceneFixedGap), 
n_tdt1=PostingsFormat(name=MockRandom), foo_d=PostingsFormat(name=Asserting), 
range_facet_i_dv=PostingsFormat(name=LuceneVarGapDocFreqInterval), 
foo_f=PostingsFormat(name=LuceneFixedGap)}, 
docValues:{range_facet_l_dv=DocValuesFormat(name=Direct), 
foo_sev_enum=DocValuesFormat(name=Memory), 
_version_=DocValuesFormat(name=Lucene70), 
range_facet_i_dv=DocValuesFormat(name=Lucene70), 
intDvoDefault=DocValuesFormat(name=Direct), 
timestamp=DocValuesFormat(name=Lucene70), 
a_i_p=DocValuesFormat(name=Lucene70)}, maxPointsInLeafNode=1296, 
maxMBSortInHeap=7.451712030568247, sim=RandomSimilarity(queryNorm=false): {}, 
locale=es-PR, timezone=BET
   [junit4]   2> NOTE: Linux 4.4.0-66-generic amd64/Oracle Corporation 
1.8.0_121 (64-bit)/cpus=12,threads=1,free=111208176,total=536870912
   [junit4]   2> NOTE: All tests run in this JVM: [BasicDistributedZkTest, 
AliasIntegrationTest, TestNRTOpen, SuggestComponentTest, SolrCoreTest, 
TestCorePropertiesReload, TestHdfsCloudBackupRestore, 
TestSuggestSpellingConverter, DateMathParserTest, BooleanFieldTest, 
TestLFUCache, DistributedSpellCheckComponentTest, TestRemoteStreaming, 
FastVectorHighlighterTest, TestDistribDocBasedVersion, 
SpellPossibilityIteratorTest, DocValuesNotIndexedTest, 
HdfsChaosMonkeyNothingIsSafeTest, TestFieldCacheReopen, TestCloudManagedSchema, 
ZkNodePropsTest, DeleteNodeTest, TestNumericTerms32, 
DistributedQueryElevationComponentTest, BasicZkTest, SparseHLLTest, 
TestNoOpRegenerator, CurrencyFieldOpenExchangeTest, 
TestAnalyzeInfixSuggestions, TestScoreJoinQPScore, TestRawTransformer, 
SearchHandlerTest, TestRebalanceLeaders, TestManagedSchemaThreadSafety, 
CollectionReloadTest, HighlighterMaxOffsetTest, TestOnReconnectListenerSupport, 
TestFreeTextSuggestions, QueryElevationComponentTest, TestOmitPositions, 
SolrGangliaReporterTest, TestSolrQueryParserDefaultOperatorResource, 
DirectoryFactoryTest, TestSimpleQParserPlugin, TestPivotHelperCode, 
PeerSyncTest, TestBlobHandler, TestDelegationWithHadoopAuth, FullHLLTest, 
TestRTGBase, TestShortCircuitedRequests, QueryEqualityTest, 
BlockJoinFacetSimpleTest, TestRandomCollapseQParserPlugin, VersionInfoTest, 
LeaderElectionIntegrationTest, BigEndianAscendingWordSerializerTest, 
TestCoreAdminApis, UUIDUpdateProcessorFallbackTest, 
TestManagedStopFilterFactory, ResponseLogComponentTest, 
DistributedFacetPivotSmallAdvancedTest, ConfigSetsAPITest, 
HdfsTlogReplayBufferedWhileIndexingTest, SubstringBytesRefFilterTest, 
SimpleMLTQParserTest, CopyFieldTest, TestJettySolrRunner, TestFunctionQuery, 
TestRequestStatusCollectionAPI, BJQParserTest, TestLRUCache, MultiTermTest, 
TestDistributedSearch]
   [junit4] Completed [271/701 (1!)] on J0 in 25.23s, 1 test, 1 failure <<< 
FAILURES!

[...truncated 44586 lines...]


---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org