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

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

Error Message:
Expected to find shardAddress in the up shard info: 
{error=org.apache.solr.client.solrj.SolrServerException: Time allowed to handle 
this request exceeded,trace=org.apache.solr.client.solrj.SolrServerException: 
Time allowed to handle this request exceeded  at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:460)
  at 
org.apache.solr.handler.component.HttpShardHandlerFactory.makeLoadBalancedRequest(HttpShardHandlerFactory.java:273)
  at 
org.apache.solr.handler.component.HttpShardHandler.lambda$submit$0(HttpShardHandler.java:175)
  at java.util.concurrent.FutureTask.run(FutureTask.java:266)  at 
java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)  at 
java.util.concurrent.FutureTask.run(FutureTask.java:266)  at 
com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:176)
  at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:188)
  at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) 
 at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) 
 at java.lang.Thread.run(Thread.java:748) ,time=1}

Stack Trace:
java.lang.AssertionError: Expected to find shardAddress in the up shard info: 
{error=org.apache.solr.client.solrj.SolrServerException: Time allowed to handle 
this request exceeded,trace=org.apache.solr.client.solrj.SolrServerException: 
Time allowed to handle this request exceeded
        at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:460)
        at 
org.apache.solr.handler.component.HttpShardHandlerFactory.makeLoadBalancedRequest(HttpShardHandlerFactory.java:273)
        at 
org.apache.solr.handler.component.HttpShardHandler.lambda$submit$0(HttpShardHandler.java:175)
        at java.util.concurrent.FutureTask.run(FutureTask.java:266)
        at 
java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
        at java.util.concurrent.FutureTask.run(FutureTask.java:266)
        at 
com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:176)
        at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:188)
        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
        at java.lang.Thread.run(Thread.java:748)
,time=1}
        at 
__randomizedtesting.SeedInfo.seed([8E4F2863D61E43C4:61B17B978E22E3C]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.assertTrue(Assert.java:43)
        at 
org.apache.solr.TestDistributedSearch.comparePartialResponses(TestDistributedSearch.java:1191)
        at 
org.apache.solr.TestDistributedSearch.queryPartialResults(TestDistributedSearch.java:1132)
        at 
org.apache.solr.TestDistributedSearch.test(TestDistributedSearch.java:992)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsRepeatStatement.callStatement(BaseDistributedSearchTestCase.java:1019)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:968)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.lang.Thread.run(Thread.java:748)




Build Log:
[...truncated 13021 lines...]
   [junit4] Suite: org.apache.solr.TestDistributedSearch
   [junit4]   2> Creating dataDir: 
/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_8E4F2863D61E43C4-001/init-core-data-001
   [junit4]   2> 2240384 WARN  
