Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.0-Linux/147/
Java: 64bit/jdk-9-ea+178 -XX:-UseCompressedOops -XX:+UseG1GC 
--illegal-access=deny

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

Error Message:
Error from server at http://127.0.0.1:38747//collection1: ERROR: [doc=1] Error 
adding field 'severity'='Not Available' msg=EnumFieldType requires 
docValues="true".

Stack Trace:
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error 
from server at http://127.0.0.1:38747//collection1: ERROR: [doc=1] Error adding 
field 'severity'='Not Available' msg=EnumFieldType requires docValues="true".
        at 
__randomizedtesting.SeedInfo.seed([81C6880737673323:992B7DD999B5EDB]:0)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:627)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:253)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:242)
        at 
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:178)
        at org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:173)
        at org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:138)
        at org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:152)
        at 
org.apache.solr.BaseDistributedSearchTestCase.indexDoc(BaseDistributedSearchTestCase.java:483)
        at 
org.apache.solr.BaseDistributedSearchTestCase.indexr(BaseDistributedSearchTestCase.java:465)
        at 
org.apache.solr.TestDistributedSearch.test(TestDistributedSearch.java:1052)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.base/java.lang.reflect.Method.invoke(Method.java:564)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsRepeatStatement.callStatement(BaseDistributedSearchTestCase.java: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:916)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
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.base/java.lang.Thread.run(Thread.java:844)




Build Log:
[...truncated 12043 lines...]
   [junit4] Suite: org.apache.solr.TestDistributedSearch
   [junit4]   2> Creating dataDir: 
/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_81C6880737673323-001/init-core-data-001
   [junit4]   2> 1323262 WARN  
