Build: https://builds.apache.org/job/Lucene-Solr-Tests-master/1710/

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=1}

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=1}
        at 
__randomizedtesting.SeedInfo.seed([EDE78071CE1C8F93:65B3BFAB60E0E26B]: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 11887 lines...]
   [junit4] Suite: org.apache.solr.TestDistributedSearch
   [junit4]   2> Creating dataDir: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_EDE78071CE1C8F93-001/init-core-data-001
   [junit4]   2> 988556 INFO  
(SUITE-TestDistributedSearch-seed#[EDE78071CE1C8F93]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields
   [junit4]   2> 988557 INFO  
(SUITE-TestDistributedSearch-seed#[EDE78071CE1C8F93]-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> 988557 INFO  
(SUITE-TestDistributedSearch-seed#[EDE78071CE1C8F93]-worker) [    ] 
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /
   [junit4]   2> 988630 INFO  
(TEST-TestDistributedSearch.test-seed#[EDE78071CE1C8F93]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_EDE78071CE1C8F93-001/tempDir-001/control/cores/collection1
   [junit4]   2> 988631 INFO  
(TEST-TestDistributedSearch.test-seed#[EDE78071CE1C8F93]) [    ] o.e.j.s.Server 
jetty-9.3.14.v20161028
   [junit4]   2> 988632 INFO  
(TEST-TestDistributedSearch.test-seed#[EDE78071CE1C8F93]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@6a50f580{/,null,AVAILABLE}
   [junit4]   2> 988633 INFO  
(TEST-TestDistributedSearch.test-seed#[EDE78071CE1C8F93]) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@1a9c9083{HTTP/1.1,[http/1.1]}{127.0.0.1:56737}
   [junit4]   2> 988633 INFO  
(TEST-TestDistributedSearch.test-seed#[EDE78071CE1C8F93]) [    ] o.e.j.s.Server 
Started @992134ms
   [junit4]   2> 988633 INFO  
(TEST-TestDistributedSearch.test-seed#[EDE78071CE1C8F93]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, hostPort=56737, 
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_EDE78071CE1C8F93-001/tempDir-001/control/cores}
   [junit4]   2> 988634 ERROR 
(TEST-TestDistributedSearch.test-seed#[EDE78071CE1C8F93]) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 988634 INFO  
(TEST-TestDistributedSearch.test-seed#[EDE78071CE1C8F93]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
7.0.0
   [junit4]   2> 988634 INFO  
(TEST-TestDistributedSearch.test-seed#[EDE78071CE1C8F93]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 988634 INFO  
(TEST-TestDistributedSearch.test-seed#[EDE78071CE1C8F93]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 988634 INFO  
(TEST-TestDistributedSearch.test-seed#[EDE78071CE1C8F93]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-03-07T14:22:45.710Z
   [junit4]   2> 988634 INFO  
(TEST-TestDistributedSearch.test-seed#[EDE78071CE1C8F93]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_EDE78071CE1C8F93-001/tempDir-001/control/solr.xml
   [junit4]   2> 988681 INFO  
(TEST-TestDistributedSearch.test-seed#[EDE78071CE1C8F93]) [    ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_EDE78071CE1C8F93-001/tempDir-001/control/cores
   [junit4]   2> 988681 INFO  
(TEST-TestDistributedSearch.test-seed#[EDE78071CE1C8F93]) [    ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 988681 INFO  (coreLoadExecutor-4308-thread-1) [    
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, 
from paths: 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/lib,
 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 988750 WARN  (coreLoadExecutor-4308-thread-1) [    
x:collection1] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is 
deprecated, use <mergePolicyFactory> instead.
   [junit4]   2> 988751 INFO  (coreLoadExecutor-4308-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 988782 INFO  (coreLoadExecutor-4308-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 989031 WARN  (coreLoadExecutor-4308-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> 989033 INFO  (coreLoadExecutor-4308-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 989038 INFO  (coreLoadExecutor-4308-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from configset 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1
   [junit4]   2> 989038 INFO  (coreLoadExecutor-4308-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1],
 
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_EDE78071CE1C8F93-001/tempDir-001/control/cores/collection1/data/]
   [junit4]   2> 989039 INFO  (coreLoadExecutor-4308-thread-1) [    
x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr 
mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@37abde4e
   [junit4]   2> 989039 INFO  (coreLoadExecutor-4308-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=33, maxMergeAtOnceExplicit=35, maxMergedSegmentMB=21.447265625, 
floorSegmentMB=2.1123046875, forceMergeDeletesPctAllowed=9.251248089245363, 
segmentsPerTier=43.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.7674448979968181
   [junit4]   2> 989095 INFO  (coreLoadExecutor-4308-thread-1) [    
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 989095 INFO  (coreLoadExecutor-4308-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 989096 INFO  (coreLoadExecutor-4308-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 989096 INFO  (coreLoadExecutor-4308-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 989103 INFO  (coreLoadExecutor-4308-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=24, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.6313991202190082]
   [junit4]   2> 989103 INFO  (coreLoadExecutor-4308-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@5e60bc2f[collection1] main]
   [junit4]   2> 989103 INFO  (coreLoadExecutor-4308-thread-1) [    
x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 989117 INFO  (coreLoadExecutor-4308-thread-1) [    
x:collection1] o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 989135 INFO  (coreLoadExecutor-4308-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 989135 INFO  
(searcherExecutor-4309-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 989135 INFO  
(searcherExecutor-4309-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 989135 INFO  
(searcherExecutor-4309-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 989136 INFO  
(searcherExecutor-4309-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 989136 INFO  (coreLoadExecutor-4308-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1561221205812314112
   [junit4]   2> 989136 INFO  
(searcherExecutor-4309-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 989136 INFO  
(searcherExecutor-4309-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 989137 INFO  
(searcherExecutor-4309-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 989137 INFO  
(searcherExecutor-4309-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 989137 INFO  
(searcherExecutor-4309-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 989139 INFO  
(searcherExecutor-4309-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@5e60bc2f[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 989730 INFO  
(TEST-TestDistributedSearch.test-seed#[EDE78071CE1C8F93]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_EDE78071CE1C8F93-001/tempDir-001/shard0/cores/collection1
   [junit4]   2> 989731 INFO  
(TEST-TestDistributedSearch.test-seed#[EDE78071CE1C8F93]) [    ] o.e.j.s.Server 
jetty-9.3.14.v20161028
   [junit4]   2> 989775 INFO  
(TEST-TestDistributedSearch.test-seed#[EDE78071CE1C8F93]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@6a82ab1c{/,null,AVAILABLE}
   [junit4]   2> 989775 INFO  
(TEST-TestDistributedSearch.test-seed#[EDE78071CE1C8F93]) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@457d6e3e{HTTP/1.1,[http/1.1]}{127.0.0.1:43579}
   [junit4]   2> 989775 INFO  
(TEST-TestDistributedSearch.test-seed#[EDE78071CE1C8F93]) [    ] o.e.j.s.Server 
Started @993277ms
   [junit4]   2> 989775 INFO  
(TEST-TestDistributedSearch.test-seed#[EDE78071CE1C8F93]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, hostPort=43579, 
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_EDE78071CE1C8F93-001/tempDir-001/shard0/cores}
   [junit4]   2> 989776 ERROR 
(TEST-TestDistributedSearch.test-seed#[EDE78071CE1C8F93]) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 989782 INFO  
(TEST-TestDistributedSearch.test-seed#[EDE78071CE1C8F93]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
7.0.0
   [junit4]   2> 989782 INFO  
(TEST-TestDistributedSearch.test-seed#[EDE78071CE1C8F93]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 989782 INFO  
(TEST-TestDistributedSearch.test-seed#[EDE78071CE1C8F93]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 989782 INFO  
(TEST-TestDistributedSearch.test-seed#[EDE78071CE1C8F93]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-03-07T14:22:46.858Z
   [junit4]   2> 989783 INFO  
(TEST-TestDistributedSearch.test-seed#[EDE78071CE1C8F93]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_EDE78071CE1C8F93-001/tempDir-001/shard0/solr.xml
   [junit4]   2> 989915 INFO  
(TEST-TestDistributedSearch.test-seed#[EDE78071CE1C8F93]) [    ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_EDE78071CE1C8F93-001/tempDir-001/shard0/cores
   [junit4]   2> 989916 INFO  
(TEST-TestDistributedSearch.test-seed#[EDE78071CE1C8F93]) [    ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 989920 INFO  (coreLoadExecutor-4319-thread-1) [    
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, 
from paths: 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/lib,
 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 989972 WARN  (coreLoadExecutor-4319-thread-1) [    
x:collection1] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is 
deprecated, use <mergePolicyFactory> instead.
   [junit4]   2> 989973 INFO  (coreLoadExecutor-4319-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 990064 INFO  (coreLoadExecutor-4319-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 990586 WARN  (coreLoadExecutor-4319-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> 990589 INFO  (coreLoadExecutor-4319-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 990593 INFO  (coreLoadExecutor-4319-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from configset 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1
   [junit4]   2> 990593 INFO  (coreLoadExecutor-4319-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1],
 
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_EDE78071CE1C8F93-001/tempDir-001/shard0/cores/collection1/data/]
   [junit4]   2> 990593 INFO  (coreLoadExecutor-4319-thread-1) [    
x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr 
mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@37abde4e
   [junit4]   2> 990600 INFO  (coreLoadExecutor-4319-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=33, maxMergeAtOnceExplicit=35, maxMergedSegmentMB=21.447265625, 
floorSegmentMB=2.1123046875, forceMergeDeletesPctAllowed=9.251248089245363, 
segmentsPerTier=43.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.7674448979968181
   [junit4]   2> 990676 INFO  (coreLoadExecutor-4319-thread-1) [    
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 990676 INFO  (coreLoadExecutor-4319-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 990677 INFO  (coreLoadExecutor-4319-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 990677 INFO  (coreLoadExecutor-4319-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 990678 INFO  (coreLoadExecutor-4319-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=24, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.6313991202190082]
   [junit4]   2> 990678 INFO  (coreLoadExecutor-4319-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@796a0ea[collection1] 
main]
   [junit4]   2> 990678 INFO  (coreLoadExecutor-4319-thread-1) [    
x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 990692 INFO  (coreLoadExecutor-4319-thread-1) [    
x:collection1] o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 990720 INFO  (coreLoadExecutor-4319-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 990720 INFO  
(searcherExecutor-4320-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 990720 INFO  
(searcherExecutor-4320-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 990720 INFO  
(searcherExecutor-4320-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 990720 INFO  
(searcherExecutor-4320-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 990720 INFO  
(searcherExecutor-4320-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 990720 INFO  
(searcherExecutor-4320-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 990721 INFO  
(searcherExecutor-4320-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 990721 INFO  
(searcherExecutor-4320-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 990721 INFO  
(searcherExecutor-4320-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 990722 INFO  
(searcherExecutor-4320-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@796a0ea[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 990723 INFO  (coreLoadExecutor-4319-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1561221207476404224
   [junit4]   2> 991128 INFO  
(TEST-TestDistributedSearch.test-seed#[EDE78071CE1C8F93]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting test
   [junit4]   2> 991137 INFO  (qtp1116088742-10866) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{deleteByQuery=*:* (-1561221207909466112)} 0 1
   [junit4]   2> 991139 INFO  (qtp2064535026-10884) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{deleteByQuery=*:* (-1561221207911563264)} 0 0
   [junit4]   2> 991141 INFO  (qtp1116088742-10867) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[1 (1561221207912611840)]} 0 1
   [junit4]   2> 991145 INFO  (qtp2064535026-10885) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[1 (1561221207917854720)]} 0 1
   [junit4]   2> 991150 INFO  (qtp1116088742-10868) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[2 (1561221207918903296)]} 0 5
   [junit4]   2> 991152 INFO  (qtp2064535026-10886) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[2 (1561221207925194752)]} 0 1
   [junit4]   2> 991156 INFO  (qtp1116088742-10869) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[3 (1561221207929389056)]} 0 0
   [junit4]   2> 991157 INFO  (qtp2064535026-10887) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[3 (1561221207930437632)]} 0 0
   [junit4]   2> 991157 INFO  (qtp1116088742-10869) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[4 (1561221207931486208)]} 0 0
   [junit4]   2> 991158 INFO  (qtp2064535026-10887) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[4 (1561221207932534784)]} 0 0
   [junit4]   2> 991159 INFO  (qtp1116088742-10863) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[5 (1561221207932534784)]} 0 0
   [junit4]   2> 991160 INFO  (qtp2064535026-10880) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[5 (1561221207934631936)]} 0 0
   [junit4]   2> 991161 INFO  (qtp1116088742-10863) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[6 (1561221207934631936)]} 0 0
   [junit4]   2> 991161 INFO  (qtp2064535026-10880) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[6 (1561221207935680512)]} 0 0
   [junit4]   2> 991162 INFO  (qtp1116088742-10863) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[7 (1561221207936729088)]} 0 0
   [junit4]   2> 991163 INFO  (qtp2064535026-10880) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[7 (1561221207936729088)]} 0 0
   [junit4]   2> 991164 INFO  (qtp1116088742-10863) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[8 (1561221207937777664)]} 0 0
   [junit4]   2> 991164 INFO  (qtp2064535026-10880) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[8 (1561221207938826240)]} 0 0
   [junit4]   2> 991165 INFO  (qtp1116088742-10870) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[9 (1561221207939874816)]} 0 0
   [junit4]   2> 991166 INFO  (qtp2064535026-10880) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[9 (1561221207939874816)]} 0 0
   [junit4]   2> 991166 INFO  (qtp1116088742-10870) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 991166 INFO  (qtp1116088742-10870) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@547b58f3
   [junit4]   2> 991184 INFO  (qtp1116088742-10870) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@37fcfb39[collection1] main]
   [junit4]   2> 991185 INFO  
(searcherExecutor-4309-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@37fcfb39[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):c9)))}
   [junit4]   2> 991185 INFO  (qtp1116088742-10870) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 991185 INFO  (qtp1116088742-10870) [    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 19
   [junit4]   2> 991186 INFO  (qtp2064535026-10887) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 991186 INFO  (qtp2064535026-10887) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@30ecfe7a
   [junit4]   2> 991192 INFO  (qtp2064535026-10887) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@6a5dd23c[collection1] main]
   [junit4]   2> 991192 INFO  (qtp2064535026-10887) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 991193 INFO  
(searcherExecutor-4320-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@6a5dd23c[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):c9)))}
   [junit4]   2> 991193 INFO  (qtp2064535026-10887) [    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 7
   [junit4]   2> 991195 INFO  (qtp1116088742-10866) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[10 (1561221207970283520)]} 0 1
   [junit4]   2> 991197 INFO  (qtp2064535026-10884) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[10 (1561221207972380672)]} 0 1
   [junit4]   2> 991199 INFO  (qtp1116088742-10867) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[11 (1561221207974477824)]} 0 1
   [junit4]   2> 991200 INFO  (qtp2064535026-10885) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[11 (1561221207975526400)]} 0 1
   [junit4]   2> 991201 INFO  (qtp1116088742-10868) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[12 (1561221207976574976)]} 0 0
   [junit4]   2> 991202 INFO  (qtp2064535026-10886) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[12 (1561221207977623552)]} 0 0
   [junit4]   2> 991202 INFO  (qtp1116088742-10868) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[13 (1561221207978672128)]} 0 0
   [junit4]   2> 991203 INFO  (qtp2064535026-10881) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[13 (1561221207979720704)]} 0 0
   [junit4]   2> 991204 INFO  (qtp1116088742-10868) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[1001 (1561221207979720704)]} 0 0
   [junit4]   2> 991205 INFO  (qtp2064535026-10880) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[1001 (1561221207980769280)]} 0 0
   [junit4]   2> 991205 INFO  (qtp1116088742-10868) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[14 (1561221207981817856)]} 0 0
   [junit4]   2> 991206 INFO  (qtp2064535026-10880) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[14 (1561221207982866432)]} 0 0
   [junit4]   2> 991207 INFO  (qtp1116088742-10868) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[15 (1561221207982866432)]} 0 0
   [junit4]   2> 991207 INFO  (qtp2064535026-10880) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[15 (1561221207983915008)]} 0 0
   [junit4]   2> 991208 INFO  (qtp1116088742-10868) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[16 (1561221207984963584)]} 0 0
   [junit4]   2> 991209 INFO  (qtp2064535026-10885) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[16 (1561221207984963584)]} 0 0
   [junit4]   2> 991210 INFO  (qtp1116088742-10868) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[17 (1561221207987060736)]} 0 0
   [junit4]   2> 991211 INFO  (qtp2064535026-10886) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[17 (1561221207988109312)]} 0 0
   [junit4]   2> 991212 INFO  (qtp1116088742-10868) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[100 (1561221207988109312)]} 0 0
   [junit4]   2> 991212 INFO  (qtp2064535026-10886) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[100 (1561221207989157888)]} 0 0
   [junit4]   2> 991213 INFO  (qtp1116088742-10870) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[101 (1561221207989157888)]} 0 0
   [junit4]   2> 991213 INFO  (qtp2064535026-10886) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[101 (1561221207990206464)]} 0 0
   [junit4]   2> 991214 INFO  (qtp1116088742-10870) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[102 (1561221207990206464)]} 0 0
   [junit4]   2> 991214 INFO  (qtp2064535026-10886) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[102 (1561221207991255040)]} 0 0
   [junit4]   2> 991215 INFO  (qtp1116088742-10870) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[103 (1561221207992303616)]} 0 0
   [junit4]   2> 991215 INFO  (qtp2064535026-10886) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[103 (1561221207992303616)]} 0 0
   [junit4]   2> 991216 INFO  (qtp1116088742-10870) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[104 (1561221207993352192)]} 0 0
   [junit4]   2> 991216 INFO  (qtp2064535026-10886) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[104 (1561221207993352192)]} 0 0
   [junit4]   2> 991217 INFO  (qtp1116088742-10870) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[105 (1561221207994400768)]} 0 0
   [junit4]   2> 991217 INFO  (qtp2064535026-10886) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[105 (1561221207994400768)]} 0 0
   [junit4]   2> 991218 INFO  (qtp1116088742-10868) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[106 (1561221207995449344)]} 0 0
   [junit4]   2> 991219 INFO  (qtp2064535026-10886) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[106 (1561221207995449344)]} 0 0
   [junit4]   2> 991219 INFO  (qtp1116088742-10866) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[107 (1561221207996497920)]} 0 0
   [junit4]   2> 991220 INFO  (qtp2064535026-10886) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[107 (1561221207996497920)]} 0 0
   [junit4]   2> 991220 INFO  (qtp1116088742-10866) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[108 (1561221207997546496)]} 0 0
   [junit4]   2> 991221 INFO  (qtp2064535026-10880) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[108 (1561221207998595072)]} 0 0
   [junit4]   2> 991222 INFO  (qtp1116088742-10866) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[109 (1561221207998595072)]} 0 0
   [junit4]   2> 991222 INFO  (qtp2064535026-10885) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[109 (1561221207999643648)]} 0 0
   [junit4]   2> 991223 INFO  (qtp1116088742-10866) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[110 (1561221207999643648)]} 0 0
   [junit4]   2> 991223 INFO  (qtp2064535026-10885) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[110 (1561221208000692224)]} 0 0
   [junit4]   2> 991224 INFO  (qtp1116088742-10866) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[111 (1561221208001740800)]} 0 0
   [junit4]   2> 991224 INFO  (qtp2064535026-10885) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[111 (1561221208001740800)]} 0 0
   [junit4]   2> 991225 INFO  (qtp1116088742-10868) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[112 (1561221208002789376)]} 0 0
   [junit4]   2> 991226 INFO  (qtp2064535026-10885) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[112 (1561221208002789376)]} 0 0
   [junit4]   2> 991226 INFO  (qtp1116088742-10867) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[113 (1561221208003837952)]} 0 0
   [junit4]   2> 991227 INFO  (qtp2064535026-10885) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[113 (1561221208003837952)]} 0 0
   [junit4]   2> 991227 INFO  (qtp1116088742-10867) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[114 (1561221208004886528)]} 0 0
   [junit4]   2> 991228 INFO  (qtp2064535026-10880) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[114 (1561221208005935104)]} 0 0
   [junit4]   2> 991228 INFO  (qtp1116088742-10867) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[115 (1561221208005935104)]} 0 0
   [junit4]   2> 991229 INFO  (qtp2064535026-10881) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[115 (1561221208006983680)]} 0 0
   [junit4]   2> 991230 INFO  (qtp1116088742-10867) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[116 (1561221208006983680)]} 0 0
   [junit4]   2> 991230 INFO  (qtp2064535026-10887) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[116 (1561221208008032256)]} 0 0
   [junit4]   2> 991231 INFO  (qtp1116088742-10867) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[117 (1561221208008032256)]} 0 0
   [junit4]   2> 991231 INFO  (qtp2064535026-10884) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[117 (1561221208009080832)]} 0 0
   [junit4]   2> 991232 INFO  (qtp1116088742-10868) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[118 (1561221208010129408)]} 0 0
   [junit4]   2> 991232 INFO  (qtp2064535026-10884) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[118 (1561221208010129408)]} 0 0
   [junit4]   2> 991233 INFO  (qtp1116088742-10868) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[119 (1561221208011177984)]} 0 0
   [junit4]   2> 991233 INFO  (qtp2064535026-10885) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[119 (1561221208011177984)]} 0 0
   [junit4]   2> 991234 INFO  (qtp1116088742-10869) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[120 (1561221208012226560)]} 0 0
   [junit4]   2> 991234 INFO  (qtp2064535026-10880) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[120 (1561221208012226560)]} 0 0
   [junit4]   2> 991235 INFO  (qtp1116088742-10869) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[121 (1561221208012226561)]} 0 0
   [junit4]   2> 991235 INFO  (qtp2064535026-10881) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[121 (1561221208013275136)]} 0 0
   [junit4]   2> 991236 INFO  (qtp1116088742-10869) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[122 (1561221208014323712)]} 0 0
   [junit4]   2> 991237 INFO  (qtp2064535026-10881) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[122 (1561221208014323712)]} 0 0
   [junit4]   2> 991237 INFO  (qtp1116088742-10869) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[123 (1561221208015372288)]} 0 0
   [junit4]   2> 991238 INFO  (qtp2064535026-10886) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[123 (1561221208015372288)]} 0 0
   [junit4]   2> 991238 INFO  (qtp1116088742-10863) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[124 (1561221208016420864)]} 0 0
   [junit4]   2> 991239 INFO  (qtp2064535026-10886) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[124 (1561221208016420864)]} 0 0
   [junit4]   2> 991239 INFO  (qtp1116088742-10863) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[125 (1561221208017469440)]} 0 0
   [junit4]   2> 991240 INFO  (qtp2064535026-10886) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[125 (1561221208017469440)]} 0 0
   [junit4]   2> 991240 INFO  (qtp1116088742-10863) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[126 (1561221208018518016)]} 0 0
   [junit4]   2> 991240 INFO  (qtp2064535026-10886) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[126 (1561221208018518016)]} 0 0
   [junit4]   2> 991241 INFO  (qtp1116088742-10863) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[127 (1561221208019566592)]} 0 0
   [junit4]   2> 991241 INFO  (qtp2064535026-10887) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[127 (1561221208019566592)]} 0 0
   [junit4]   2> 991242 INFO  (qtp1116088742-10863) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[128 (1561221208020615168)]} 0 0
   [junit4]   2> 991242 INFO  (qtp2064535026-10881) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[128 (1561221208020615168)]} 0 0
   [junit4]   2> 991243 INFO  (qtp1116088742-10863) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[129 (1561221208021663744)]} 0 0
   [junit4]   2> 991243 INFO  (qtp2064535026-10881) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[129 (1561221208021663744)]} 0 0
   [junit4]   2> 991244 INFO  (qtp1116088742-10863) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[130 (1561221208022712320)]} 0 0
   [junit4]   2> 991244 INFO  (qtp2064535026-10885) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[130 (1561221208022712320)]} 0 0
   [junit4]   2> 991245 INFO  (qtp1116088742-10863) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[131 (1561221208023760896)]} 0 0
   [junit4]   2> 991245 INFO  (qtp2064535026-10885) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[131 (1561221208023760896)]} 0 0
   [junit4]   2> 991246 INFO  (qtp1116088742-10863) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[132 (1561221208024809472)]} 0 0
   [junit4]   2> 991246 INFO  (qtp2064535026-10885) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[132 (1561221208024809472)]} 0 0
   [junit4]   2> 991247 INFO  (qtp1116088742-10863) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[133 (1561221208025858048)]} 0 0
   [junit4]   2> 991247 INFO  (qtp2064535026-10887) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[133 (1561221208025858048)]} 0 0
   [junit4]   2> 991248 INFO  (qtp1116088742-10863) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[134 (1561221208026906624)]} 0 0
   [junit4]   2> 991248 INFO  (qtp2064535026-10887) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[134 (1561221208026906624)]} 0 0
   [junit4]   2> 991249 INFO  (qtp1116088742-10863) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[135 (1561221208027955200)]} 0 0
   [junit4]   2> 991250 INFO  (qtp2064535026-10881) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[135 (1561221208027955200)]} 0 0
   [junit4]   2> 991250 INFO  (qtp1116088742-10870) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[136 (1561221208029003776)]} 0 0
   [junit4]   2> 991251 INFO  (qtp2064535026-10880) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[136 (1561221208029003776)]} 0 0
   [junit4]   2> 991251 INFO  (qtp1116088742-10870) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[137 (1561221208030052352)]} 0 0
   [junit4]   2> 991252 INFO  (qtp2064535026-10886) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[137 (1561221208030052352)]} 0 0
   [junit4]   2> 991252 INFO  (qtp1116088742-10870) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[138 (1561221208031100928)]} 0 0
   [junit4]   2> 991253 INFO  (qtp2064535026-10885) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[138 (1561221208031100928)]} 0 0
   [junit4]   2> 991253 INFO  (qtp1116088742-10870) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[139 (1561221208032149504)]} 0 0
   [junit4]   2> 991254 INFO  (qtp2064535026-10884) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[139 (1561221208032149504)]} 0 0
   [junit4]   2> 991254 INFO  (qtp1116088742-10870) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[140 (1561221208033198080)]} 0 0
   [junit4]   2> 991255 INFO  (qtp2064535026-10887) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[140 (1561221208033198080)]} 0 0
   [junit4]   2> 991255 INFO  (qtp1116088742-10870) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[141 (1561221208034246656)]} 0 0
   [junit4]   2> 991256 INFO  (qtp2064535026-10887) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[141 (1561221208034246656)]} 0 0
   [junit4]   2> 991256 INFO  (qtp1116088742-10870) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[142 (1561221208035295232)]} 0 0
   [junit4]   2> 991257 INFO  (qtp2064535026-10887) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[142 (1561221208035295232)]} 0 0
   [junit4]   2> 991257 INFO  (qtp1116088742-10870) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[143 (1561221208036343808)]} 0 0
   [junit4]   2> 991258 INFO  (qtp2064535026-10886) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[143 (1561221208036343808)]} 0 0
   [junit4]   2> 991258 INFO  (qtp1116088742-10870) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[144 (1561221208037392384)]} 0 0
   [junit4]   2> 991259 INFO  (qtp2064535026-10885) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[144 (1561221208037392384)]} 0 0
   [junit4]   2> 991259 INFO  (qtp1116088742-10870) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[145 (1561221208038440960)]} 0 0
   [junit4]   2> 991260 INFO  (qtp2064535026-10884) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[145 (1561221208038440960)]} 0 0
   [junit4]   2> 991260 INFO  (qtp1116088742-10870) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[146 (1561221208039489536)]} 0 0
   [junit4]   2> 991261 INFO  (qtp2064535026-10881) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[146 (1561221208039489536)]} 0 0
   [junit4]   2> 991261 INFO  (qtp1116088742-10870) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[147 (1561221208040538112)]} 0 0
   [junit4]   2> 991262 INFO  (qtp2064535026-10880) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[147 (1561221208040538112)]} 0 0
   [junit4]   2> 991262 INFO  (qtp1116088742-10870) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[148 (1561221208041586688)]} 0 0
   [junit4]   2> 991263 INFO  (qtp2064535026-10880) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[148 (1561221208041586688)]} 0 0
   [junit4]   2> 991263 INFO  (qtp1116088742-10869) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[149 (1561221208042635264)]} 0 0
   [junit4]   2> 991264 INFO  (qtp2064535026-10880) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[149 (1561221208042635264)]} 0 0
   [junit4]   2> 991264 INFO  (qtp1116088742-10869) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 991264 INFO  (qtp1116088742-10869) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@547b58f3
   [junit4]   2> 991277 INFO  (qtp1116088742-10869) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@5443100e[collection1] main]
   [junit4]   2> 991277 INFO  (qtp1116088742-10869) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 991278 INFO  