(SUITE-TestDistributedSearch-seed#[8E4F2863D61E43C4]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=1 numCloses=1
   [junit4]   2> 2240384 INFO  
(SUITE-TestDistributedSearch-seed#[8E4F2863D61E43C4]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 2240386 INFO  
(SUITE-TestDistributedSearch-seed#[8E4F2863D61E43C4]-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> 2240386 INFO  
(SUITE-TestDistributedSearch-seed#[8E4F2863D61E43C4]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 2240386 INFO  
(SUITE-TestDistributedSearch-seed#[8E4F2863D61E43C4]-worker) [    ] 
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /q_j/aw
   [junit4]   2> 2240515 INFO  
(TEST-TestDistributedSearch.test-seed#[8E4F2863D61E43C4]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_8E4F2863D61E43C4-001/tempDir-001/control/cores/collection1
   [junit4]   2> 2240516 INFO  
(TEST-TestDistributedSearch.test-seed#[8E4F2863D61E43C4]) [    ] o.e.j.s.Server 
jetty-9.3.20.v20170531
   [junit4]   2> 2240517 INFO  
(TEST-TestDistributedSearch.test-seed#[8E4F2863D61E43C4]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@6a0d33b7{/q_j/aw,null,AVAILABLE}
   [junit4]   2> 2240518 INFO  
(TEST-TestDistributedSearch.test-seed#[8E4F2863D61E43C4]) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@3ce5e34d{HTTP/1.1,[http/1.1]}{127.0.0.1:39198}
   [junit4]   2> 2240518 INFO  
(TEST-TestDistributedSearch.test-seed#[8E4F2863D61E43C4]) [    ] o.e.j.s.Server 
Started @2244385ms
   [junit4]   2> 2240518 INFO  
(TEST-TestDistributedSearch.test-seed#[8E4F2863D61E43C4]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/q_j/aw, 
hostPort=39198, 
coreRootDirectory=/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_8E4F2863D61E43C4-001/tempDir-001/control/cores}
   [junit4]   2> 2240519 ERROR 
(TEST-TestDistributedSearch.test-seed#[8E4F2863D61E43C4]) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 2240519 INFO  
(TEST-TestDistributedSearch.test-seed#[8E4F2863D61E43C4]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
7.3.0
   [junit4]   2> 2240519 INFO  
(TEST-TestDistributedSearch.test-seed#[8E4F2863D61E43C4]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 2240519 INFO  
(TEST-TestDistributedSearch.test-seed#[8E4F2863D61E43C4]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 2240519 INFO  
(TEST-TestDistributedSearch.test-seed#[8E4F2863D61E43C4]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-01-15T19:31:59.383Z
   [junit4]   2> 2240519 INFO  
(TEST-TestDistributedSearch.test-seed#[8E4F2863D61E43C4]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_8E4F2863D61E43C4-001/tempDir-001/control/solr.xml
   [junit4]   2> 2240521 INFO  
(TEST-TestDistributedSearch.test-seed#[8E4F2863D61E43C4]) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay 
is ignored
   [junit4]   2> 2240521 INFO  
(TEST-TestDistributedSearch.test-seed#[8E4F2863D61E43C4]) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 2240522 INFO  
(TEST-TestDistributedSearch.test-seed#[8E4F2863D61E43C4]) [    ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1aeec3f3, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 2240552 INFO  
(TEST-TestDistributedSearch.test-seed#[8E4F2863D61E43C4]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1aeec3f3
   [junit4]   2> 2240557 INFO  
(TEST-TestDistributedSearch.test-seed#[8E4F2863D61E43C4]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1aeec3f3
   [junit4]   2> 2240557 INFO  
(TEST-TestDistributedSearch.test-seed#[8E4F2863D61E43C4]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1aeec3f3
   [junit4]   2> 2240558 INFO  
(TEST-TestDistributedSearch.test-seed#[8E4F2863D61E43C4]) [    ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_8E4F2863D61E43C4-001/tempDir-001/control/cores
   [junit4]   2> 2240559 INFO  
(TEST-TestDistributedSearch.test-seed#[8E4F2863D61E43C4]) [    ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 2240559 INFO  (coreLoadExecutor-7285-thread-1) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 2240559 INFO  (coreLoadExecutor-7285-thread-1) [    
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, 
from paths: 
[/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1/lib,
 
/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 2240607 INFO  (coreLoadExecutor-7285-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.3.0
   [junit4]   2> 2240621 INFO  (coreLoadExecutor-7285-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 2240687 INFO  (coreLoadExecutor-7285-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 2240692 INFO  (coreLoadExecutor-7285-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from configset 
/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1,
 trusted=true
   [junit4]   2> 2240692 INFO  (coreLoadExecutor-7285-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@1aeec3f3
   [junit4]   2> 2240692 INFO  (coreLoadExecutor-7285-thread-1) [    
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 2240692 INFO  (coreLoadExecutor-7285-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1],
 
dataDir=[/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_8E4F2863D61E43C4-001/tempDir-001/control/cores/collection1/data/]
   [junit4]   2> 2240693 INFO  (coreLoadExecutor-7285-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=11, maxMergeAtOnceExplicit=17, maxMergedSegmentMB=63.8544921875, 
floorSegmentMB=1.552734375, forceMergeDeletesPctAllowed=2.8161855320590923, 
segmentsPerTier=45.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.5619633746553124
   [junit4]   2> 2240731 INFO  (coreLoadExecutor-7285-thread-1) [    
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 2240731 INFO  (coreLoadExecutor-7285-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 2240732 INFO  (coreLoadExecutor-7285-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2240732 INFO  (coreLoadExecutor-7285-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2240733 INFO  (coreLoadExecutor-7285-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=37, maxMergeAtOnceExplicit=38, maxMergedSegmentMB=39.9560546875, 
floorSegmentMB=0.8955078125, forceMergeDeletesPctAllowed=1.5042579589580252, 
segmentsPerTier=34.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 2240733 INFO  (coreLoadExecutor-7285-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@65b7a39c[collection1] main]
   [junit4]   2> 2240733 INFO  (coreLoadExecutor-7285-thread-1) [    
x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 2240736 INFO  (coreLoadExecutor-7285-thread-1) [    
x:collection1] o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 2240752 INFO  (coreLoadExecutor-7285-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 2240752 INFO  
(searcherExecutor-7286-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 2240752 INFO  (coreLoadExecutor-7285-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1589688107916066816
   [junit4]   2> 2240752 INFO  
(searcherExecutor-7286-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 2240752 INFO  
(searcherExecutor-7286-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 2240753 INFO  
(searcherExecutor-7286-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 2240753 INFO  
(searcherExecutor-7286-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 2240753 INFO  
(searcherExecutor-7286-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 2240753 INFO  
(searcherExecutor-7286-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 2240753 INFO  
(searcherExecutor-7286-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 2240754 INFO  
(searcherExecutor-7286-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 2240755 INFO  
(searcherExecutor-7286-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@65b7a39c[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2240864 INFO  
(TEST-TestDistributedSearch.test-seed#[8E4F2863D61E43C4]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_8E4F2863D61E43C4-001/tempDir-001/shard0/cores/collection1
   [junit4]   2> 2240865 INFO  
(TEST-TestDistributedSearch.test-seed#[8E4F2863D61E43C4]) [    ] o.e.j.s.Server 
jetty-9.3.20.v20170531
   [junit4]   2> 2240874 INFO  
(TEST-TestDistributedSearch.test-seed#[8E4F2863D61E43C4]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@775b07da{/q_j/aw,null,AVAILABLE}
   [junit4]   2> 2240874 INFO  
(TEST-TestDistributedSearch.test-seed#[8E4F2863D61E43C4]) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@130dfef8{HTTP/1.1,[http/1.1]}{127.0.0.1:41218}
   [junit4]   2> 2240874 INFO  
(TEST-TestDistributedSearch.test-seed#[8E4F2863D61E43C4]) [    ] o.e.j.s.Server 
Started @2244740ms
   [junit4]   2> 2240874 INFO  
(TEST-TestDistributedSearch.test-seed#[8E4F2863D61E43C4]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/q_j/aw, 
hostPort=41218, 
coreRootDirectory=/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_8E4F2863D61E43C4-001/tempDir-001/shard0/cores}
   [junit4]   2> 2240874 ERROR 
(TEST-TestDistributedSearch.test-seed#[8E4F2863D61E43C4]) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 2240875 INFO  
(TEST-TestDistributedSearch.test-seed#[8E4F2863D61E43C4]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
7.3.0
   [junit4]   2> 2240875 INFO  
(TEST-TestDistributedSearch.test-seed#[8E4F2863D61E43C4]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 2240875 INFO  
(TEST-TestDistributedSearch.test-seed#[8E4F2863D61E43C4]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 2240875 INFO  
(TEST-TestDistributedSearch.test-seed#[8E4F2863D61E43C4]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-01-15T19:31:59.739Z
   [junit4]   2> 2240875 INFO  
(TEST-TestDistributedSearch.test-seed#[8E4F2863D61E43C4]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_8E4F2863D61E43C4-001/tempDir-001/shard0/solr.xml
   [junit4]   2> 2240877 INFO  
(TEST-TestDistributedSearch.test-seed#[8E4F2863D61E43C4]) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay 
is ignored
   [junit4]   2> 2240878 INFO  
(TEST-TestDistributedSearch.test-seed#[8E4F2863D61E43C4]) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 2240878 INFO  
(TEST-TestDistributedSearch.test-seed#[8E4F2863D61E43C4]) [    ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1aeec3f3, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 2240904 INFO  
(TEST-TestDistributedSearch.test-seed#[8E4F2863D61E43C4]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1aeec3f3
   [junit4]   2> 2240910 INFO  
(TEST-TestDistributedSearch.test-seed#[8E4F2863D61E43C4]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1aeec3f3
   [junit4]   2> 2240910 INFO  
(TEST-TestDistributedSearch.test-seed#[8E4F2863D61E43C4]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1aeec3f3
   [junit4]   2> 2240911 INFO  
(TEST-TestDistributedSearch.test-seed#[8E4F2863D61E43C4]) [    ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_8E4F2863D61E43C4-001/tempDir-001/shard0/cores
   [junit4]   2> 2240911 INFO  
(TEST-TestDistributedSearch.test-seed#[8E4F2863D61E43C4]) [    ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 2240912 INFO  (coreLoadExecutor-7296-thread-1) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 2240912 INFO  (coreLoadExecutor-7296-thread-1) [    
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, 
from paths: 
[/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1/lib,
 
/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 2240934 INFO  (coreLoadExecutor-7296-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.3.0
   [junit4]   2> 2240948 INFO  (coreLoadExecutor-7296-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 2241015 INFO  (coreLoadExecutor-7296-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 2241021 INFO  (coreLoadExecutor-7296-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from configset 
/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1,
 trusted=true
   [junit4]   2> 2241021 INFO  (coreLoadExecutor-7296-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@1aeec3f3
   [junit4]   2> 2241021 INFO  (coreLoadExecutor-7296-thread-1) [    
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 2241021 INFO  (coreLoadExecutor-7296-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1],
 
dataDir=[/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_8E4F2863D61E43C4-001/tempDir-001/shard0/cores/collection1/data/]
   [junit4]   2> 2241022 INFO  (coreLoadExecutor-7296-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=11, maxMergeAtOnceExplicit=17, maxMergedSegmentMB=63.8544921875, 
floorSegmentMB=1.552734375, forceMergeDeletesPctAllowed=2.8161855320590923, 
segmentsPerTier=45.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.5619633746553124
   [junit4]   2> 2241061 INFO  (coreLoadExecutor-7296-thread-1) [    
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 2241062 INFO  (coreLoadExecutor-7296-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 2241062 INFO  (coreLoadExecutor-7296-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2241062 INFO  (coreLoadExecutor-7296-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2241063 INFO  (coreLoadExecutor-7296-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=37, maxMergeAtOnceExplicit=38, maxMergedSegmentMB=39.9560546875, 
floorSegmentMB=0.8955078125, forceMergeDeletesPctAllowed=1.5042579589580252, 
segmentsPerTier=34.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 2241063 INFO  (coreLoadExecutor-7296-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@6da453f[collection1] 
main]
   [junit4]   2> 2241064 INFO  (coreLoadExecutor-7296-thread-1) [    
x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 2241068 INFO  (coreLoadExecutor-7296-thread-1) [    
x:collection1] o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 2241083 INFO  (coreLoadExecutor-7296-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 2241083 INFO  (coreLoadExecutor-7296-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1589688108263145472
   [junit4]   2> 2241083 INFO  
(searcherExecutor-7297-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 2241083 INFO  
(searcherExecutor-7297-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 2241084 INFO  
(searcherExecutor-7297-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 2241084 INFO  
(searcherExecutor-7297-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 2241084 INFO  
(searcherExecutor-7297-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 2241084 INFO  
(searcherExecutor-7297-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 2241084 INFO  
(searcherExecutor-7297-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 2241085 INFO  
(searcherExecutor-7297-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 2241085 INFO  
(searcherExecutor-7297-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 2241085 INFO  
(TEST-TestDistributedSearch.test-seed#[8E4F2863D61E43C4]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting test
   [junit4]   2> 2241086 INFO  
(searcherExecutor-7297-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@6da453f[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2241087 INFO  (qtp1973216483-22873) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{deleteByQuery=*:* (-1589688108266291200)} 0 0
   [junit4]   2> 2241089 INFO  (qtp380360740-22892) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{deleteByQuery=*:* (-1589688108268388352)} 0 0
   [junit4]   2> 2241090 INFO  (qtp1973216483-22874) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[1 (1589688108270485504)]} 0 0
   [junit4]   2> 2241091 INFO  (qtp380360740-22893) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[1 (1589688108271534080)]} 0 0
   [junit4]   2> 2241092 INFO  (qtp1973216483-22875) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[2 (1589688108272582656)]} 0 0
   [junit4]   2> 2241093 INFO  (qtp380360740-22889) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[2 (1589688108273631232)]} 0 0
   [junit4]   2> 2241093 INFO  (qtp1973216483-22876) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[3 (1589688108273631232)]} 0 0
   [junit4]   2> 2241094 INFO  (qtp380360740-22895) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[3 (1589688108274679808)]} 0 0
   [junit4]   2> 2241094 INFO  (qtp1973216483-22877) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[4 (1589688108274679808)]} 0 0
   [junit4]   2> 2241095 INFO  (qtp380360740-22894) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[4 (1589688108275728384)]} 0 0
   [junit4]   2> 2241096 INFO  (qtp1973216483-22878) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[5 (1589688108275728384)]} 0 0
   [junit4]   2> 2241096 INFO  (qtp380360740-22890) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[5 (1589688108276776960)]} 0 0
   [junit4]   2> 2241097 INFO  (qtp1973216483-22871) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[6 (1589688108276776960)]} 0 0
   [junit4]   2> 2241097 INFO  (qtp380360740-22888) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[6 (1589688108277825536)]} 0 0
   [junit4]   2> 2241098 INFO  (qtp1973216483-22873) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[7 (1589688108277825536)]} 0 0
   [junit4]   2> 2241098 INFO  (qtp380360740-22892) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[7 (1589688108278874112)]} 0 0
   [junit4]   2> 2241098 INFO  (qtp1973216483-22874) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[8 (1589688108278874112)]} 0 0
   [junit4]   2> 2241099 INFO  (qtp380360740-22893) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[8 (1589688108279922688)]} 0 0
   [junit4]   2> 2241099 INFO  (qtp1973216483-22874) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[9 (1589688108279922688)]} 0 0
   [junit4]   2> 2241100 INFO  (qtp380360740-22889) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[9 (1589688108280971264)]} 0 0
   [junit4]   2> 2241100 INFO  (qtp1973216483-22876) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1589688108280971264,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 2241100 INFO  (qtp1973216483-22876) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@8ba4a42 
commitCommandVersion:1589688108280971264
   [junit4]   2> 2241104 INFO  (qtp1973216483-22876) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@3755d71d[collection1] main]
   [junit4]   2> 2241105 INFO  (qtp1973216483-22876) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 2241106 INFO  
(searcherExecutor-7286-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@3755d71d[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.3.0):C9)))}
   [junit4]   2> 2241106 INFO  (qtp1973216483-22876) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 5
   [junit4]   2> 2241106 INFO  (qtp380360740-22895) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1589688108287262720,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 2241106 INFO  (qtp380360740-22895) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@1dce6d84 
commitCommandVersion:1589688108287262720
   [junit4]   2> 2241110 INFO  (qtp380360740-22895) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@605d6de2[collection1] main]
   [junit4]   2> 2241110 INFO  (qtp380360740-22895) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 2241111 INFO  
(searcherExecutor-7297-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@605d6de2[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.3.0):C9)))}
   [junit4]   2> 2241112 INFO  (qtp380360740-22895) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 5
   [junit4]   2> 2241113 INFO  (qtp1973216483-22877) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[10 (1589688108293554176)]} 0 1
   [junit4]   2> 2241115 INFO  (qtp380360740-22894) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[10 (1589688108295651328)]} 0 1
   [junit4]   2> 2241116 INFO  (qtp1973216483-22878) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[11 (1589688108297748480)]} 0 0
   [junit4]   2> 2241117 INFO  (qtp380360740-22890) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[11 (1589688108297748480)]} 0 0
   [junit4]   2> 2241117 INFO  (qtp1973216483-22871) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[12 (1589688108298797056)]} 0 0
   [junit4]   2> 2241118 INFO  (qtp380360740-22888) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[12 (1589688108299845632)]} 0 0
   [junit4]   2> 2241118 INFO  (qtp1973216483-22873) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[13 (1589688108299845632)]} 0 0
   [junit4]   2> 2241119 INFO  (qtp380360740-22888) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[13 (1589688108300894208)]} 0 0
   [junit4]   2> 2241120 INFO  (qtp1973216483-22875) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[1001 (1589688108301942784)]} 0 0
   [junit4]   2> 2241121 INFO  (qtp380360740-22893) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[1001 (1589688108302991360)]} 0 0
   [junit4]   2> 2241122 INFO  (qtp1973216483-22874) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[14 (1589688108302991360)]} 0 0
   [junit4]   2> 2241122 INFO  (qtp380360740-22889) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[14 (1589688108304039936)]} 0 0
   [junit4]   2> 2241122 INFO  (qtp1973216483-22876) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[15 (1589688108304039936)]} 0 0
   [junit4]   2> 2241123 INFO  (qtp380360740-22895) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[15 (1589688108305088512)]} 0 0
   [junit4]   2> 2241123 INFO  (qtp1973216483-22877) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[16 (1589688108305088512)]} 0 0
   [junit4]   2> 2241124 INFO  (qtp380360740-22894) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[16 (1589688108306137088)]} 0 0
   [junit4]   2> 2241124 INFO  (qtp1973216483-22878) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[17 (1589688108306137088)]} 0 0
   [junit4]   2> 2241125 INFO  (qtp380360740-22890) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[17 (1589688108307185664)]} 0 0
   [junit4]   2> 2241125 INFO  (qtp1973216483-22871) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[100 (1589688108307185664)]} 0 0
   [junit4]   2> 2241126 INFO  (qtp380360740-22892) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[100 (1589688108307185665)]} 0 0
   [junit4]   2> 2241126 INFO  (qtp1973216483-22873) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[101 (1589688108308234240)]} 0 0
   [junit4]   2> 2241126 INFO  (qtp380360740-22888) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[101 (1589688108308234240)]} 0 0
   [junit4]   2> 2241127 INFO  (qtp1973216483-22875) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[102 (1589688108309282816)]} 0 0
   [junit4]   2> 2241127 INFO  (qtp380360740-22893) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[102 (1589688108309282816)]} 0 0
   [junit4]   2> 2241128 INFO  (qtp1973216483-22874) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[103 (1589688108309282817)]} 0 0
   [junit4]   2> 2241128 INFO  (qtp380360740-22889) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[103 (1589688108310331392)]} 0 0
   [junit4]   2> 2241128 INFO  (qtp1973216483-22876) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[104 (1589688108310331392)]} 0 0
   [junit4]   2> 2241129 INFO  (qtp380360740-22895) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[104 (1589688108311379968)]} 0 0
   [junit4]   2> 2241129 INFO  (qtp1973216483-22877) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[105 (1589688108311379968)]} 0 0
   [junit4]   2> 2241129 INFO  (qtp380360740-22894) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[105 (1589688108311379969)]} 0 0
   [junit4]   2> 2241130 INFO  (qtp1973216483-22878) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[106 (1589688108312428544)]} 0 0
   [junit4]   2> 2241130 INFO  (qtp380360740-22890) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[106 (1589688108312428544)]} 0 0
   [junit4]   2> 2241131 INFO  (qtp1973216483-22871) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[107 (1589688108312428545)]} 0 0
   [junit4]   2> 2241131 INFO  (qtp380360740-22892) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[107 (1589688108313477120)]} 0 0
   [junit4]   2> 2241131 INFO  (qtp1973216483-22873) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[108 (1589688108313477120)]} 0 0
   [junit4]   2> 2241132 INFO  (qtp380360740-22888) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[108 (1589688108314525696)]} 0 0
   [junit4]   2> 2241132 INFO  (qtp1973216483-22875) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[109 (1589688108314525696)]} 0 0
   [junit4]   2> 2241132 INFO  (qtp380360740-22893) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[109 (1589688108314525697)]} 0 0
   [junit4]   2> 2241133 INFO  (qtp1973216483-22874) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[110 (1589688108315574272)]} 0 0
   [junit4]   2> 2241133 INFO  (qtp380360740-22889) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[110 (1589688108315574272)]} 0 0
   [junit4]   2> 2241134 INFO  (qtp1973216483-22876) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[111 (1589688108316622848)]} 0 0
   [junit4]   2> 2241134 INFO  (qtp380360740-22895) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[111 (1589688108316622848)]} 0 0
   [junit4]   2> 2241135 INFO  (qtp1973216483-22877) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[112 (1589688108316622849)]} 0 0
   [junit4]   2> 2241135 INFO  (qtp380360740-22894) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[112 (1589688108317671424)]} 0 0
   [junit4]   2> 2241135 INFO  (qtp1973216483-22878) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[113 (1589688108317671424)]} 0 0
   [junit4]   2> 2241136 INFO  (qtp380360740-22890) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[113 (1589688108318720000)]} 0 0
   [junit4]   2> 2241136 INFO  (qtp1973216483-22871) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[114 (1589688108318720000)]} 0 0
   [junit4]   2> 2241137 INFO  (qtp380360740-22892) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[114 (1589688108319768576)]} 0 0
   [junit4]   2> 2241137 INFO  (qtp1973216483-22873) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[115 (1589688108319768576)]} 0 0
   [junit4]   2> 2241138 INFO  (qtp380360740-22888) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[115 (1589688108320817152)]} 0 0
   [junit4]   2> 2241139 INFO  (qtp1973216483-22875) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[116 (1589688108320817152)]} 0 0
   [junit4]   2> 2241139 INFO  (qtp380360740-22893) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[116 (1589688108321865728)]} 0 0
   [junit4]   2> 2241139 INFO  (qtp1973216483-22874) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[117 (1589688108321865728)]} 0 0
   [junit4]   2> 2241140 INFO  (qtp380360740-22889) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[117 (1589688108321865729)]} 0 0
   [junit4]   2> 2241140 INFO  (qtp1973216483-22876) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[118 (1589688108322914304)]} 0 0
   [junit4]   2> 2241140 INFO  (qtp380360740-22895) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[118 (1589688108322914304)]} 0 0
   [junit4]   2> 2241141 INFO  (qtp1973216483-22877) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[119 (1589688108323962880)]} 0 0
   [junit4]   2> 2241141 INFO  (qtp380360740-22894) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[119 (1589688108323962880)]} 0 0
   [junit4]   2> 2241141 INFO  (qtp1973216483-22878) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[120 (1589688108323962881)]} 0 0
   [junit4]   2> 2241142 INFO  (qtp380360740-22890) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[120 (1589688108325011456)]} 0 0
   [junit4]   2> 2241142 INFO  (qtp1973216483-22871) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[121 (1589688108325011456)]} 0 0
   [junit4]   2> 2241143 INFO  (qtp380360740-22892) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[121 (1589688108325011457)]} 0 0
   [junit4]   2> 2241143 INFO  (qtp1973216483-22873) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[122 (1589688108326060032)]} 0 0
   [junit4]   2> 2241143 INFO  (qtp380360740-22888) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[122 (1589688108326060032)]} 0 0
   [junit4]   2> 2241144 INFO  (qtp1973216483-22875) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[123 (1589688108327108608)]} 0 0
   [junit4]   2> 2241144 INFO  (qtp380360740-22893) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[123 (1589688108327108608)]} 0 0
   [junit4]   2> 2241145 INFO  (qtp1973216483-22874) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[124 (1589688108327108609)]} 0 0
   [junit4]   2> 2241145 INFO  (qtp380360740-22889) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[124 (1589688108328157184)]} 0 0
   [junit4]   2> 2241145 INFO  (qtp1973216483-22876) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[125 (1589688108328157184)]} 0 0
   [junit4]   2> 2241146 INFO  (qtp380360740-22895) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[125 (1589688108329205760)]} 0 0
   [junit4]   2> 2241146 INFO  (qtp1973216483-22877) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[126 (1589688108329205760)]} 0 0
   [junit4]   2> 2241146 INFO  (qtp380360740-22894) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[126 (1589688108329205761)]} 0 0
   [junit4]   2> 2241147 INFO  (qtp1973216483-22878) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[127 (1589688108330254336)]} 0 0
   [junit4]   2> 2241147 INFO  (qtp380360740-22890) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[127 (1589688108330254336)]} 0 0
   [junit4]   2> 2241147 INFO  (qtp1973216483-22871) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[128 (1589688108330254337)]} 0 0
   [junit4]   2> 2241148 INFO  (qtp380360740-22892) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[128 (1589688108331302912)]} 0 0
   [junit4]   2> 2241148 INFO  (qtp1973216483-22873) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[129 (1589688108331302912)]} 0 0
   [junit4]   2> 2241149 INFO  (qtp380360740-22888) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[129 (1589688108331302913)]} 0 0
   [junit4]   2> 2241149 INFO  (qtp1973216483-22875) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[130 (1589688108332351488)]} 0 0
   [junit4]   2> 2241149 INFO  (qtp380360740-22893) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[130 (1589688108332351488)]} 0 0
   [junit4]   2> 2241150 INFO  (qtp1973216483-22874) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[131 (1589688108333400064)]} 0 0
   [junit4]   2> 2241150 INFO  (qtp380360740-22889) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[131 (1589688108333400064)]} 0 0
   [junit4]   2> 2241150 INFO  (qtp1973216483-22876) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[132 (1589688108333400065)]} 0 0
   [junit4]   2> 2241151 INFO  (qtp380360740-22895) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[132 (1589688108333400065)]} 0 0
   [junit4]   2> 2241151 INFO  (qtp1973216483-22877) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[133 (1589688108334448640)]} 0 0
   [junit4]   2> 2241151 INFO  (qtp380360740-22894) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[133 (1589688108334448640)]} 0 0
   [junit4]   2> 2241151 INFO  (qtp1973216483-22878) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[134 (1589688108334448641)]} 0 0
   [junit4]   2> 2241152 INFO  (qtp380360740-22890) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[134 (1589688108335497216)]} 0 0
   [junit4]   2> 2241152 INFO  (qtp1973216483-22871) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[135 (1589688108335497216)]} 0 0
   [junit4]   2> 2241153 INFO  (qtp380360740-22892) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[135 (1589688108336545792)]} 0 0
   [junit4]   2> 2241153 INFO  (qtp1973216483-22873) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[136 (1589688108336545792)]} 0 0
   [junit4]   2> 2241153 INFO  (qtp380360740-22888) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[136 (1589688108336545793)]} 0 0
   [junit4]   2> 2241154 INFO  (qtp1973216483-22875) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[137 (1589688108337594368)]} 0 0
   [junit4]   2> 2241154 INFO  (qtp380360740-22893) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[137 (1589688108337594368)]} 0 0
   [junit4]   2> 2241155 INFO  (qtp1973216483-22874) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[138 (1589688108337594369)]} 0 0
   [junit4]   2> 2241155 INFO  (qtp380360740-22889) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[138 (1589688108338642944)]} 0 0
   [junit4]   2> 2241155 INFO  (qtp1973216483-22876) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[139 (1589688108338642944)]} 0 0
   [junit4]   2> 2241156 INFO  (qtp380360740-22895) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[139 (1589688108339691520)]} 0 0
   [junit4]   2> 2241156 INFO  (qtp1973216483-22877) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[140 (1589688108339691520)]} 0 0
   [junit4]   2> 2241156 INFO  (qtp380360740-22894) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[140 (1589688108339691521)]} 0 0
   [junit4]   2> 2241157 INFO  (qtp1973216483-22878) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[141 (1589688108339691521)]} 0 0
   [junit4]   2> 2241157 INFO  (qtp380360740-22890) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[141 (1589688108340740096)]} 0 0
   [junit4]   2> 2241157 INFO  (qtp1973216483-22871) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[142 (1589688108340740096)]} 0 0
   [junit4]   2> 2241158 INFO  (qtp380360740-22892) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[142 (1589688108341788672)]} 0 0
   [junit4]   2> 2241158 INFO  (qtp1973216483-22873) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[143 (1589688108341788672)]} 0 0
   [junit4]   2> 2241158 INFO  (qtp380360740-22888) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[143 (1589688108341788673)]} 0 0
   [junit4]   2> 2241159 INFO  (qtp1973216483-22875) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[144 (1589688108342837248)]} 0 0
   [junit4]   2> 2241159 INFO  (qtp380360740-22893) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[144 (1589688108342837248)]} 0 0
   [junit4]   2> 2241160 INFO  (qtp1973216483-22874) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[145 (1589688108342837249)]} 0 0
   [junit4]   2> 2241160 INFO  (qtp380360740-22889) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[145 (1589688108343885824)]} 0 0
   [junit4]   2> 2241160 INFO  (qtp1973216483-22876) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[146 (1589688108343885824)]} 0 0
   [junit4]   2> 2241161 INFO  (qtp380360740-22895) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[146 (1589688108343885825)]} 0 0
   [junit4]   2> 2241161 INFO  (qtp1973216483-22877) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[147 (1589688108344934400)]} 0 0
   [junit4]   2> 2241161 INFO  (qtp380360740-22894) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[147 (1589688108344934400)]} 0 0
   [junit4]   2> 2241161 INFO  (qtp1973216483-22878) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[148 (1589688108344934401)]} 0 0
   [junit4]   2> 2241162 INFO  (qtp380360740-22890) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[148 (1589688108345982976)]} 0 0
   [junit4]   2> 2241162 INFO  (qtp1973216483-22871) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[149 (1589688108345982976)]} 0 0
   [junit4]   2> 2241163 INFO  (qtp380360740-22892) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={wt=javabin&version=2}{add=[149 (1589688108345982977)]} 0 0
   [junit4]   2> 2241163 INFO  (qtp1973216483-22873) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1589688108347031552,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 2241163 INFO  (qtp1973216483-22873) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@8ba4a42 