(SUITE-TestDistributedSearch-seed#[81C6880737673323]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=926 numCloses=926
   [junit4]   2> 1323262 INFO  
(SUITE-TestDistributedSearch-seed#[81C6880737673323]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 1323263 INFO  
(SUITE-TestDistributedSearch-seed#[81C6880737673323]-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> 1323263 INFO  
(SUITE-TestDistributedSearch-seed#[81C6880737673323]-worker) [    ] 
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /
   [junit4]   2> 1323332 INFO  
(TEST-TestDistributedSearch.test-seed#[81C6880737673323]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_81C6880737673323-001/tempDir-001/control/cores/collection1
   [junit4]   2> 1323333 INFO  
(TEST-TestDistributedSearch.test-seed#[81C6880737673323]) [    ] o.e.j.s.Server 
jetty-9.3.14.v20161028
   [junit4]   2> 1323334 INFO  
(TEST-TestDistributedSearch.test-seed#[81C6880737673323]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@224388e3{/,null,AVAILABLE}
   [junit4]   2> 1323335 INFO  
(TEST-TestDistributedSearch.test-seed#[81C6880737673323]) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@167b2cb2{HTTP/1.1,[http/1.1]}{127.0.0.1:38747}
   [junit4]   2> 1323335 INFO  
(TEST-TestDistributedSearch.test-seed#[81C6880737673323]) [    ] o.e.j.s.Server 
Started @1323991ms
   [junit4]   2> 1323335 INFO  
(TEST-TestDistributedSearch.test-seed#[81C6880737673323]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, hostPort=38747, 
coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_81C6880737673323-001/tempDir-001/control/cores}
   [junit4]   2> 1323335 ERROR 
(TEST-TestDistributedSearch.test-seed#[81C6880737673323]) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1323335 INFO  
(TEST-TestDistributedSearch.test-seed#[81C6880737673323]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.0.0
   [junit4]   2> 1323335 INFO  
(TEST-TestDistributedSearch.test-seed#[81C6880737673323]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 1323335 INFO  
(TEST-TestDistributedSearch.test-seed#[81C6880737673323]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null, Default config 
dir: null
   [junit4]   2> 1323335 INFO  
(TEST-TestDistributedSearch.test-seed#[81C6880737673323]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-08-05T05:20:58.744472Z
   [junit4]   2> 1323335 INFO  
(TEST-TestDistributedSearch.test-seed#[81C6880737673323]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_81C6880737673323-001/tempDir-001/control/solr.xml
   [junit4]   2> 1323337 INFO  
(TEST-TestDistributedSearch.test-seed#[81C6880737673323]) [    ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@373e6809, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 1323355 INFO  
(TEST-TestDistributedSearch.test-seed#[81C6880737673323]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@373e6809
   [junit4]   2> 1323357 INFO  
(TEST-TestDistributedSearch.test-seed#[81C6880737673323]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@373e6809
   [junit4]   2> 1323357 INFO  
(TEST-TestDistributedSearch.test-seed#[81C6880737673323]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@373e6809
   [junit4]   2> 1323358 INFO  
(TEST-TestDistributedSearch.test-seed#[81C6880737673323]) [    ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_81C6880737673323-001/tempDir-001/control/cores
   [junit4]   2> 1323358 INFO  
(TEST-TestDistributedSearch.test-seed#[81C6880737673323]) [    ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 1323359 INFO  (coreLoadExecutor-5236-thread-1) [    ] 
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: 
[/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/core/src/test-files/solr/collection1/lib,
 
/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1323374 INFO  (coreLoadExecutor-5236-thread-1) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1323388 INFO  (coreLoadExecutor-5236-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1323497 INFO  (coreLoadExecutor-5236-thread-1) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1323503 INFO  (coreLoadExecutor-5236-thread-1) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from 
configset 
/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/core/src/test-files/solr/collection1,
 trusted=true
   [junit4]   2> 1323503 INFO  (coreLoadExecutor-5236-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 
'solr.core.collection1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@373e6809
   [junit4]   2> 1323503 INFO  (coreLoadExecutor-5236-thread-1) [    ] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 1323503 INFO  (coreLoadExecutor-5236-thread-1) [    ] 
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/core/src/test-files/solr/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_81C6880737673323-001/tempDir-001/control/cores/collection1/data/]
   [junit4]   2> 1323504 INFO  (coreLoadExecutor-5236-thread-1) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=50, maxMergeAtOnceExplicit=35, maxMergedSegmentMB=14.3876953125, 
floorSegmentMB=1.4375, forceMergeDeletesPctAllowed=21.34502973683646, 
segmentsPerTier=49.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.4089906465293901
   [junit4]   2> 1323543 INFO  (coreLoadExecutor-5236-thread-1) [    ] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1323543 INFO  (coreLoadExecutor-5236-thread-1) [    ] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1323544 INFO  (coreLoadExecutor-5236-thread-1) [    ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1323544 INFO  (coreLoadExecutor-5236-thread-1) [    ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1323545 INFO  (coreLoadExecutor-5236-thread-1) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=37, maxMergeAtOnceExplicit=41, maxMergedSegmentMB=40.30078125, 
floorSegmentMB=0.2685546875, forceMergeDeletesPctAllowed=19.256829075608547, 
segmentsPerTier=48.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 1323545 INFO  (coreLoadExecutor-5236-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@63b351b4[collection1] main]
   [junit4]   2> 1323546 INFO  (coreLoadExecutor-5236-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1323565 INFO  (coreLoadExecutor-5236-thread-1) [    ] 
o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 1323620 INFO  (coreLoadExecutor-5236-thread-1) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1323620 INFO  (searcherExecutor-5237-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1323620 INFO  (coreLoadExecutor-5236-thread-1) [    ] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1574867261486792704
   [junit4]   2> 1323620 INFO  (searcherExecutor-5237-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1323620 INFO  (searcherExecutor-5237-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1323620 INFO  (searcherExecutor-5237-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 1323621 INFO  (searcherExecutor-5237-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1323621 INFO  (searcherExecutor-5237-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1323621 INFO  (searcherExecutor-5237-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1323621 INFO  (searcherExecutor-5237-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 1323621 INFO  (searcherExecutor-5237-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 1323622 INFO  (searcherExecutor-5237-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@63b351b4[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1323928 INFO  
(TEST-TestDistributedSearch.test-seed#[81C6880737673323]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_81C6880737673323-001/tempDir-001/shard0/cores/collection1
   [junit4]   2> 1323929 INFO  
(TEST-TestDistributedSearch.test-seed#[81C6880737673323]) [    ] o.e.j.s.Server 
jetty-9.3.14.v20161028
   [junit4]   2> 1323930 INFO  
(TEST-TestDistributedSearch.test-seed#[81C6880737673323]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@395382db{/,null,AVAILABLE}
   [junit4]   2> 1323930 INFO  
(TEST-TestDistributedSearch.test-seed#[81C6880737673323]) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@71f5ede4{HTTP/1.1,[http/1.1]}{127.0.0.1:32893}
   [junit4]   2> 1323930 INFO  
(TEST-TestDistributedSearch.test-seed#[81C6880737673323]) [    ] o.e.j.s.Server 
Started @1324587ms
   [junit4]   2> 1323930 INFO  
(TEST-TestDistributedSearch.test-seed#[81C6880737673323]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, hostPort=32893, 
coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_81C6880737673323-001/tempDir-001/shard0/cores}
   [junit4]   2> 1323931 ERROR 
(TEST-TestDistributedSearch.test-seed#[81C6880737673323]) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1323931 INFO  
(TEST-TestDistributedSearch.test-seed#[81C6880737673323]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.0.0
   [junit4]   2> 1323931 INFO  
(TEST-TestDistributedSearch.test-seed#[81C6880737673323]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 1323931 INFO  
(TEST-TestDistributedSearch.test-seed#[81C6880737673323]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null, Default config 
dir: null
   [junit4]   2> 1323931 INFO  
(TEST-TestDistributedSearch.test-seed#[81C6880737673323]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-08-05T05:20:59.340227Z
   [junit4]   2> 1323931 INFO  
(TEST-TestDistributedSearch.test-seed#[81C6880737673323]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_81C6880737673323-001/tempDir-001/shard0/solr.xml
   [junit4]   2> 1323933 INFO  
(TEST-TestDistributedSearch.test-seed#[81C6880737673323]) [    ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@373e6809, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 1323947 INFO  
(TEST-TestDistributedSearch.test-seed#[81C6880737673323]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@373e6809
   [junit4]   2> 1323951 INFO  
(TEST-TestDistributedSearch.test-seed#[81C6880737673323]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@373e6809
   [junit4]   2> 1323951 INFO  
(TEST-TestDistributedSearch.test-seed#[81C6880737673323]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@373e6809
   [junit4]   2> 1323952 INFO  
(TEST-TestDistributedSearch.test-seed#[81C6880737673323]) [    ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_81C6880737673323-001/tempDir-001/shard0/cores
   [junit4]   2> 1323952 INFO  
(TEST-TestDistributedSearch.test-seed#[81C6880737673323]) [    ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 1323952 INFO  (coreLoadExecutor-5247-thread-1) [    ] 
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: 
[/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/core/src/test-files/solr/collection1/lib,
 
/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1323991 INFO  (coreLoadExecutor-5247-thread-1) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1324011 INFO  (coreLoadExecutor-5247-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1324090 INFO  (coreLoadExecutor-5247-thread-1) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1324095 INFO  (coreLoadExecutor-5247-thread-1) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from 
configset 
/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/core/src/test-files/solr/collection1,
 trusted=true
   [junit4]   2> 1324095 INFO  (coreLoadExecutor-5247-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 
'solr.core.collection1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@373e6809
   [junit4]   2> 1324095 INFO  (coreLoadExecutor-5247-thread-1) [    ] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 1324095 INFO  (coreLoadExecutor-5247-thread-1) [    ] 
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/core/src/test-files/solr/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_81C6880737673323-001/tempDir-001/shard0/cores/collection1/data/]
   [junit4]   2> 1324096 INFO  (coreLoadExecutor-5247-thread-1) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=50, maxMergeAtOnceExplicit=35, maxMergedSegmentMB=14.3876953125, 
floorSegmentMB=1.4375, forceMergeDeletesPctAllowed=21.34502973683646, 
segmentsPerTier=49.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.4089906465293901
   [junit4]   2> 1324123 INFO  (coreLoadExecutor-5247-thread-1) [    ] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1324123 INFO  (coreLoadExecutor-5247-thread-1) [    ] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1324128 INFO  (coreLoadExecutor-5247-thread-1) [    ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1324128 INFO  (coreLoadExecutor-5247-thread-1) [    ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1324128 INFO  (coreLoadExecutor-5247-thread-1) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=37, maxMergeAtOnceExplicit=41, maxMergedSegmentMB=40.30078125, 
floorSegmentMB=0.2685546875, forceMergeDeletesPctAllowed=19.256829075608547, 
segmentsPerTier=48.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 1324128 INFO  (coreLoadExecutor-5247-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@7322c091[collection1] main]
   [junit4]   2> 1324129 INFO  (coreLoadExecutor-5247-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1324140 INFO  (coreLoadExecutor-5247-thread-1) [    ] 
o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 1324236 INFO  (coreLoadExecutor-5247-thread-1) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1324236 INFO  (searcherExecutor-5248-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1324236 INFO  (coreLoadExecutor-5247-thread-1) [    ] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1574867262132715520
   [junit4]   2> 1324236 INFO  (searcherExecutor-5248-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1324236 INFO  (searcherExecutor-5248-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1324236 INFO  (searcherExecutor-5248-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 1324237 INFO  (searcherExecutor-5248-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1324237 INFO  (searcherExecutor-5248-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1324237 INFO  (searcherExecutor-5248-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1324237 INFO  (searcherExecutor-5248-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 1324237 INFO  (searcherExecutor-5248-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 1324238 INFO  (searcherExecutor-5248-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@7322c091[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1324471 INFO  
(TEST-TestDistributedSearch.test-seed#[81C6880737673323]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting test
   [junit4]   2> 1324474 INFO  (qtp416018098-11673) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{deleteByQuery=*:* (-1574867262381228032)} 0 1
   [junit4]   2> 1324476 INFO  (qtp1367891013-11690) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{deleteByQuery=*:* (-1574867262383325184)} 0 0
   [junit4]   2> 1324478 INFO  (qtp416018098-11674) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[1 (1574867262384373760)]} 0 1
   [junit4]   2> 1324479 INFO  (qtp1367891013-11691) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[1 (1574867262386470912)]} 0 0
   [junit4]   2> 1324480 INFO  (qtp416018098-11675) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[2 (1574867262387519488)]} 0 0
   [junit4]   2> 1324481 INFO  (qtp1367891013-11692) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[2 (1574867262388568064)]} 0 0
   [junit4]   2> 1324481 INFO  (qtp416018098-11668) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[3 (1574867262389616640)]} 0 0
   [junit4]   2> 1324482 INFO  (qtp1367891013-11685) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[3 (1574867262390665216)]} 0 0
   [junit4]   2> 1324483 INFO  (qtp416018098-11673) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[4 (1574867262390665216)]} 0 0
   [junit4]   2> 1324483 INFO  (qtp1367891013-11690) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[4 (1574867262391713792)]} 0 0
   [junit4]   2> 1324484 INFO  (qtp416018098-11674) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[5 (1574867262392762368)]} 0 0
   [junit4]   2> 1324484 INFO  (qtp1367891013-11691) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[5 (1574867262392762368)]} 0 0
   [junit4]   2> 1324485 INFO  (qtp416018098-11675) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[6 (1574867262393810944)]} 0 0
   [junit4]   2> 1324485 INFO  (qtp1367891013-11692) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[6 (1574867262393810944)]} 0 0
   [junit4]   2> 1324486 INFO  (qtp416018098-11668) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[7 (1574867262393810945)]} 0 0
   [junit4]   2> 1324486 INFO  (qtp1367891013-11685) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[7 (1574867262394859520)]} 0 0
   [junit4]   2> 1324487 INFO  (qtp416018098-11673) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[8 (1574867262394859520)]} 0 0
   [junit4]   2> 1324487 INFO  (qtp1367891013-11690) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[8 (1574867262395908096)]} 0 0
   [junit4]   2> 1324487 INFO  (qtp416018098-11674) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[9 (1574867262395908096)]} 0 0
   [junit4]   2> 1324488 INFO  (qtp1367891013-11691) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[9 (1574867262396956672)]} 0 0
   [junit4]   2> 1324488 INFO  (qtp416018098-11675) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1574867262396956672,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1324488 INFO  (qtp416018098-11675) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@56c2af7a 
commitCommandVersion:1574867262396956672
   [junit4]   2> 1324494 INFO  (qtp416018098-11675) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@4f1cb9dd[collection1] main]
   [junit4]   2> 1324495 INFO  (qtp416018098-11675) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1324496 INFO  (searcherExecutor-5237-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@4f1cb9dd[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C9)))}
   [junit4]   2> 1324496 INFO  (qtp416018098-11675) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 7
   [junit4]   2> 1324496 INFO  (qtp1367891013-11692) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1574867262405345280,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1324496 INFO  (qtp1367891013-11692) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@79fd0ed1 
commitCommandVersion:1574867262405345280
   [junit4]   2> 1324500 INFO  (qtp1367891013-11692) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@11e0e422[collection1] main]
   [junit4]   2> 1324500 INFO  (qtp1367891013-11692) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1324501 INFO  (searcherExecutor-5248-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@11e0e422[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C9)))}
   [junit4]   2> 1324501 INFO  (qtp1367891013-11692) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 5
   [junit4]   2> 1324503 INFO  (qtp416018098-11668) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[10 (1574867262410588160)]} 0 1
   [junit4]   2> 1324504 INFO  (qtp1367891013-11685) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[10 (1574867262412685312)]} 0 1
   [junit4]   2> 1324505 INFO  (qtp416018098-11673) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[11 (1574867262413733888)]} 0 0
   [junit4]   2> 1324505 INFO  (qtp1367891013-11690) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[11 (1574867262414782464)]} 0 0
   [junit4]   2> 1324505 INFO  (qtp416018098-11674) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[12 (1574867262414782464)]} 0 0
   [junit4]   2> 1324506 INFO  (qtp1367891013-11690) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[12 (1574867262415831040)]} 0 0
   [junit4]   2> 1324506 INFO  (qtp416018098-11675) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[13 (1574867262415831040)]} 0 0
   [junit4]   2> 1324507 INFO  (qtp1367891013-11692) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[13 (1574867262415831041)]} 0 0
   [junit4]   2> 1324507 INFO  (qtp416018098-11668) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[1001 (1574867262416879616)]} 0 0
   [junit4]   2> 1324508 INFO  (qtp1367891013-11685) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[1001 (1574867262416879616)]} 0 0
   [junit4]   2> 1324508 INFO  (qtp416018098-11673) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[14 (1574867262417928192)]} 0 0
   [junit4]   2> 1324509 INFO  (qtp1367891013-11691) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[14 (1574867262418976768)]} 0 0
   [junit4]   2> 1324509 INFO  (qtp416018098-11673) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[15 (1574867262418976768)]} 0 0
   [junit4]   2> 1324510 INFO  (qtp1367891013-11691) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[15 (1574867262420025344)]} 0 0
   [junit4]   2> 1324510 INFO  (qtp416018098-11673) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[16 (1574867262420025344)]} 0 0
   [junit4]   2> 1324510 INFO  (qtp1367891013-11691) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[16 (1574867262420025345)]} 0 0
   [junit4]   2> 1324511 INFO  (qtp416018098-11673) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[17 (1574867262421073920)]} 0 0
   [junit4]   2> 1324512 INFO  (qtp1367891013-11691) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[17 (1574867262421073920)]} 0 0
   [junit4]   2> 1324512 INFO  (qtp416018098-11673) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[100 (1574867262422122496)]} 0 0
   [junit4]   2> 1324512 INFO  (qtp1367891013-11691) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[100 (1574867262422122496)]} 0 0
   [junit4]   2> 1324513 INFO  (qtp416018098-11673) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[101 (1574867262423171072)]} 0 0
   [junit4]   2> 1324513 INFO  (qtp1367891013-11691) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[101 (1574867262423171072)]} 0 0
   [junit4]   2> 1324513 INFO  (qtp416018098-11673) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[102 (1574867262423171073)]} 0 0
   [junit4]   2> 1324514 INFO  (qtp1367891013-11691) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[102 (1574867262424219648)]} 0 0
   [junit4]   2> 1324514 INFO  (qtp416018098-11673) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[103 (1574867262424219648)]} 0 0
   [junit4]   2> 1324514 INFO  (qtp1367891013-11691) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[103 (1574867262424219649)]} 0 0
   [junit4]   2> 1324515 INFO  (qtp416018098-11673) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[104 (1574867262425268224)]} 0 0
   [junit4]   2> 1324515 INFO  (qtp1367891013-11691) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[104 (1574867262425268224)]} 0 0
   [junit4]   2> 1324515 INFO  (qtp416018098-11673) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[105 (1574867262425268225)]} 0 0
   [junit4]   2> 1324516 INFO  (qtp1367891013-11691) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[105 (1574867262426316800)]} 0 0
   [junit4]   2> 1324516 INFO  (qtp416018098-11673) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[106 (1574867262426316800)]} 0 0
   [junit4]   2> 1324517 INFO  (qtp1367891013-11691) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[106 (1574867262426316801)]} 0 0
   [junit4]   2> 1324517 INFO  (qtp416018098-11673) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[107 (1574867262427365376)]} 0 0
   [junit4]   2> 1324517 INFO  (qtp1367891013-11692) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[107 (1574867262427365376)]} 0 0
   [junit4]   2> 1324518 INFO  (qtp416018098-11675) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[108 (1574867262428413952)]} 0 0
   [junit4]   2> 1324518 INFO  (qtp1367891013-11685) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[108 (1574867262428413952)]} 0 0
   [junit4]   2> 1324519 INFO  (qtp416018098-11668) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[109 (1574867262429462528)]} 0 0
   [junit4]   2> 1324520 INFO  (qtp1367891013-11690) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[109 (1574867262430511104)]} 0 0
   [junit4]   2> 1324521 INFO  (qtp416018098-11674) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[110 (1574867262431559680)]} 0 0
   [junit4]   2> 1324521 INFO  (qtp1367891013-11690) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[110 (1574867262431559680)]} 0 0
   [junit4]   2> 1324522 INFO  (qtp416018098-11674) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[111 (1574867262432608256)]} 0 0
   [junit4]   2> 1324522 INFO  (qtp1367891013-11690) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[111 (1574867262432608256)]} 0 0
   [junit4]   2> 1324523 INFO  (qtp416018098-11674) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[112 (1574867262433656832)]} 0 0
   [junit4]   2> 1324523 INFO  (qtp1367891013-11685) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[112 (1574867262433656832)]} 0 0
   [junit4]   2> 1324524 INFO  (qtp416018098-11674) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[113 (1574867262434705408)]} 0 0
   [junit4]   2> 1324524 INFO  (qtp1367891013-11685) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[113 (1574867262434705408)]} 0 0
   [junit4]   2> 1324525 INFO  (qtp416018098-11674) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[114 (1574867262435753984)]} 0 0
   [junit4]   2> 1324526 INFO  (qtp1367891013-11685) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[114 (1574867262435753984)]} 0 0
   [junit4]   2> 1324526 INFO  (qtp416018098-11674) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[115 (1574867262436802560)]} 0 0
   [junit4]   2> 1324527 INFO  (qtp1367891013-11685) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[115 (1574867262436802560)]} 0 0
   [junit4]   2> 1324527 INFO  (qtp416018098-11674) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[116 (1574867262437851136)]} 0 0
   [junit4]   2> 1324528 INFO  (qtp1367891013-11685) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[116 (1574867262437851136)]} 0 0
   [junit4]   2> 1324528 INFO  (qtp416018098-11674) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[117 (1574867262438899712)]} 0 0
   [junit4]   2> 1324529 INFO  (qtp1367891013-11685) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[117 (1574867262438899712)]} 0 0
   [junit4]   2> 1324529 INFO  (qtp416018098-11674) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[118 (1574867262439948288)]} 0 0
   [junit4]   2> 1324529 INFO  (qtp1367891013-11690) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[118 (1574867262439948288)]} 0 0
   [junit4]   2> 1324530 INFO  (qtp416018098-11673) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[119 (1574867262440996864)]} 0 0
   [junit4]   2> 1324531 INFO  (qtp1367891013-11691) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[119 (1574867262440996864)]} 0 0
   [junit4]   2> 1324531 INFO  (qtp416018098-11675) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[120 (1574867262442045440)]} 0 0
   [junit4]   2> 1324531 INFO  (qtp1367891013-11692) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[120 (1574867262442045440)]} 0 0
   [junit4]   2> 1324532 INFO  (qtp416018098-11668) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[121 (1574867262443094016)]} 0 0
   [junit4]   2> 1324532 INFO  (qtp1367891013-11692) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[121 (1574867262443094016)]} 0 0
   [junit4]   2> 1324533 INFO  (qtp416018098-11674) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[122 (1574867262444142592)]} 0 0
   [junit4]   2> 1324533 INFO  (qtp1367891013-11690) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[122 (1574867262444142592)]} 0 0
   [junit4]   2> 1324534 INFO  (qtp416018098-11673) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[123 (1574867262445191168)]} 0 0
   [junit4]   2> 1324535 INFO  (qtp1367891013-11691) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[123 (1574867262445191168)]} 0 0
   [junit4]   2> 1324535 INFO  (qtp416018098-11673) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[124 (1574867262446239744)]} 0 0
   [junit4]   2> 1324535 INFO  (qtp1367891013-11691) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[124 (1574867262446239744)]} 0 0
   [junit4]   2> 1324536 INFO  (qtp416018098-11668) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[125 (1574867262447288320)]} 0 0
   [junit4]   2> 1324536 INFO  (qtp1367891013-11692) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[125 (1574867262447288320)]} 0 0
   [junit4]   2> 1324537 INFO  (qtp416018098-11668) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[126 (1574867262448336896)]} 0 0
   [junit4]   2> 1324537 INFO  (qtp1367891013-11690) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[126 (1574867262448336896)]} 0 0
   [junit4]   2> 1324538 INFO  (qtp416018098-11675) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[127 (1574867262449385472)]} 0 0
   [junit4]   2> 1324538 INFO  (qtp1367891013-11690) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[127 (1574867262449385472)]} 0 0
   [junit4]   2> 1324539 INFO  (qtp416018098-11673) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[128 (1574867262450434048)]} 0 0
   [junit4]   2> 1324539 INFO  (qtp1367891013-11690) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[128 (1574867262450434048)]} 0 0
   [junit4]   2> 1324540 INFO  (qtp416018098-11674) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[129 (1574867262450434049)]} 0 0
   [junit4]   2> 1324540 INFO  (qtp1367891013-11692) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[129 (1574867262451482624)]} 0 0
   [junit4]   2> 1324541 INFO  (qtp416018098-11668) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[130 (1574867262452531200)]} 0 0
   [junit4]   2> 1324541 INFO  (qtp1367891013-11692) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[130 (1574867262452531200)]} 0 0
   [junit4]   2> 1324542 INFO  (qtp416018098-11675) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[131 (1574867262452531201)]} 0 0
   [junit4]   2> 1324542 INFO  (qtp1367891013-11692) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[131 (1574867262453579776)]} 0 0
   [junit4]   2> 1324542 INFO  (qtp416018098-11673) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[132 (1574867262453579776)]} 0 0
   [junit4]   2> 1324543 INFO  (qtp1367891013-11692) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[132 (1574867262453579777)]} 0 0
   [junit4]   2> 1324543 INFO  (qtp416018098-11674) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[133 (1574867262454628352)]} 0 0
   [junit4]   2> 1324543 INFO  (qtp1367891013-11692) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[133 (1574867262454628352)]} 0 0
   [junit4]   2> 1324544 INFO  (qtp416018098-11668) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[134 (1574867262455676928)]} 0 0
   [junit4]   2> 1324544 INFO  (qtp1367891013-11685) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[134 (1574867262455676928)]} 0 0
   [junit4]   2> 1324545 INFO  (qtp416018098-11675) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[135 (1574867262455676929)]} 0 0
   [junit4]   2> 1324545 INFO  (qtp1367891013-11691) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[135 (1574867262456725504)]} 0 0
   [junit4]   2> 1324546 INFO  (qtp416018098-11673) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[136 (1574867262456725504)]} 0 0
   [junit4]   2> 1324546 INFO  (qtp1367891013-11690) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[136 (1574867262457774080)]} 0 0
   [junit4]   2> 1324546 INFO  (qtp416018098-11674) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[137 (1574867262457774080)]} 0 0
   [junit4]   2> 1324546 INFO  (qtp1367891013-11692) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[137 (1574867262457774081)]} 0 0
   [junit4]   2> 1324547 INFO  (qtp416018098-11668) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[138 (1574867262458822656)]} 0 0
   [junit4]   2> 1324547 INFO  (qtp1367891013-11685) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[138 (1574867262458822656)]} 0 0
   [junit4]   2> 1324548 INFO  (qtp416018098-11675) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[139 (1574867262458822657)]} 0 0
   [junit4]   2> 1324548 INFO  (qtp1367891013-11691) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[139 (1574867262459871232)]} 0 0
   [junit4]   2> 1324548 INFO  (qtp416018098-11673) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[140 (1574867262459871232)]} 0 0
   [junit4]   2> 1324549 INFO  (qtp1367891013-11690) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[140 (1574867262460919808)]} 0 0
   [junit4]   2> 1324549 INFO  (qtp416018098-11674) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[141 (1574867262460919808)]} 0 0
   [junit4]   2> 1324549 INFO  (qtp1367891013-11692) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[141 (1574867262460919809)]} 0 0
   [junit4]   2> 1324550 INFO  (qtp416018098-11668) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[142 (1574867262461968384)]} 0 0
   [junit4]   2> 1324550 INFO  (qtp1367891013-11685) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[142 (1574867262461968384)]} 0 0
   [junit4]   2> 1324551 INFO  (qtp416018098-11675) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[143 (1574867262463016960)]} 0 0
   [junit4]   2> 1324551 INFO  (qtp1367891013-11691) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[143 (1574867262463016960)]} 0 0
   [junit4]   2> 1324552 INFO  (qtp416018098-11673) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[144 (1574867262464065536)]} 0 0
   [junit4]   2> 1324552 INFO  (qtp1367891013-11690) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[144 (1574867262464065536)]} 0 0
   [junit4]   2> 1324552 INFO  (qtp416018098-11674) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[145 (1574867262464065537)]} 0 0
   [junit4]   2> 1324553 INFO  (qtp1367891013-11692) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[145 (1574867262465114112)]} 0 0
   [junit4]   2> 1324553 INFO  (qtp416018098-11668) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[146 (1574867262465114112)]} 0 0
   [junit4]   2> 1324553 INFO  (qtp1367891013-11685) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[146 (1574867262465114113)]} 0 0
   [junit4]   2> 1324554 INFO  (qtp416018098-11675) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[147 (1574867262466162688)]} 0 0
   [junit4]   2> 1324554 INFO  (qtp1367891013-11691) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[147 (1574867262466162688)]} 0 0
   [junit4]   2> 1324554 INFO  (qtp416018098-11673) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[148 (1574867262466162689)]} 0 0
   [junit4]   2> 1324555 INFO  (qtp1367891013-11690) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[148 (1574867262467211264)]} 0 0
   [junit4]   2> 1324555 INFO  (qtp416018098-11674) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[149 (1574867262467211264)]} 0 0
   [junit4]   2> 1324555 INFO  (qtp1367891013-11692) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[149 (1574867262467211265)]} 0 0
   [junit4]   2> 1324555 INFO  (qtp416018098-11668) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1574867262467211265,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1324555 INFO  (qtp416018098-11668) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@56c2af7a 
