Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/20245/
Java: 64bit/jdk1.8.0_141 -XX:-UseCompressedOops -XX:+UseConcMarkSweepGC

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

Error Message:
.responseHeader.status!=warnings (unordered or missing)

Stack Trace:
junit.framework.AssertionFailedError: .responseHeader.status!=warnings 
(unordered or missing)
        at 
__randomizedtesting.SeedInfo.seed([42901BE3AAF5531C:CAC4243904093EE4]:0)
        at junit.framework.Assert.fail(Assert.java:50)
        at 
org.apache.solr.BaseDistributedSearchTestCase.compareSolrResponses(BaseDistributedSearchTestCase.java:913)
        at 
org.apache.solr.BaseDistributedSearchTestCase.compareResponses(BaseDistributedSearchTestCase.java:932)
        at 
org.apache.solr.BaseDistributedSearchTestCase.query(BaseDistributedSearchTestCase.java:607)
        at 
org.apache.solr.BaseDistributedSearchTestCase.query(BaseDistributedSearchTestCase.java:587)
        at 
org.apache.solr.BaseDistributedSearchTestCase.query(BaseDistributedSearchTestCase.java:566)
        at 
org.apache.solr.TestDistributedSearch.test(TestDistributedSearch.java:241)
        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:748)




Build Log:
[...truncated 11920 lines...]
   [junit4] Suite: org.apache.solr.TestDistributedSearch
   [junit4]   2> 1026161 INFO  