commitCommandVersion:1589688108347031552
   [junit4]   2> 2241168 INFO  (qtp1973216483-22873) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@fab6209[collection1] main]
   [junit4]   2> 2241168 INFO  (qtp1973216483-22873) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 2241169 INFO  
(searcherExecutor-7286-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@fab6209[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.3.0):C9)
 Uninverting(_1(7.3.0):C59)))}
   [junit4]   2> 2241169 INFO  (qtp1973216483-22873) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 6
   [junit4]   2> 2241170 INFO  (qtp380360740-22888) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1589688108354371584,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 2241170 INFO  (qtp380360740-22888) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@1dce6d84 
commitCommandVersion:1589688108354371584
   [junit4]   2> 2241174 INFO  (qtp380360740-22888) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@6ac47e03[collection1] main]
   [junit4]   2> 2241175 INFO  (qtp380360740-22888) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 2241176 INFO  
(searcherExecutor-7297-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@6ac47e03[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.3.0):C9)
 Uninverting(_1(7.3.0):C59)))}
   [junit4]   2> 2241176 INFO  (qtp380360740-22888) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/q_j/aw path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 6
   [junit4]   2> 2241176 INFO  (qtp1973216483-22875) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching parameter cannot be 
negative
   [junit4]   2> 2241177 INFO  (qtp1973216483-22875) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={q=*&distrib=false&start=-1&wt=javabin&version=2} status=400 QTime=0
   [junit4]   2> 2241177 INFO  (qtp1973216483-22874) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching parameter cannot be 