commitCommandVersion:1574867262467211265
   [junit4]   2> 1324561 INFO  (qtp416018098-11668) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@fbde3e7[collection1] main]
   [junit4]   2> 1324561 INFO  (qtp416018098-11668) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1324562 INFO  (searcherExecutor-5237-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@fbde3e7[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C9)
 Uninverting(_1(7.0.0):C59)))}
   [junit4]   2> 1324562 INFO  (qtp416018098-11668) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 6
   [junit4]   2> 1324563 INFO  (qtp1367891013-11685) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1574867262475599872,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1324563 INFO  (qtp1367891013-11685) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@79fd0ed1 
commitCommandVersion:1574867262475599872
   [junit4]   2> 1324568 INFO  (qtp1367891013-11685) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@17669999[collection1] main]
   [junit4]   2> 1324569 INFO  (qtp1367891013-11685) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1324570 INFO  (searcherExecutor-5248-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@17669999[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C9)
 Uninverting(_1(7.0.0):C59)))}
   [junit4]   2> 1324570 INFO  (qtp1367891013-11685) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 7
   [junit4]   2> 1324571 INFO  (qtp416018098-11675) [    ] 
o.a.s.h.RequestHandlerBase Ignoring exception matching parameter cannot be 
negative
   [junit4]   2> 1324571 INFO  (qtp416018098-11675) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*&distrib=false&start=-1&wt=javabin&version=2} status=400 QTime=0
   [junit4]   2> 1324572 INFO  (qtp416018098-11673) [    ] 