(SUITE-TestDistributedSearch-seed#[42901BE3AAF5531C]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> Creating dataDir: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_42901BE3AAF5531C-001/init-core-data-001
   [junit4]   2> 1026161 WARN  
(SUITE-TestDistributedSearch-seed#[42901BE3AAF5531C]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=2 numCloses=2
   [junit4]   2> 1026161 INFO  
(SUITE-TestDistributedSearch-seed#[42901BE3AAF5531C]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 1026162 INFO  
(SUITE-TestDistributedSearch-seed#[42901BE3AAF5531C]-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> 1026163 INFO  
(SUITE-TestDistributedSearch-seed#[42901BE3AAF5531C]-worker) [    ] 
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /aux/d
   [junit4]   2> 1026221 INFO  
(TEST-TestDistributedSearch.test-seed#[42901BE3AAF5531C]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_42901BE3AAF5531C-001/tempDir-001/control/cores/collection1
   [junit4]   2> 1026222 INFO  
(TEST-TestDistributedSearch.test-seed#[42901BE3AAF5531C]) [    ] o.e.j.s.Server 
jetty-9.3.14.v20161028
   [junit4]   2> 1026223 INFO  
(TEST-TestDistributedSearch.test-seed#[42901BE3AAF5531C]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@2fbdb025{/aux/d,null,AVAILABLE}
   [junit4]   2> 1026223 INFO  
(TEST-TestDistributedSearch.test-seed#[42901BE3AAF5531C]) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@42f9d3ac{HTTP/1.1,[http/1.1]}{127.0.0.1:33805}
   [junit4]   2> 1026223 INFO  
(TEST-TestDistributedSearch.test-seed#[42901BE3AAF5531C]) [    ] o.e.j.s.Server 
Started @1027721ms
   [junit4]   2> 1026223 INFO  
(TEST-TestDistributedSearch.test-seed#[42901BE3AAF5531C]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/aux/d, 
hostPort=33805, 
coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_42901BE3AAF5531C-001/tempDir-001/control/cores}
   [junit4]   2> 1026223 ERROR 
(TEST-TestDistributedSearch.test-seed#[42901BE3AAF5531C]) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1026223 INFO  
(TEST-TestDistributedSearch.test-seed#[42901BE3AAF5531C]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
8.0.0
   [junit4]   2> 1026223 INFO  
(TEST-TestDistributedSearch.test-seed#[42901BE3AAF5531C]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 1026223 INFO  
(TEST-TestDistributedSearch.test-seed#[42901BE3AAF5531C]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null, Default config 
dir: null
   [junit4]   2> 1026223 INFO  
(TEST-TestDistributedSearch.test-seed#[42901BE3AAF5531C]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-08-02T12:07:08.395Z
   [junit4]   2> 1026224 INFO  
(TEST-TestDistributedSearch.test-seed#[42901BE3AAF5531C]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_42901BE3AAF5531C-001/tempDir-001/control/solr.xml
   [junit4]   2> 1026226 INFO  
(TEST-TestDistributedSearch.test-seed#[42901BE3AAF5531C]) [    ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@784e2bff, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 1026244 INFO  
(TEST-TestDistributedSearch.test-seed#[42901BE3AAF5531C]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@784e2bff
   [junit4]   2> 1026246 INFO  
(TEST-TestDistributedSearch.test-seed#[42901BE3AAF5531C]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@784e2bff
   [junit4]   2> 1026246 INFO  
(TEST-TestDistributedSearch.test-seed#[42901BE3AAF5531C]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@784e2bff
   [junit4]   2> 1026247 INFO  
(TEST-TestDistributedSearch.test-seed#[42901BE3AAF5531C]) [    ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_42901BE3AAF5531C-001/tempDir-001/control/cores
   [junit4]   2> 1026247 INFO  
(TEST-TestDistributedSearch.test-seed#[42901BE3AAF5531C]) [    ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 1026248 INFO  (coreLoadExecutor-4928-thread-1) [    
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, 
from paths: 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib,
 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1026261 INFO  (coreLoadExecutor-4928-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 1026273 INFO  (coreLoadExecutor-4928-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1026333 INFO  (coreLoadExecutor-4928-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1026336 INFO  (coreLoadExecutor-4928-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from configset 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1,
 trusted=true
   [junit4]   2> 1026337 INFO  (coreLoadExecutor-4928-thread-1) [    
x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@784e2bff
   [junit4]   2> 1026337 INFO  (coreLoadExecutor-4928-thread-1) [    
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 1026337 INFO  (coreLoadExecutor-4928-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_42901BE3AAF5531C-001/tempDir-001/control/cores/collection1/data/]
   [junit4]   2> 1026337 INFO  (coreLoadExecutor-4928-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=17, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=1.0]
   [junit4]   2> 1026359 INFO  (coreLoadExecutor-4928-thread-1) [    
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1026359 INFO  (coreLoadExecutor-4928-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 1026360 INFO  (coreLoadExecutor-4928-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1026360 INFO  (coreLoadExecutor-4928-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1026360 INFO  (coreLoadExecutor-4928-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=21, maxMergeAtOnceExplicit=28, maxMergedSegmentMB=18.7939453125, 
floorSegmentMB=2.1142578125, forceMergeDeletesPctAllowed=4.359767474186496, 
segmentsPerTier=6.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.35883407828469893
   [junit4]   2> 1026361 INFO  (coreLoadExecutor-4928-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@72e4eae7[collection1] main]
   [junit4]   2> 1026361 INFO  (coreLoadExecutor-4928-thread-1) [    
x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1026373 INFO  (coreLoadExecutor-4928-thread-1) [    
x:collection1] o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 1026423 INFO  (coreLoadExecutor-4928-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1026423 INFO  
(searcherExecutor-4929-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1026423 INFO  (coreLoadExecutor-4928-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1574621023929630720
   [junit4]   2> 1026423 INFO  
(searcherExecutor-4929-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1026423 INFO  
(searcherExecutor-4929-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1026423 INFO  
(searcherExecutor-4929-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 1026423 INFO  
(searcherExecutor-4929-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1026424 INFO  
(searcherExecutor-4929-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1026424 INFO  
(searcherExecutor-4929-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1026424 INFO  
(searcherExecutor-4929-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 1026424 INFO  
(searcherExecutor-4929-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 1026425 INFO  
(searcherExecutor-4929-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@72e4eae7[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1026810 INFO  
(TEST-TestDistributedSearch.test-seed#[42901BE3AAF5531C]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_42901BE3AAF5531C-001/tempDir-001/shard0/cores/collection1
   [junit4]   2> 1026811 INFO  
(TEST-TestDistributedSearch.test-seed#[42901BE3AAF5531C]) [    ] o.e.j.s.Server 
jetty-9.3.14.v20161028
   [junit4]   2> 1026812 INFO  
(TEST-TestDistributedSearch.test-seed#[42901BE3AAF5531C]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@5b99ef59{/aux/d,null,AVAILABLE}
   [junit4]   2> 1026812 INFO  
(TEST-TestDistributedSearch.test-seed#[42901BE3AAF5531C]) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@46bef82d{HTTP/1.1,[http/1.1]}{127.0.0.1:40695}
   [junit4]   2> 1026812 INFO  
(TEST-TestDistributedSearch.test-seed#[42901BE3AAF5531C]) [    ] o.e.j.s.Server 
Started @1028311ms
   [junit4]   2> 1026812 INFO  
(TEST-TestDistributedSearch.test-seed#[42901BE3AAF5531C]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/aux/d, 
hostPort=40695, 
coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_42901BE3AAF5531C-001/tempDir-001/shard0/cores}
   [junit4]   2> 1026812 ERROR 
(TEST-TestDistributedSearch.test-seed#[42901BE3AAF5531C]) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1026812 INFO  
(TEST-TestDistributedSearch.test-seed#[42901BE3AAF5531C]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
8.0.0
   [junit4]   2> 1026812 INFO  
(TEST-TestDistributedSearch.test-seed#[42901BE3AAF5531C]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 1026812 INFO  
(TEST-TestDistributedSearch.test-seed#[42901BE3AAF5531C]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null, Default config 
dir: null
   [junit4]   2> 1026812 INFO  
(TEST-TestDistributedSearch.test-seed#[42901BE3AAF5531C]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-08-02T12:07:08.984Z
   [junit4]   2> 1026813 INFO  
(TEST-TestDistributedSearch.test-seed#[42901BE3AAF5531C]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_42901BE3AAF5531C-001/tempDir-001/shard0/solr.xml
   [junit4]   2> 1026815 INFO  
(TEST-TestDistributedSearch.test-seed#[42901BE3AAF5531C]) [    ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@784e2bff, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 1026829 INFO  
(TEST-TestDistributedSearch.test-seed#[42901BE3AAF5531C]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@784e2bff
   [junit4]   2> 1026832 INFO  
(TEST-TestDistributedSearch.test-seed#[42901BE3AAF5531C]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@784e2bff
   [junit4]   2> 1026832 INFO  
(TEST-TestDistributedSearch.test-seed#[42901BE3AAF5531C]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@784e2bff
   [junit4]   2> 1026833 INFO  
(TEST-TestDistributedSearch.test-seed#[42901BE3AAF5531C]) [    ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_42901BE3AAF5531C-001/tempDir-001/shard0/cores
   [junit4]   2> 1026833 INFO  
(TEST-TestDistributedSearch.test-seed#[42901BE3AAF5531C]) [    ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 1026833 INFO  (coreLoadExecutor-4939-thread-1) [    
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, 
from paths: 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib,
 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1026853 INFO  (coreLoadExecutor-4939-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 1026864 INFO  (coreLoadExecutor-4939-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1026916 INFO  (coreLoadExecutor-4939-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1026919 INFO  (coreLoadExecutor-4939-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from configset 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1,
 trusted=true
   [junit4]   2> 1026920 INFO  (coreLoadExecutor-4939-thread-1) [    
x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@784e2bff
   [junit4]   2> 1026920 INFO  (coreLoadExecutor-4939-thread-1) [    
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 1026920 INFO  (coreLoadExecutor-4939-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_42901BE3AAF5531C-001/tempDir-001/shard0/cores/collection1/data/]
   [junit4]   2> 1026921 INFO  (coreLoadExecutor-4939-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=17, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=1.0]
   [junit4]   2> 1026945 INFO  (coreLoadExecutor-4939-thread-1) [    
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1026945 INFO  (coreLoadExecutor-4939-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 1026945 INFO  (coreLoadExecutor-4939-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1026945 INFO  (coreLoadExecutor-4939-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1026946 INFO  (coreLoadExecutor-4939-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=21, maxMergeAtOnceExplicit=28, maxMergedSegmentMB=18.7939453125, 
floorSegmentMB=2.1142578125, forceMergeDeletesPctAllowed=4.359767474186496, 
segmentsPerTier=6.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.35883407828469893
   [junit4]   2> 1026946 INFO  (coreLoadExecutor-4939-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@36a74cb1[collection1] main]
   [junit4]   2> 1026946 INFO  (coreLoadExecutor-4939-thread-1) [    
x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1026958 INFO  (coreLoadExecutor-4939-thread-1) [    
x:collection1] o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 1027008 INFO  (coreLoadExecutor-4939-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1027008 INFO  
(searcherExecutor-4940-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1027008 INFO  (coreLoadExecutor-4939-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1574621024543047680
   [junit4]   2> 1027008 INFO  
(searcherExecutor-4940-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1027008 INFO  
(searcherExecutor-4940-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1027008 INFO  
(searcherExecutor-4940-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 1027008 INFO  
(searcherExecutor-4940-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1027008 INFO  
(searcherExecutor-4940-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1027009 INFO  
(searcherExecutor-4940-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1027009 INFO  
(searcherExecutor-4940-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 1027009 INFO  
(searcherExecutor-4940-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 1027010 INFO  
(searcherExecutor-4940-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@36a74cb1[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1027350 INFO  
(TEST-TestDistributedSearch.test-seed#[42901BE3AAF5531C]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting test
   [junit4]   2> 1027353 INFO  (qtp1423106060-17440) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{deleteByQuery=*:* (-1574621024902709248)} 0 1
   [junit4]   2> 1027355 INFO  (qtp2088426305-17457) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{deleteByQuery=*:* (-1574621024905854976)} 0 1
   [junit4]   2> 1027357 INFO  (qtp1423106060-17441) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[1 (1574621024907952128)]} 0 1
   [junit4]   2> 1027359 INFO  (qtp2088426305-17458) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[1 (1574621024910049280)]} 0 0
   [junit4]   2> 1027359 INFO  (qtp1423106060-17442) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[2 (1574621024911097856)]} 0 0
   [junit4]   2> 1027360 INFO  (qtp2088426305-17459) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[2 (1574621024912146432)]} 0 0
   [junit4]   2> 1027361 INFO  (qtp1423106060-17435) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[3 (1574621024913195008)]} 0 0
   [junit4]   2> 1027362 INFO  (qtp2088426305-17452) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[3 (1574621024913195008)]} 0 0
   [junit4]   2> 1027363 INFO  (qtp1423106060-17440) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[4 (1574621024914243584)]} 0 0
   [junit4]   2> 1027363 INFO  (qtp2088426305-17457) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[4 (1574621024915292160)]} 0 0
   [junit4]   2> 1027364 INFO  (qtp1423106060-17441) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[5 (1574621024916340736)]} 0 0
   [junit4]   2> 1027365 INFO  (qtp2088426305-17458) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[5 (1574621024916340736)]} 0 0
   [junit4]   2> 1027365 INFO  (qtp1423106060-17442) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[6 (1574621024917389312)]} 0 0
   [junit4]   2> 1027366 INFO  (qtp2088426305-17459) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[6 (1574621024918437888)]} 0 0
   [junit4]   2> 1027367 INFO  (qtp1423106060-17435) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[7 (1574621024919486464)]} 0 0
   [junit4]   2> 1027367 INFO  (qtp2088426305-17452) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[7 (1574621024919486464)]} 0 0
   [junit4]   2> 1027368 INFO  (qtp1423106060-17440) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[8 (1574621024920535040)]} 0 0
   [junit4]   2> 1027369 INFO  (qtp2088426305-17457) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[8 (1574621024921583616)]} 0 0
   [junit4]   2> 1027370 INFO  (qtp1423106060-17441) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[9 (1574621024921583616)]} 0 0
   [junit4]   2> 1027370 INFO  (qtp2088426305-17458) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[9 (1574621024922632192)]} 0 0
   [junit4]   2> 1027371 INFO  (qtp1423106060-17442) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1574621024923680768,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1027371 INFO  (qtp1423106060-17442) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@626667f8 
commitCommandVersion:1574621024923680768
   [junit4]   2> 1027385 INFO  (qtp1423106060-17442) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@5cb82f4e[collection1] main]
   [junit4]   2> 1027385 INFO  (qtp1423106060-17442) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1027387 INFO  
(searcherExecutor-4929-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@5cb82f4e[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):c9)))}
   [junit4]   2> 1027387 INFO  (qtp1423106060-17442) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 16
   [junit4]   2> 1027388 INFO  (qtp2088426305-17459) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1574621024941506560,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1027388 INFO  (qtp2088426305-17459) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@4ffca9bf 
commitCommandVersion:1574621024941506560
   [junit4]   2> 1027395 INFO  (qtp2088426305-17459) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@2cac5b6c[collection1] main]
   [junit4]   2> 1027396 INFO  (qtp2088426305-17459) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1027398 INFO  
(searcherExecutor-4940-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@2cac5b6c[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):c9)))}
   [junit4]   2> 1027398 INFO  (qtp2088426305-17459) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 10
   [junit4]   2> 1027401 INFO  (qtp1423106060-17435) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[10 (1574621024953040896)]} 0 2
   [junit4]   2> 1027403 INFO  (qtp2088426305-17452) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[10 (1574621024955138048)]} 0 2
   [junit4]   2> 1027404 INFO  (qtp1423106060-17440) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[11 (1574621024958283776)]} 0 0
   [junit4]   2> 1027405 INFO  (qtp2088426305-17457) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[11 (1574621024959332352)]} 0 0
   [junit4]   2> 1027406 INFO  (qtp1423106060-17441) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[12 (1574621024960380928)]} 0 0
   [junit4]   2> 1027406 INFO  (qtp2088426305-17458) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[12 (1574621024960380928)]} 0 0
   [junit4]   2> 1027407 INFO  (qtp1423106060-17442) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[13 (1574621024961429504)]} 0 0
   [junit4]   2> 1027408 INFO  (qtp2088426305-17459) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[13 (1574621024962478080)]} 0 0
   [junit4]   2> 1027409 INFO  (qtp1423106060-17435) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[1001 (1574621024962478080)]} 0 0
   [junit4]   2> 1027410 INFO  (qtp2088426305-17452) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[1001 (1574621024963526656)]} 0 0
   [junit4]   2> 1027411 INFO  (qtp1423106060-17440) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[14 (1574621024964575232)]} 0 0
   [junit4]   2> 1027411 INFO  (qtp2088426305-17457) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[14 (1574621024965623808)]} 0 0
   [junit4]   2> 1027412 INFO  (qtp1423106060-17441) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[15 (1574621024966672384)]} 0 0
   [junit4]   2> 1027412 INFO  (qtp2088426305-17458) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[15 (1574621024966672384)]} 0 0
   [junit4]   2> 1027413 INFO  (qtp1423106060-17442) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[16 (1574621024967720960)]} 0 0
   [junit4]   2> 1027414 INFO  (qtp2088426305-17459) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[16 (1574621024968769536)]} 0 0
   [junit4]   2> 1027415 INFO  (qtp1423106060-17435) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[17 (1574621024968769536)]} 0 0
   [junit4]   2> 1027415 INFO  (qtp2088426305-17452) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[17 (1574621024969818112)]} 0 0
   [junit4]   2> 1027416 INFO  (qtp1423106060-17440) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[100 (1574621024970866688)]} 0 0
   [junit4]   2> 1027417 INFO  (qtp2088426305-17457) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[100 (1574621024971915264)]} 0 0
   [junit4]   2> 1027417 INFO  (qtp1423106060-17441) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[101 (1574621024971915264)]} 0 0
   [junit4]   2> 1027418 INFO  (qtp2088426305-17458) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[101 (1574621024972963840)]} 0 0
   [junit4]   2> 1027419 INFO  (qtp1423106060-17442) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[102 (1574621024972963840)]} 0 0
   [junit4]   2> 1027419 INFO  (qtp2088426305-17459) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[102 (1574621024974012416)]} 0 0
   [junit4]   2> 1027420 INFO  (qtp1423106060-17435) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[103 (1574621024975060992)]} 0 0
   [junit4]   2> 1027421 INFO  (qtp2088426305-17452) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[103 (1574621024975060992)]} 0 0
   [junit4]   2> 1027421 INFO  (qtp1423106060-17440) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[104 (1574621024976109568)]} 0 0
   [junit4]   2> 1027422 INFO  (qtp2088426305-17457) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[104 (1574621024977158144)]} 0 0
   [junit4]   2> 1027422 INFO  (qtp1423106060-17441) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[105 (1574621024977158144)]} 0 0
   [junit4]   2> 1027423 INFO  (qtp2088426305-17458) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[105 (1574621024978206720)]} 0 0
   [junit4]   2> 1027424 INFO  (qtp1423106060-17442) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[106 (1574621024979255296)]} 0 0
   [junit4]   2> 1027424 INFO  (qtp2088426305-17459) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[106 (1574621024979255296)]} 0 0
   [junit4]   2> 1027425 INFO  (qtp1423106060-17435) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[107 (1574621024980303872)]} 0 0
   [junit4]   2> 1027426 INFO  (qtp2088426305-17452) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[107 (1574621024980303872)]} 0 0
   [junit4]   2> 1027426 INFO  (qtp1423106060-17440) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[108 (1574621024981352448)]} 0 0
   [junit4]   2> 1027427 INFO  (qtp2088426305-17457) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[108 (1574621024982401024)]} 0 0
   [junit4]   2> 1027428 INFO  (qtp1423106060-17441) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[109 (1574621024982401024)]} 0 0
   [junit4]   2> 1027428 INFO  (qtp2088426305-17458) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[109 (1574621024983449600)]} 0 0
   [junit4]   2> 1027429 INFO  (qtp1423106060-17442) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[110 (1574621024984498176)]} 0 0
   [junit4]   2> 1027429 INFO  (qtp2088426305-17459) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[110 (1574621024984498176)]} 0 0
   [junit4]   2> 1027430 INFO  (qtp1423106060-17435) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[111 (1574621024985546752)]} 0 0
   [junit4]   2> 1027431 INFO  (qtp2088426305-17452) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[111 (1574621024985546752)]} 0 0
   [junit4]   2> 1027431 INFO  (qtp1423106060-17440) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[112 (1574621024986595328)]} 0 0
   [junit4]   2> 1027432 INFO  (qtp2088426305-17457) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[112 (1574621024987643904)]} 0 0
   [junit4]   2> 1027432 INFO  (qtp1423106060-17441) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[113 (1574621024987643904)]} 0 0
   [junit4]   2> 1027433 INFO  (qtp2088426305-17458) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[113 (1574621024988692480)]} 0 0
   [junit4]   2> 1027434 INFO  (qtp1423106060-17442) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[114 (1574621024988692480)]} 0 0
   [junit4]   2> 1027434 INFO  (qtp2088426305-17459) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[114 (1574621024989741056)]} 0 0
   [junit4]   2> 1027434 INFO  (qtp1423106060-17435) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[115 (1574621024989741056)]} 0 0
   [junit4]   2> 1027435 INFO  (qtp2088426305-17452) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[115 (1574621024990789632)]} 0 0
   [junit4]   2> 1027435 INFO  (qtp1423106060-17440) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[116 (1574621024990789632)]} 0 0
   [junit4]   2> 1027436 INFO  (qtp2088426305-17457) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[116 (1574621024991838208)]} 0 0
   [junit4]   2> 1027436 INFO  (qtp1423106060-17441) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[117 (1574621024991838208)]} 0 0
   [junit4]   2> 1027437 INFO  (qtp2088426305-17458) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[117 (1574621024992886784)]} 0 0
   [junit4]   2> 1027437 INFO  (qtp1423106060-17442) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[118 (1574621024992886784)]} 0 0
   [junit4]   2> 1027438 INFO  (qtp2088426305-17459) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[118 (1574621024993935360)]} 0 0
   [junit4]   2> 1027438 INFO  (qtp1423106060-17435) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[119 (1574621024993935360)]} 0 0
   [junit4]   2> 1027438 INFO  (qtp2088426305-17452) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[119 (1574621024993935361)]} 0 0
   [junit4]   2> 1027439 INFO  (qtp1423106060-17440) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[120 (1574621024994983936)]} 0 0
   [junit4]   2> 1027439 INFO  (qtp2088426305-17457) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[120 (1574621024994983936)]} 0 0
   [junit4]   2> 1027440 INFO  (qtp1423106060-17441) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[121 (1574621024996032512)]} 0 0
   [junit4]   2> 1027440 INFO  (qtp2088426305-17458) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[121 (1574621024996032512)]} 0 0
   [junit4]   2> 1027441 INFO  (qtp1423106060-17442) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[122 (1574621024996032513)]} 0 0
   [junit4]   2> 1027441 INFO  (qtp2088426305-17459) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[122 (1574621024997081088)]} 0 0
   [junit4]   2> 1027441 INFO  (qtp1423106060-17435) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[123 (1574621024997081088)]} 0 0
   [junit4]   2> 1027442 INFO  (qtp2088426305-17452) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[123 (1574621024998129664)]} 0 0
   [junit4]   2> 1027442 INFO  (qtp1423106060-17440) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[124 (1574621024998129664)]} 0 0
   [junit4]   2> 1027443 INFO  (qtp2088426305-17457) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[124 (1574621024998129665)]} 0 0
   [junit4]   2> 1027443 INFO  (qtp1423106060-17441) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[125 (1574621024999178240)]} 0 0
   [junit4]   2> 1027443 INFO  (qtp2088426305-17458) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[125 (1574621024999178240)]} 0 0
   [junit4]   2> 1027444 INFO  (qtp1423106060-17442) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[126 (1574621024999178241)]} 0 0
   [junit4]   2> 1027444 INFO  (qtp2088426305-17459) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[126 (1574621025000226816)]} 0 0
   [junit4]   2> 1027444 INFO  (qtp1423106060-17435) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[127 (1574621025000226816)]} 0 0
   [junit4]   2> 1027445 INFO  (qtp2088426305-17452) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[127 (1574621025000226817)]} 0 0
   [junit4]   2> 1027445 INFO  (qtp1423106060-17440) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[128 (1574621025001275392)]} 0 0
   [junit4]   2> 1027445 INFO  (qtp2088426305-17457) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[128 (1574621025001275392)]} 0 0
   [junit4]   2> 1027446 INFO  (qtp1423106060-17441) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[129 (1574621025002323968)]} 0 0
   [junit4]   2> 1027446 INFO  (qtp2088426305-17458) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[129 (1574621025002323968)]} 0 0
   [junit4]   2> 1027446 INFO  (qtp1423106060-17442) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[130 (1574621025002323969)]} 0 0
   [junit4]   2> 1027447 INFO  (qtp2088426305-17459) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[130 (1574621025003372544)]} 0 0
   [junit4]   2> 1027447 INFO  (qtp1423106060-17435) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[131 (1574621025003372544)]} 0 0
   [junit4]   2> 1027448 INFO  (qtp2088426305-17452) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[131 (1574621025003372545)]} 0 0
   [junit4]   2> 1027448 INFO  (qtp1423106060-17440) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[132 (1574621025004421120)]} 0 0
   [junit4]   2> 1027448 INFO  (qtp2088426305-17457) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[132 (1574621025004421120)]} 0 0
   [junit4]   2> 1027448 INFO  (qtp1423106060-17441) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[133 (1574621025004421121)]} 0 0
   [junit4]   2> 1027449 INFO  (qtp2088426305-17458) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[133 (1574621025005469696)]} 0 0
   [junit4]   2> 1027449 INFO  (qtp1423106060-17442) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[134 (1574621025005469696)]} 0 0
   [junit4]   2> 1027449 INFO  (qtp2088426305-17459) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[134 (1574621025005469697)]} 0 0
   [junit4]   2> 1027450 INFO  (qtp1423106060-17435) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[135 (1574621025005469697)]} 0 0
   [junit4]   2> 1027450 INFO  (qtp2088426305-17452) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[135 (1574621025006518272)]} 0 0
   [junit4]   2> 1027450 INFO  (qtp1423106060-17440) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[136 (1574621025006518272)]} 0 0
   [junit4]   2> 1027450 INFO  (qtp2088426305-17457) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[136 (1574621025006518273)]} 0 0
   [junit4]   2> 1027451 INFO  (qtp1423106060-17441) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[137 (1574621025007566848)]} 0 0
   [junit4]   2> 1027451 INFO  (qtp2088426305-17458) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[137 (1574621025007566848)]} 0 0
   [junit4]   2> 1027451 INFO  (qtp1423106060-17442) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[138 (1574621025007566849)]} 0 0
   [junit4]   2> 1027452 INFO  (qtp2088426305-17459) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[138 (1574621025008615424)]} 0 0
   [junit4]   2> 1027452 INFO  (qtp1423106060-17435) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[139 (1574621025008615424)]} 0 0
   [junit4]   2> 1027452 INFO  (qtp2088426305-17452) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[139 (1574621025008615425)]} 0 0
   [junit4]   2> 1027452 INFO  (qtp1423106060-17440) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[140 (1574621025008615425)]} 0 0
   [junit4]   2> 1027453 INFO  (qtp2088426305-17457) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[140 (1574621025009664000)]} 0 0
   [junit4]   2> 1027453 INFO  (qtp1423106060-17441) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[141 (1574621025009664000)]} 0 0
   [junit4]   2> 1027453 INFO  (qtp2088426305-17458) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[141 (1574621025009664001)]} 0 0
   [junit4]   2> 1027453 INFO  (qtp1423106060-17442) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[142 (1574621025009664001)]} 0 0
   [junit4]   2> 1027454 INFO  (qtp2088426305-17459) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[142 (1574621025010712576)]} 0 0
   [junit4]   2> 1027454 INFO  (qtp1423106060-17435) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[143 (1574621025010712576)]} 0 0
   [junit4]   2> 1027454 INFO  (qtp2088426305-17452) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[143 (1574621025010712577)]} 0 0
   [junit4]   2> 1027454 INFO  (qtp1423106060-17440) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[144 (1574621025010712577)]} 0 0
   [junit4]   2> 1027455 INFO  (qtp2088426305-17457) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[144 (1574621025010712578)]} 0 0
   [junit4]   2> 1027455 INFO  (qtp1423106060-17441) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[145 (1574621025011761152)]} 0 0
   [junit4]   2> 1027455 INFO  (qtp2088426305-17458) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[145 (1574621025011761152)]} 0 0
   [junit4]   2> 1027455 INFO  (qtp1423106060-17442) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[146 (1574621025011761153)]} 0 0
   [junit4]   2> 1027455 INFO  (qtp2088426305-17459) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[146 (1574621025011761153)]} 0 0
   [junit4]   2> 1027456 INFO  (qtp1423106060-17435) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[147 (1574621025012809728)]} 0 0
   [junit4]   2> 1027456 INFO  (qtp2088426305-17452) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[147 (1574621025012809728)]} 0 0
   [junit4]   2> 1027456 INFO  (qtp1423106060-17440) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[148 (1574621025012809729)]} 0 0
   [junit4]   2> 1027456 INFO  (qtp2088426305-17457) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[148 (1574621025012809729)]} 0 0
   [junit4]   2> 1027457 INFO  (qtp1423106060-17441) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[149 (1574621025012809730)]} 0 0
   [junit4]   2> 1027457 INFO  (qtp2088426305-17458) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={wt=javabin&version=2}{add=[149 (1574621025013858304)]} 0 0
   [junit4]   2> 1027457 INFO  (qtp1423106060-17442) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1574621025013858304,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1027457 INFO  (qtp1423106060-17442) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@626667f8 
