[JENKINS] Lucene-Solr-master-Solaris (64bit/jdk1.8.0) - Build # 1220 - Unstable!

[Policeman Jenkins Server]

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

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

Error Message:
Expected to find shardAddress in the up shard info: 
{error=org.apache.solr.client.solrj.SolrServerException: 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=3}

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=3}
        at 
__randomizedtesting.SeedInfo.seed([9B5979D1DEC85986:130D460B7034347E]: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 12003 lines...]
   [junit4] Suite: org.apache.solr.TestDistributedSearch
   [junit4]   2> Creating dataDir: 
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_9B5979D1DEC85986-001/init-core-data-001
   [junit4]   2> 1515146 WARN  
(SUITE-TestDistributedSearch-seed#[9B5979D1DEC85986]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=2 numCloses=2
   [junit4]   2> 1515146 INFO  
(SUITE-TestDistributedSearch-seed#[9B5979D1DEC85986]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using TrieFields
   [junit4]   2> 1515148 INFO  
(SUITE-TestDistributedSearch-seed#[9B5979D1DEC85986]-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> 1515148 INFO  
(SUITE-TestDistributedSearch-seed#[9B5979D1DEC85986]-worker) [    ] 
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /
   [junit4]   2> 1515292 INFO  
(TEST-TestDistributedSearch.test-seed#[9B5979D1DEC85986]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_9B5979D1DEC85986-001/tempDir-001/control/cores/collection1
   [junit4]   2> 1515293 INFO  
(TEST-TestDistributedSearch.test-seed#[9B5979D1DEC85986]) [    ] o.e.j.s.Server 
jetty-9.3.14.v20161028
   [junit4]   2> 1515295 INFO  
(TEST-TestDistributedSearch.test-seed#[9B5979D1DEC85986]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@1cbcbfc7{/,null,AVAILABLE}
   [junit4]   2> 1515297 INFO  
(TEST-TestDistributedSearch.test-seed#[9B5979D1DEC85986]) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@27d70811{HTTP/1.1,[http/1.1]}{127.0.0.1:54665}
   [junit4]   2> 1515297 INFO  
(TEST-TestDistributedSearch.test-seed#[9B5979D1DEC85986]) [    ] o.e.j.s.Server 
Started @1518184ms
   [junit4]   2> 1515297 INFO  
(TEST-TestDistributedSearch.test-seed#[9B5979D1DEC85986]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, hostPort=54665, 
coreRootDirectory=/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_9B5979D1DEC85986-001/tempDir-001/control/cores}
   [junit4]   2> 1515297 ERROR 
(TEST-TestDistributedSearch.test-seed#[9B5979D1DEC85986]) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1515298 INFO  
(TEST-TestDistributedSearch.test-seed#[9B5979D1DEC85986]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
7.0.0
   [junit4]   2> 1515298 INFO  
(TEST-TestDistributedSearch.test-seed#[9B5979D1DEC85986]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 1515298 INFO  
(TEST-TestDistributedSearch.test-seed#[9B5979D1DEC85986]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1515298 INFO  
(TEST-TestDistributedSearch.test-seed#[9B5979D1DEC85986]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-03-27T01:27:34.894Z
   [junit4]   2> 1515299 INFO  
(TEST-TestDistributedSearch.test-seed#[9B5979D1DEC85986]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_9B5979D1DEC85986-001/tempDir-001/control/solr.xml
   [junit4]   2> 1515338 INFO  
(TEST-TestDistributedSearch.test-seed#[9B5979D1DEC85986]) [    ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_9B5979D1DEC85986-001/tempDir-001/control/cores
   [junit4]   2> 1515338 INFO  
(TEST-TestDistributedSearch.test-seed#[9B5979D1DEC85986]) [    ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 1515339 INFO  (coreLoadExecutor-6506-thread-1) [    
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, 
from paths: 
[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/lib,
 
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1515369 WARN  (coreLoadExecutor-6506-thread-1) [    
x:collection1] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is 
deprecated, use <mergePolicyFactory> instead.
   [junit4]   2> 1515371 INFO  (coreLoadExecutor-6506-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1515392 INFO  (coreLoadExecutor-6506-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1515541 WARN  (coreLoadExecutor-6506-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> 1515543 INFO  (coreLoadExecutor-6506-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1515549 INFO  (coreLoadExecutor-6506-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from configset 
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1
   [junit4]   2> 1515550 INFO  (coreLoadExecutor-6506-thread-1) [    
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 1515550 INFO  (coreLoadExecutor-6506-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1],
 
dataDir=[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_9B5979D1DEC85986-001/tempDir-001/control/cores/collection1/data/]
   [junit4]   2> 1515550 INFO  (coreLoadExecutor-6506-thread-1) [    
x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr 
mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@317c3ff2
   [junit4]   2> 1515551 INFO  (coreLoadExecutor-6506-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=48, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.0]
   [junit4]   2> 1515620 INFO  (coreLoadExecutor-6506-thread-1) [    
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1515620 INFO  (coreLoadExecutor-6506-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 1515621 INFO  (coreLoadExecutor-6506-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1515621 INFO  (coreLoadExecutor-6506-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1515622 INFO  (coreLoadExecutor-6506-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: 
minMergeSize=0, mergeFactor=10, maxMergeSize=2114503065, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.1]
   [junit4]   2> 1515622 INFO  (coreLoadExecutor-6506-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@2c8e21d8[collection1] main]
   [junit4]   2> 1515622 INFO  (coreLoadExecutor-6506-thread-1) [    
x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1515630 INFO  (coreLoadExecutor-6506-thread-1) [    
x:collection1] o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 1515647 INFO  (coreLoadExecutor-6506-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1515647 INFO  
(searcherExecutor-6507-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1515647 INFO  
(searcherExecutor-6507-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1515647 INFO  
(searcherExecutor-6507-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1515647 INFO  
(searcherExecutor-6507-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 1515648 INFO  (coreLoadExecutor-6506-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1562984374855532544
   [junit4]   2> 1515648 INFO  
(searcherExecutor-6507-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1515648 INFO  
(searcherExecutor-6507-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1515648 INFO  
(searcherExecutor-6507-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1515649 INFO  
(searcherExecutor-6507-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 1515649 INFO  
(searcherExecutor-6507-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 1515650 INFO  
(searcherExecutor-6507-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@2c8e21d8[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1516038 INFO  
(TEST-TestDistributedSearch.test-seed#[9B5979D1DEC85986]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_9B5979D1DEC85986-001/tempDir-001/shard0/cores/collection1
   [junit4]   2> 1516039 INFO  
(TEST-TestDistributedSearch.test-seed#[9B5979D1DEC85986]) [    ] o.e.j.s.Server 
jetty-9.3.14.v20161028
   [junit4]   2> 1516040 INFO  
(TEST-TestDistributedSearch.test-seed#[9B5979D1DEC85986]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@ee8e5aa{/,null,AVAILABLE}
   [junit4]   2> 1516041 INFO  
(TEST-TestDistributedSearch.test-seed#[9B5979D1DEC85986]) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@447b177f{HTTP/1.1,[http/1.1]}{127.0.0.1:50269}
   [junit4]   2> 1516041 INFO  
(TEST-TestDistributedSearch.test-seed#[9B5979D1DEC85986]) [    ] o.e.j.s.Server 
Started @1518928ms
   [junit4]   2> 1516041 INFO  
(TEST-TestDistributedSearch.test-seed#[9B5979D1DEC85986]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, hostPort=50269, 
coreRootDirectory=/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_9B5979D1DEC85986-001/tempDir-001/shard0/cores}
   [junit4]   2> 1516042 ERROR 
(TEST-TestDistributedSearch.test-seed#[9B5979D1DEC85986]) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1516042 INFO  
(TEST-TestDistributedSearch.test-seed#[9B5979D1DEC85986]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
7.0.0
   [junit4]   2> 1516042 INFO  
(TEST-TestDistributedSearch.test-seed#[9B5979D1DEC85986]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 1516042 INFO  
(TEST-TestDistributedSearch.test-seed#[9B5979D1DEC85986]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1516043 INFO  
(TEST-TestDistributedSearch.test-seed#[9B5979D1DEC85986]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-03-27T01:27:35.639Z
   [junit4]   2> 1516043 INFO  
(TEST-TestDistributedSearch.test-seed#[9B5979D1DEC85986]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_9B5979D1DEC85986-001/tempDir-001/shard0/solr.xml
   [junit4]   2> 1516088 INFO  
(TEST-TestDistributedSearch.test-seed#[9B5979D1DEC85986]) [    ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_9B5979D1DEC85986-001/tempDir-001/shard0/cores
   [junit4]   2> 1516088 INFO  
(TEST-TestDistributedSearch.test-seed#[9B5979D1DEC85986]) [    ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 1516089 INFO  (coreLoadExecutor-6517-thread-1) [    
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, 
from paths: 
[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/lib,
 
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1516118 WARN  (coreLoadExecutor-6517-thread-1) [    
x:collection1] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is 
deprecated, use <mergePolicyFactory> instead.
   [junit4]   2> 1516120 INFO  (coreLoadExecutor-6517-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1516140 INFO  (coreLoadExecutor-6517-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1516211 WARN  (coreLoadExecutor-6517-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> 1516213 INFO  (coreLoadExecutor-6517-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1516219 INFO  (coreLoadExecutor-6517-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from configset 
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1
   [junit4]   2> 1516219 INFO  (coreLoadExecutor-6517-thread-1) [    
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 1516219 INFO  (coreLoadExecutor-6517-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1],
 
dataDir=[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_9B5979D1DEC85986-001/tempDir-001/shard0/cores/collection1/data/]
   [junit4]   2> 1516220 INFO  (coreLoadExecutor-6517-thread-1) [    
x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr 
mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@317c3ff2
   [junit4]   2> 1516220 INFO  (coreLoadExecutor-6517-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=48, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.0]
   [junit4]   2> 1516315 INFO  (coreLoadExecutor-6517-thread-1) [    
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1516315 INFO  (coreLoadExecutor-6517-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 1516316 INFO  (coreLoadExecutor-6517-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1516316 INFO  (coreLoadExecutor-6517-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1516319 INFO  (coreLoadExecutor-6517-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: 
minMergeSize=0, mergeFactor=10, maxMergeSize=2114503065, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.1]
   [junit4]   2> 1516319 INFO  (coreLoadExecutor-6517-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@833f5b[collection1] 
main]
   [junit4]   2> 1516319 INFO  (coreLoadExecutor-6517-thread-1) [    
x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1516324 INFO  (coreLoadExecutor-6517-thread-1) [    
x:collection1] o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 1516341 INFO  (coreLoadExecutor-6517-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1516341 INFO  
(searcherExecutor-6518-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1516342 INFO  
(searcherExecutor-6518-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1516342 INFO  
(searcherExecutor-6518-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1516342 INFO  
(searcherExecutor-6518-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 1516343 INFO  
(searcherExecutor-6518-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1516343 INFO  
(searcherExecutor-6518-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1516343 INFO  
(searcherExecutor-6518-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1516344 INFO  
(searcherExecutor-6518-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 1516344 INFO  
(searcherExecutor-6518-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 1516355 INFO  
(searcherExecutor-6518-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@833f5b[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1516356 INFO  (coreLoadExecutor-6517-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1562984375597924352
   [junit4]   2> 1516636 INFO  
(TEST-TestDistributedSearch.test-seed#[9B5979D1DEC85986]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting test
   [junit4]   2> 1516648 INFO  (qtp511679363-17794) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{deleteByQuery=*:* (-1562984375902011392)} 0 1
   [junit4]   2> 1516663 INFO  (qtp618048348-17811) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{deleteByQuery=*:* (-1562984375917740032)} 0 1
   [junit4]   2> 1516664 INFO  (qtp511679363-17795) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[1 (1562984375919837184)]} 0 1
   [junit4]   2> 1516666 INFO  (qtp618048348-17812) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[1 (1562984375921934336)]} 0 1
   [junit4]   2> 1516667 INFO  (qtp511679363-17796) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[2 (1562984375924031488)]} 0 0
   [junit4]   2> 1516668 INFO  (qtp618048348-17813) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[2 (1562984375924031488)]} 0 0
   [junit4]   2> 1516669 INFO  (qtp511679363-17797) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[3 (1562984375925080064)]} 0 0
   [junit4]   2> 1516670 INFO  (qtp618048348-17814) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[3 (1562984375926128640)]} 0 0
   [junit4]   2> 1516671 INFO  (qtp511679363-17798) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[4 (1562984375927177216)]} 0 0
   [junit4]   2> 1516698 INFO  (qtp618048348-17815) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[4 (1562984375955488768)]} 0 0
   [junit4]   2> 1516699 INFO  (qtp511679363-17799) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[5 (1562984375956537344)]} 0 0
   [junit4]   2> 1516700 INFO  (qtp618048348-17816) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[5 (1562984375957585920)]} 0 0
   [junit4]   2> 1516700 INFO  (qtp511679363-17792) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[6 (1562984375958634496)]} 0 0
   [junit4]   2> 1516701 INFO  (qtp618048348-17809) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[6 (1562984375959683072)]} 0 0
   [junit4]   2> 1516702 INFO  (qtp511679363-17794) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[7 (1562984375959683072)]} 0 0
   [junit4]   2> 1516702 INFO  (qtp618048348-17811) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[7 (1562984375960731648)]} 0 0
   [junit4]   2> 1516703 INFO  (qtp511679363-17795) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[8 (1562984375961780224)]} 0 0
   [junit4]   2> 1516704 INFO  (qtp618048348-17812) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[8 (1562984375962828800)]} 0 0
   [junit4]   2> 1516705 INFO  (qtp511679363-17796) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[9 (1562984375963877376)]} 0 0
   [junit4]   2> 1516705 INFO  (qtp618048348-17813) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[9 (1562984375963877376)]} 0 0
   [junit4]   2> 1516706 INFO  (qtp511679363-17797) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1516706 INFO  (qtp511679363-17797) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@1415841 commitCommandVersion:0
   [junit4]   2> 1516737 INFO  (qtp511679363-17797) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@51ba425f[collection1] main]
   [junit4]   2> 1516737 INFO  (qtp511679363-17797) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1516739 INFO  
(searcherExecutor-6507-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@51ba425f[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C9)))}
   [junit4]   2> 1516739 INFO  (qtp511679363-17797) [    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 32
   [junit4]   2> 1516740 INFO  (qtp618048348-17814) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1516740 INFO  (qtp618048348-17814) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@5a228752 commitCommandVersion:0
   [junit4]   2> 1516750 INFO  (qtp618048348-17814) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@3214ddc[collection1] main]
   [junit4]   2> 1516751 INFO  (qtp618048348-17814) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1516752 INFO  
(searcherExecutor-6518-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@3214ddc[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C9)))}
   [junit4]   2> 1516752 INFO  (qtp618048348-17814) [    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 12
   [junit4]   2> 1516790 INFO  (qtp511679363-17798) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[10 (1562984376051957760)]} 0 1
   [junit4]   2> 1516797 INFO  (qtp618048348-17815) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[10 (1562984376054054912)]} 0 6
   [junit4]   2> 1516864 INFO  (qtp511679363-17799) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[11 (1562984376129552384)]} 0 0
   [junit4]   2> 1516864 INFO  (qtp618048348-17816) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[11 (1562984376130600960)]} 0 0
   [junit4]   2> 1516865 INFO  (qtp511679363-17792) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[12 (1562984376131649536)]} 0 0
   [junit4]   2> 1516866 INFO  (qtp618048348-17809) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[12 (1562984376132698112)]} 0 0
   [junit4]   2> 1516868 INFO  (qtp511679363-17794) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[13 (1562984376133746688)]} 0 0
   [junit4]   2> 1516868 INFO  (qtp618048348-17811) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[13 (1562984376134795264)]} 0 0
   [junit4]   2> 1516869 INFO  (qtp511679363-17795) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[1001 (1562984376135843840)]} 0 0
   [junit4]   2> 1516870 INFO  (qtp618048348-17812) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[1001 (1562984376136892416)]} 0 0
   [junit4]   2> 1516871 INFO  (qtp511679363-17796) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[14 (1562984376137940992)]} 0 0
   [junit4]   2> 1516871 INFO  (qtp618048348-17813) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[14 (1562984376137940992)]} 0 0
   [junit4]   2> 1516872 INFO  (qtp511679363-17797) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[15 (1562984376138989568)]} 0 0
   [junit4]   2> 1516873 INFO  (qtp618048348-17814) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[15 (1562984376140038144)]} 0 0
   [junit4]   2> 1516873 INFO  (qtp511679363-17798) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[16 (1562984376140038144)]} 0 0
   [junit4]   2> 1516874 INFO  (qtp618048348-17814) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[16 (1562984376141086720)]} 0 0
   [junit4]   2> 1516875 INFO  (qtp511679363-17799) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[17 (1562984376141086720)]} 0 0
   [junit4]   2> 1516876 INFO  (qtp618048348-17816) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[17 (1562984376143183872)]} 0 0
   [junit4]   2> 1516877 INFO  (qtp511679363-17792) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[100 (1562984376144232448)]} 0 0
   [junit4]   2> 1516878 INFO  (qtp618048348-17809) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[100 (1562984376145281024)]} 0 0
   [junit4]   2> 1516879 INFO  (qtp511679363-17794) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[101 (1562984376146329600)]} 0 0
   [junit4]   2> 1516883 INFO  (qtp618048348-17811) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[101 (1562984376150523904)]} 0 0
   [junit4]   2> 1516886 INFO  (qtp511679363-17795) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[102 (1562984376153669632)]} 0 0
   [junit4]   2> 1516888 INFO  (qtp618048348-17812) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[102 (1562984376155766784)]} 0 0
   [junit4]   2> 1516891 INFO  (qtp511679363-17795) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[103 (1562984376157863936)]} 0 0
   [junit4]   2> 1516891 INFO  (qtp618048348-17813) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[103 (1562984376158912512)]} 0 0
   [junit4]   2> 1516892 INFO  (qtp511679363-17797) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[104 (1562984376159961088)]} 0 0
   [junit4]   2> 1516893 INFO  (qtp618048348-17813) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[104 (1562984376159961088)]} 0 0
   [junit4]   2> 1516893 INFO  (qtp511679363-17797) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[105 (1562984376161009664)]} 0 0
   [junit4]   2> 1516894 INFO  (qtp618048348-17813) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[105 (1562984376162058240)]} 0 0
   [junit4]   2> 1516894 INFO  (qtp511679363-17797) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[106 (1562984376162058240)]} 0 0
   [junit4]   2> 1516895 INFO  (qtp618048348-17813) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[106 (1562984376163106816)]} 0 0
   [junit4]   2> 1516895 INFO  (qtp511679363-17797) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[107 (1562984376163106816)]} 0 0
   [junit4]   2> 1516896 INFO  (qtp618048348-17813) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[107 (1562984376164155392)]} 0 0
   [junit4]   2> 1516896 INFO  (qtp511679363-17797) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[108 (1562984376164155392)]} 0 0
   [junit4]   2> 1516897 INFO  (qtp618048348-17813) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[108 (1562984376165203968)]} 0 0
   [junit4]   2> 1516897 INFO  (qtp511679363-17792) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[109 (1562984376165203968)]} 0 0
   [junit4]   2> 1516898 INFO  (qtp618048348-17811) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[109 (1562984376166252544)]} 0 0
   [junit4]   2> 1516899 INFO  (qtp511679363-17794) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[110 (1562984376166252544)]} 0 0
   [junit4]   2> 1516899 INFO  (qtp618048348-17812) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[110 (1562984376167301120)]} 0 0
   [junit4]   2> 1516901 INFO  (qtp511679363-17796) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[111 (1562984376169398272)]} 0 0
   [junit4]   2> 1516902 INFO  (qtp618048348-17815) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[111 (1562984376170446848)]} 0 0
   [junit4]   2> 1516903 INFO  (qtp511679363-17795) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[112 (1562984376171495424)]} 0 0
   [junit4]   2> 1516906 INFO  (qtp618048348-17814) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[112 (1562984376174641152)]} 0 0
   [junit4]   2> 1516907 INFO  (qtp511679363-17795) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[113 (1562984376175689728)]} 0 0
   [junit4]   2> 1516908 INFO  (qtp618048348-17816) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[113 (1562984376175689728)]} 0 0
   [junit4]   2> 1516909 INFO  (qtp511679363-17799) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[114 (1562984376176738304)]} 0 0
   [junit4]   2> 1516909 INFO  (qtp618048348-17816) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[114 (1562984376177786880)]} 0 0
   [junit4]   2> 1516910 INFO  (qtp511679363-17797) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[115 (1562984376178835456)]} 0 0
   [junit4]   2> 1516910 INFO  (qtp618048348-17816) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[115 (1562984376178835456)]} 0 0
   [junit4]   2> 1516911 INFO  (qtp511679363-17792) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[116 (1562984376179884032)]} 0 0
   [junit4]   2> 1516911 INFO  (qtp618048348-17811) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[116 (1562984376179884032)]} 0 0
   [junit4]   2> 1516912 INFO  (qtp511679363-17794) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[117 (1562984376180932608)]} 0 0
   [junit4]   2> 1516913 INFO  (qtp618048348-17812) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[117 (1562984376180932608)]} 0 0
   [junit4]   2> 1516913 INFO  (qtp511679363-17796) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[118 (1562984376181981184)]} 0 0
   [junit4]   2> 1516914 INFO  (qtp618048348-17815) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[118 (1562984376181981184)]} 0 0
   [junit4]   2> 1516914 INFO  (qtp511679363-17798) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[119 (1562984376183029760)]} 0 0
   [junit4]   2> 1516915 INFO  (qtp618048348-17814) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[119 (1562984376184078336)]} 0 0
   [junit4]   2> 1516915 INFO  (qtp511679363-17798) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[120 (1562984376184078336)]} 0 0
   [junit4]   2> 1516916 INFO  (qtp618048348-17809) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[120 (1562984376185126912)]} 0 0
   [junit4]   2> 1516917 INFO  (qtp511679363-17799) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[121 (1562984376186175488)]} 0 0
   [junit4]   2> 1516917 INFO  (qtp618048348-17813) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[121 (1562984376186175488)]} 0 0
   [junit4]   2> 1516918 INFO  (qtp511679363-17797) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[122 (1562984376187224064)]} 0 0
   [junit4]   2> 1516919 INFO  (qtp618048348-17816) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[122 (1562984376187224064)]} 0 0
   [junit4]   2> 1516919 INFO  (qtp511679363-17792) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[123 (1562984376188272640)]} 0 0
   [junit4]   2> 1516920 INFO  (qtp618048348-17811) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[123 (1562984376189321216)]} 0 0
   [junit4]   2> 1516920 INFO  (qtp511679363-17794) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[124 (1562984376189321216)]} 0 0
   [junit4]   2> 1516921 INFO  (qtp618048348-17812) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[124 (1562984376190369792)]} 0 0
   [junit4]   2> 1516922 INFO  (qtp511679363-17796) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[125 (1562984376190369792)]} 0 0
   [junit4]   2> 1516922 INFO  (qtp618048348-17815) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[125 (1562984376191418368)]} 0 0
   [junit4]   2> 1516923 INFO  (qtp511679363-17795) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[126 (1562984376192466944)]} 0 0
   [junit4]   2> 1516923 INFO  (qtp618048348-17814) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[126 (1562984376192466944)]} 0 0
   [junit4]   2> 1516924 INFO  (qtp511679363-17795) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[127 (1562984376193515520)]} 0 0
   [junit4]   2> 1516925 INFO  (qtp618048348-17809) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[127 (1562984376193515520)]} 0 0
   [junit4]   2> 1516925 INFO  (qtp511679363-17799) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[128 (1562984376194564096)]} 0 0
   [junit4]   2> 1516926 INFO  (qtp618048348-17813) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[128 (1562984376195612672)]} 0 0
   [junit4]   2> 1516926 INFO  (qtp511679363-17797) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[129 (1562984376195612672)]} 0 0
   [junit4]   2> 1516927 INFO  (qtp618048348-17816) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[129 (1562984376196661248)]} 0 0
   [junit4]   2> 1516927 INFO  (qtp511679363-17797) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[130 (1562984376196661248)]} 0 0
   [junit4]   2> 1516928 INFO  (qtp618048348-17811) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[130 (1562984376197709824)]} 0 0
   [junit4]   2> 1516929 INFO  (qtp511679363-17794) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[131 (1562984376197709824)]} 0 0
   [junit4]   2> 1516929 INFO  (qtp618048348-17812) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[131 (1562984376198758400)]} 0 0
   [junit4]   2> 1516930 INFO  (qtp511679363-17796) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[132 (1562984376199806976)]} 0 0
   [junit4]   2> 1516931 INFO  (qtp618048348-17815) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[132 (1562984376199806976)]} 0 0
   [junit4]   2> 1516931 INFO  (qtp511679363-17798) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[133 (1562984376200855552)]} 0 0
   [junit4]   2> 1516932 INFO  (qtp618048348-17814) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[133 (1562984376201904128)]} 0 0
   [junit4]   2> 1516932 INFO  (qtp511679363-17795) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[134 (1562984376201904128)]} 0 0
   [junit4]   2> 1516933 INFO  (qtp618048348-17809) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[134 (1562984376202952704)]} 0 0
   [junit4]   2> 1516933 INFO  (qtp511679363-17795) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[135 (1562984376202952704)]} 0 0
   [junit4]   2> 1516934 INFO  (qtp618048348-17813) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[135 (1562984376204001280)]} 0 0
   [junit4]   2> 1516935 INFO  (qtp511679363-17795) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[136 (1562984376204001280)]} 0 0
   [junit4]   2> 1516935 INFO  (qtp618048348-17813) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[136 (1562984376205049856)]} 0 0
   [junit4]   2> 1516935 INFO  (qtp511679363-17795) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[137 (1562984376205049856)]} 0 0
   [junit4]   2> 1516936 INFO  (qtp618048348-17813) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[137 (1562984376206098432)]} 0 0
   [junit4]   2> 1516936 INFO  (qtp511679363-17795) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[138 (1562984376206098432)]} 0 0
   [junit4]   2> 1516937 INFO  (qtp618048348-17813) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[138 (1562984376207147008)]} 0 0
   [junit4]   2> 1516937 INFO  (qtp511679363-17795) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[139 (1562984376207147008)]} 0 0
   [junit4]   2> 1516938 INFO  (qtp618048348-17813) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[139 (1562984376208195584)]} 0 0
   [junit4]   2> 1516938 INFO  (qtp511679363-17795) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[140 (1562984376208195584)]} 0 0
   [junit4]   2> 1516939 INFO  (qtp618048348-17813) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[140 (1562984376209244160)]} 0 0
   [junit4]   2> 1516939 INFO  (qtp511679363-17795) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[141 (1562984376209244160)]} 0 0
   [junit4]   2> 1516940 INFO  (qtp618048348-17813) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[141 (1562984376209244161)]} 0 0
   [junit4]   2> 1516940 INFO  (qtp511679363-17795) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[142 (1562984376210292736)]} 0 0
   [junit4]   2> 1516940 INFO  (qtp618048348-17813) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[142 (1562984376210292736)]} 0 0
   [junit4]   2> 1516941 INFO  (qtp511679363-17795) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[143 (1562984376211341312)]} 0 0
   [junit4]   2> 1516942 INFO  (qtp618048348-17813) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[143 (1562984376211341312)]} 0 0
   [junit4]   2> 1516943 INFO  (qtp511679363-17794) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[144 (1562984376212389888)]} 0 0
   [junit4]   2> 1516943 INFO  (qtp618048348-17811) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[144 (1562984376213438464)]} 0 0
   [junit4]   2> 1516944 INFO  (qtp511679363-17796) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[145 (1562984376213438464)]} 0 0
   [junit4]   2> 1516944 INFO  (qtp618048348-17811) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[145 (1562984376214487040)]} 0 0
   [junit4]   2> 1516946 INFO  (qtp511679363-17798) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[146 (1562984376216584192)]} 0 0
   [junit4]   2> 1516946 INFO  (qtp618048348-17815) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[146 (1562984376216584192)]} 0 0
   [junit4]   2> 1516947 INFO  (qtp511679363-17799) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[147 (1562984376217632768)]} 0 0
   [junit4]   2> 1516948 INFO  (qtp618048348-17814) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[147 (1562984376217632768)]} 0 0
   [junit4]   2> 1516948 INFO  (qtp511679363-17792) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[148 (1562984376218681344)]} 0 0
   [junit4]   2> 1516949 INFO  (qtp618048348-17809) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[148 (1562984376219729920)]} 0 0
   [junit4]   2> 1516949 INFO  (qtp511679363-17792) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[149 (1562984376219729920)]} 0 0
   [junit4]   2> 1516950 INFO  (qtp618048348-17816) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[149 (1562984376220778496)]} 0 0
   [junit4]   2> 1516950 INFO  (qtp511679363-17792) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1516950 INFO  (qtp511679363-17792) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@1415841 commitCommandVersion:0
   [junit4]   2> 1516958 INFO  (qtp511679363-17792) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@6f258998[collection1] main]
   [junit4]   2> 1516959 INFO  (qtp511679363-17792) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1516960 INFO  