o.a.s.h.RequestHandlerBase Ignoring exception matching parameter cannot be 
negative
   [junit4]   2> 1324572 INFO  (qtp416018098-11673) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*&distrib=false&start=0&rows=-1&wt=javabin&version=2} status=400 
QTime=0
   [junit4]   2> 1324573 INFO  (qtp416018098-11674) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&distrib=false&sort=n_ti1+desc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 1324584 INFO  (qtp1367891013-11692) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_ti1+desc&shard.url=[ff01::114]:33332/|http://127.0.0.1:32893//collection1&rows=10&version=2&q=*:*&NOW=1501910459983&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1324585 INFO  (qtp1367891013-11685) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1501910459983&ids=132,133,135,124,147,104,139,8,140,141&isShard=true&shard.url=[ff01::114]:33332/|http://127.0.0.1:32893//collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1324589 INFO  (qtp1367891013-11691) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&shards=[ff01::114]:33332/|http://127.0.0.1:32893//collection1&sort=n_ti1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=14
   [junit4]   2> 1324597 INFO  (qtp416018098-11668) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&distrib=false&sort=n_ti1+asc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 1324599 INFO  (qtp1367891013-11686) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_ti1+asc&shard.url=http://127.0.0.1:32893//collection1&rows=10&version=2&q=*:*&NOW=1501910460007&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1324600 INFO  (qtp1367891013-11685) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1501910460007&ids=122,1,112,2,6,17,138,7,106,107&isShard=true&shard.url=http://127.0.0.1:32893//collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1324602 INFO  (qtp1367891013-11690) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&shards=http://127.0.0.1:32893//collection1&sort=n_ti1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=4
   [junit4]   2> 1324603 INFO  (qtp416018098-11675) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&distrib=false&sort=n_f1+desc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 1324618 INFO  (qtp1367891013-11691) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_f1+desc&shard.url=[ff01::083]:33332/|[ff01::114]:33332/|[ff01::213]:33332/|http://127.0.0.1:32893//collection1&rows=10&version=2&q=*:*&NOW=1501910460013&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1324619 INFO  (qtp1367891013-11685) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1501910460013&ids=111,122,123,135,15,148,6,117,118,8&isShard=true&shard.url=[ff01::083]:33332/|[ff01::114]:33332/|[ff01::213]:33332/|http://127.0.0.1:32893//collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1324620 INFO  (qtp1367891013-11692) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&shards=[ff01::083]:33332/|[ff01::114]:33332/|[ff01::213]:33332/|http://127.0.0.1:32893//collection1&sort=n_f1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=16
   [junit4]   2> 1324621 INFO  (qtp416018098-11673) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&distrib=false&sort=n_f1+asc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 1324623 INFO  (qtp1367891013-11690) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_f1+asc&shard.url=[ff01::213]:33332/|http://127.0.0.1:32893//collection1|[ff01::083]:33332/&rows=10&version=2&q=*:*&NOW=1501910460031&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1324623 INFO  (qtp1367891013-11685) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1501910460031&ids=133,14,113,103,105,128,119,130,10,142&isShard=true&shard.url=[ff01::213]:33332/|http://127.0.0.1:32893//collection1|[ff01::083]:33332/&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1324625 INFO  (qtp1367891013-11686) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&shards=[ff01::213]:33332/|http://127.0.0.1:32893//collection1|[ff01::083]:33332/&sort=n_f1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=3
   [junit4]   2> 1324626 INFO  (qtp416018098-11674) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&distrib=false&sort=n_tf1+desc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 1324628 INFO  (qtp1367891013-11692) [    ] o.a.s.c.S.Request 