commitCommandVersion:1574621025013858304
   [junit4]   2> 1027461 INFO  (qtp1423106060-17442) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@3cdab6f7[collection1] main]
   [junit4]   2> 1027462 INFO  (qtp1423106060-17442) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1027463 INFO  
(searcherExecutor-4929-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@3cdab6f7[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):c9)
 Uninverting(_1(8.0.0):c59)))}
   [junit4]   2> 1027463 INFO  (qtp1423106060-17442) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 5
   [junit4]   2> 1027463 INFO  (qtp2088426305-17459) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1574621025020149760,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1027463 INFO  (qtp2088426305-17459) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@4ffca9bf 
commitCommandVersion:1574621025020149760
   [junit4]   2> 1027467 INFO  (qtp2088426305-17459) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@298c79d5[collection1] main]
   [junit4]   2> 1027468 INFO  (qtp2088426305-17459) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1027469 INFO  
(searcherExecutor-4940-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@298c79d5[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):c9)
 Uninverting(_1(8.0.0):c59)))}
   [junit4]   2> 1027469 INFO  (qtp2088426305-17459) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/aux/d path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 5
   [junit4]   2> 1027469 INFO  (qtp1423106060-17435) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching parameter cannot be 
negative
   [junit4]   2> 1027469 INFO  (qtp1423106060-17435) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*&distrib=false&start=-1&wt=javabin&version=2} status=400 QTime=0
   [junit4]   2> 1027470 INFO  (qtp1423106060-17440) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching parameter cannot be 