(searcherExecutor-6507-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@6f258998[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C9)
 Uninverting(_1(7.0.0):C59)))}
   [junit4]   2> 1516960 INFO  (qtp511679363-17792) [    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 9
   [junit4]   2> 1516960 INFO  (qtp618048348-17813) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1516960 INFO  (qtp618048348-17813) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@5a228752 commitCommandVersion:0
   [junit4]   2> 1516967 INFO  (qtp618048348-17813) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@3a3e4c12[collection1] main]
   [junit4]   2> 1516968 INFO  (qtp618048348-17813) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1516969 INFO  
(searcherExecutor-6518-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@3a3e4c12[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C9)
 Uninverting(_1(7.0.0):C59)))}
   [junit4]   2> 1516969 INFO  (qtp618048348-17813) [    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 8
   [junit4]   2> 1516970 INFO  (qtp511679363-17794) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching parameter cannot be 
negative
   [junit4]   2> 1516970 INFO  (qtp511679363-17794) [    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> 1516970 INFO  (qtp511679363-17794) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching parameter cannot be 
negative
   [junit4]   2> 1516970 INFO  (qtp511679363-17794) [    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> 1516971 INFO  (qtp511679363-17794) [    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> 1516988 INFO  (qtp618048348-17815) [    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::114]:33332/|[ff01::213]:33332/|http://127.0.0.1:50269//collection1&rows=10&version=2&q=*:*&NOW=1490578056568&isShard=true&wt=javabin}
 hits=68 status=0 QTime=4
   [junit4]   2> 1516990 INFO  (qtp618048348-17814) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1490578056568&ids=122,133,1,12,13,124,137,127,109,142&isShard=true&shard.url=[ff01::114]:33332/|[ff01::213]:33332/|http://127.0.0.1:50269//collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1516994 INFO  (qtp618048348-17812) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=[ff01::114]:33332/|[ff01::213]:33332/|http://127.0.0.1:50269//collection1&sort=n_ti1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=21
   [junit4]   2> 1516995 INFO  (qtp511679363-17794) [    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> 1516996 INFO  (qtp618048348-17816) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_ti1+asc&shard.url=http://127.0.0.1:50269//collection1&rows=10&version=2&q=*:*&NOW=1490578056592&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1516997 INFO  (qtp618048348-17813) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1490578056592&ids=143,111,134,123,15,5,116,7,129,108&isShard=true&shard.url=http://127.0.0.1:50269//collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1517000 INFO  (qtp618048348-17809) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=http://127.0.0.1:50269//collection1&sort=n_ti1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=4
   [junit4]   2> 1517001 INFO  (qtp511679363-17799) [    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> 1517003 INFO  (qtp618048348-17815) [    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:50269//collection1&rows=10&version=2&q=*:*&NOW=1490578056599&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1517004 INFO  (qtp618048348-17814) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1490578056599&ids=133,13,145,104,6,117,129,9,109,140&isShard=true&shard.url=http://127.0.0.1:50269//collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1517007 INFO  (qtp618048348-17811) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=http://127.0.0.1:50269//collection1&sort=n_f1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=4
   [junit4]   2> 1517008 INFO  (qtp511679363-17797) [    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> 1517015 INFO  (qtp618048348-17816) [    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=[ff01::114]:33332/|[ff01::083]:33332/|[ff01::213]:33332/|http://127.0.0.1:50269//collection1&rows=10&version=2&q=*:*&NOW=1490578056605&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1517016 INFO  (qtp618048348-17813) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1490578056605&ids=132,112,101,3,14,4,149,138,107,119&isShard=true&shard.url=[ff01::114]:33332/|[ff01::083]:33332/|[ff01::213]:33332/|http://127.0.0.1:50269//collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1517019 INFO  (qtp618048348-17812) [    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:50269//collection1&sort=n_f1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=10
   [junit4]   2> 1517020 INFO  (qtp511679363-17795) [    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> 1517021 INFO  (qtp618048348-17815) [    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=http://127.0.0.1:50269//collection1|[ff01::213]:33332/&rows=10&version=2&q=*:*&NOW=1490578056616&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1517022 INFO  (qtp618048348-17815) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1490578056616&ids=121,143,101,134,124,15,16,127,8,129&isShard=true&shard.url=http://127.0.0.1:50269//collection1|[ff01::213]:33332/&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1517022 INFO  (qtp618048348-17809) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=http://127.0.0.1:50269//collection1|[ff01::213]:33332/&sort=n_tf1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=2
   [junit4]   2> 1517023 INFO  (qtp511679363-17792) [    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> 1517024 INFO  (qtp618048348-17816) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_tf1+asc&shard.url=http://127.0.0.1:50269//collection1|[ff01::213]:33332/&rows=10&version=2&q=*:*&NOW=1490578056620&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1517026 INFO  (qtp618048348-17816) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1490578056620&ids=133,113,114,125,148,116,117,7,9,141&isShard=true&shard.url=http://127.0.0.1:50269//collection1|[ff01::213]:33332/&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1517027 INFO  (qtp618048348-17811) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=http://127.0.0.1:50269//collection1|[ff01::213]:33332/&sort=n_tf1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=3
   [junit4]   2> 1517028 INFO  (qtp511679363-17796) [    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> 1517029 INFO  (qtp618048348-17814) [    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:50269//collection1&rows=10&version=2&q=*:*&NOW=1490578056625&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1517030 INFO  (qtp618048348-17814) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1490578056625&ids=12,1,13,147,148,116,149,1001,8,120&isShard=true&shard.url=http://127.0.0.1:50269//collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1517031 INFO  (qtp618048348-17816) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=http://127.0.0.1:50269//collection1&sort=n_d1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=2
   [junit4]   2> 1517032 INFO  (qtp511679363-17798) [    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> 1517033 INFO  (qtp618048348-17813) [    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=[ff01::213]:33332/|http://127.0.0.1:50269//collection1|[ff01::083]:33332/&rows=10&version=2&q=*:*&NOW=1490578056628&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1517034 INFO  (qtp618048348-17812) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1490578056628&ids=110,11,102,4,104,126,128,129,9,142&isShard=true&shard.url=[ff01::213]:33332/|http://127.0.0.1:50269//collection1|[ff01::083]:33332/&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1517035 INFO  (qtp618048348-17814) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=[ff01::213]:33332/|http://127.0.0.1:50269//collection1|[ff01::083]:33332/&sort=n_d1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=2
   [junit4]   2> 1517036 INFO  (qtp511679363-17794) [    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> 1517037 INFO  (qtp618048348-17815) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_td1+desc&shard.url=[ff01::083]:33332/|http://127.0.0.1:50269//collection1|[ff01::114]:33332/&rows=10&version=2&q=*:*&NOW=1490578056632&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1517037 INFO  (qtp618048348-17809) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1490578056632&ids=12,100,5,149,138,7,129,109,120,142&isShard=true&shard.url=[ff01::083]:33332/|http://127.0.0.1:50269//collection1|[ff01::114]:33332/&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1517039 INFO  (qtp618048348-17811) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=[ff01::083]:33332/|http://127.0.0.1:50269//collection1|[ff01::114]:33332/&sort=n_td1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=2
   [junit4]   2> 1517039 INFO  (qtp511679363-17799) [    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> 1517040 INFO  (qtp618048348-17813) [    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:50269//collection1&rows=10&version=2&q=*:*&NOW=1490578056636&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1517041 INFO  (qtp618048348-17813) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1490578056636&ids=144,101,112,135,114,105,1001,117,119,10&isShard=true&shard.url=http://127.0.0.1:50269//collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1517042 INFO  (qtp618048348-17816) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=http://127.0.0.1:50269//collection1&sort=n_td1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=2
   [junit4]   2> 1517043 INFO  (qtp511679363-17797) [    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> 1517044 INFO  (qtp618048348-17815) [    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=http://127.0.0.1:50269//collection1|[ff01::114]:33332/|[ff01::083]:33332/|[ff01::213]:33332/&rows=10&version=2&q=*:*&NOW=1490578056640&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1517045 INFO  (qtp618048348-17815) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1490578056640&ids=11,2,147,103,126,5,117,109,141,142&isShard=true&shard.url=http://127.0.0.1:50269//collection1|[ff01::114]:33332/|[ff01::083]:33332/|[ff01::213]:33332/&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1517046 INFO  (qtp618048348-17814) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=http://127.0.0.1:50269//collection1|[ff01::114]:33332/|[ff01::083]:33332/|[ff01::213]:33332/&sort=n_l1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=2
   [junit4]   2> 1517047 INFO  (qtp511679363-17797) [    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> 1517048 INFO  (qtp618048348-17812) [    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::083]:33332/|http://127.0.0.1:50269//collection1&rows=10&version=2&q=*:*&NOW=1490578056643&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1517049 INFO  (qtp618048348-17812) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1490578056643&ids=143,121,3,125,148,127,107,108,9,131&isShard=true&shard.url=[ff01::083]:33332/|http://127.0.0.1:50269//collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1517049 INFO  (qtp618048348-17811) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=[ff01::083]:33332/|http://127.0.0.1:50269//collection1&sort=n_l1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=1
   [junit4]   2> 1517050 INFO  (qtp511679363-17797) [    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> 1517052 INFO  (qtp618048348-17816) [    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:50269//collection1|[ff01::213]:33332/|[ff01::114]:33332/&rows=10&version=2&q=*:*&NOW=1490578056647&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1517052 INFO  (qtp618048348-17816) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1490578056647&ids=121,143,144,122,134,136,148,16,107,120&isShard=true&shard.url=http://127.0.0.1:50269//collection1|[ff01::213]:33332/|[ff01::114]:33332/&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1517073 INFO  (qtp618048348-17812) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=http://127.0.0.1:50269//collection1|[ff01::213]:33332/|[ff01::114]:33332/&sort=n_tl1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=21
   [junit4]   2> 1517074 INFO  (qtp511679363-17797) [    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> 1517076 INFO  (qtp618048348-17815) [    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::083]:33332/|http://127.0.0.1:50269//collection1&rows=10&version=2&q=*:*&NOW=1490578056671&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1517077 INFO  (qtp618048348-17815) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1490578056671&ids=1,145,13,146,124,115,17,116,9,140&isShard=true&shard.url=[ff01::083]:33332/|http://127.0.0.1:50269//collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1517079 INFO  (qtp618048348-17816) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=[ff01::083]:33332/|http://127.0.0.1:50269//collection1&sort=n_tl1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=3
   [junit4]   2> 1517081 INFO  (qtp511679363-17798) [    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> 1517085 INFO  (qtp618048348-17811) [    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:50269//collection1&rows=10&version=2&q=*:*&NOW=1490578056678&isShard=true&wt=javabin}
 hits=68 status=0 QTime=1
   [junit4]   2> 1517087 INFO  (qtp618048348-17813) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1490578056678&ids=11,144,123,134,14,17,9,119,130,142&isShard=true&shard.url=http://127.0.0.1:50269//collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1517093 INFO  (qtp618048348-17815) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=http://127.0.0.1:50269//collection1&sort=n_dt1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=10
   [junit4]   2> 1517098 INFO  (qtp511679363-17794) [    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=2
   [junit4]   2> 1517100 INFO  (qtp618048348-17812) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_dt1+asc&shard.url=http://127.0.0.1:50269//collection1|[ff01::083]:33332/|[ff01::114]:33332/&rows=10&version=2&q=*:*&NOW=1490578056695&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1517101 INFO  (qtp618048348-17816) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1490578056695&ids=101,3,104,126,127,1001,139,140,131,10&isShard=true&shard.url=http://127.0.0.1:50269//collection1|[ff01::083]:33332/|[ff01::114]:33332/&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1517101 INFO  (qtp618048348-17813) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=http://127.0.0.1:50269//collection1|[ff01::083]:33332/|[ff01::114]:33332/&sort=n_dt1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=2
   [junit4]   2> 1517102 INFO  (qtp511679363-17794) [    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> 1517103 INFO  (qtp618048348-17811) [    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::114]:33332/|[ff01::083]:33332/|[ff01::213]:33332/|http://127.0.0.1:50269//collection1&rows=10&version=2&q=*:*&NOW=1490578056699&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1517104 INFO  (qtp618048348-17809) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1490578056699&ids=143,12,100,135,137,16,116,7,140,142&isShard=true&shard.url=[ff01::114]:33332/|[ff01::083]:33332/|[ff01::213]:33332/|http://127.0.0.1:50269//collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1517105 INFO  (qtp618048348-17814) [    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:50269//collection1&sort=n_tdt1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=1
   [junit4]   2> 1517105 INFO  (qtp511679363-17795) [    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> 1517106 INFO  (qtp618048348-17812) [    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:50269//collection1&rows=10&version=2&q=*:*&NOW=1490578056702&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1517107 INFO  (qtp618048348-17816) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1490578056702&ids=144,112,102,147,115,126,139,128,129,120&isShard=true&shard.url=http://127.0.0.1:50269//collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1517108 INFO  (qtp618048348-17815) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=http://127.0.0.1:50269//collection1&sort=n_tdt1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=1
   [junit4]   2> 1517108 INFO  (qtp511679363-17792) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&sort=a_i_p+desc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 1517110 INFO  (qtp618048348-17811) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=a_i_p+desc&shard.url=[ff01::213]:33332/|http://127.0.0.1:50269//collection1|[ff01::114]:33332/|[ff01::083]:33332/&rows=10&version=2&q=*:*&NOW=1490578056705&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1517111 INFO  (qtp618048348-17809) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1490578056705&ids=1,12,2,13,3,5,7,8,9,10&isShard=true&shard.url=[ff01::213]:33332/|http://127.0.0.1:50269//collection1|[ff01::114]:33332/|[ff01::083]:33332/&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1517111 INFO  (qtp618048348-17813) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=[ff01::213]:33332/|http://127.0.0.1:50269//collection1|[ff01::114]:33332/|[ff01::083]:33332/&sort=a_i_p+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=2
   [junit4]   2> 1517114 INFO  (qtp511679363-17796) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&sort={!func}testfunc(add(a_i_p,5))+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=1
   [junit4]   2> 1517115 INFO  (qtp618048348-17812) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort={!func}testfunc(add(a_i_p,5))+desc&shard.url=[ff01::213]:33332/|http://127.0.0.1:50269//collection1|[ff01::083]:33332/|[ff01::114]:33332/&rows=10&version=2&q=*:*&NOW=1490578056711&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1517116 INFO  (qtp618048348-17816) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1490578056711&ids=1,12,2,13,3,5,7,8,9,10&isShard=true&shard.url=[ff01::213]:33332/|http://127.0.0.1:50269//collection1|[ff01::083]:33332/|[ff01::114]:33332/&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1517117 INFO  (qtp618048348-17814) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=[ff01::213]:33332/|http://127.0.0.1:50269//collection1|[ff01::083]:33332/|[ff01::114]:33332/&sort={!func}testfunc(add(a_i_p,5))+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=2
   [junit4]   2> 1517121 INFO  (qtp511679363-17797) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=a_i_p[*+TO+*]&distrib=false&sort=a_i_p+asc&wt=javabin&version=2} 
hits=13 status=0 QTime=3
   [junit4]   2> 1517123 INFO  (qtp618048348-17811) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=a_i_p+asc&shard.url=http://127.0.0.1:50269//collection1|[ff01::114]:33332/&rows=10&version=2&q=a_i_p[*+TO+*]&NOW=1490578056718&isShard=true&wt=javabin}
 hits=13 status=0 QTime=0
   [junit4]   2> 1517128 INFO  (qtp618048348-17811) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=a_i_p[*+TO+*]&distrib=false&shards.purpose=64&NOW=1490578056718&ids=11,12,1,13,2,3,4,6,7,9&isShard=true&shard.url=http://127.0.0.1:50269//collection1|[ff01::114]:33332/&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1517129 INFO  (qtp618048348-17816) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=a_i_p[*+TO+*]&shards=http://127.0.0.1:50269//collection1|[ff01::114]:33332/&sort=a_i_p+asc&wt=javabin&version=2}
 hits=13 status=0 QTime=6
   [junit4]   2> 1517131 INFO  (qtp511679363-17798) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&sort=a_i_p+asc,+id+desc&wt=javabin&version=2} 
hits=68 status=0 QTime=0
   [junit4]   2> 1517136 INFO  (qtp618048348-17813) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=a_i_p+asc,+id+desc&shard.url=http://127.0.0.1:50269//collection1&rows=10&version=2&q=*:*&NOW=1490578056727&isShard=true&wt=javabin}
 hits=68 status=0 QTime=4
   [junit4]   2> 1517139 INFO  (qtp618048348-17812) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&shards.purpose=64&NOW=1490578056727&ids=11,144,145,146,147,4,148,149,6,1001&isShard=true&shard.url=http://127.0.0.1:50269//collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1517140 INFO  (qtp618048348-17809) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=http://127.0.0.1:50269//collection1&sort=a_i_p+asc,+id+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=8
   [junit4]   2> 1517140 INFO  (qtp511679363-17799) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&fl=*,score&sort=a_i_p+desc&wt=javabin&version=2} 
hits=68 status=0 QTime=0
   [junit4]   2> 1517142 INFO  (qtp618048348-17814) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={distrib=false&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&sort=a_i_p+desc&shard.url=[ff01::213]:33332/|http://127.0.0.1:50269//collection1&rows=10&version=2&q=*:*&NOW=1490578056737&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1517143 INFO  (qtp618048348-17811) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&distrib=false&fl=*,score&shards.purpose=64&NOW=1490578056737&ids=1,12,2,13,3,5,7,8,9,10&isShard=true&shard.url=[ff01::213]:33332/|http://127.0.0.1:50269//collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1517144 INFO  (qtp618048348-17815) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=[ff01::213]:33332/|http://127.0.0.1:5026

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

e.j.s.ServletContextHandler@5dc7ef93{/,null,UNAVAILABLE}
   [junit4]   2> 1546210 INFO  
(TEST-TestDistributedSearch.test-seed#[9B5979D1DEC85986]) [    ] 
o.e.j.s.AbstractConnector Stopped 
ServerConnector@4b0763cc{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 1546210 INFO  
(TEST-TestDistributedSearch.test-seed#[9B5979D1DEC85986]) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=58586738
   [junit4]   2> 1546210 INFO  
(TEST-TestDistributedSearch.test-seed#[9B5979D1DEC85986]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 1546211 INFO  (coreCloseExecutor-6562-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@18e2f457
   [junit4]   2> 1546215 INFO  (coreCloseExecutor-6562-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=417526871
   [junit4]   2> 1546218 INFO  
(TEST-TestDistributedSearch.test-seed#[9B5979D1DEC85986]) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@43cd0a03{/,null,UNAVAILABLE}
   [junit4]   2> 1546222 INFO  
(TEST-TestDistributedSearch.test-seed#[9B5979D1DEC85986]) [    ] 
o.e.j.s.AbstractConnector Stopped 
ServerConnector@79ae33a7{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 1546222 INFO  
(TEST-TestDistributedSearch.test-seed#[9B5979D1DEC85986]) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=429424115
   [junit4]   2> 1546223 INFO  
(TEST-TestDistributedSearch.test-seed#[9B5979D1DEC85986]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 1546223 INFO  (coreCloseExecutor-6564-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@1c15247b
   [junit4]   2> 1546228 INFO  (coreCloseExecutor-6564-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=471147643
   [junit4]   2> 1546229 INFO  
(TEST-TestDistributedSearch.test-seed#[9B5979D1DEC85986]) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@469a33ea{/,null,UNAVAILABLE}
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=TestDistributedSearch -Dtests.method=test 
-Dtests.seed=9B5979D1DEC85986 -Dtests.slow=true -Dtests.locale=en-PH 
-Dtests.timezone=Mexico/BajaNorte -Dtests.asserts=true 
-Dtests.file.encoding=ISO-8859-1
   [junit4] FAILURE 31.1s J1 | TestDistributedSearch.test <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: Expected to find 
shardAddress in the up shard info: 
{error=org.apache.solr.client.solrj.SolrServerException: 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=3}
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([9B5979D1DEC85986:130D460B7034347E]: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> 1546236 INFO  
(SUITE-TestDistributedSearch-seed#[9B5979D1DEC85986]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_9B5979D1DEC85986-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70), 
sim=RandomSimilarity(queryNorm=false): {}, locale=en-PH, 
timezone=Mexico/BajaNorte
   [junit4]   2> NOTE: SunOS 5.11 amd64/Oracle Corporation 1.8.0_121 
(64-bit)/cpus=3,threads=1,free=103733912,total=536870912
   [junit4]   2> NOTE: All tests run in this JVM: [TestManagedResource, 
AutoCommitTest, TestDownShardTolerantSearch, TestManagedSynonymFilterFactory, 
TestMiniSolrCloudCluster, JsonLoaderTest, CacheHeaderTest, TestPathTrie, 
TestQuerySenderListener, TestSolrCloudWithDelegationTokens, TestRestManager, 
TestSQLHandlerNonCloud, ScriptEngineTest, TestConfigOverlay, NoCacheHeaderTest, 
TestCoreDiscovery, LeaderElectionIntegrationTest, HdfsLockFactoryTest, 
TestBulkSchemaConcurrent, TestSmileRequest, HLLSerializationTest, 
TestNonDefinedSimilarityFactory, TestSolrDeletionPolicy2, 
TlogReplayBufferedWhileIndexingTest, TestConfigReload, 
CoreAdminRequestStatusTest, TestGraphMLResponseWriter, TestValueSourceCache, 
SharedFSAutoReplicaFailoverTest, TestUnifiedSolrHighlighter, 
TestFoldingMultitermQuery, JSONWriterTest, TestClassicSimilarityFactory, 
PreAnalyzedFieldTest, PKIAuthenticationIntegrationTest, TestDynamicLoading, 
IndexSchemaTest, TestPushWriter, DistribCursorPagingTest, 
TestReversedWildcardFilterFactory, TestBlendedInfixSuggestions, 
DistributedIntervalFacetingTest, DistanceFunctionTest, TestManagedSchemaAPI, 
LukeRequestHandlerTest, SolrIndexSplitterTest, DistributedFacetPivotSmallTest, 
DefaultValueUpdateProcessorTest, TestSuggestSpellingConverter, 
CollectionTooManyReplicasTest, HttpSolrCallGetCoreTest, UUIDFieldTest, 
RollingRestartTest, CachingDirectoryFactoryTest, TestStandardQParsers, 
ConfigSetsAPITest, TestAddFieldRealTimeGet, BufferStoreTest, 
TestDeleteCollectionOnDownNodes, TestRandomFaceting, EchoParamsTest, 
TestUseDocValuesAsStored2, TestEmbeddedSolrServerSchemaAPI, AtomicUpdatesTest, 
TestLMDirichletSimilarityFactory, TestIndexingPerformance, 
VMParamsZkACLAndCredentialsProvidersTest, TestRequestForwarding, 
TestFieldCache, CloneFieldUpdateProcessorFactoryTest, 
OverseerModifyCollectionTest, CleanupOldIndexTest, TestJsonFacets, 
WordBreakSolrSpellCheckerTest, SolrShardReporterTest, SuggesterTest, 
DistribJoinFromCollectionTest, CdcrVersionReplicationTest, CheckHdfsIndexTest, 
TestCloudInspectUtil, CreateCollectionCleanupTest, 
DistributedFacetPivotLongTailTest, DebugComponentTest, BasicFunctionalityTest, 
CollectionReloadTest, TestSimpleTrackingShardHandler, TestDistribIDF, 
TestUtils, DeleteNodeTest, ForceLeaderTest, TestBadConfig, DateRangeFieldTest, 
InfoHandlerTest, AnalyticsQueryTest, BadComponentTest, 
BigEndianAscendingWordSerializerTest, V2ApiIntegrationTest, 
ConjunctionSolrSpellCheckerTest, SolrCmdDistributorTest, 
FieldMutatingUpdateProcessorTest, AsyncCallRequestStatusResponseTest, 
BasicZkTest, CdcrUpdateLogTest, TestReplicationHandlerBackup, 
JavabinLoaderTest, QueryResultKeyTest, TestRandomFlRTGCloud, TestExportWriter, 
TestTrie, FullSolrCloudDistribCmdsTest, TestTrieFacet, TestSolrCLIRunExample, 
TestAnalyzedSuggestions, PreAnalyzedUpdateProcessorTest, ConnectionReuseTest, 
ZkSolrClientTest, CoreAdminHandlerTest, TestSubQueryTransformerCrossCore, 
TestAtomicUpdateErrorCases, SignatureUpdateProcessorFactoryTest, TestNRTOpen, 
RankQueryTest, TestSolr4Spatial, TestRecovery, TestClassNameShortening, 
TestShardHandlerFactory, TestCollationFieldDocValues, TestSSLRandomization, 
BlockJoinFacetRandomTest, AliasIntegrationTest, 
IgnoreCommitOptimizeUpdateProcessorFactoryTest, TestQueryUtils, TestJoin, 
TestPointFields, DistributedTermsComponentTest, AddBlockUpdateTest, 
FieldAnalysisRequestHandlerTest, PeerSyncWithIndexFingerprintCachingTest, 
SegmentsInfoRequestHandlerTest, TestWriterPerf, 
TestDistributedStatsComponentCardinality, TestApiFramework, 
TestPKIAuthenticationPlugin, OverriddenZkACLAndCredentialsProvidersTest, 
TestZkChroot, BasicAuthIntegrationTest, SpellCheckComponentTest, 
FileBasedSpellCheckerTest, TestIndexSearcher, 
TestLMJelinekMercerSimilarityFactory, TestSolrConfigHandlerConcurrent, 
DistanceUnitsTest, TestOmitPositions, TestFilteredDocIdSet, CircularListTest, 
TestSearchPerf, TestPHPSerializedResponseWriter, URLClassifyProcessorTest, 
TestFieldResource, SuggestComponentContextFilterQueryTest, 
HdfsBasicDistributedZkTest, TestClusterStateMutator, OnlyLeaderIndexesTest, 
SaslZkACLProviderTest, SolrCloudExampleTest, 
TestSolrQueryParserDefaultOperatorResource, TestTolerantUpdateProcessorCloud, 
TestSolrCloudWithSecureImpersonation, TestNumericTerms64, TestNoOpRegenerator, 
TestSystemIdResolver, BlockCacheTest, ChaosMonkeySafeLeaderTest, 
BasicDistributedZk2Test, SyncSliceTest, OpenCloseCoreStressTest, OverseerTest, 
ClusterStateUpdateTest, ZkCLITest, ShardRoutingCustomTest, 
TestDistributedSearch]
   [junit4] Completed [365/701 (1!)] on J1 in 31.11s, 1 test, 1 failure <<< 
FAILURES!

[...truncated 44310 lines...]


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