[collection1]  webapp= 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:32893//collection1|[ff01::114]:33332/&rows=10&version=2&q=*:*&NOW=1501910460036&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1324629 INFO  (qtp1367891013-11685) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1501910460036&ids=143,110,122,144,113,136,137,126,138,108&isShard=true&shard.url=http://127.0.0.1:32893//collection1|[ff01::114]:33332/&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1324630 INFO  (qtp1367891013-11691) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&shards=http://127.0.0.1:32893//collection1|[ff01::114]:33332/&sort=n_tf1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=3
   [junit4]   2> 1324631 INFO  (qtp416018098-11668) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&distrib=false&sort=n_tf1+asc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 1324633 INFO  (qtp1367891013-11686) [    ] o.a.s.c.S.Request 
[collection1]  webapp= 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/|http://127.0.0.1:32893//collection1&rows=10&version=2&q=*:*&NOW=1501910460041&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1324634 INFO  (qtp1367891013-11685) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1501910460041&ids=101,146,3,114,148,107,8,140,120,131&isShard=true&shard.url=[ff01::083]:33332/|http://127.0.0.1:32893//collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1324635 INFO  (qtp1367891013-11690) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&shards=[ff01::083]:33332/|http://127.0.0.1:32893//collection1&sort=n_tf1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=2
   [junit4]   2> 1324636 INFO  (qtp416018098-11675) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&distrib=false&sort=n_d1+desc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 1324638 INFO  (qtp1367891013-11691) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_d1+desc&shard.url=[ff01::213]:33332/|http://127.0.0.1:32893//collection1|[ff01::114]:33332/&rows=10&version=2&q=*:*&NOW=1501910460046&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1324638 INFO  (qtp1367891013-11691) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1501910460046&ids=121,12,113,4,17,7,8,9,109,141&isShard=true&shard.url=[ff01::213]:33332/|http://127.0.0.1:32893//collection1|[ff01::114]:33332/&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1324639 INFO  (qtp1367891013-11692) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&shards=[ff01::213]:33332/|http://127.0.0.1:32893//collection1|[ff01::114]:33332/&sort=n_d1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=1
   [junit4]   2> 1324640 INFO  (qtp416018098-11673) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&distrib=false&sort=n_d1+asc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 1324642 INFO  (qtp1367891013-11690) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_d1+asc&shard.url=[ff01::114]:33332/|http://127.0.0.1:32893//collection1|[ff01::083]:33332/|[ff01::213]:33332/&rows=10&version=2&q=*:*&NOW=1501910460050&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1324643 INFO  (qtp1367891013-11690) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1501910460050&ids=143,100,133,145,2,135,102,103,118,140&isShard=true&shard.url=[ff01::114]:33332/|http://127.0.0.1:32893//collection1|[ff01::083]:33332/|[ff01::213]:33332/&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1324643 INFO  (qtp1367891013-11686) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&shards=[ff01::114]:33332/|http://127.0.0.1:32893//collection1|[ff01::083]:33332/|[ff01::213]:33332/&sort=n_d1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=2
   [junit4]   2> 1324644 INFO  (qtp416018098-11674) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&distrib=false&sort=n_td1+desc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 1324646 INFO  (qtp1367891013-11692) [    ] o.a.s.c.S.Request 
[collection1]  webapp= 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:32893//collection1|[ff01::213]:33332/&rows=10&version=2&q=*:*&NOW=1501910460054&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1324650 INFO  (qtp1367891013-11690) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1501910460054&ids=132,100,122,145,146,3,148,128,139,7&isShard=true&shard.url=http://127.0.0.1:32893//collection1|[ff01::213]:33332/&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1324650 INFO  (qtp1367891013-11685) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&shards=http://127.0.0.1:32893//collection1|[ff01::213]:33332/&sort=n_td1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=5
   [junit4]   2> 1324651 INFO  (qtp416018098-11668) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&distrib=false&sort=n_td1+asc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 1324653 INFO  (qtp1367891013-11686) [    ] o.a.s.c.S.Request 