negative
   [junit4]   2> 1027470 INFO  (qtp1423106060-17440) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*&distrib=false&start=0&rows=-1&wt=javabin&version=2} status=400 
QTime=0
   [junit4]   2> 1027471 INFO  (qtp1423106060-17441) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*:*&distrib=false&sort=n_ti1+desc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 1027485 INFO  (qtp2088426305-17458) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_ti1+desc&shard.url=[ff01::213]:33332/aux/d|[ff01::083]:33332/aux/d|http://127.0.0.1:40695/aux/d/collection1|[ff01::114]:33332/aux/d&rows=10&version=2&q=*:*&NOW=1501675629644&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1027487 INFO  (qtp2088426305-17459) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1501675629644&ids=121,11,133,112,135,146,6,1001,107,108&isShard=true&shard.url=[ff01::213]:33332/aux/d|[ff01::083]:33332/aux/d|http://127.0.0.1:40695/aux/d/collection1|[ff01::114]:33332/aux/d&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1027487 INFO  (qtp2088426305-17452) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*:*&shards=[ff01::213]:33332/aux/d|[ff01::083]:33332/aux/d|http://127.0.0.1:40695/aux/d/collection1|[ff01::114]:33332/aux/d&sort=n_ti1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=15
   [junit4]   2> 1027488 INFO  (qtp1423106060-17442) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*:*&distrib=false&sort=n_ti1+asc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 1027496 INFO  (qtp2088426305-17453) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_ti1+asc&shard.url=[ff01::213]:33332/aux/d|[ff01::114]:33332/aux/d|http://127.0.0.1:40695/aux/d/collection1&rows=10&version=2&q=*:*&NOW=1501675629661&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1027497 INFO  (qtp2088426305-17459) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1501675629661&ids=1,3,124,136,114,127,7,106,118,142&isShard=true&shard.url=[ff01::213]:33332/aux/d|[ff01::114]:33332/aux/d|http://127.0.0.1:40695/aux/d/collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1027498 INFO  (qtp2088426305-17457) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*:*&shards=[ff01::213]:33332/aux/d|[ff01::114]:33332/aux/d|http://127.0.0.1:40695/aux/d/collection1&sort=n_ti1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=8
   [junit4]   2> 1027499 INFO  (qtp1423106060-17435) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*:*&distrib=false&sort=n_f1+desc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 1027500 INFO  (qtp2088426305-17452) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_f1+desc&shard.url=http://127.0.0.1:40695/aux/d/collection1|[ff01::114]:33332/aux/d&rows=10&version=2&q=*:*&NOW=1501675629671&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1027501 INFO  (qtp2088426305-17459) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1501675629671&ids=110,1,144,113,135,14,3,4,138,128&isShard=true&shard.url=http://127.0.0.1:40695/aux/d/collection1|[ff01::114]:33332/aux/d&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1027501 INFO  (qtp2088426305-17458) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*:*&shards=http://127.0.0.1:40695/aux/d/collection1|[ff01::114]:33332/aux/d&sort=n_f1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=1
   [junit4]   2> 1027502 INFO  (qtp1423106060-17440) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*:*&distrib=false&sort=n_f1+asc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 1027503 INFO  (qtp2088426305-17457) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_f1+asc&shard.url=http://127.0.0.1:40695/aux/d/collection1&rows=10&version=2&q=*:*&NOW=1501675629675&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1027504 INFO  (qtp2088426305-17459) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1501675629675&ids=11,133,124,136,116,105,118,8,130,141&isShard=true&shard.url=http://127.0.0.1:40695/aux/d/collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1027504 INFO  (qtp2088426305-17453) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*:*&shards=http://127.0.0.1:40695/aux/d/collection1&sort=n_f1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=1
   [junit4]   2> 1027505 INFO  (qtp1423106060-17441) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*:*&distrib=false&sort=n_tf1+desc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 1027506 INFO  (qtp2088426305-17458) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_tf1+desc&shard.url=[ff01::213]:33332/aux/d|http://127.0.0.1:40695/aux/d/collection1|[ff01::114]:33332/aux/d|[ff01::083]:33332/aux/d&rows=10&version=2&q=*:*&NOW=1501675629678&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1027507 INFO  (qtp2088426305-17459) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1501675629678&ids=143,101,14,147,15,5,137,119,140,120&isShard=true&shard.url=[ff01::213]:33332/aux/d|http://127.0.0.1:40695/aux/d/collection1|[ff01::114]:33332/aux/d|[ff01::083]:33332/aux/d&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1027508 INFO  (qtp2088426305-17452) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*:*&shards=[ff01::213]:33332/aux/d|http://127.0.0.1:40695/aux/d/collection1|[ff01::114]:33332/aux/d|[ff01::083]:33332/aux/d&sort=n_tf1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=1
   [junit4]   2> 1027508 INFO  (qtp1423106060-17442) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*:*&distrib=false&sort=n_tf1+asc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 1027509 INFO  (qtp2088426305-17453) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_tf1+asc&shard.url=[ff01::213]:33332/aux/d|http://127.0.0.1:40695/aux/d/collection1&rows=10&version=2&q=*:*&NOW=1501675629681&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1027510 INFO  (qtp2088426305-17459) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1501675629681&ids=3,113,103,136,4,126,116,17,8,10&isShard=true&shard.url=[ff01::213]:33332/aux/d|http://127.0.0.1:40695/aux/d/collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1027510 INFO  (qtp2088426305-17457) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*:*&shards=[ff01::213]:33332/aux/d|http://127.0.0.1:40695/aux/d/collection1&sort=n_tf1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=1
   [junit4]   2> 1027511 INFO  (qtp1423106060-17435) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*:*&distrib=false&sort=n_d1+desc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 1027512 INFO  (qtp2088426305-17452) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_d1+desc&shard.url=[ff01::213]:33332/aux/d|http://127.0.0.1:40695/aux/d/collection1&rows=10&version=2&q=*:*&NOW=1501675629684&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1027513 INFO  (qtp2088426305-17459) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1501675629684&ids=143,11,133,146,14,125,137,105,128,1001&isShard=true&shard.url=[ff01::213]:33332/aux/d|http://127.0.0.1:40695/aux/d/collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1027514 INFO  (qtp2088426305-17458) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*:*&shards=[ff01::213]:33332/aux/d|http://127.0.0.1:40695/aux/d/collection1&sort=n_d1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=1
   [junit4]   2> 1027515 INFO  (qtp1423106060-17440) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*:*&distrib=false&sort=n_d1+asc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 1027516 INFO  (qtp2088426305-17457) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_d1+asc&shard.url=http://127.0.0.1:40695/aux/d/collection1|[ff01::114]:33332/aux/d|[ff01::213]:33332/aux/d&rows=10&version=2&q=*:*&NOW=1501675629687&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1027517 INFO  (qtp2088426305-17459) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1501675629687&ids=110,12,13,145,113,6,7,106,8,129&isShard=true&shard.url=http://127.0.0.1:40695/aux/d/collection1|[ff01::114]:33332/aux/d|[ff01::213]:33332/aux/d&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1027517 INFO  (qtp2088426305-17453) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*:*&shards=http://127.0.0.1:40695/aux/d/collection1|[ff01::114]:33332/aux/d|[ff01::213]:33332/aux/d&sort=n_d1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=1
   [junit4]   2> 1027518 INFO  (qtp1423106060-17441) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*:*&distrib=false&sort=n_td1+desc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 1027519 INFO  (qtp2088426305-17458) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_td1+desc&shard.url=[ff01::114]:33332/aux/d|http://127.0.0.1:40695/aux/d/collection1|[ff01::083]:33332/aux/d|[ff01::213]:33332/aux/d&rows=10&version=2&q=*:*&NOW=1501675629691&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1027520 INFO  (qtp2088426305-17459) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1501675629691&ids=132,122,133,146,104,17,106,107,130,120&isShard=true&shard.url=[ff01::114]:33332/aux/d|http://127.0.0.1:40695/aux/d/collection1|[ff01::083]:33332/aux/d|[ff01::213]:33332/aux/d&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1027521 INFO  (qtp2088426305-17452) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*:*&shards=[ff01::114]:33332/aux/d|http://127.0.0.1:40695/aux/d/collection1|[ff01::083]:33332/aux/d|[ff01::213]:33332/aux/d&sort=n_td1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=2
   [junit4]   2> 1027522 INFO  (qtp1423106060-17442) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*:*&distrib=false&sort=n_td1+asc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 1027523 INFO  (qtp2088426305-17453) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_td1+asc&shard.url=[ff01::213]:33332/aux/d|http://127.0.0.1:40695/aux/d/collection1&rows=10&version=2&q=*:*&NOW=1501675629695&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1027524 INFO  (qtp2088426305-17459) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1501675629695&ids=143,121,12,100,101,3,103,149,140,141&isShard=true&shard.url=[ff01::213]:33332/aux/d|http://127.0.0.1:40695/aux/d/collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1027525 INFO  (qtp2088426305-17457) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*:*&shards=[ff01::213]:33332/aux/d|http://127.0.0.1:40695/aux/d/collection1&sort=n_td1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=2
   [junit4]   2> 1027525 INFO  (qtp1423106060-17435) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*:*&distrib=false&sort=n_l1+desc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 1027526 INFO  (qtp2088426305-17452) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_l1+desc&shard.url=[ff01::083]:33332/aux/d|http://127.0.0.1:40695/aux/d/collection1|[ff01::213]:33332/aux/d&rows=10&version=2&q=*:*&NOW=1501675629698&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1027527 INFO  (qtp2088426305-17459) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1501675629698&ids=135,14,137,126,115,149,128,139,107,120&isShard=true&shard.url=[ff01::083]:33332/aux/d|http://127.0.0.1:40695/aux/d/collection1|[ff01::213]:33332/aux/d&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1027528 INFO  (qtp2088426305-17458) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*:*&shards=[ff01::083]:33332/aux/d|http://127.0.0.1:40695/aux/d/collection1|[ff01::213]:33332/aux/d&sort=n_l1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=2
   [junit4]   2> 1027529 INFO  (qtp1423106060-17440) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*:*&distrib=false&sort=n_l1+asc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 1027530 INFO  (qtp2088426305-17457) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_l1+asc&shard.url=http://127.0.0.1:40695/aux/d/collection1|[ff01::083]:33332/aux/d|[ff01::213]:33332/aux/d&rows=10&version=2&q=*:*&NOW=1501675629701&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1027530 INFO  (qtp2088426305-17459) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1501675629701&ids=122,112,2,103,104,116,6,17,1001,129&isShard=true&shard.url=http://127.0.0.1:40695/aux/d/collection1|[ff01::083]:33332/aux/d|[ff01::213]:33332/aux/d&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1027531 INFO  (qtp2088426305-17453) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*:*&shards=http://127.0.0.1:40695/aux/d/collection1|[ff01::083]:33332/aux/d|[ff01::213]:33332/aux/d&sort=n_l1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=1
   [junit4]   2> 1027532 INFO  (qtp1423106060-17441) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*:*&distrib=false&sort=n_tl1+desc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 1027533 INFO  (qtp2088426305-17458) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_tl1+desc&shard.url=[ff01::213]:33332/aux/d|http://127.0.0.1:40695/aux/d/collection1&rows=10&version=2&q=*:*&NOW=1501675629704&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1027533 INFO  (qtp2088426305-17459) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1501675629704&ids=100,12,145,14,102,114,16,6,118,142&isShard=true&shard.url=[ff01::213]:33332/aux/d|http://127.0.0.1:40695/aux/d/collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1027534 INFO  (qtp2088426305-17452) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*:*&shards=[ff01::213]:33332/aux/d|http://127.0.0.1:40695/aux/d/collection1&sort=n_tl1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=1
   [junit4]   2> 1027534 INFO  (qtp1423106060-17442) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*:*&distrib=false&sort=n_tl1+asc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 1027535 INFO  (qtp2088426305-17453) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_tl1+asc&shard.url=http://127.0.0.1:40695/aux/d/collection1|[ff01::213]:33332/aux/d&rows=10&version=2&q=*:*&NOW=1501675629707&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1027536 INFO  (qtp2088426305-17459) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1501675629707&ids=121,112,3,113,137,116,17,7,9,141&isShard=true&shard.url=http://127.0.0.1:40695/aux/d/collection1|[ff01::213]:33332/aux/d&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1027537 INFO  (qtp2088426305-17457) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*:*&shards=http://127.0.0.1:40695/aux/d/collection1|[ff01::213]:33332/aux/d&sort=n_tl1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=1
   [junit4]   2> 1027537 INFO  (qtp1423106060-17435) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*:*&distrib=false&sort=n_dt1+desc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 1027538 INFO  (qtp2088426305-17452) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_dt1+desc&shard.url=[ff01::213]:33332/aux/d|http://127.0.0.1:40695/aux/d/collection1|[ff01::114]:33332/aux/d|[ff01::083]:33332/aux/d&rows=10&version=2&q=*:*&NOW=1501675629710&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1027539 INFO  (qtp2088426305-17459) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1501675629710&ids=143,132,144,14,15,114,105,138,106,131&isShard=true&shard.url=[ff01::213]:33332/aux/d|http://127.0.0.1:40695/aux/d/collection1|[ff01::114]:33332/aux/d|[ff01::083]:33332/aux/d&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1027539 INFO  (qtp2088426305-17458) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*:*&shards=[ff01::213]:33332/aux/d|http://127.0.0.1:40695/aux/d/collection1|[ff01::114]:33332/aux/d|[ff01::083]:33332/aux/d&sort=n_dt1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=1
   [junit4]   2> 1027540 INFO  (qtp1423106060-17440) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*:*&distrib=false&sort=n_dt1+asc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 1027541 INFO  (qtp2088426305-17457) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_dt1+asc&shard.url=http://127.0.0.1:40695/aux/d/collection1&rows=10&version=2&q=*:*&NOW=1501675629713&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1027542 INFO  (qtp2088426305-17459) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1501675629713&ids=122,100,145,134,2,136,5,116,7,119&isShard=true&shard.url=http://127.0.0.1:40695/aux/d/collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1027542 INFO  (qtp2088426305-17453) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*:*&shards=http://127.0.0.1:40695/aux/d/collection1&sort=n_dt1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=1
   [junit4]   2> 1027543 INFO  (qtp1423106060-17441) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*:*&distrib=false&sort=n_tdt1+desc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 1027544 INFO  (qtp2088426305-17458) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_tdt1+desc&shard.url=[ff01::114]:33332/aux/d|[ff01::083]:33332/aux/d|http://127.0.0.1:40695/aux/d/collection1|[ff01::213]:33332/aux/d&rows=10&version=2&q=*:*&NOW=1501675629715&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1027545 INFO  (qtp2088426305-17459) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1501675629715&ids=11,132,133,1,134,124,116,17,117,108&isShard=true&shard.url=[ff01::114]:33332/aux/d|[ff01::083]:33332/aux/d|http://127.0.0.1:40695/aux/d/collection1|[ff01::213]:33332/aux/d&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1027545 INFO  (qtp2088426305-17452) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*:*&shards=[ff01::114]:33332/aux/d|[ff01::083]:33332/aux/d|http://127.0.0.1:40695/aux/d/collection1|[ff01::213]:33332/aux/d&sort=n_tdt1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=1
   [junit4]   2> 1027546 INFO  (qtp1423106060-17442) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*:*&distrib=false&sort=n_tdt1+asc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 1027547 INFO  (qtp2088426305-17453) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_tdt1+asc&shard.url=http://127.0.0.1:40695/aux/d/collection1|[ff01::083]:33332/aux/d&rows=10&version=2&q=*:*&NOW=1501675629719&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1027547 INFO  (qtp2088426305-17459) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1501675629719&ids=144,145,123,4,136,1001,106,141,130,10&isShard=true&shard.url=http://127.0.0.1:40695/aux/d/collection1|[ff01::083]:33332/aux/d&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1027548 INFO  (qtp2088426305-17457) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*:*&shards=http://127.0.0.1:40695/aux/d/collection1|[ff01::083]:33332/aux/d&sort=n_tdt1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=1
   [junit4]   2> 1027549 INFO  (qtp1423106060-17435) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*:*&distrib=false&sort=a_i_p+desc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 1027550 INFO  (qtp2088426305-17452) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=a_i_p+desc&shard.url=[ff01::114]:33332/aux/d|[ff01::083]:33332/aux/d|http://127.0.0.1:40695/aux/d/collection1&rows=10&version=2&q=*:*&NOW=1501675629721&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1027551 INFO  (qtp2088426305-17459) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1501675629721&ids=1,12,2,13,3,5,7,8,9,10&isShard=true&shard.url=[ff01::114]:33332/aux/d|[ff01::083]:33332/aux/d|http://127.0.0.1:40695/aux/d/collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1027551 INFO  (qtp2088426305-17458) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*:*&shards=[ff01::114]:33332/aux/d|[ff01::083]:33332/aux/d|http://127.0.0.1:40695/aux/d/collection1&sort=a_i_p+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=1
   [junit4]   2> 1027552 INFO  (qtp1423106060-17440) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*:*&distrib=false&sort={!func}testfunc(add(a_i_p,5))+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=0
   [junit4]   2> 1027553 INFO  (qtp2088426305-17457) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={df=text&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/aux/d|http://127.0.0.1:40695/aux/d/collection1&rows=10&version=2&q=*:*&NOW=1501675629725&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1027554 INFO  (qtp2088426305-17459) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1501675629725&ids=1,12,2,13,3,5,7,8,9,10&isShard=true&shard.url=[ff01::213]:33332/aux/d|http://127.0.0.1:40695/aux/d/collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1027554 INFO  (qtp2088426305-17453) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=*:*&shards=[ff01::213]:33332/aux/d|http://127.0.0.1:40695/aux/d/collection1&sort={!func}testfunc(add(a_i_p,5))+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=1
   [junit4]   2> 1027555 INFO  (qtp1423106060-17441) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=a_i_p[*+TO+*]&distrib=false&sort=a_i_p+asc&wt=javabin&version=2} 