(searcherExecutor-4309-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@5443100e[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):c9)
 Uninverting(_1(7.0.0):c59)))}
   [junit4]   2> 991279 INFO  (qtp1116088742-10869) [    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 14
   [junit4]   2> 991279 INFO  (qtp2064535026-10885) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 991279 INFO  (qtp2064535026-10885) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@30ecfe7a
   [junit4]   2> 991294 INFO  (qtp2064535026-10885) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@2f4a482[collection1] main]
   [junit4]   2> 991295 INFO  (qtp2064535026-10885) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 991296 INFO  
(searcherExecutor-4320-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@2f4a482[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):c9)
 Uninverting(_1(7.0.0):c59)))}
   [junit4]   2> 991296 INFO  (qtp2064535026-10885) [    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> 991297 INFO  (qtp1116088742-10863) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching parameter cannot be 
negative
   [junit4]   2> 991297 INFO  (qtp1116088742-10863) [    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> 991297 INFO  (qtp1116088742-10863) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching parameter cannot be 
negative
   [junit4]   2> 991297 INFO  (qtp1116088742-10863) [    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> 991298 INFO  (qtp1116088742-10863) [    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> 991435 INFO  (qtp2064535026-10887) [    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::083]:33332/|http://127.0.0.1:43579//collection1|[ff01::114]:33332/&rows=10&version=2&q=*:*&NOW=1488896568375&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 991437 INFO  (qtp2064535026-10886) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1488896568375&ids=132,100,3,4,137,6,108,9,109,141&isShard=true&shard.url=[ff01::213]:33332/|[ff01::083]:33332/|http://127.0.0.1:43579//collection1|[ff01::114]:33332/&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 991444 INFO  (qtp2064535026-10884) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=[ff01::213]:33332/|[ff01::083]:33332/|http://127.0.0.1:43579//collection1|[ff01::114]:33332/&sort=n_ti1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=144
   [junit4]   2> 991444 INFO  (qtp1116088742-10870) [    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> 991497 INFO  (qtp2064535026-10880) [    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=[ff01::114]:33332/|http://127.0.0.1:43579//collection1|[ff01::083]:33332/|[ff01::213]:33332/&rows=10&version=2&q=*:*&NOW=1488896568522&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 991501 INFO  (qtp2064535026-10880) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1488896568522&ids=110,1,122,124,102,135,103,148,115,130&isShard=true&shard.url=[ff01::114]:33332/|http://127.0.0.1:43579//collection1|[ff01::083]:33332/|[ff01::213]:33332/&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 991502 INFO  (qtp2064535026-10881) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=[ff01::114]:33332/|http://127.0.0.1:43579//collection1|[ff01::083]:33332/|[ff01::213]:33332/&sort=n_ti1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=56
   [junit4]   2> 991503 INFO  (qtp1116088742-10868) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&sort=n_f1+desc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 991505 INFO  (qtp2064535026-10887) [    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:43579//collection1&rows=10&version=2&q=*:*&NOW=1488896568580&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 991506 INFO  (qtp2064535026-10886) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1488896568580&ids=143,15,136,147,5,137,6,1001,140,10&isShard=true&shard.url=http://127.0.0.1:43579//collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 991509 INFO  (qtp2064535026-10885) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=http://127.0.0.1:43579//collection1&sort=n_f1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=4
   [junit4]   2> 991510 INFO  (qtp1116088742-10869) [    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> 991512 INFO  (qtp2064535026-10882) [    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:43579//collection1|[ff01::213]:33332/&rows=10&version=2&q=*:*&NOW=1488896568587&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 991513 INFO  (qtp2064535026-10881) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1488896568587&ids=132,12,102,3,4,104,16,105,128,139&isShard=true&shard.url=http://127.0.0.1:43579//collection1|[ff01::213]:33332/&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 991515 INFO  (qtp2064535026-10884) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=http://127.0.0.1:43579//collection1|[ff01::213]:33332/&sort=n_f1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=4
   [junit4]   2> 991516 INFO  (qtp1116088742-10866) [    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> 991517 INFO  (qtp2064535026-10887) [    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::083]:33332/|http://127.0.0.1:43579//collection1|[ff01::114]:33332/|[ff01::213]:33332/&rows=10&version=2&q=*:*&NOW=1488896568593&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 991518 INFO  (qtp2064535026-10887) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1488896568593&ids=1,111,133,134,113,15,136,126,17,130&isShard=true&shard.url=[ff01::083]:33332/|http://127.0.0.1:43579//collection1|[ff01::114]:33332/|[ff01::213]:33332/&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 991519 INFO  (qtp2064535026-10880) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=[ff01::083]:33332/|http://127.0.0.1:43579//collection1|[ff01::114]:33332/|[ff01::213]:33332/&sort=n_tf1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=2
   [junit4]   2> 991520 INFO  (qtp1116088742-10866) [    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> 991521 INFO  (qtp2064535026-10882) [    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=[ff01::114]:33332/|[ff01::213]:33332/|[ff01::083]:33332/|http://127.0.0.1:43579//collection1&rows=10&version=2&q=*:*&NOW=1488896568596&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 991522 INFO  (qtp2064535026-10884) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1488896568596&ids=121,135,125,16,127,7,1001,8,109,141&isShard=true&shard.url=[ff01::114]:33332/|[ff01::213]:33332/|[ff01::083]:33332/|http://127.0.0.1:43579//collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 991524 INFO  (qtp2064535026-10886) [    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:43579//collection1&sort=n_tf1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=3
   [junit4]   2> 991525 INFO  (qtp1116088742-10866) [    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> 991526 INFO  (qtp2064535026-10885) [    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:43579//collection1|[ff01::083]:33332/|[ff01::114]:33332/&rows=10&version=2&q=*:*&NOW=1488896568602&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 991527 INFO  (qtp2064535026-10885) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1488896568602&ids=100,113,114,148,116,1001,117,106,109,131&isShard=true&shard.url=http://127.0.0.1:43579//collection1|[ff01::083]:33332/|[ff01::114]:33332/&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 991528 INFO  (qtp2064535026-10881) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=http://127.0.0.1:43579//collection1|[ff01::083]:33332/|[ff01::114]:33332/&sort=n_d1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=2
   [junit4]   2> 991529 INFO  (qtp1116088742-10866) [    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> 991530 INFO  (qtp2064535026-10882) [    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:43579//collection1|[ff01::213]:33332/|[ff01::083]:33332/&rows=10&version=2&q=*:*&NOW=1488896568606&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 991531 INFO  (qtp2064535026-10882) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1488896568606&ids=11,110,123,134,103,104,138,149,9,130&isShard=true&shard.url=http://127.0.0.1:43579//collection1|[ff01::213]:33332/|[ff01::083]:33332/&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 991532 INFO  (qtp2064535026-10887) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=http://127.0.0.1:43579//collection1|[ff01::213]:33332/|[ff01::083]:33332/&sort=n_d1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=2
   [junit4]   2> 991533 INFO  (qtp1116088742-10866) [    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> 991534 INFO  (qtp2064535026-10882) [    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=http://127.0.0.1:43579//collection1|[ff01::114]:33332/|[ff01::213]:33332/|[ff01::083]:33332/&rows=10&version=2&q=*:*&NOW=1488896568609&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 991535 INFO  (qtp2064535026-10881) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1488896568609&ids=100,112,134,146,4,103,5,104,7,8&isShard=true&shard.url=http://127.0.0.1:43579//collection1|[ff01::114]:33332/|[ff01::213]:33332/|[ff01::083]:33332/&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 991536 INFO  (qtp2064535026-10884) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=http://127.0.0.1:43579//collection1|[ff01::114]:33332/|[ff01::213]:33332/|[ff01::083]:33332/&sort=n_td1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=2
   [junit4]   2> 991537 INFO  (qtp1116088742-10869) [    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> 991538 INFO  (qtp2064535026-10886) [    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:43579//collection1|[ff01::083]:33332/|[ff01::114]:33332/&rows=10&version=2&q=*:*&NOW=1488896568614&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 991539 INFO  (qtp2064535026-10886) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1488896568614&ids=132,110,122,15,6,116,138,117,109,140&isShard=true&shard.url=http://127.0.0.1:43579//collection1|[ff01::083]:33332/|[ff01::114]:33332/&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 991540 INFO  (qtp2064535026-10885) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=http://127.0.0.1:43579//collection1|[ff01::083]:33332/|[ff01::114]:33332/&sort=n_td1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=2
   [junit4]   2> 991540 INFO  (qtp1116088742-10869) [    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> 991542 INFO  (qtp2064535026-10886) [    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/|http://127.0.0.1:43579//collection1|[ff01::213]:33332/&rows=10&version=2&q=*:*&NOW=1488896568617&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 991542 INFO  (qtp2064535026-10886) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1488896568617&ids=11,121,1,122,123,134,4,16,6,149&isShard=true&shard.url=[ff01::083]:33332/|http://127.0.0.1:43579//collection1|[ff01::213]:33332/&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 991543 INFO  (qtp2064535026-10880) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=[ff01::083]:33332/|http://127.0.0.1:43579//collection1|[ff01::213]:33332/&sort=n_l1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=1
   [junit4]   2> 991544 INFO  (qtp1116088742-10863) [    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> 991545 INFO  (qtp2064535026-10886) [    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=[ff01::213]:33332/|[ff01::083]:33332/|http://127.0.0.1:43579//collection1&rows=10&version=2&q=*:*&NOW=1488896568621&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 991546 INFO  (qtp2064535026-10886) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1488896568621&ids=133,144,2,145,135,148,104,139,109,140&isShard=true&shard.url=[ff01::213]:33332/|[ff01::083]:33332/|http://127.0.0.1:43579//collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 991547 INFO  (qtp2064535026-10881) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=[ff01::213]:33332/|[ff01::083]:33332/|http://127.0.0.1:43579//collection1&sort=n_l1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=2
   [junit4]   2> 991548 INFO  (qtp1116088742-10870) [    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> 991549 INFO  (qtp2064535026-10886) [    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=http://127.0.0.1:43579//collection1|[ff01::083]:33332/|[ff01::114]:33332/&rows=10&version=2&q=*:*&NOW=1488896568624&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 991550 INFO  (qtp2064535026-10886) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1488896568624&ids=135,146,16,17,149,127,7,118,109,142&isShard=true&shard.url=http://127.0.0.1:43579//collection1|[ff01::083]:33332/|[ff01::114]:33332/&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 991551 INFO  (qtp2064535026-10882) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=http://127.0.0.1:43579//collection1|[ff01::083]:33332/|[ff01::114]:33332/&sort=n_tl1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=2
   [junit4]   2> 991551 INFO  (qtp1116088742-10870) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&sort=n_tl1+asc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 991552 INFO  (qtp2064535026-10886) [    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=[ff01::114]:33332/|[ff01::083]:33332/|[ff01::213]:33332/|http://127.0.0.1:43579//collection1&rows=10&version=2&q=*:*&NOW=1488896568628&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 991553 INFO  (qtp2064535026-10886) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1488896568628&ids=100,112,101,113,124,115,5,6,10,131&isShard=true&shard.url=[ff01::114]:33332/|[ff01::083]:33332/|[ff01::213]:33332/|http://127.0.0.1:43579//collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 991554 INFO  (qtp2064535026-10887) [    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:43579//collection1&sort=n_tl1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=1
   [junit4]   2> 991554 INFO  (qtp1116088742-10870) [    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> 991556 INFO  (qtp2064535026-10886) [    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:43579//collection1|[ff01::114]:33332/&rows=10&version=2&q=*:*&NOW=1488896568631&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 991556 INFO  (qtp2064535026-10882) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1488896568631&ids=143,1,123,104,127,6,8,140,130,142&isShard=true&shard.url=http://127.0.0.1:43579//collection1|[ff01::114]:33332/&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 991557 INFO  (qtp2064535026-10884) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=http://127.0.0.1:43579//collection1|[ff01::114]:33332/&sort=n_dt1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=1
   [junit4]   2> 991558 INFO  (qtp1116088742-10867) [    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> 991559 INFO  (qtp2064535026-10881) [    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=[ff01::114]:33332/|http://127.0.0.1:43579//collection1|[ff01::083]:33332/&rows=10&version=2&q=*:*&NOW=1488896568635&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 991560 INFO  (qtp2064535026-10881) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1488896568635&ids=122,133,100,101,114,147,7,9,119,141&isShard=true&shard.url=[ff01::114]:33332/|http://127.0.0.1:43579//collection1|[ff01::083]:33332/&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 991561 INFO  (qtp2064535026-10885) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=[ff01::114]:33332/|http://127.0.0.1:43579//collection1|[ff01::083]:33332/&sort=n_dt1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=2
   [junit4]   2> 991562 INFO  (qtp1116088742-10867) [    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> 991563 INFO  (qtp2064535026-10886) [    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=[ff01::213]:33332/|http://127.0.0.1:43579//collection1|[ff01::083]:33332/&rows=10&version=2&q=*:*&NOW=1488896568639&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 991565 INFO  (qtp2064535026-10884) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1488896568639&ids=121,100,13,4,6,17,105,127,139,142&isShard=true&shard.url=[ff01::213]:33332/|http://127.0.0.1:43579//collection1|[ff01::083]:33332/&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 991566 INFO  (qtp2064535026-10880) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=[ff01::213]:33332/|http://127.0.0.1:43579//collection1|[ff01::083]:33332/&sort=n_tdt1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=3
   [junit4]   2> 991567 INFO  (qtp1116088742-10863) [    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> 991568 INFO  (qtp2064535026-10887) [    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=http://127.0.0.1:43579//collection1|[ff01::083]:33332/&rows=10&version=2&q=*:*&NOW=1488896568643&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 991568 INFO  (qtp2064535026-10887) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1488896568643&ids=111,144,1,134,145,113,124,126,106,9&isShard=true&shard.url=http://127.0.0.1:43579//collection1|[ff01::083]:33332/&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 991569 INFO  (qtp2064535026-10882) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=http://127.0.0.1:43579//collection1|[ff01::083]:33332/&sort=n_tdt1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=1
   [junit4]   2> 991570 INFO  (qtp1116088742-10863) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&sort=a_i1+desc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 991571 INFO  (qtp2064535026-10886) [    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_i1+desc&shard.url=[ff01::213]:33332/|[ff01::114]:33332/|http://127.0.0.1:43579//collection1&rows=10&version=2&q=*:*&NOW=1488896568647&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 991572 INFO  (qtp2064535026-10886) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1488896568647&ids=1,12,2,13,3,5,7,8,9,10&isShard=true&shard.url=[ff01::213]:33332/|[ff01::114]:33332/|http://127.0.0.1:43579//collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 991573 INFO  (qtp2064535026-10881) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=[ff01::213]:33332/|[ff01::114]:33332/|http://127.0.0.1:43579//collection1&sort=a_i1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=2
   [junit4]   2> 991574 INFO  (qtp1116088742-10866) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&sort={!func}testfunc(add(a_i1,5))+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=0
   [junit4]   2> 991576 INFO  (qtp2064535026-10886) [    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_i1,5))+desc&shard.url=http://127.0.0.1:43579//collection1&rows=10&version=2&q=*:*&NOW=1488896568651&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 991576 INFO  (qtp2064535026-10882) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1488896568651&ids=1,12,2,13,3,5,7,8,9,10&isShard=true&shard.url=http://127.0.0.1:43579//collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 991577 INFO  (qtp2064535026-10884) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=http://127.0.0.1:43579//collection1&sort={!func}testfunc(add(a_i1,5))+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=2
   [junit4]   2> 991580 INFO  (qtp1116088742-10870) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=a_i1[*+TO+*]&distrib=false&sort=a_i1+asc&wt=javabin&version=2} 
hits=13 status=0 QTime=2
   [junit4]   2> 991582 INFO  (qtp2064535026-10880) [    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_i1+asc&shard.url=[ff01::083]:33332/|http://127.0.0.1:43579//collection1|[ff01::213]:33332/&rows=10&version=2&q=a_i1[*+TO+*]&NOW=1488896568657&isShard=true&wt=javabin}
 hits=13 status=0 QTime=0
   [junit4]   2> 991582 INFO  (qtp2064535026-10880) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=a_i1[*+TO+*]&distrib=false&shards.purpose=64&NOW=1488896568657&ids=11,12,1,13,2,3,4,6,7,9&isShard=true&shard.url=[ff01::083]:33332/|http://127.0.0.1:43579//collection1|[ff01::213]:33332/&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 991583 INFO  (qtp2064535026-10887) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=a_i1[*+TO+*]&shards=[ff01::083]:33332/|http://127.0.0.1:43579//collection1|[ff01::213]:33332/&sort=a_i1+asc&wt=javabin&version=2}
 hits=13 status=0 QTime=2
   [junit4]   2> 991584 INFO  (qtp1116088742-10869) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&sort=a_i1+asc,+id+desc&wt=javabin&version=2} 
hits=68 status=0 QTime=0
   [junit4]   2> 991586 INFO  (qtp2064535026-10886) [    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_i1+asc,+id+desc&shard.url=[ff01::213]:33332/|http://127.0.0.1:43579//collection1|[ff01::083]:33332/|[ff01::114]:33332/&rows=10&version=2&q=*:*&NOW=1488896568661&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 991586 INFO  (qtp2064535026-10884) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1488896568661&ids=11,12,1,13,2,3,4,6,7,9&isShard=true&shard.url=[ff01::213]:33332/|http://127.0.0.1:43579//collection1|[ff01::083]:33332/|[ff01::114]:33332/&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 991587 INFO  (qtp2064535026-10885) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=[ff01::213]:33332/|http://127.0.0.1:43579//collection1|[ff01::083]:33332/|[ff01::114]:33332/&sort=a_i1+asc,+id+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=2
   [junit4]   2> 991588 INFO  (qtp1116088742-10867) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&fl=*,score&sort=a_i1+desc&wt=javabin&version=2} 
hits=68 status=0 QTime=0
   [junit4]   2> 991589 INFO  (qtp2064535026-10884) [    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_i1+desc&shard.url=[ff01::213]:33332/|[ff01::114]:33332/|http://127.0.0.1:43579//collection1|[ff01::083]:33332/&rows=10&version=2&q=*:*&NOW=1488896568665&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 991590 INFO  (qtp2064535026-10884) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&fl=*,score&shards.purpose=64&NOW=1488896568665&ids=1,12,2,13,3,5,7,8,9,10&isShard=true&shard.url=[ff01::213]:33332/|[ff01::114]:33332/|h

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

t4]   2> 1021806 INFO  (coreCloseExecutor-4362-thread-1) [    x:collection1] 
o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@1cd25a69
   [junit4]   2> 1021867 INFO  (coreCloseExecutor-4362-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: 
solr.core.collection1
   [junit4]   2> 1021867 INFO  
(TEST-TestDistributedSearch.test-seed#[EDE78071CE1C8F93]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
   [junit4]   2> 1021868 INFO  
(TEST-TestDistributedSearch.test-seed#[EDE78071CE1C8F93]) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@4025b5df{/,null,UNAVAILABLE}
   [junit4]   2> 1021869 INFO  
(TEST-TestDistributedSearch.test-seed#[EDE78071CE1C8F93]) [    ] 
o.e.j.s.AbstractConnector Stopped 
ServerConnector@c9120e{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 1021869 INFO  
(TEST-TestDistributedSearch.test-seed#[EDE78071CE1C8F93]) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1105292911
   [junit4]   2> 1021870 INFO  (coreCloseExecutor-4364-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@18b333ed
   [junit4]   2> 1021911 INFO  (coreCloseExecutor-4364-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: 
solr.core.collection1
   [junit4]   2> 1021912 INFO  
(TEST-TestDistributedSearch.test-seed#[EDE78071CE1C8F93]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
   [junit4]   2> 1021912 INFO  
(TEST-TestDistributedSearch.test-seed#[EDE78071CE1C8F93]) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@4bc6dc04{/,null,UNAVAILABLE}
   [junit4]   2> 1021913 INFO  
(TEST-TestDistributedSearch.test-seed#[EDE78071CE1C8F93]) [    ] 
o.e.j.s.AbstractConnector Stopped 
ServerConnector@6ecdda0b{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 1021913 INFO  
(TEST-TestDistributedSearch.test-seed#[EDE78071CE1C8F93]) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=350348326
   [junit4]   2> 1021914 INFO  (coreCloseExecutor-4366-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@4876312b
   [junit4]   2> 1021931 INFO  (coreCloseExecutor-4366-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: 
solr.core.collection1
   [junit4]   2> 1021932 INFO  
(TEST-TestDistributedSearch.test-seed#[EDE78071CE1C8F93]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
   [junit4]   2> 1021932 INFO  
(TEST-TestDistributedSearch.test-seed#[EDE78071CE1C8F93]) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@3fcae4f2{/,null,UNAVAILABLE}
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=TestDistributedSearch -Dtests.method=test 
-Dtests.seed=EDE78071CE1C8F93 -Dtests.multiplier=2 -Dtests.slow=true 
-Dtests.locale=el -Dtests.timezone=NET -Dtests.asserts=true 
-Dtests.file.encoding=US-ASCII
   [junit4] FAILURE 33.4s 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=1}
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([EDE78071CE1C8F93:65B3BFAB60E0E26B]: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> 1021935 INFO  
(SUITE-TestDistributedSearch-seed#[EDE78071CE1C8F93]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_EDE78071CE1C8F93-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): 
{severity=PostingsFormat(name=LuceneFixedGap), 
other_tl1=BlockTreeOrds(blocksize=128), 
foo_sev_enum=PostingsFormat(name=Asserting), 
SubjectTerms_mfacet=BlockTreeOrds(blocksize=128), 
a_n_tdt=PostingsFormat(name=Asserting), 
multiDefault=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
 a_i1=BlockTreeOrds(blocksize=128), 
n_td1=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
 b_n_tdt=BlockTreeOrds(blocksize=128), n_ti1=PostingsFormat(name=Asserting), 
rnd_b=PostingsFormat(name=Asserting), 
n_tl1=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
 a_s=PostingsFormat(name=LuceneFixedGap), 
oddField_s=PostingsFormat(name=LuceneFixedGap), 
n_tf1=BlockTreeOrds(blocksize=128), 
lowerfilt1and2=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
 a_t=BlockTreeOrds(blocksize=128), foo_b=PostingsFormat(name=LuceneFixedGap), 
n_tdt1=BlockTreeOrds(blocksize=128), 
lowerfilt=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
 id=PostingsFormat(name=Asserting), text=PostingsFormat(name=LuceneFixedGap)}, 
docValues:{range_facet_l_dv=DocValuesFormat(name=Memory), 
foo_sev_enum=DocValuesFormat(name=Memory), 
n_l1=DocValuesFormat(name=Asserting), 
intDefault=DocValuesFormat(name=Asserting), n_dt1=DocValuesFormat(name=Direct), 
n_d1=DocValuesFormat(name=Asserting), 
range_facet_l=DocValuesFormat(name=Asserting), 
n_f1=DocValuesFormat(name=Direct), _version_=DocValuesFormat(name=Asserting), 
foo_d=DocValuesFormat(name=Memory), 
range_facet_i_dv=DocValuesFormat(name=Asserting), 
foo_f=DocValuesFormat(name=Lucene70), 
intDvoDefault=DocValuesFormat(name=Lucene70), 
timestamp=DocValuesFormat(name=Asserting)}, maxPointsInLeafNode=339, 
maxMBSortInHeap=5.693744456037518, sim=RandomSimilarity(queryNorm=false): {}, 
locale=el, timezone=NET
   [junit4]   2> NOTE: Linux 3.13.0-85-generic amd64/Oracle Corporation 
1.8.0_121 (64-bit)/cpus=4,threads=1,free=102539600,total=533200896
   [junit4]   2> NOTE: All tests run in this JVM: [TestInitQParser, 
TestConfigSets, TestCollationFieldDocValues, TestFieldCacheSortRandom, 
UUIDFieldTest, NotRequiredUniqueKeyTest, SolrIndexMetricsTest, 
PreAnalyzedFieldManagedSchemaCloudTest, TestHighlightDedupGrouping, 
TestReplicationHandler, BlobRepositoryCloudTest, TestJavabinTupleStreamParser, 
ExplicitHLLTest, DistributedQueryElevationComponentTest, 
ConjunctionSolrSpellCheckerTest, CdcrReplicationHandlerTest, 
CustomCollectionTest, TestExportWriter, MinimalSchemaTest, 
TestSolrConfigHandlerCloud, DeleteNodeTest, TestSolrCloudWithHadoopAuthPlugin, 
TestSchemalessBufferedUpdates, DateMathParserTest, TestJmxIntegration, 
TestSolr4Spatial, TestSuggestSpellingConverter, SolrCoreTest, 
TestCrossCoreJoin, SolrGraphiteReporterTest, TestFieldTypeResource, 
TestSha256AuthenticationProvider, TestReplicaProperties, 
BigEndianAscendingWordDeserializerTest, HdfsDirectoryTest, 
TestStandardQParsers, TestRestoreCore, BasicZkTest, TestSearcherReuse, 
HdfsUnloadDistributedZkTest, TestAuthorizationFramework, 
TestShardHandlerFactory, NumericFieldsTest, DistributedSpellCheckComponentTest, 
BooleanFieldTest, TestFaceting, SignatureUpdateProcessorFactoryTest, 
JvmMetricsTest, HdfsRecoverLeaseTest, TestRangeQuery, SystemInfoHandlerTest, 
FastVectorHighlighterTest, PeerSyncTest, ReplaceNodeTest, TestSolrXml, 
SecurityConfHandlerTest, TestSolrCoreProperties, BasicAuthIntegrationTest, 
TestBadConfig, AliasIntegrationTest, HdfsBasicDistributedZk2Test, 
TestPseudoReturnFields, QueryEqualityTest, TestJmxMonitoredMap, 
TestFilteredDocIdSet, DistributedFacetExistsSmallTest, TestQuerySenderListener, 
DocValuesNotIndexedTest, TestLFUCache, SimpleCollectionCreateDeleteTest, 
RequestLoggingTest, TestLMJelinekMercerSimilarityFactory, HLLUtilTest, 
HdfsSyncSliceTest, TestConfigOverlay, TestSolrDeletionPolicy2, 
LeaderElectionContextKeyTest, SearchHandlerTest, TolerantUpdateProcessorTest, 
TestHdfsBackupRestoreCore, DocumentAnalysisRequestHandlerTest, ShardSplitTest, 
IgnoreCommitOptimizeUpdateProcessorFactoryTest, TestFunctionQuery, 
TestDistributedSearch]
   [junit4] Completed [319/693 (1!)] on J0 in 33.40s, 1 test, 1 failure <<< 
FAILURES!

[...truncated 63777 lines...]


---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to