[collection1]  webapp= 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:32893//collection1|[ff01::213]:33332/&rows=10&version=2&q=*:*&NOW=1501910460061&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1324654 INFO  (qtp1367891013-11690) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1501910460061&ids=125,103,5,6,129,119,109,140,130,120&isShard=true&shard.url=http://127.0.0.1:32893//collection1|[ff01::213]:33332/&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1324655 INFO  (qtp1367891013-11691) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&shards=http://127.0.0.1:32893//collection1|[ff01::213]:33332/&sort=n_td1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=2
   [junit4]   2> 1324656 INFO  (qtp416018098-11675) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&distrib=false&sort=n_l1+desc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 1324657 INFO  (qtp1367891013-11685) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_l1+desc&shard.url=[ff01::114]:33332/|http://127.0.0.1:32893//collection1|[ff01::213]:33332/&rows=10&version=2&q=*:*&NOW=1501910460065&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1324658 INFO  (qtp1367891013-11690) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1501910460065&ids=2,124,14,125,17,6,117,118,129,108&isShard=true&shard.url=[ff01::114]:33332/|http://127.0.0.1:32893//collection1|[ff01::213]:33332/&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1324658 INFO  (qtp1367891013-11692) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&shards=[ff01::114]:33332/|http://127.0.0.1:32893//collection1|[ff01::213]:33332/&sort=n_l1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=1
   [junit4]   2> 1324659 INFO  (qtp416018098-11673) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&distrib=false&sort=n_l1+asc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 1324660 INFO  (qtp1367891013-11691) [    ] o.a.s.c.S.Request 
[collection1]  webapp= 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:32893//collection1&rows=10&version=2&q=*:*&NOW=1501910460069&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1324661 INFO  (qtp1367891013-11690) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1501910460069&ids=111,1,12,113,3,104,137,138,149,8&isShard=true&shard.url=http://127.0.0.1:32893//collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1324662 INFO  (qtp1367891013-11686) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&shards=http://127.0.0.1:32893//collection1&sort=n_l1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=1
   [junit4]   2> 1324662 INFO  (qtp416018098-11674) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&distrib=false&sort=n_tl1+desc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 1324665 INFO  (qtp1367891013-11692) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_tl1+desc&shard.url=[ff01::213]:33332/|http://127.0.0.1:32893//collection1&rows=10&version=2&q=*:*&NOW=1501910460073&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1324665 INFO  (qtp1367891013-11690) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1501910460073&ids=100,112,145,102,14,135,137,126,108,140&isShard=true&shard.url=[ff01::213]:33332/|http://127.0.0.1:32893//collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1324666 INFO  (qtp1367891013-11685) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&shards=[ff01::213]:33332/|http://127.0.0.1:32893//collection1&sort=n_tl1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=2
   [junit4]   2> 1324667 INFO  (qtp416018098-11668) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&distrib=false&sort=n_tl1+asc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 1324668 INFO  (qtp1367891013-11686) [    ] o.a.s.c.S.Request 
[collection1]  webapp= 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/|[ff01::213]:33332/|[ff01::083]:33332/|http://127.0.0.1:32893//collection1&rows=10&version=2&q=*:*&NOW=1501910460077&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1324669 INFO  (qtp1367891013-11690) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1501910460077&ids=121,144,122,134,113,125,115,117,109,10&isShard=true&shard.url=[ff01::114]:33332/|[ff01::213]:33332/|[ff01::083]:33332/|http://127.0.0.1:32893//collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1324670 INFO  (qtp1367891013-11691) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&shards=[ff01::114]:33332/|[ff01::213]:33332/|[ff01::083]:33332/|http://127.0.0.1:32893//collection1&sort=n_tl1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=1
   [junit4]   2> 1324670 INFO  (qtp416018098-11675) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&distrib=false&sort=n_dt1+desc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 1324672 INFO  (qtp1367891013-11685) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_dt1+desc&shard.url=[ff01::213]:33332/|[ff01::083]:33332/|[ff01::114]:33332/|http://127.0.0.1:32893//collection1&rows=10&version=2&q=*:*&NOW=1501910460080&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1324678 INFO  (qtp1367891013-11690) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1501910460080&ids=132,11,2,134,3,139,118,9,109,141&isShard=true&shard.url=[ff01::213]:33332/|[ff01::083]:33332/|[ff01::114]:33332/|http://127.0.0.1:32893//collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1324679 INFO  (qtp1367891013-11692) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&shards=[ff01::213]:33332/|[ff01::083]:33332/|[ff01::114]:33332/|http://127.0.0.1:32893//collection1&sort=n_dt1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=7
   [junit4]   2> 1324680 INFO  (qtp416018098-11673) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&distrib=false&sort=n_dt1+asc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 1324681 INFO  (qtp1367891013-11691) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_dt1+asc&shard.url=http://127.0.0.1:32893//collection1&rows=10&version=2&q=*:*&NOW=1501910460089&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1324682 INFO  (qtp1367891013-11690) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1501910460089&ids=1,112,13,102,124,148,137,127,138,10&isShard=true&shard.url=http://127.0.0.1:32893//collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1324682 INFO  (qtp1367891013-11686) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&shards=http://127.0.0.1:32893//collection1&sort=n_dt1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=2
   [junit4]   2> 1324683 INFO  (qtp416018098-11674) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&distrib=false&sort=n_tdt1+desc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 1324684 INFO  (qtp1367891013-11692) [    ] o.a.s.c.S.Request 
[collection1]  webapp= 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:32893//collection1|[ff01::083]:33332/|[ff01::213]:33332/&rows=10&version=2&q=*:*&NOW=1501910460093&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1324685 INFO  (qtp1367891013-11690) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1501910460093&ids=143,111,14,136,103,126,104,7,107,142&isShard=true&shard.url=http://127.0.0.1:32893//collection1|[ff01::083]:33332/|[ff01::213]:33332/&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1324685 INFO  (qtp1367891013-11685) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&shards=http://127.0.0.1:32893//collection1|[ff01::083]:33332/|[ff01::213]:33332/&sort=n_tdt1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=1
   [junit4]   2> 1324686 INFO  (qtp416018098-11668) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&distrib=false&sort=n_tdt1+asc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 1324687 INFO  (qtp1367891013-11686) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_tdt1+asc&shard.url=http://127.0.0.1:32893//collection1|[ff01::213]:33332/&rows=10&version=2&q=*:*&NOW=1501910460095&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1324687 INFO  (qtp1367891013-11690) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1501910460095&ids=11,12,122,101,114,138,139,117,118,120&isShard=true&shard.url=http://127.0.0.1:32893//collection1|[ff01::213]:33332/&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1324688 INFO  (qtp1367891013-11691) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&shards=http://127.0.0.1:32893//collection1|[ff01::213]:33332/&sort=n_tdt1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=1
   [junit4]   2> 1324689 INFO  (qtp416018098-11675) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&distrib=false&sort=a_i1+desc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 1324690 INFO  (qtp1367891013-11685) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=a_i1+desc&shard.url=[ff01::114]:33332/|http://127.0.0.1:32893//collection1|[ff01::083]:33332/|[ff01::213]:33332/&rows=10&version=2&q=*:*&NOW=1501910460098&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1324691 INFO  (qtp1367891013-11690) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1501910460098&ids=1,12,2,13,3,5,7,8,9,10&isShard=true&shard.url=[ff01::114]:33332/|http://127.0.0.1:32893//collection1|[ff01::083]:33332/|[ff01::213]:33332/&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1324691 INFO  (qtp1367891013-11692) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&shards=[ff01::114]:33332/|http://127.0.0.1:32893//collection1|[ff01::083]:33332/|[ff01::213]:33332/&sort=a_i1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=1
   [junit4]   2> 1324692 INFO  (qtp416018098-11673) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&distrib=false&sort={!func}testfunc(add(a_i1,5))+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=0
   [junit4]   2> 1324693 INFO  (qtp1367891013-11691) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort={!func}testfunc(add(a_i1,5))+desc&shard.url=[ff01::114]:33332/|[ff01::083]:33332/|[ff01::213]:33332/|http://127.0.0.1:32893//collection1&rows=10&version=2&q=*:*&NOW=1501910460102&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1324694 INFO  (qtp1367891013-11690) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1501910460102&ids=1,12,2,13,3,5,7,8,9,10&isShard=true&shard.url=[ff01::114]:33332/|[ff01::083]:33332/|[ff01::213]:33332/|http://127.0.0.1:32893//collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1324695 INFO  (qtp1367891013-11686) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&shards=[ff01::114]:33332/|[ff01::083]:33332/|[ff01::213]:33332/|http://127.0.0.1:32893//collection1&sort={!func}testfunc(add(a_i1,5))+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=2
   [junit4]   2> 1324696 INFO  (qtp416018098-11674) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=a_i1[*+TO+*]&distrib=false&sort=a_i1+asc&wt=javabin&version=2} 