hits=13 status=0 QTime=0
   [junit4]   2> 1027557 INFO  (qtp2088426305-17458) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=a_i_p+asc&shard.url=http://127.0.0.1:40695/aux/d/collection1|[ff01::213]:33332/aux/d|[ff01::114]:33332/aux/d|[ff01::083]:33332/aux/d&rows=10&version=2&q=a_i_p[*+TO+*]&NOW=1501675629728&isShard=true&wt=javabin}
 hits=13 status=0 QTime=0
   [junit4]   2> 1027557 INFO  (qtp2088426305-17459) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/aux/d path=/select 
params={q=a_i_p[*+TO+*]&df=text&distrib=false&shards.purpose=64&NOW=1501675629728&ids=11,12,1,13,2

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

tainer Shutting down CoreContainer instance=1623054781
   [junit4]   2> 1027618 INFO  
(TEST-TestDistributedSearch.test-seed#[42901BE3AAF5531C]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 1027620 INFO  
(TEST-TestDistributedSearch.test-seed#[42901BE3AAF5531C]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 1027621 INFO  
(TEST-TestDistributedSearch.test-seed#[42901BE3AAF5531C]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 1027621 INFO  
(TEST-TestDistributedSearch.test-seed#[42901BE3AAF5531C]) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 1027621 INFO  (coreCloseExecutor-4945-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@50576bb5
   [junit4]   2> 1027621 INFO  (coreCloseExecutor-4945-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=1347906485
   [junit4]   2> 1027624 INFO  
(TEST-TestDistributedSearch.test-seed#[42901BE3AAF5531C]) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@2fbdb025{/aux/d,null,UNAVAILABLE}
   [junit4]   2> 1027625 INFO  
(TEST-TestDistributedSearch.test-seed#[42901BE3AAF5531C]) [    ] 
o.e.j.s.AbstractConnector Stopped 
ServerConnector@46bef82d{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 1027625 INFO  
(TEST-TestDistributedSearch.test-seed#[42901BE3AAF5531C]) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1621989391
   [junit4]   2> 1027625 INFO  
(TEST-TestDistributedSearch.test-seed#[42901BE3AAF5531C]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 1027625 INFO  
(TEST-TestDistributedSearch.test-seed#[42901BE3AAF5531C]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 1027625 INFO  
(TEST-TestDistributedSearch.test-seed#[42901BE3AAF5531C]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 1027625 INFO  
(TEST-TestDistributedSearch.test-seed#[42901BE3AAF5531C]) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 1027625 INFO  (coreCloseExecutor-4947-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@51ff816f
   [junit4]   2> 1027626 INFO  (coreCloseExecutor-4947-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=1375699311
   [junit4]   2> 1027626 INFO  
(TEST-TestDistributedSearch.test-seed#[42901BE3AAF5531C]) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@5b99ef59{/aux/d,null,UNAVAILABLE}
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=TestDistributedSearch -Dtests.method=test 
-Dtests.seed=42901BE3AAF5531C -Dtests.multiplier=3 -Dtests.slow=true 
-Dtests.locale=sv -Dtests.timezone=America/Regina -Dtests.asserts=true 
-Dtests.file.encoding=UTF-8
   [junit4] FAILURE 1.47s J1 | TestDistributedSearch.test <<<
   [junit4]    > Throwable #1: junit.framework.AssertionFailedError: 
.responseHeader.status!=warnings (unordered or missing)
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([42901BE3AAF5531C:CAC4243904093EE4]:0)
   [junit4]    >        at junit.framework.Assert.fail(Assert.java:50)
   [junit4]    >        at 
org.apache.solr.BaseDistributedSearchTestCase.compareSolrResponses(BaseDistributedSearchTestCase.java:913)
   [junit4]    >        at 
org.apache.solr.BaseDistributedSearchTestCase.compareResponses(BaseDistributedSearchTestCase.java:932)
   [junit4]    >        at 
org.apache.solr.BaseDistributedSearchTestCase.query(BaseDistributedSearchTestCase.java:607)
   [junit4]    >        at 
org.apache.solr.BaseDistributedSearchTestCase.query(BaseDistributedSearchTestCase.java:587)
   [junit4]    >        at 
org.apache.solr.BaseDistributedSearchTestCase.query(BaseDistributedSearchTestCase.java:566)
   [junit4]    >        at 
org.apache.solr.TestDistributedSearch.test(TestDistributedSearch.java:241)
   [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:748)
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_42901BE3AAF5531C-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): 
{rnd_b=PostingsFormat(name=LuceneVarGapDocFreqInterval), 
a_s=PostingsFormat(name=MockRandom), 
foo_sev_enum=PostingsFormat(name=MockRandom), 
SubjectTerms_mfacet=PostingsFormat(name=LuceneVarGapFixedInterval), 
oddField_s=PostingsFormat(name=LuceneVarGapDocFreqInterval), 
multiDefault=FSTOrd50, lowerfilt1and2=FSTOrd50, a_t=FSTOrd50, 
foo_b=PostingsFormat(name=MockRandom), lowerfilt=FSTOrd50, 
id=PostingsFormat(name=LuceneVarGapDocFreqInterval), 
text=PostingsFormat(name=MockRandom)}, 
docValues:{other_tl1=DocValuesFormat(name=Lucene70), 
range_facet_l_dv=DocValuesFormat(name=Lucene70), 
foo_sev_enum=DocValuesFormat(name=Direct), n_l1=DocValuesFormat(name=Memory), 
a_n_tdt=DocValuesFormat(name=Direct), 
intDefault=DocValuesFormat(name=Lucene70), 
n_dt1=DocValuesFormat(name=Lucene70), n_td1=DocValuesFormat(name=Lucene70), 
b_n_tdt=DocValuesFormat(name=Lucene70), n_d1=DocValuesFormat(name=Memory), 
range_facet_l=DocValuesFormat(name=Memory), 
n_f1=DocValuesFormat(name=Lucene70), n_ti1=DocValuesFormat(name=Lucene70), 
n_tl1=DocValuesFormat(name=Lucene70), _version_=DocValuesFormat(name=Lucene70), 
n_tf1=DocValuesFormat(name=Memory), n_tdt1=DocValuesFormat(name=Lucene70), 
id_i1=DocValuesFormat(name=Lucene70), foo_d=DocValuesFormat(name=Lucene70), 
range_facet_i_dv=DocValuesFormat(name=Memory), 
foo_f=DocValuesFormat(name=Direct), 
intDvoDefault=DocValuesFormat(name=Lucene70), 
timestamp=DocValuesFormat(name=Memory), a_i_p=DocValuesFormat(name=Lucene70)}, 
maxPointsInLeafNode=576, maxMBSortInHeap=5.584296358800282, 
sim=RandomSimilarity(queryNorm=false): {}, locale=sv, timezone=America/Regina
   [junit4]   2> NOTE: Linux 4.10.0-27-generic amd64/Oracle Corporation 
1.8.0_141 (64-bit)/cpus=8,threads=1,free=184301192,total=518979584
   [junit4]   2> NOTE: All tests run in this JVM: 
[ClassificationUpdateProcessorIntegrationTest, BlobRepositoryCloudTest, 
TestHashPartitioner, DisMaxRequestHandlerTest, TestSweetSpotSimilarityFactory, 
TestLegacyFieldReuse, UtilsToolTest, AtomicUpdateProcessorFactoryTest, 
StatsReloadRaceTest, ScriptEngineTest, TestPostingsSolrHighlighter, 
TestFilteredDocIdSet, TestExpandComponent, PrimUtilsTest, HttpPartitionTest, 
TestJavabinTupleStreamParser, TestSolrCoreSnapshots, OpenCloseCoreStressTest, 
TestScoreJoinQPScore, TestXmlQParser, SoftAutoCommitTest, TestFieldCache, 
TestPointFields, TestAuthenticationFramework, 
TestTolerantUpdateProcessorRandomCloud, TestFastLRUCache, 
ClusterStateUpdateTest, TestManagedResource, BooleanFieldTest, BlockCacheTest, 
ReplicaListTransformerTest, DistributedTermsComponentTest, 
LukeRequestHandlerTest, TestSQLHandler, CreateCollectionCleanupTest, 
SpatialRPTFieldTypeTest, AlternateDirectoryTest, TestStressVersions, 
CollectionsAPIDistributedZkTest, DistributedSuggestComponentTest, 
ActionThrottleTest, TestDistributedGrouping, SolrGraphiteReporterTest, 
TestSortByMinMaxFunction, TestReplicationHandlerBackup, TestQueryTypes, 
TestStressLiveNodes, MetricsConfigTest, LoggingHandlerTest, DOMUtilTest, 
TestExactStatsCache, TestFiltering, BasicAuthStandaloneTest, 
TestElisionMultitermQuery, ReplicationFactorTest, 
ConcurrentDeleteAndCreateCollectionTest, SmileWriterTest, 
TestUseDocValuesAsStored, DeleteLastCustomShardedReplicaTest, 
TestSolrIndexConfig, MigrateRouteKeyTest, SchemaVersionSpecificBehaviorTest, 
SparseHLLTest, SliceStateTest, TestFuzzyAnalyzedSuggestions, 
BigEndianAscendingWordSerializerTest, TestEmbeddedSolrServerSchemaAPI, 
JsonLoaderTest, TestFileDictionaryLookup, TestStandardQParsers, 
TestConfigSetProperties, TestOverriddenPrefixQueryForCustomFieldType, 
DistribDocExpirationUpdateProcessorTest, TestLegacyFieldCache, 
HdfsSyncSliceTest, TestSystemIdResolver, TestCursorMarkWithoutUniqueKey, 
DistributedMLTComponentTest, SpellCheckComponentTest, 
PreAnalyzedUpdateProcessorTest, CacheHeaderTest, DateRangeFieldTest, 
ExitableDirectoryReaderTest, MoreLikeThisHandlerTest, TestXIncludeConfig, 
TestConfigSetsAPIExclusivity, SolrCmdDistributorTest, 
DistributedFacetPivotLongTailTest, IndexSchemaRuntimeFieldTest, 
CSVRequestHandlerTest, CoreMergeIndexesAdminHandlerTest, 
DirectSolrSpellCheckerTest, DistributedExpandComponentTest, 
RecoveryAfterSoftCommitTest, TestMacroExpander, TestBackupRepositoryFactory, 
SOLR749Test, TestQueryWrapperFilter, TestClusterStateMutator, 
SolrIndexMetricsTest, ZkSolrClientTest, TestSizeLimitedDistributedMap, 
HdfsChaosMonkeySafeLeaderTest, SpatialFilterTest, ShardRoutingTest, 
OverseerCollectionConfigSetProcessorTest, TermVectorComponentTest, 
TestDelegationWithHadoopAuth, TestDynamicFieldResource, 
TestAtomicUpdateErrorCases, OverseerStatusTest, TestSSLRandomization, 
CoreAdminHandlerTest, TestPKIAuthenticationPlugin, TestPrepRecovery, 
TestRawTransformer, PropertiesRequestHandlerTest, BasicFunctionalityTest, 
TestBulkSchemaAPI, DistributedIntervalFacetingTest, ChaosMonkeySafeLeaderTest, 
UnloadDistributedZkTest, LeaderElectionIntegrationTest, BasicZkTest, 
RecoveryZkTest, TestReplicationHandler, TestZkChroot, ZkCLITest, 
ShardRoutingCustomTest, TestDistributedSearch]
   [junit4] Completed [356/727 (1!)] on J1 in 1.49s, 1 test, 1 failure <<< 
FAILURES!

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

Reply via email to