negative
   [junit4]   2> 2241177 INFO  (qtp1973216483-22874) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={q=*&distrib=false&start=0&rows=-1&wt=javabin&version=2} status=400 
QTime=0
   [junit4]   2> 2241178 INFO  (qtp1973216483-22876) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={q=*:*&distrib=false&sort=n_ti1+desc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 2241188 INFO  (qtp380360740-22889) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw 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/q_j/aw|[ff01::083]:33332/q_j/aw|http://127.0.0.1:41218/q_j/aw/collection1|[ff01::114]:33332/q_j/aw&rows=10&version=2&q=*:*&NOW=1516044720043&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 2241189 INFO  (qtp380360740-22895) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1516044720043&ids=111,145,101,146,5,126,139,8,108,131&isShard=true&shard.url=[ff01::213]:33332/q_j/aw|[ff01::083]:33332/q_j/aw|http://127.0.0.1:41218/q_j/aw/collection1|[ff01::114]:33332/q_j/aw&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2241190 INFO  (qtp380360740-22893) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={q=*:*&shards=[ff01::213]:33332/q_j/aw|[ff01::083]:33332/q_j/aw|http://127.0.0.1:41218/q_j/aw/collection1|[ff01::114]:33332/q_j/aw&sort=n_ti1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=11
   [junit4]   2> 2241191 INFO  (qtp1973216483-22877) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={q=*:*&distrib=false&sort=n_ti1+asc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 2241193 INFO  (qtp380360740-22890) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_ti1+asc&shard.url=[ff01::083]:33332/q_j/aw|http://127.0.0.1:41218/q_j/aw/collection1|[ff01::114]:33332/q_j/aw&rows=10&version=2&q=*:*&NOW=1516044720056&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 2241194 INFO  (qtp380360740-22892) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1516044720056&ids=132,12,1,135,114,4,137,149,128,107&isShard=true&shard.url=[ff01::083]:33332/q_j/aw|http://127.0.0.1:41218/q_j/aw/collection1|[ff01::114]:33332/q_j/aw&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2241195 INFO  (qtp380360740-22894) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={q=*:*&shards=[ff01::083]:33332/q_j/aw|http://127.0.0.1:41218/q_j/aw/collection1|[ff01::114]:33332/q_j/aw&sort=n_ti1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=2
   [junit4]   2> 2241196 INFO  (qtp1973216483-22878) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={q=*:*&distrib=false&sort=n_f1+desc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 2241197 INFO  (qtp380360740-22889) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw 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:41218/q_j/aw/collection1|[ff01::213]:33332/q_j/aw&rows=10&version=2&q=*:*&NOW=1516044720060&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 2241197 INFO  (qtp380360740-22895) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1516044720060&ids=144,145,2,6,107,118,9,119,109,141&isShard=true&shard.url=http://127.0.0.1:41218/q_j/aw/collection1|[ff01::213]:33332/q_j/aw&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2241198 INFO  (qtp380360740-22888) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={q=*:*&shards=http://127.0.0.1:41218/q_j/aw/collection1|[ff01::213]:33332/q_j/aw&sort=n_f1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=1
   [junit4]   2> 2241199 INFO  (qtp1973216483-22871) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={q=*:*&distrib=false&sort=n_f1+asc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 2241200 INFO  (qtp380360740-22890) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_f1+asc&shard.url=[ff01::083]:33332/q_j/aw|http://127.0.0.1:41218/q_j/aw/collection1|[ff01::114]:33332/q_j/aw&rows=10&version=2&q=*:*&NOW=1516044720064&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 2241201 INFO  (qtp380360740-22892) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1516044720064&ids=111,134,123,147,115,104,139,140,130,120&isShard=true&shard.url=[ff01::083]:33332/q_j/aw|http://127.0.0.1:41218/q_j/aw/collection1|[ff01::114]:33332/q_j/aw&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2241201 INFO  (qtp380360740-22893) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={q=*:*&shards=[ff01::083]:33332/q_j/aw|http://127.0.0.1:41218/q_j/aw/collection1|[ff01::114]:33332/q_j/aw&sort=n_f1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=1
   [junit4]   2> 2241202 INFO  (qtp1973216483-22873) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={q=*:*&distrib=false&sort=n_tf1+desc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 2241203 INFO  (qtp380360740-22889) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_tf1+desc&shard.url=http://127.0.0.1:41218/q_j/aw/collection1&rows=10&version=2&q=*:*&NOW=1516044720067&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 2241204 INFO  (qtp380360740-22889) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1516044720067&ids=143,121,122,135,136,147,127,129,108,119&isShard=true&shard.url=http://127.0.0.1:41218/q_j/aw/collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2241205 INFO  (qtp380360740-22894) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={q=*:*&shards=http://127.0.0.1:41218/q_j/aw/collection1&sort=n_tf1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=1
   [junit4]   2> 2241205 INFO  (qtp1973216483-22875) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={q=*:*&distrib=false&sort=n_tf1+asc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 2241206 INFO  (qtp380360740-22888) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_tf1+asc&shard.url=[ff01::083]:33332/q_j/aw|[ff01::213]:33332/q_j/aw|http://127.0.0.1:41218/q_j/aw/collection1|[ff01::114]:33332/q_j/aw&rows=10&version=2&q=*:*&NOW=1516044720070&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 2241207 INFO  (qtp380360740-22890) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1516044720070&ids=13,14,102,103,115,148,126,16,149,107&isShard=true&shard.url=[ff01::083]:33332/q_j/aw|[ff01::213]:33332/q_j/aw|http://127.0.0.1:41218/q_j/aw/collection1|[ff01::114]:33332/q_j/aw&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2241208 INFO  (qtp380360740-22889) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={q=*:*&shards=[ff01::083]:33332/q_j/aw|[ff01::213]:33332/q_j/aw|http://127.0.0.1:41218/q_j/aw/collection1|[ff01::114]:33332/q_j/aw&sort=n_tf1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=2
   [junit4]   2> 2241209 INFO  (qtp1973216483-22874) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={q=*:*&distrib=false&sort=n_d1+desc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 2241210 INFO  (qtp380360740-22893) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_d1+desc&shard.url=http://127.0.0.1:41218/q_j/aw/collection1&rows=10&version=2&q=*:*&NOW=1516044720073&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 2241211 INFO  (qtp380360740-22895) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1516044720073&ids=112,113,114,115,104,105,138,7,119,131&isShard=true&shard.url=http://127.0.0.1:41218/q_j/aw/collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2241211 INFO  (qtp380360740-22892) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={q=*:*&shards=http://127.0.0.1:41218/q_j/aw/collection1&sort=n_d1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=2
   [junit4]   2> 2241212 INFO  (qtp1973216483-22876) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={q=*:*&distrib=false&sort=n_d1+asc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 2241213 INFO  (qtp380360740-22894) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw 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:41218/q_j/aw/collection1&rows=10&version=2&q=*:*&NOW=1516044720077&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 2241214 INFO  (qtp380360740-22894) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1516044720077&ids=143,121,132,100,13,124,137,139,107,142&isShard=true&shard.url=http://127.0.0.1:41218/q_j/aw/collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2241215 INFO  (qtp380360740-22895) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={q=*:*&shards=http://127.0.0.1:41218/q_j/aw/collection1&sort=n_d1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=2
   [junit4]   2> 2241216 INFO  (qtp1973216483-22876) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={q=*:*&distrib=false&sort=n_td1+desc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 2241217 INFO  (qtp380360740-22888) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_td1+desc&shard.url=http://127.0.0.1:41218/q_j/aw/collection1|[ff01::083]:33332/q_j/aw|[ff01::213]:33332/q_j/aw&rows=10&version=2&q=*:*&NOW=1516044720080&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 2241218 INFO  (qtp380360740-22888) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1516044720080&ids=111,101,146,115,104,17,6,139,107,141&isShard=true&shard.url=http://127.0.0.1:41218/q_j/aw/collection1|[ff01::083]:33332/q_j/aw|[ff01::213]:33332/q_j/aw&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2241218 INFO  (qtp380360740-22894) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={q=*:*&shards=http://127.0.0.1:41218/q_j/aw/collection1|[ff01::083]:33332/q_j/aw|[ff01::213]:33332/q_j/aw&sort=n_td1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=1
   [junit4]   2> 2241219 INFO  (qtp1973216483-22876) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={q=*:*&distrib=false&sort=n_td1+asc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 2241220 INFO  (qtp380360740-22890) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_td1+asc&shard.url=http://127.0.0.1:41218/q_j/aw/collection1|[ff01::083]:33332/q_j/aw|[ff01::114]:33332/q_j/aw&rows=10&version=2&q=*:*&NOW=1516044720084&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 2241221 INFO  (qtp380360740-22890) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1516044720084&ids=3,102,125,5,148,137,149,138,7,120&isShard=true&shard.url=http://127.0.0.1:41218/q_j/aw/collection1|[ff01::083]:33332/q_j/aw|[ff01::114]:33332/q_j/aw&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2241222 INFO  (qtp380360740-22888) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={q=*:*&shards=http://127.0.0.1:41218/q_j/aw/collection1|[ff01::083]:33332/q_j/aw|[ff01::114]:33332/q_j/aw&sort=n_td1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=1
   [junit4]   2> 2241222 INFO  (qtp1973216483-22876) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={q=*:*&distrib=false&sort=n_l1+desc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 2241223 INFO  (qtp380360740-22894) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_l1+desc&shard.url=http://127.0.0.1:41218/q_j/aw/collection1&rows=10&version=2&q=*:*&NOW=1516044720087&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 2241224 INFO  (qtp380360740-22889) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1516044720087&ids=110,143,122,111,145,146,136,147,15,117&isShard=true&shard.url=http://127.0.0.1:41218/q_j/aw/collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2241225 INFO  (qtp380360740-22890) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={q=*:*&shards=http://127.0.0.1:41218/q_j/aw/collection1&sort=n_l1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=1
   [junit4]   2> 2241225 INFO  (qtp1973216483-22873) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={q=*:*&distrib=false&sort=n_l1+asc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 2241226 INFO  (qtp380360740-22888) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw 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:41218/q_j/aw/collection1|[ff01::114]:33332/q_j/aw|[ff01::213]:33332/q_j/aw|[ff01::083]:33332/q_j/aw&rows=10&version=2&q=*:*&NOW=1516044720090&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 2241227 INFO  (qtp380360740-22892) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1516044720090&ids=1,2,114,103,115,127,149,7,131,120&isShard=true&shard.url=http://127.0.0.1:41218/q_j/aw/collection1|[ff01::114]:33332/q_j/aw|[ff01::213]:33332/q_j/aw|[ff01::083]:33332/q_j/aw&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2241228 INFO  (qtp380360740-22893) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={q=*:*&shards=http://127.0.0.1:41218/q_j/aw/collection1|[ff01::114]:33332/q_j/aw|[ff01::213]:33332/q_j/aw|[ff01::083]:33332/q_j/aw&sort=n_l1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=1
   [junit4]   2> 2241228 INFO  (qtp1973216483-22875) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={q=*:*&distrib=false&sort=n_tl1+desc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 2241233 INFO  (qtp380360740-22894) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_tl1+desc&shard.url=[ff01::114]:33332/q_j/aw|[ff01::213]:33332/q_j/aw|http://127.0.0.1:41218/q_j/aw/collection1|[ff01::083]:33332/q_j/aw&rows=10&version=2&q=*:*&NOW=1516044720093&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 2241234 INFO  (qtp380360740-22889) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1516044720093&ids=110,1,123,113,14,126,16,116,117,140&isShard=true&shard.url=[ff01::114]:33332/q_j/aw|[ff01::213]:33332/q_j/aw|http://127.0.0.1:41218/q_j/aw/collection1|[ff01::083]:33332/q_j/aw&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2241235 INFO  (qtp380360740-22895) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={q=*:*&shards=[ff01::114]:33332/q_j/aw|[ff01::213]:33332/q_j/aw|http://127.0.0.1:41218/q_j/aw/collection1|[ff01::083]:33332/q_j/aw&sort=n_tl1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=5
   [junit4]   2> 2241235 INFO  (qtp1973216483-22874) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={q=*:*&distrib=false&sort=n_tl1+asc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 2241236 INFO  (qtp380360740-22888) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_tl1+asc&shard.url=[ff01::114]:33332/q_j/aw|[ff01::083]:33332/q_j/aw|[ff01::213]:33332/q_j/aw|http://127.0.0.1:41218/q_j/aw/collection1&rows=10&version=2&q=*:*&NOW=1516044720100&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 2241237 INFO  (qtp380360740-22888) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1516044720100&ids=122,112,3,124,114,5,17,142,131,10&isShard=true&shard.url=[ff01::114]:33332/q_j/aw|[ff01::083]:33332/q_j/aw|[ff01::213]:33332/q_j/aw|http://127.0.0.1:41218/q_j/aw/collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2241237 INFO  (qtp380360740-22890) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={q=*:*&shards=[ff01::114]:33332/q_j/aw|[ff01::083]:33332/q_j/aw|[ff01::213]:33332/q_j/aw|http://127.0.0.1:41218/q_j/aw/collection1&sort=n_tl1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=1
   [junit4]   2> 2241238 INFO  (qtp1973216483-22874) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={q=*:*&distrib=false&sort=n_dt1+desc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 2241239 INFO  (qtp380360740-22892) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_dt1+desc&shard.url=http://127.0.0.1:41218/q_j/aw/collection1|[ff01::083]:33332/q_j/aw|[ff01::213]:33332/q_j/aw|[ff01::114]:33332/q_j/aw&rows=10&version=2&q=*:*&NOW=1516044720103&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 2241239 INFO  (qtp380360740-22892) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1516044720103&ids=122,144,135,136,125,103,115,105,107,140&isShard=true&shard.url=http://127.0.0.1:41218/q_j/aw/collection1|[ff01::083]:33332/q_j/aw|[ff01::213]:33332/q_j/aw|[ff01::114]:33332/q_j/aw&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2241240 INFO  (qtp380360740-22888) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={q=*:*&shards=http://127.0.0.1:41218/q_j/aw/collection1|[ff01::083]:33332/q_j/aw|[ff01::213]:33332/q_j/aw|[ff01::114]:33332/q_j/aw&sort=n_dt1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=1
   [junit4]   2> 2241240 INFO  (qtp1973216483-22874) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={q=*:*&distrib=false&sort=n_dt1+asc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 2241241 INFO  (qtp380360740-22893) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_dt1+asc&shard.url=[ff01::083]:33332/q_j/aw|[ff01::114]:33332/q_j/aw|http://127.0.0.1:41218/q_j/aw/collection1&rows=10&version=2&q=*:*&NOW=1516044720105&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 2241242 INFO  (qtp380360740-22893) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1516044720105&ids=143,1,100,14,137,127,128,117,118,108&isShard=true&shard.url=[ff01::083]:33332/q_j/aw|[ff01::114]:33332/q_j/aw|http://127.0.0.1:41218/q_j/aw/collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2241243 INFO  (qtp380360740-22892) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={q=*:*&shards=[ff01::083]:33332/q_j/aw|[ff01::114]:33332/q_j/aw|http://127.0.0.1:41218/q_j/aw/collection1&sort=n_dt1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=1
   [junit4]   2> 2241243 INFO  (qtp1973216483-22874) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={q=*:*&distrib=false&sort=n_tdt1+desc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 2241245 INFO  (qtp380360740-22888) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_tdt1+desc&shard.url=http://127.0.0.1:41218/q_j/aw/collection1&rows=10&version=2&q=*:*&NOW=1516044720108&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 2241245 INFO  (qtp380360740-22894) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1516044720108&ids=110,144,2,145,14,124,16,116,7,129&isShard=true&shard.url=http://127.0.0.1:41218/q_j/aw/collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2241246 INFO  (qtp380360740-22890) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={q=*:*&shards=http://127.0.0.1:41218/q_j/aw/collection1&sort=n_tdt1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=1
   [junit4]   2> 2241246 INFO  (qtp1973216483-22876) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={q=*:*&distrib=false&sort=n_tdt1+asc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 2241248 INFO  (qtp380360740-22895) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_tdt1+asc&shard.url=[ff01::083]:33332/q_j/aw|http://127.0.0.1:41218/q_j/aw/collection1|[ff01::114]:33332/q_j/aw&rows=10&version=2&q=*:*&NOW=1516044720111&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 2241248 INFO  (qtp380360740-22893) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1516044720111&ids=11,100,101,13,135,115,6,9,109,141&isShard=true&shard.url=[ff01::083]:33332/q_j/aw|http://127.0.0.1:41218/q_j/aw/collection1|[ff01::114]:33332/q_j/aw&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2241249 INFO  (qtp380360740-22889) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/q_j/aw path=/select 
params={q=*:*&shards=[ff01::083]:33332/q_j/aw|http://127.0.0.1:41218/q_j/aw/collection1|[ff01::114]:33332/q_j/aw&sort=n_tdt1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=1
   [junit4]   2> 2241250 INFO  (qtp1973216483-22873) [    x:collection1] o.a.

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

it4]   2> 2263163 INFO  (coreCloseExecutor-7343-thread-1) [    x:collection1] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@5b2f3df4: rootName = null, 
domain = solr.core.collection1, service url = null, agent id = null] for 
registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@7a0c494a
   [junit4]   2> 2263174 INFO  
(TEST-TestDistributedSearch.test-seed#[8E4F2863D61E43C4]) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@3c5abd86{/q_j/aw,null,UNAVAILABLE}
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=TestDistributedSearch -Dtests.method=test 
-Dtests.seed=8E4F2863D61E43C4 -Dtests.slow=true -Dtests.locale=hr-HR 
-Dtests.timezone=Europe/Gibraltar -Dtests.asserts=true 
-Dtests.file.encoding=US-ASCII
   [junit4] FAILURE 22.8s J1 | TestDistributedSearch.test <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: Expected to find 
shardAddress in the up shard info: 
{error=org.apache.solr.client.solrj.SolrServerException: Time allowed to handle 
this request exceeded,trace=org.apache.solr.client.solrj.SolrServerException: 
Time allowed to handle this request exceeded
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:460)
   [junit4]    >        at 
org.apache.solr.handler.component.HttpShardHandlerFactory.makeLoadBalancedRequest(HttpShardHandlerFactory.java:273)
   [junit4]    >        at 
org.apache.solr.handler.component.HttpShardHandler.lambda$submit$0(HttpShardHandler.java:175)
   [junit4]    >        at 
java.util.concurrent.FutureTask.run(FutureTask.java:266)
   [junit4]    >        at 
java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
   [junit4]    >        at 
java.util.concurrent.FutureTask.run(FutureTask.java:266)
   [junit4]    >        at 
com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:176)
   [junit4]    >        at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:188)
   [junit4]    >        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
   [junit4]    >        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
   [junit4]    >        at java.lang.Thread.run(Thread.java:748)
   [junit4]    > ,time=1}
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([8E4F2863D61E43C4:61B17B978E22E3C]:0)
   [junit4]    >        at 
org.apache.solr.TestDistributedSearch.comparePartialResponses(TestDistributedSearch.java:1191)
   [junit4]    >        at 
org.apache.solr.TestDistributedSearch.queryPartialResults(TestDistributedSearch.java:1132)
   [junit4]    >        at 
org.apache.solr.TestDistributedSearch.test(TestDistributedSearch.java:992)
   [junit4]    >        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsRepeatStatement.callStatement(BaseDistributedSearchTestCase.java:1019)
   [junit4]    >        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:968)
   [junit4]    >        at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_8E4F2863D61E43C4-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): 
{severity=PostingsFormat(name=LuceneVarGapFixedInterval), foo_sev_enum=FST50, 
SubjectTerms_mfacet=PostingsFormat(name=Direct), 
multiDefault=PostingsFormat(name=LuceneFixedGap), rnd_b=FST50, 
a_s=PostingsFormat(name=LuceneVarGapFixedInterval), 
oddField_s=PostingsFormat(name=LuceneVarGapFixedInterval), 
lowerfilt1and2=PostingsFormat(name=LuceneFixedGap), 
a_t=PostingsFormat(name=Direct), 
foo_b=PostingsFormat(name=LuceneVarGapFixedInterval), 
lowerfilt=PostingsFormat(name=LuceneFixedGap), id=FST50, 
text=PostingsFormat(name=LuceneVarGapFixedInterval)}, 
docValues:{other_tl1=DocValuesFormat(name=Memory), 
range_facet_l_dv=DocValuesFormat(name=Lucene70), 
n_l1=DocValuesFormat(name=Memory), a_n_tdt=DocValuesFormat(name=Lucene70), 
intDefault=DocValuesFormat(name=Memory), n_td1=DocValuesFormat(name=Direct), 
n_d1=DocValuesFormat(name=Memory), range_facet_l=DocValuesFormat(name=Memory), 
n_f1=DocValuesFormat(name=Direct), n_tl1=DocValuesFormat(name=Direct), 
n_tf1=DocValuesFormat(name=Memory), 
intDvoDefault=DocValuesFormat(name=Asserting), 
timestamp=DocValuesFormat(name=Memory), 
severity=DocValuesFormat(name=Asserting), 
foo_sev_enum=DocValuesFormat(name=Lucene70), 
n_dt1=DocValuesFormat(name=Direct), a_i1=DocValuesFormat(name=Memory), 
b_n_tdt=DocValuesFormat(name=Memory), n_ti1=DocValuesFormat(name=Lucene70), 
_version_=DocValuesFormat(name=Memory), n_tdt1=DocValuesFormat(name=Memory), 
id_i1=DocValuesFormat(name=Direct), foo_d=DocValuesFormat(name=Lucene70), 
range_facet_i_dv=DocValuesFormat(name=Memory), 
foo_f=DocValuesFormat(name=Asserting)}, maxPointsInLeafNode=247, 
maxMBSortInHeap=6.23067014308808, sim=RandomSimilarity(queryNorm=false): {}, 
locale=hr-HR, timezone=Europe/Gibraltar
   [junit4]   2> NOTE: SunOS 5.11 amd64/Oracle Corporation 1.8.0_152 
(64-bit)/cpus=3,threads=1,free=151491592,total=528482304
   [junit4]   2> NOTE: All tests run in this JVM: [FacetPivotSmallTest, 
TestIndexSearcher, TestExpandComponent, TestXmlQParserPlugin, BasicZkTest, 
TestFieldTypeCollectionResource, CdcrVersionReplicationTest, 
TestIntervalFaceting, TestManagedSchema, TestFastLRUCache, 
TemplateUpdateProcessorTest, TestOnReconnectListenerSupport, TestQueryTypes, 
BasicAuthStandaloneTest, DistribDocExpirationUpdateProcessorTest, 
SolrShardReporterTest, OpenCloseCoreStressTest, TestCollationFieldDocValues, 
FullSolrCloudDistribCmdsTest, TestElisionMultitermQuery, JsonLoaderTest, 
TestDFISimilarityFactory, LeaderInitiatedRecoveryOnCommitTest, 
AnalyticsMergeStrategyTest, TestStandardQParsers, BasicDistributedZk2Test, 
TestCustomSort, DistributedFacetPivotSmallAdvancedTest, TestFieldCacheReopen, 
TestHashQParserPlugin, TestConfig, DeleteStatusTest, DocumentBuilderTest, 
TestStressReorder, OverseerTaskQueueTest, TestAnalyzedSuggestions, 
DocValuesMissingTest, TimeRoutedAliasUpdateProcessorTest, 
LeaderElectionIntegrationTest, SearchHandlerTest, 
TermVectorComponentDistributedTest, TestLockTree, TestSkipOverseerOperations, 
TestConfigSetsAPIExclusivity, BlockJoinFacetDistribTest, SystemInfoHandlerTest, 
CustomHighlightComponentTest, HdfsBasicDistributedZkTest, 
TestSimDistributedQueue, ComputePlanActionTest, ReplaceNodeTest, 
HdfsWriteToMultipleCollectionsTest, TestDocTermOrds, TestFoldingMultitermQuery, 
DirectSolrSpellCheckerTest, ShardRoutingCustomTest, TestSolrCLIRunExample, 
FullHLLTest, SOLR749Test, TestSchemaSimilarityResource, 
TestExclusionRuleCollectionAccess, HttpSolrCallGetCoreTest, 
DistributedFacetPivotLargeTest, TestExactSharedStatsCache, TestSort, 
TestDocumentBuilder, TestCloudPivotFacet, TestTrieFacet, TestBadConfig, 
TestManagedSynonymGraphFilterFactory, TestFieldCacheSortRandom, 
ManagedSchemaRoundRobinCloudTest, MoveReplicaHDFSTest, BasicFunctionalityTest, 
HLLUtilTest, MetricUtilsTest, TestLegacyFieldReuse, CacheHeaderTest, 
V2ApiIntegrationTest, ZkStateWriterTest, UpdateParamsTest, 
SuggestComponentTest, SolrJmxReporterCloudTest, TestComputePlanAction, 
CdcrBootstrapTest, TestReplicationHandlerBackup, UpdateLogTest, 
TestExecutePlanAction, TestHighFrequencyDictionaryFactory, TestBlobHandler, 
QueryEqualityTest, CoreAdminRequestStatusTest, SolrCoreCheckLockOnStartupTest, 
TestAuthenticationFramework, TestExceedMaxTermLength, TestSmileRequest, 
TestRTGBase, PropertiesRequestHandlerTest, PluginInfoTest, 
DistributedMLTComponentTest, HdfsNNFailoverTest, TestLegacyTerms, 
TestCoreContainer, SolrSlf4jReporterTest, TestComponentsName, 
LegacyCloudClusterPropTest, ActionThrottleTest, TestPartialUpdateDeduplication, 
TestDistribDocBasedVersion, TestExtendedDismaxParser, 
TestFieldCacheWithThreads, CopyFieldTest, TestCoreBackup, MBeansHandlerTest, 
TestSortByMinMaxFunction, TestLMJelinekMercerSimilarityFactory, 
TestNumericTerms32, TestMinMaxOnMultiValuedField, 
TestStressCloudBlindAtomicUpdates, TestUnifiedSolrHighlighter, 
TestDistributedMissingSort, CoreAdminHandlerTest, TestObjectReleaseTracker, 
TestQueryUtils, TestFaceting, TestNRTOpen, TestPerFieldSimilarity, 
PeerSyncTest, DocValuesMultiTest, CoreSorterTest, FileUtilsTest, 
TestShardHandlerFactory, TestLargeCluster, QueryResultKeyTest, 
TestSchemaManager, TestWordDelimiterFilterFactory, 
SegmentsInfoRequestHandlerTest, TestMacroExpander, TestFunctionQuery, 
SoftAutoCommitTest, BadComponentTest, SolrGangliaReporterTest, 
BlockJoinFacetSimpleTest, SynonymTokenizerTest, HdfsChaosMonkeySafeLeaderTest, 
TestFastOutputStream, TestCrossCoreJoin, CollectionStateFormat2Test, 
TestManagedResourceStorage, TestClusterStateMutator, 
AutoscalingHistoryHandlerTest, TestDynamicFieldCollectionResource, 
CheckHdfsIndexTest, CloneFieldUpdateProcessorFactoryTest, TestSearchPerf, 
TermsComponentTest, UninvertDocValuesMergePolicyTest, PreAnalyzedFieldTest, 
CurrencyFieldTypeTest, TestMissingGroups, DeleteLastCustomShardedReplicaTest, 
TestLRUCache, TestUseDocValuesAsStored, TestFastWriter, TestRemoteStreaming, 
TestNoOpRegenerator, TestLRUStatsCache, TestExportWriter, DocValuesTest, 
TestSolrCloudWithHadoopAuthPlugin, CachingDirectoryFactoryTest, 
SchemaApiFailureTest, DistributedExpandComponentTest, SolrCloudExampleTest, 
SpellingQueryConverterTest, CollectionsAPIDistributedZkTest, 
TestPivotHelperCode, SystemLogListenerTest, TriggerIntegrationTest, 
TestAuthorizationFramework, TestSolrJ, TestEmbeddedSolrServerConstructors, 
TestCloudNestedDocsSort, FieldMutatingUpdateProcessorTest, 
PreAnalyzedUpdateProcessorTest, DataDrivenBlockJoinTest, 
UUIDUpdateProcessorFallbackTest, AtomicUpdatesTest, HdfsRecoveryZkTest, 
ChaosMonkeySafeLeaderTest, UnloadDistributedZkTest, SyncSliceTest, 
TestRandomFaceting, ZkSolrClientTest, TestDistributedSearch]
   [junit4] Completed [394/767 (1!)] on J1 in 22.81s, 1 test, 1 failure <<< 
FAILURES!

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

Reply via email to