hits=13 status=0 QTime=0
   [junit4]   2> 1324697 INFO  (qtp1367891013-11692) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=a_i1+asc&shard.url=[ff01::114]:33332/|[ff01::213]:33332/|[ff01::083]:33332/|http://127.0.0.1:32893//collection1&rows=10&version=2&q=a_i1[*+TO+*]&NOW=1501910460106&isShard=true&wt=javabin}
 hits=13 status=0 QTime=0
   [junit4]   2> 1324698 INFO  (qtp1367891013-11690) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=a_i1[*+TO+*]&df=text&distrib=false&shards.purpose=64&NOW=1501910460106&ids=11,12,1,13,2,3,4,6,7,9&isShard=true&shard.url=[ff01::114]:33332/|[ff01::213]:33332/|[ff01::083]:33332/|http://127.0.0.1:32893//collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1324699 INFO  (qtp1367891013-11685) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=a_i1[*+TO+*]&shards=[ff01::114]:33332/|[ff01::213]:33332/|[ff01::083]:33332/|http://127.0.0.1:32893//collection1&sort=a_i1+asc&wt=javabin&version=2}
 hits=13 status=0 QTime=1
   [junit4]   2> 1324700 INFO  (qtp416018098-11668) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&distrib=false&sort=a_i1+asc,+id+desc&wt=javabin&version=2} 
hits=68 status=0 QTime=0
   [junit4]   2> 1324702 INFO  (qtp1367891013-11686) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=a_i1+asc,+id+desc&shard.url=http://127.0.0.1:32893//collection1|[ff01::114]:33332/|[ff01::083]:33332/|[ff01::213]:33332/&rows=10&version=2&q=*:*&NOW=1501910460110&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1324703 INFO  (qtp1367891013-11686) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1501910460110&ids=11,12,1,13,2,3,4,6,7,9&isShard=true&shard.url=http://127.0.0.1:32893//collection1|[ff01::114]:33332/|[ff01::083]:33332/|[ff01::213]:33332/&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1324703 INFO  (qtp1367891013-11691) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&shards=http://127.0.0.1:32893//collection1|[ff01::114]:33332/|[ff01::083]:33332/|[ff01::213]:33332/&sort=a_i1+asc,+id+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=2
   [junit4]   2> 1324704 INFO  (qtp416018098-11675) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&distrib=false&fl=*,score&sort=a_i1+desc&wt=javabin&version=2} 
hits=68 status=0 QTime=0
   [junit4]   2> 1324705 INFO  (qtp1367891013-11691) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={df=text&distrib=false&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&sort=a_i1+desc&shard.url=http://127.0.0.1:32893//collection1|[ff01::083]:33332/|[ff01::114]:33332/&rows=10&version=2&q=*:*&NOW=1501910460114&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1324706 INFO  (qtp1367891013-11691) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&df=text&distrib=false&fl=*,score&shards.purpose=64&NOW=1501910460114&ids=1,12,2,13,3,5,7,8,9,10&isShard=true&shard.url=http://127.0.0.1:32893//collection1|[ff01::083]:33332/|[ff01::114]:33332/&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1324707 INFO  (qtp1367891013-11692) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&shards=http://127.0.0.1:32893//collection1|[ff01::083]:33332/|[ff01::114]:33332/&fl=*,score&sort=a_i1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=1
   [junit4]   2> 1324708 INFO  (qtp416018098-11673) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&distrib=false&fl=*,score&sort=n_tl1+asc&wt=javabin&version=2} 
hits=68 status=0 QTime=0
   [junit4]   2> 1324709 INFO  (qtp1367891013-11691) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={df=text&distrib=false&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&sort=n_tl1+asc&shard.url=[ff01::213]:33332/|http://127.0.0.1:32893//collection1|[ff01::083]:33332/&rows=10&version=2&q=*:*&NOW=1501910460117&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1324710 INFO  (qtp1367891013-11685) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&df=text&distrib=false&fl=*,score&shards.purpose=64&NOW=1501910460117&ids=121,144,122,134,113,125,115,117,109,10&isShard=true&shard.url=[ff01::213]:33332/|http://127.0.0.1:32893//collection1|[ff01::083]:33332/&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1324711 INFO  (qtp1367891013-11692) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&shards=[ff01::213]:33332/|http://127.0.0.1:32893//collection1|[ff01::083]:33332/&fl=*,score&sort=n_tl1+asc&wt=javabin&version=2}
 hits=68 status=0 QTime=2
   [junit4]   2> 1324712 INFO  (qtp416018098-11674) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&distrib=false&sort=n_tl1+desc&wt=javabin&version=2} hits=68 
status=0 QTime=0
   [junit4]   2> 1324713 INFO  (qtp1367891013-11686) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_tl1+desc&shard.url=http://127.0.0.1:32893//collection1|[ff01::213]:33332/|[ff01::083]:33332/&rows=10&version=2&q=*:*&NOW=1501910460121&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1324714 INFO  (qtp1367891013-11685) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1501910460121&ids=100,112,145,102,14,135,137,126,108,140&isShard=true&shard.url=http://127.0.0.1:32893//collection1|[ff01::213]:33332/|[ff01::083]:33332/&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1324714 INFO  (qtp1367891013-11690) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q=*:*&shards=http://127.0.0.1:32893//collection1|[ff01::213]:33332/|[ff01::083]:33332/&sort=n_tl1+desc&wt=javabin&version=2}
 hits=68 status=0 QTime=2
   [junit4]   2> 1324715 INFO  (qtp416018098-11668) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q={!func}a_i1&distrib=false&wt=javabin&version=2} hits=68 status=0 
QTime=0
   [junit4]   2> 1324717 INFO  (qtp1367891013-11692) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={df=text&distrib=false&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=[ff01::083]:33332/|http://127.0.0.1:32893//collection1&rows=10&version=2&q={!func}a_i1&NOW=1501910460125&isShard=true&wt=javabin}
 hits=68 status=0 QTime=0
   [junit4]   2> 1324717 INFO  (qtp1367891013-11692) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q={!func}a_i1&df=text&distrib=false&shards.purpose=64&NOW=1501910460125&ids=1,12,2,13,3,5,7,8,9,10&isShard=true&shard.url=[ff01::083]:33332/|http://127.0.0.1:32893//collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1324718 INFO  (qtp1367891013-11691) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q={!func}a_i1&shards=[ff01::083]:33332/|http://127.0.0.1:32893//collection1&wt=javabin&version=2}
 hits=68 status=0 QTime=1
   [junit4]   2> 1324719 INFO  (qtp416018098-11675) [    ] o.a.s.c.S.Request 
[collection1]  webapp= path=/select 
params={q={!func}a_i1&distrib=false&fl=*,score&wt=javabin&versi

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

g=null
   [junit4]   2> 1332906 INFO  
(TEST-TestDistributedSearch.test-seed#[81C6880737673323]) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 1332906 INFO  (coreCloseExecutor-5253-thread-1) [    ] 
o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@390ca79c
   [junit4]   2> 1332907 INFO  (coreCloseExecutor-5253-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=957130652
   [junit4]   2> 1332934 INFO  
(TEST-TestDistributedSearch.test-seed#[81C6880737673323]) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@224388e3{/,null,UNAVAILABLE}
   [junit4]   2> 1332935 INFO  
(TEST-TestDistributedSearch.test-seed#[81C6880737673323]) [    ] 
o.e.j.s.AbstractConnector Stopped 
ServerConnector@71f5ede4{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 1332935 INFO  
(TEST-TestDistributedSearch.test-seed#[81C6880737673323]) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1419202956
   [junit4]   2> 1332935 INFO  
(TEST-TestDistributedSearch.test-seed#[81C6880737673323]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 1332935 INFO  
(TEST-TestDistributedSearch.test-seed#[81C6880737673323]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 1332935 INFO  
(TEST-TestDistributedSearch.test-seed#[81C6880737673323]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 1332936 INFO  
(TEST-TestDistributedSearch.test-seed#[81C6880737673323]) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 1332936 INFO  (coreCloseExecutor-5255-thread-1) [    ] 
o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@5bc4d109
   [junit4]   2> 1332939 INFO  (coreCloseExecutor-5255-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=1539625225
   [junit4]   2> 1332940 INFO  
(TEST-TestDistributedSearch.test-seed#[81C6880737673323]) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@395382db{/,null,UNAVAILABLE}
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=TestDistributedSearch -Dtests.method=test 
-Dtests.seed=81C6880737673323 -Dtests.multiplier=3 -Dtests.slow=true 
-Dtests.locale=ms -Dtests.timezone=EAT -Dtests.asserts=true 
-Dtests.file.encoding=UTF-8
   [junit4] ERROR   9.68s J1 | TestDistributedSearch.test <<<
   [junit4]    > Throwable #1: 
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error 
from server at http://127.0.0.1:38747//collection1: ERROR: [doc=1] Error adding 
field 'severity'='Not Available' msg=EnumFieldType requires docValues="true".
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([81C6880737673323:992B7DD999B5EDB]:0)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:627)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:253)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:242)
   [junit4]    >        at 
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:178)
   [junit4]    >        at 
org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:173)
   [junit4]    >        at 
org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:138)
   [junit4]    >        at 
org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:152)
   [junit4]    >        at 
org.apache.solr.BaseDistributedSearchTestCase.indexDoc(BaseDistributedSearchTestCase.java:483)
   [junit4]    >        at 
org.apache.solr.BaseDistributedSearchTestCase.indexr(BaseDistributedSearchTestCase.java:465)
   [junit4]    >        at 
org.apache.solr.TestDistributedSearch.test(TestDistributedSearch.java:1052)
   [junit4]    >        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   [junit4]    >        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
   [junit4]    >        at 
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   [junit4]    >        at 
java.base/java.lang.reflect.Method.invoke(Method.java:564)
   [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.base/java.lang.Thread.run(Thread.java:844)
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_81C6880737673323-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): 
{rnd_b=PostingsFormat(name=MockRandom), a_s=Lucene50(blocksize=128), 
foo_sev_enum=PostingsFormat(name=MockRandom), 
SubjectTerms_mfacet=PostingsFormat(name=LuceneFixedGap), 
oddField_s=Lucene50(blocksize=128), 
multiDefault=PostingsFormat(name=LuceneVarGapFixedInterval), 
lowerfilt1and2=PostingsFormat(name=LuceneVarGapFixedInterval), 
a_t=PostingsFormat(name=LuceneFixedGap), foo_b=Lucene50(blocksize=128), 
lowerfilt=PostingsFormat(name=LuceneVarGapFixedInterval), 
id=PostingsFormat(name=MockRandom), text=Lucene50(blocksize=128)}, 
docValues:{other_tl1=DocValuesFormat(name=Asserting), 
range_facet_l_dv=DocValuesFormat(name=Lucene70), 
foo_sev_enum=DocValuesFormat(name=Lucene70), 
n_l1=DocValuesFormat(name=Asserting), a_n_tdt=DocValuesFormat(name=Lucene70), 
intDefault=DocValuesFormat(name=Asserting), 
n_dt1=DocValuesFormat(name=Lucene70), a_i1=DocValuesFormat(name=Asserting), 
n_td1=DocValuesFormat(name=Lucene70), b_n_tdt=DocValuesFormat(name=Asserting), 
n_d1=DocValuesFormat(name=Asserting), 
range_facet_l=DocValuesFormat(name=Asserting), 
n_f1=DocValuesFormat(name=Lucene70), n_ti1=DocValuesFormat(name=Lucene70), 
n_tl1=DocValuesFormat(name=Lucene70), 
_version_=DocValuesFormat(name=Asserting), 
n_tf1=DocValuesFormat(name=Asserting), n_tdt1=DocValuesFormat(name=Asserting), 
id_i1=DocValuesFormat(name=Lucene70), foo_d=DocValuesFormat(name=Lucene70), 
range_facet_i_dv=DocValuesFormat(name=Asserting), 
foo_f=DocValuesFormat(name=Memory), intDvoDefault=DocValuesFormat(name=Memory), 
timestamp=DocValuesFormat(name=Asserting)}, maxPointsInLeafNode=557, 
maxMBSortInHeap=6.199624544272822, sim=RandomSimilarity(queryNorm=true): {}, 
locale=ms, timezone=EAT
   [junit4]   2> NOTE: Linux 4.10.0-27-generic amd64/Oracle Corporation 9 
(64-bit)/cpus=8,threads=1,free=200312320,total=536870912
   [junit4]   2> NOTE: All tests run in this JVM: [CoreAdminCreateDiscoverTest, 
TlogReplayBufferedWhileIndexingTest, ShardRoutingTest, TestFieldTypeResource, 
TestConfigReload, SampleTest, TestPartialUpdateDeduplication, 
RequestLoggingTest, BlockCacheTest, TestHashPartitioner, LoggingHandlerTest, 
TestStressRecovery, SparseHLLTest, SpellCheckCollatorWithCollapseTest, 
TestConfigSets, BasicAuthStandaloneTest, TestInitQParser, 
StatelessScriptUpdateProcessorFactoryTest, TestPerFieldSimilarity, 
HdfsBasicDistributedZkTest, SolrCmdDistributorTest, SuggestComponentTest, 
TestScoreJoinQPScore, TestSolr4Spatial2, ZkSolrClientTest, 
DistributedTermsComponentTest, DistributedFacetPivotSmallAdvancedTest, 
DistanceFunctionTest, JavabinLoaderTest, TestCoreDiscovery, 
OverseerTaskQueueTest, SoftAutoCommitTest, HdfsDirectoryFactoryTest, 
TestManagedSchema, DistributedFacetExistsSmallTest, 
AtomicUpdateProcessorFactoryTest, InfoHandlerTest, TestRTGBase, 
TestRequestForwarding, TestFuzzyAnalyzedSuggestions, TestBM25SimilarityFactory, 
HighlighterTest, AsyncCallRequestStatusResponseTest, LukeRequestHandlerTest, 
BasicFunctionalityTest, HdfsRecoveryZkTest, SolrShardReporterTest, 
TestCoreContainer, DistanceUnitsTest, SolrCloudExampleTest, SliceStateTest, 
ActionThrottleTest, TestSQLHandlerNonCloud, SOLR749Test, ZkCLITest, 
DistribJoinFromCollectionTest, UpdateRequestProcessorFactoryTest, 
OutOfBoxZkACLAndCredentialsProvidersTest, TestDelegationWithHadoopAuth, 
TestPullReplica, TestLegacyNumericUtils, TestSubQueryTransformerDistrib, 
TestCursorMarkWithoutUniqueKey, TestSystemCollAutoCreate, 
BlockJoinFacetRandomTest, SystemInfoHandlerTest, UpdateLogTest, 
OverseerModifyCollectionTest, DOMUtilTest, FacetPivotSmallTest, TestLockTree, 
ZkControllerTest, TestSolrJ, TestSortByMinMaxFunction, DeleteStatusTest, 
TestValueSourceCache, TestSlowCompositeReaderWrapper, TestMissingGroups, 
FileUtilsTest, MergeStrategyTest, HdfsWriteToMultipleCollectionsTest, 
TestApiFramework, RemoteQueryErrorTest, TestRestManager, 
TestAtomicUpdateErrorCases, CustomCollectionTest, TestGraphMLResponseWriter, 
TestJsonFacets, TestUninvertingReader, CdcrVersionReplicationTest, 
TestQueryWrapperFilter, MissingSegmentRecoveryTest, AnalyticsQueryTest, 
TestCloudDeleteByQuery, TestFieldCollectionResource, 
TestManagedSynonymGraphFilterFactory, DirectSolrConnectionTest, TestLRUCache, 
TestReqParamsAPI, TestSegmentSorting, ShufflingReplicaListTransformerTest, 
TestTlogReplica, ShardRoutingCustomTest, DisMaxRequestHandlerTest, 
TestFiltering, CdcrUpdateLogTest, TestFilteredDocIdSet, ZkStateReaderTest, 
TestConfigSetsAPIExclusivity, SharedFSAutoReplicaFailoverUtilsTest, 
ClusterStateUpdateTest, TestSchemaSimilarityResource, TestFieldCache, 
TestUpdate, DocExpirationUpdateProcessorFactoryTest, 
TestLeaderElectionZkExpiry, TestSolrXml, TestSimpleTrackingShardHandler, 
ChaosMonkeySafeLeaderTest, UnloadDistributedZkTest, 
CollectionsAPIDistributedZkTest, SyncSliceTest, OpenCloseCoreStressTest, 
BasicZkTest, RecoveryZkTest, FullSolrCloudDistribCmdsTest, TestRandomFaceting, 
TestDistributedSearch]
   [junit4] Completed [374/727 (1!)] on J1 in 9.70s, 1 test, 1 error <<< 
FAILURES!

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

Reply via email to