Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Linux/205/
Java: 64bit/jdk-9-ea+178 -XX:+UseCompressedOops -XX:+UseParallelGC 
--illegal-access=deny

2 tests failed.
FAILED:  org.apache.solr.update.HardAutoCommitTest.testCommitWithin

Error Message:
Exception during query

Stack Trace:
java.lang.RuntimeException: Exception during query
        at 
__randomizedtesting.SeedInfo.seed([B6ECC9258FCA2FBC:C3EA65D0CE4C1A9]:0)
        at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:886)
        at 
org.apache.solr.update.HardAutoCommitTest.testCommitWithin(HardAutoCommitTest.java:100)
        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 
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)
Caused by: java.lang.RuntimeException: REQUEST FAILED: 
xpath=//result[@numFound=1]
        xml response was: <?xml version="1.0" encoding="UTF-8"?>
<response>
<lst name="responseHeader"><int name="status">0</int><int 
name="QTime">0</int></lst><result name="response" numFound="0" 
start="0"></result>
</response>

        request was:q=id:529&qt=&start=0&rows=20&version=2.2
        at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:879)
        ... 39 more


FAILED:  org.apache.solr.TestDistributedSearch.test

Error Message:
Error from server at http://127.0.0.1:41115/_rwi/e/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:41115/_rwi/e/collection1: ERROR: [doc=1] Error 
adding field 'severity'='Not Available' msg=EnumFieldType requires 
docValues="true".
        at 
__randomizedtesting.SeedInfo.seed([B6ECC9258FCA2FBC:3EB8F6FF21364244]: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 10860 lines...]
   [junit4] Suite: org.apache.solr.update.HardAutoCommitTest
   [junit4]   2> 3651 INFO  
(SUITE-HardAutoCommitTest-seed#[B6ECC9258FCA2FBC]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> Creating dataDir: 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.update.HardAutoCommitTest_B6ECC9258FCA2FBC-001/init-core-data-001
   [junit4]   2> 3652 WARN  
(SUITE-HardAutoCommitTest-seed#[B6ECC9258FCA2FBC]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=2 numCloses=2
   [junit4]   2> 3652 INFO  
(SUITE-HardAutoCommitTest-seed#[B6ECC9258FCA2FBC]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 3653 INFO  
(SUITE-HardAutoCommitTest-seed#[B6ECC9258FCA2FBC]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: 
@org.apache.solr.util.RandomizeSSL(reason="", value=0.0/0.0, ssl=0.0/0.0, 
clientAuth=0.0/0.0)
   [junit4]   2> 3654 INFO  
(SUITE-HardAutoCommitTest-seed#[B6ECC9258FCA2FBC]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 3654 INFO  
(SUITE-HardAutoCommitTest-seed#[B6ECC9258FCA2FBC]-worker) [    ] 
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: 
[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/lib,
 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 3693 INFO  
(SUITE-HardAutoCommitTest-seed#[B6ECC9258FCA2FBC]-worker) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.1.0
   [junit4]   2> 3737 INFO  
(SUITE-HardAutoCommitTest-seed#[B6ECC9258FCA2FBC]-worker) [    ] 
o.a.s.s.IndexSchema [null] Schema name=test
   [junit4]   2> 3922 INFO  
(SUITE-HardAutoCommitTest-seed#[B6ECC9258FCA2FBC]-worker) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 4037 WARN  
(SUITE-HardAutoCommitTest-seed#[B6ECC9258FCA2FBC]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter No JMX server found. Not exposing Solr metrics via 
JMX.
   [junit4]   2> 4037 WARN  
(SUITE-HardAutoCommitTest-seed#[B6ECC9258FCA2FBC]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter No JMX server found. Not exposing Solr metrics via 
JMX.
   [junit4]   2> 4037 WARN  
(SUITE-HardAutoCommitTest-seed#[B6ECC9258FCA2FBC]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter No JMX server found. Not exposing Solr metrics via 
JMX.
   [junit4]   2> 4041 INFO  (coreLoadExecutor-18-thread-1) [    ] 
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: 
[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/lib,
 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 4072 INFO  (coreLoadExecutor-18-thread-1) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.1.0
   [junit4]   2> 4100 INFO  (coreLoadExecutor-18-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 4215 INFO  (coreLoadExecutor-18-thread-1) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 4251 INFO  (coreLoadExecutor-18-thread-1) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from 
instancedir 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1,
 trusted=true
   [junit4]   2> 4251 WARN  (coreLoadExecutor-18-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter No JMX server found. Not exposing Solr metrics via 
JMX.
   [junit4]   2> 4252 INFO  (coreLoadExecutor-18-thread-1) [    ] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 4252 INFO  (coreLoadExecutor-18-thread-1) [    ] 
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.update.HardAutoCommitTest_B6ECC9258FCA2FBC-001/init-core-data-001/]
   [junit4]   2> 4253 INFO  (coreLoadExecutor-18-thread-1) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=34, maxMergeAtOnceExplicit=11, maxMergedSegmentMB=46.546875, 
floorSegmentMB=2.0322265625, forceMergeDeletesPctAllowed=22.08892809269672, 
segmentsPerTier=11.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.6983661947315518
   [junit4]   2> 4264 WARN  (coreLoadExecutor-18-thread-1) [    ] 
o.a.s.c.SolrResourceLoader Solr loaded a deprecated plugin/analysis class 
[solr.OldLuceneQParserPlugin]. Please consult documentation how to replace it 
accordingly.
   [junit4]   2> 4372 INFO  (coreLoadExecutor-18-thread-1) [    ] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 4373 INFO  (coreLoadExecutor-18-thread-1) [    ] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 4379 INFO  (coreLoadExecutor-18-thread-1) [    ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 4380 INFO  (coreLoadExecutor-18-thread-1) [    ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 4380 INFO  (coreLoadExecutor-18-thread-1) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=24, maxMergeAtOnceExplicit=32, maxMergedSegmentMB=91.4873046875, 
floorSegmentMB=0.259765625, forceMergeDeletesPctAllowed=5.7127552017162895, 
segmentsPerTier=43.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.24461183534412836
   [junit4]   2> 4381 INFO  (coreLoadExecutor-18-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@3de53bed[collection1] main]
   [junit4]   2> 4382 INFO  (coreLoadExecutor-18-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 4434 INFO  (coreLoadExecutor-18-thread-1) [    ] 
o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 4554 INFO  (coreLoadExecutor-18-thread-1) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 4554 INFO  (searcherExecutor-19-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 4555 INFO  (searcherExecutor-19-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 4555 INFO  (searcherExecutor-19-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 4555 INFO  (searcherExecutor-19-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 4556 INFO  (searcherExecutor-19-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 4559 INFO  (searcherExecutor-19-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 4559 INFO  (searcherExecutor-19-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 4560 INFO  (searcherExecutor-19-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 4563 INFO  (searcherExecutor-19-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 4565 INFO  (searcherExecutor-19-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@3de53bed[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 4575 INFO  (coreLoadExecutor-18-thread-1) [    ] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1574877129200369664
   [junit4]   2> 4585 INFO  
(SUITE-HardAutoCommitTest-seed#[B6ECC9258FCA2FBC]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 4590 INFO  
(TEST-HardAutoCommitTest.testCommitWithin-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testCommitWithin
   [junit4]   2> 4599 INFO  
(TEST-HardAutoCommitTest.testCommitWithin-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 4600 INFO  
(TEST-HardAutoCommitTest.testCommitWithin-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@5fef92a8[collection1] realtime]
   [junit4]   2> 4600 INFO  
(TEST-HardAutoCommitTest.testCommitWithin-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}{deleteByQuery=*:*
 (-9223372036854775807)} 0 4
   [junit4]   2> 4603 ERROR 
(TEST-HardAutoCommitTest.testCommitWithin-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.c.CorePropertiesLocator Couldn't load core descriptor from 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/core.properties:java.nio.file.NoSuchFileException:
 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/core.properties
   [junit4]   2> 4604 INFO  
(TEST-HardAutoCommitTest.testCommitWithin-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: 
[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/lib,
 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 4648 INFO  
(TEST-HardAutoCommitTest.testCommitWithin-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.1.0
   [junit4]   2> 4683 INFO  
(TEST-HardAutoCommitTest.testCommitWithin-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 4837 INFO  
(TEST-HardAutoCommitTest.testCommitWithin-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 4881 INFO  
(TEST-HardAutoCommitTest.testCommitWithin-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using configuration from 
instancedir 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1
   [junit4]   2> 4885 WARN  
(TEST-HardAutoCommitTest.testCommitWithin-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.m.r.SolrJmxReporter No JMX server found. Not exposing Solr metrics via 
JMX.
   [junit4]   2> 4885 INFO  
(TEST-HardAutoCommitTest.testCommitWithin-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.update.HardAutoCommitTest_B6ECC9258FCA2FBC-001/init-core-data-001/]
   [junit4]   2> 5002 INFO  
(TEST-HardAutoCommitTest.testCommitWithin-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 5002 INFO  
(TEST-HardAutoCommitTest.testCommitWithin-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 5004 INFO  
(TEST-HardAutoCommitTest.testCommitWithin-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@1f1da9b[collection1] main]
   [junit4]   2> 5005 INFO  
(TEST-HardAutoCommitTest.testCommitWithin-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 5008 INFO  
(TEST-HardAutoCommitTest.testCommitWithin-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 5013 INFO  
(TEST-HardAutoCommitTest.testCommitWithin-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 5014 INFO  
(TEST-HardAutoCommitTest.testCommitWithin-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1574877129660694528
   [junit4]   2> 5023 INFO  (searcherExecutor-24-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 5041 INFO  (searcherExecutor-24-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 5042 INFO  
(TEST-HardAutoCommitTest.testCommitWithin-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=18, maxMergeAtOnceExplicit=42, maxMergedSegmentMB=30.7001953125, 
floorSegmentMB=0.6376953125, forceMergeDeletesPctAllowed=22.672333894633464, 
segmentsPerTier=19.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 5042 INFO  (searcherExecutor-24-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 5042 INFO  (searcherExecutor-24-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 5043 INFO  
(TEST-HardAutoCommitTest.testCommitWithin-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 5044 INFO  (searcherExecutor-24-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 5045 INFO  (searcherExecutor-24-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 5046 INFO  (searcherExecutor-24-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 5047 INFO  (searcherExecutor-24-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 5048 INFO  (searcherExecutor-24-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 5049 INFO  (searcherExecutor-24-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@1f1da9b[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 5050 INFO  
(TEST-HardAutoCommitTest.testCommitWithin-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@6dd7616f[collection1] main]
   [junit4]   2> 5050 INFO  
(TEST-HardAutoCommitTest.testCommitWithin-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@50aeadad
   [junit4]   2> 5052 INFO  
(TEST-HardAutoCommitTest.testCommitWithin-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=1353625005
   [junit4]   2> 5069 INFO  (searcherExecutor-24-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@6dd7616f[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 5103 INFO  
(TEST-HardAutoCommitTest.testCommitWithin-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[529 
(1574877129705783296)]} 0 49
   [junit4]   2> 5105 INFO  
(TEST-HardAutoCommitTest.testCommitWithin-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:529&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=1
   [junit4]   2> 5109 INFO  
(TEST-HardAutoCommitTest.testCommitWithin-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[530 
(1574877129759260672)]} 0 54
   [junit4]   2> 5109 INFO  
(TEST-HardAutoCommitTest.testCommitWithin-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:530&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
   [junit4]   2> 5111 INFO  
(TEST-HardAutoCommitTest.testCommitWithin-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[529 
(-1574877129761357824)]} 0 56
   [junit4]   2> 5111 INFO  
(TEST-HardAutoCommitTest.testCommitWithin-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:529&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
   [junit4]   2> 5112 ERROR 
(TEST-HardAutoCommitTest.testCommitWithin-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.SolrTestCaseJ4 REQUEST FAILED: xpath=//result[@numFound=1]
   [junit4]   2>        xml response was: <?xml version="1.0" encoding="UTF-8"?>
   [junit4]   2> <response>
   [junit4]   2> <lst name="responseHeader"><int name="status">0</int><int 
name="QTime">0</int></lst><result name="response" numFound="0" 
start="0"></result>
   [junit4]   2> </response>
   [junit4]   2> 
   [junit4]   2>        request was:q=id:529&qt=&start=0&rows=20&version=2.2
   [junit4]   2> 5113 ERROR 
(TEST-HardAutoCommitTest.testCommitWithin-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.SolrTestCaseJ4 REQUEST FAILED: 
q=id:529&qt=&start=0&rows=20&version=2.2:java.lang.RuntimeException: REQUEST 
FAILED: xpath=//result[@numFound=1]
   [junit4]   2>        xml response was: <?xml version="1.0" encoding="UTF-8"?>
   [junit4]   2> <response>
   [junit4]   2> <lst name="responseHeader"><int name="status">0</int><int 
name="QTime">0</int></lst><result name="response" numFound="0" 
start="0"></result>
   [junit4]   2> </response>
   [junit4]   2> 
   [junit4]   2>        request was:q=id:529&qt=&start=0&rows=20&version=2.2
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:879)
   [junit4]   2>        at 
org.apache.solr.update.HardAutoCommitTest.testCommitWithin(HardAutoCommitTest.java:100)
   [junit4]   2>        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   [junit4]   2>        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
   [junit4]   2>        at 
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   [junit4]   2>        at 
java.base/java.lang.reflect.Method.invoke(Method.java:564)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
   [junit4]   2>        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
   [junit4]   2>        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
   [junit4]   2>        at java.base/java.lang.Thread.run(Thread.java:844)
   [junit4]   2> 
   [junit4]   2> 5114 INFO  
(TEST-HardAutoCommitTest.testCommitWithin-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testCommitWithin
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=HardAutoCommitTest 
-Dtests.method=testCommitWithin -Dtests.seed=B6ECC9258FCA2FBC 
-Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=or 
-Dtests.timezone=America/Regina -Dtests.asserts=true -Dtests.file.encoding=UTF-8
   [junit4] ERROR   0.54s J2 | HardAutoCommitTest.testCommitWithin <<<
   [junit4]    > Throwable #1: java.lang.RuntimeException: Exception during 
query
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([B6ECC9258FCA2FBC:C3EA65D0CE4C1A9]:0)
   [junit4]    >        at 
org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:886)
   [junit4]    >        at 
org.apache.solr.update.HardAutoCommitTest.testCommitWithin(HardAutoCommitTest.java:100)
   [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 java.base/java.lang.Thread.run(Thread.java:844)
   [junit4]    > Caused by: java.lang.RuntimeException: REQUEST FAILED: 
xpath=//result[@numFound=1]
   [junit4]    >        xml response was: <?xml version="1.0" encoding="UTF-8"?>
   [junit4]    > <response>
   [junit4]    > <lst name="responseHeader"><int name="status">0</int><int 
name="QTime">0</int></lst><result name="response" numFound="0" 
start="0"></result>
   [junit4]    > </response>
   [junit4]    >        request was:q=id:529&qt=&start=0&rows=20&version=2.2
   [junit4]    >        at 
org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:879)
   [junit4]    >        ... 39 more
   [junit4]   2> 5123 INFO  
(SUITE-HardAutoCommitTest-seed#[B6ECC9258FCA2FBC]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> 5125 INFO  
(SUITE-HardAutoCommitTest-seed#[B6ECC9258FCA2FBC]-worker) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1667408907
   [junit4]   2> 5125 INFO  
(SUITE-HardAutoCommitTest-seed#[B6ECC9258FCA2FBC]-worker) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 5125 INFO  
(SUITE-HardAutoCommitTest-seed#[B6ECC9258FCA2FBC]-worker) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 5125 INFO  
(SUITE-HardAutoCommitTest-seed#[B6ECC9258FCA2FBC]-worker) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 5126 INFO  
(SUITE-HardAutoCommitTest-seed#[B6ECC9258FCA2FBC]-worker) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 5139 INFO  (coreCloseExecutor-28-thread-1) [    ] 
o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@48c81ce9
   [junit4]   2> 5140 INFO  (coreCloseExecutor-28-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter close.
   [junit4]   2> 5140 INFO  (coreCloseExecutor-28-thread-1) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@60ad056a commitCommandVersion:0
   [junit4]   2> 5167 INFO  (coreCloseExecutor-28-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=1221074153
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.update.HardAutoCommitTest_B6ECC9258FCA2FBC-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): 
{field_t=PostingsFormat(name=LuceneVarGapFixedInterval), 
multiDefault=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
 
subject=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
 id=PostingsFormat(name=Asserting), 
text=PostingsFormat(name=LuceneVarGapFixedInterval)}, 
docValues:{range_facet_l_dv=DocValuesFormat(name=Direct), 
_version_=DocValuesFormat(name=Asserting), 
intDefault=DocValuesFormat(name=Asserting), id_i1=DocValuesFormat(name=Memory), 
range_facet_i_dv=DocValuesFormat(name=Asserting), 
intDvoDefault=DocValuesFormat(name=Lucene70), 
range_facet_l=DocValuesFormat(name=Asserting), 
timestamp=DocValuesFormat(name=Asserting)}, maxPointsInLeafNode=1402, 
maxMBSortInHeap=6.562283058024748, sim=RandomSimilarity(queryNorm=true): {}, 
locale=or, timezone=America/Regina
   [junit4]   2> NOTE: Linux 4.10.0-27-generic amd64/Oracle Corporation 9 
(64-bit)/cpus=8,threads=1,free=371120072,total=514850816
   [junit4]   2> NOTE: All tests run in this JVM: [CircularListTest, 
TestSolrDeletionPolicy2, HardAutoCommitTest]
   [junit4] Completed [8/727 (1!)] on J2 in 1.53s, 1 test, 1 error <<< FAILURES!

[...truncated 1172 lines...]
   [junit4] Suite: org.apache.solr.TestDistributedSearch
   [junit4]   2> 1065538 INFO  
(SUITE-TestDistributedSearch-seed#[B6ECC9258FCA2FBC]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> Creating dataDir: 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_B6ECC9258FCA2FBC-001/init-core-data-001
   [junit4]   2> 1065538 WARN  
(SUITE-TestDistributedSearch-seed#[B6ECC9258FCA2FBC]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=2 numCloses=2
   [junit4]   2> 1065539 INFO  
(SUITE-TestDistributedSearch-seed#[B6ECC9258FCA2FBC]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 1065540 INFO  
(SUITE-TestDistributedSearch-seed#[B6ECC9258FCA2FBC]-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> 1065540 INFO  
(SUITE-TestDistributedSearch-seed#[B6ECC9258FCA2FBC]-worker) [    ] 
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /_rwi/e
   [junit4]   2> 1065630 INFO  
(TEST-TestDistributedSearch.test-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_B6ECC9258FCA2FBC-001/tempDir-001/control/cores/collection1
   [junit4]   2> 1065630 INFO  
(TEST-TestDistributedSearch.test-seed#[B6ECC9258FCA2FBC]) [    ] o.e.j.s.Server 
jetty-9.3.14.v20161028
   [junit4]   2> 1065631 INFO  
(TEST-TestDistributedSearch.test-seed#[B6ECC9258FCA2FBC]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@3a9c9a6d{/_rwi/e,null,AVAILABLE}
   [junit4]   2> 1065632 INFO  
(TEST-TestDistributedSearch.test-seed#[B6ECC9258FCA2FBC]) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@63ccfc8c{HTTP/1.1,[http/1.1]}{127.0.0.1:٤١١١٥}
   [junit4]   2> 1065632 INFO  
(TEST-TestDistributedSearch.test-seed#[B6ECC9258FCA2FBC]) [    ] o.e.j.s.Server 
Started @١٠٦٦٦٠٣ms
   [junit4]   2> 1065632 INFO  
(TEST-TestDistributedSearch.test-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/_rwi/e, 
hostPort=41115, 
coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_B6ECC9258FCA2FBC-001/tempDir-001/control/cores}
   [junit4]   2> 1065632 ERROR 
(TEST-TestDistributedSearch.test-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1065632 INFO  
(TEST-TestDistributedSearch.test-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.1.0
   [junit4]   2> 1065632 INFO  
(TEST-TestDistributedSearch.test-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 1065632 INFO  
(TEST-TestDistributedSearch.test-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null, Default config 
dir: null
   [junit4]   2> 1065632 INFO  
(TEST-TestDistributedSearch.test-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-08-05T08:15:30.342916Z
   [junit4]   2> 1065633 INFO  
(TEST-TestDistributedSearch.test-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_B6ECC9258FCA2FBC-001/tempDir-001/control/solr.xml
   [junit4]   2> 1065634 INFO  
(TEST-TestDistributedSearch.test-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@44d5bc31, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 1065659 INFO  
(TEST-TestDistributedSearch.test-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@44d5bc31
   [junit4]   2> 1065665 INFO  
(TEST-TestDistributedSearch.test-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@44d5bc31
   [junit4]   2> 1065665 INFO  
(TEST-TestDistributedSearch.test-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@44d5bc31
   [junit4]   2> 1065667 INFO  
(TEST-TestDistributedSearch.test-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_B6ECC9258FCA2FBC-001/tempDir-001/control/cores
   [junit4]   2> 1065667 INFO  
(TEST-TestDistributedSearch.test-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 1065668 INFO  (coreLoadExecutor-4800-thread-1) [    ] 
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: 
[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/lib,
 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1065693 INFO  (coreLoadExecutor-4800-thread-1) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.1.0
   [junit4]   2> 1065705 INFO  (coreLoadExecutor-4800-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1065745 INFO  (coreLoadExecutor-4800-thread-1) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1065748 INFO  (coreLoadExecutor-4800-thread-1) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from 
configset 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1,
 trusted=true
   [junit4]   2> 1065748 INFO  (coreLoadExecutor-4800-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@44d5bc31
   [junit4]   2> 1065748 INFO  (coreLoadExecutor-4800-thread-1) [    ] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 1065749 INFO  (coreLoadExecutor-4800-thread-1) [    ] 
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_B6ECC9258FCA2FBC-001/tempDir-001/control/cores/collection1/data/]
   [junit4]   2> 1065749 INFO  (coreLoadExecutor-4800-thread-1) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: 
minMergeSize=0, mergeFactor=10, maxMergeSize=2104424139, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.1]
   [junit4]   2> 1065772 INFO  (coreLoadExecutor-4800-thread-1) [    ] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1065772 INFO  (coreLoadExecutor-4800-thread-1) [    ] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1065772 INFO  (coreLoadExecutor-4800-thread-1) [    ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1065772 INFO  (coreLoadExecutor-4800-thread-1) [    ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1065773 INFO  (coreLoadExecutor-4800-thread-1) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=25, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.10503358499920115]
   [junit4]   2> 1065773 INFO  (coreLoadExecutor-4800-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@73a4d7f1[collection1] main]
   [junit4]   2> 1065773 INFO  (coreLoadExecutor-4800-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1065786 INFO  (coreLoadExecutor-4800-thread-1) [    ] 
o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 1065847 INFO  (coreLoadExecutor-4800-thread-1) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1065847 INFO  (searcherExecutor-4801-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1065847 INFO  (coreLoadExecutor-4800-thread-1) [    ] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1574878241679736832
   [junit4]   2> 1065848 INFO  (searcherExecutor-4801-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1065848 INFO  (searcherExecutor-4801-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1065848 INFO  (searcherExecutor-4801-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 1065848 INFO  (searcherExecutor-4801-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1065849 INFO  (searcherExecutor-4801-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1065849 INFO  (searcherExecutor-4801-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1065850 INFO  (searcherExecutor-4801-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 1065850 INFO  (searcherExecutor-4801-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 1065851 INFO  (searcherExecutor-4801-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@73a4d7f1[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1066250 INFO  
(TEST-TestDistributedSearch.test-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_B6ECC9258FCA2FBC-001/tempDir-001/shard0/cores/collection1
   [junit4]   2> 1066251 INFO  
(TEST-TestDistributedSearch.test-seed#[B6ECC9258FCA2FBC]) [    ] o.e.j.s.Server 
jetty-9.3.14.v20161028
   [junit4]   2> 1066252 INFO  
(TEST-TestDistributedSearch.test-seed#[B6ECC9258FCA2FBC]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@66507d00{/_rwi/e,null,AVAILABLE}
   [junit4]   2> 1066252 INFO  
(TEST-TestDistributedSearch.test-seed#[B6ECC9258FCA2FBC]) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@18e56443{HTTP/1.1,[http/1.1]}{127.0.0.1:٤٤٣٠٩}
   [junit4]   2> 1066252 INFO  
(TEST-TestDistributedSearch.test-seed#[B6ECC9258FCA2FBC]) [    ] o.e.j.s.Server 
Started @١٠٦٧٢٢٣ms
   [junit4]   2> 1066252 INFO  
(TEST-TestDistributedSearch.test-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/_rwi/e, 
hostPort=44309, 
coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_B6ECC9258FCA2FBC-001/tempDir-001/shard0/cores}
   [junit4]   2> 1066252 ERROR 
(TEST-TestDistributedSearch.test-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1066253 INFO  
(TEST-TestDistributedSearch.test-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.1.0
   [junit4]   2> 1066253 INFO  
(TEST-TestDistributedSearch.test-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 1066253 INFO  
(TEST-TestDistributedSearch.test-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null, Default config 
dir: null
   [junit4]   2> 1066253 INFO  
(TEST-TestDistributedSearch.test-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-08-05T08:15:30.963136Z
   [junit4]   2> 1066253 INFO  
(TEST-TestDistributedSearch.test-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_B6ECC9258FCA2FBC-001/tempDir-001/shard0/solr.xml
   [junit4]   2> 1066254 INFO  
(TEST-TestDistributedSearch.test-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@44d5bc31, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 1066267 INFO  
(TEST-TestDistributedSearch.test-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@44d5bc31
   [junit4]   2> 1066270 INFO  
(TEST-TestDistributedSearch.test-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@44d5bc31
   [junit4]   2> 1066270 INFO  
(TEST-TestDistributedSearch.test-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@44d5bc31
   [junit4]   2> 1066271 INFO  
(TEST-TestDistributedSearch.test-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_B6ECC9258FCA2FBC-001/tempDir-001/shard0/cores
   [junit4]   2> 1066271 INFO  
(TEST-TestDistributedSearch.test-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 1066271 INFO  (coreLoadExecutor-4811-thread-1) [    ] 
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: 
[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/lib,
 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1066283 INFO  (coreLoadExecutor-4811-thread-1) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.1.0
   [junit4]   2> 1066298 INFO  (coreLoadExecutor-4811-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1066338 INFO  (coreLoadExecutor-4811-thread-1) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1066341 INFO  (coreLoadExecutor-4811-thread-1) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from 
configset 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1,
 trusted=true
   [junit4]   2> 1066342 INFO  (coreLoadExecutor-4811-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@44d5bc31
   [junit4]   2> 1066342 INFO  (coreLoadExecutor-4811-thread-1) [    ] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 1066342 INFO  (coreLoadExecutor-4811-thread-1) [    ] 
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_B6ECC9258FCA2FBC-001/tempDir-001/shard0/cores/collection1/data/]
   [junit4]   2> 1066343 INFO  (coreLoadExecutor-4811-thread-1) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: 
minMergeSize=0, mergeFactor=10, maxMergeSize=2104424139, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.1]
   [junit4]   2> 1066366 INFO  (coreLoadExecutor-4811-thread-1) [    ] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1066366 INFO  (coreLoadExecutor-4811-thread-1) [    ] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1066367 INFO  (coreLoadExecutor-4811-thread-1) [    ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1066367 INFO  (coreLoadExecutor-4811-thread-1) [    ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1066367 INFO  (coreLoadExecutor-4811-thread-1) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=25, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.10503358499920115]
   [junit4]   2> 1066368 INFO  (coreLoadExecutor-4811-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@7cb20162[collection1] main]
   [junit4]   2> 1066368 INFO  (coreLoadExecutor-4811-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1066380 INFO  (coreLoadExecutor-4811-thread-1) [    ] 
o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 1066444 INFO  (coreLoadExecutor-4811-thread-1) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1066444 INFO  (searcherExecutor-4812-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1066444 INFO  (coreLoadExecutor-4811-thread-1) [    ] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1574878242305736704
   [junit4]   2> 1066445 INFO  (searcherExecutor-4812-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1066445 INFO  (searcherExecutor-4812-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1066445 INFO  (searcherExecutor-4812-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 1066445 INFO  (searcherExecutor-4812-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1066446 INFO  (searcherExecutor-4812-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1066446 INFO  (searcherExecutor-4812-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1066447 INFO  (searcherExecutor-4812-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 1066447 INFO  (searcherExecutor-4812-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 1066448 INFO  (searcherExecutor-4812-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@7cb20162[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1066781 INFO  
(TEST-TestDistributedSearch.test-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting test
   [junit4]   2> 1066784 INFO  (qtp997135684-17164) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{deleteByQuery=*:* (-1574878242661203968)} 0 1
   [junit4]   2> 1066786 INFO  (qtp1424715128-17181) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{deleteByQuery=*:* (-1574878242663301120)} 0 0
   [junit4]   2> 1066789 INFO  (qtp997135684-17165) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[1 (1574878242665398272)]} 0 2
   [junit4]   2> 1066790 INFO  (qtp1424715128-17182) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[1 (1574878242667495424)]} 0 0
   [junit4]   2> 1066796 INFO  (qtp997135684-17166) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[2 (1574878242669592576)]} 0 5
   [junit4]   2> 1066800 INFO  (qtp1424715128-17183) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[2 (1574878242674835456)]} 0 3
   [junit4]   2> 1066801 INFO  (qtp997135684-17159) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[3 (1574878242679029760)]} 0 1
   [junit4]   2> 1066803 INFO  (qtp1424715128-17176) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[3 (1574878242681126912)]} 0 1
   [junit4]   2> 1066809 INFO  (qtp997135684-17164) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[4 (1574878242683224064)]} 0 5
   [junit4]   2> 1066814 INFO  (qtp1424715128-17181) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[4 (1574878242688466944)]} 0 4
   [junit4]   2> 1066815 INFO  (qtp997135684-17165) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[5 (1574878242693709824)]} 0 0
   [junit4]   2> 1066816 INFO  (qtp1424715128-17182) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[5 (1574878242695806976)]} 0 0
   [junit4]   2> 1066821 INFO  (qtp997135684-17166) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[6 (1574878242696855552)]} 0 4
   [junit4]   2> 1066825 INFO  (qtp1424715128-17183) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[6 (1574878242701049856)]} 0 4
   [junit4]   2> 1066826 INFO  (qtp997135684-17159) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[7 (1574878242706292736)]} 0 0
   [junit4]   2> 1066827 INFO  (qtp1424715128-17176) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[7 (1574878242707341312)]} 0 0
   [junit4]   2> 1066832 INFO  (qtp997135684-17164) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[8 (1574878242708389888)]} 0 4
   [junit4]   2> 1066837 INFO  (qtp1424715128-17181) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[8 (1574878242713632768)]} 0 4
   [junit4]   2> 1066838 INFO  (qtp997135684-17165) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[9 (1574878242718875648)]} 0 0
   [junit4]   2> 1066839 INFO  (qtp1424715128-17182) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[9 (1574878242719924224)]} 0 0
   [junit4]   2> 1066840 INFO  (qtp997135684-17166) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1574878242720972800,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1066840 INFO  (qtp997135684-17166) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@7003d685 
commitCommandVersion:1574878242720972800
   [junit4]   2> 1066846 INFO  (qtp997135684-17166) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@1d8d549f[collection1] main]
   [junit4]   2> 1066847 INFO  (qtp997135684-17166) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1066848 INFO  (searcherExecutor-4801-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@1d8d549f[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.1.0):C2)
 Uninverting(_1(7.1.0):C2) Uninverting(_2(7.1.0):C2) Uninverting(_3(7.1.0):C2) 
Uninverting(_4(7.1.0):C1)))}
   [junit4]   2> 1066849 INFO  (qtp997135684-17166) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 9
   [junit4]   2> 1066849 INFO  (qtp1424715128-17183) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1574878242730409984,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1066849 INFO  (qtp1424715128-17183) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@2c16aafc 
commitCommandVersion:1574878242730409984
   [junit4]   2> 1066855 INFO  (qtp1424715128-17183) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@5b62abfa[collection1] main]
   [junit4]   2> 1066856 INFO  (qtp1424715128-17183) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1066857 INFO  (searcherExecutor-4812-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@5b62abfa[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.1.0):C2)
 Uninverting(_1(7.1.0):C2) Uninverting(_2(7.1.0):C2) Uninverting(_3(7.1.0):C2) 
Uninverting(_4(7.1.0):C1)))}
   [junit4]   2> 1066858 INFO  (qtp1424715128-17183) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 8
   [junit4]   2> 1066859 INFO  (qtp997135684-17159) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[10 (1574878242739847168)]} 0 1
   [junit4]   2> 1066861 INFO  (qtp1424715128-17176) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[10 (1574878242741944320)]} 0 1
   [junit4]   2> 1066865 INFO  (qtp997135684-17164) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[11 (1574878242744041472)]} 0 3
   [junit4]   2> 1066868 INFO  (qtp1424715128-17181) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[11 (1574878242747187200)]} 0 3
   [junit4]   2> 1066869 INFO  (qtp997135684-17165) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[12 (1574878242751381504)]} 0 0
   [junit4]   2> 1066870 INFO  (qtp1424715128-17182) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[12 (1574878242752430080)]} 0 0
   [junit4]   2> 1066875 INFO  (qtp997135684-17166) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[13 (1574878242753478656)]} 0 4
   [junit4]   2> 1066880 INFO  (qtp1424715128-17183) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[13 (1574878242758721536)]} 0 4
   [junit4]   2> 1066882 INFO  (qtp997135684-17159) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[1001 (1574878242763964416)]} 0 1
   [junit4]   2> 1066883 INFO  (qtp1424715128-17176) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[1001 (1574878242765012992)]} 0 0
   [junit4]   2> 1066888 INFO  (qtp997135684-17164) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[14 (1574878242767110144)]} 0 4
   [junit4]   2> 1066895 INFO  (qtp1424715128-17181) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[14 (1574878242771304448)]} 0 6
   [junit4]   2> 1066896 INFO  (qtp997135684-17165) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[15 (1574878242779693056)]} 0 0
   [junit4]   2> 1066897 INFO  (qtp1424715128-17182) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[15 (1574878242780741632)]} 0 0
   [junit4]   2> 1066902 INFO  (qtp997135684-17166) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[16 (1574878242781790208)]} 0 3
   [junit4]   2> 1066907 INFO  (qtp1424715128-17183) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[16 (1574878242785984512)]} 0 4
   [junit4]   2> 1066908 INFO  (qtp997135684-17159) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[17 (1574878242791227392)]} 0 0
   [junit4]   2> 1066908 INFO  (qtp1424715128-17176) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[17 (1574878242792275968)]} 0 0
   [junit4]   2> 1066911 INFO  (qtp997135684-17164) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[100 (1574878242793324544)]} 0 2
   [junit4]   2> 1066914 INFO  (qtp1424715128-17181) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[100 (1574878242796470272)]} 0 2
   [junit4]   2> 1066914 INFO  (qtp997135684-17165) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[101 (1574878242798567424)]} 0 0
   [junit4]   2> 1066915 INFO  (qtp1424715128-17182) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[101 (1574878242799616000)]} 0 0
   [junit4]   2> 1066917 INFO  (qtp997135684-17166) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[102 (1574878242799616000)]} 0 1
   [junit4]   2> 1066919 INFO  (qtp1424715128-17183) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[102 (1574878242801713152)]} 0 1
   [junit4]   2> 1066920 INFO  (qtp997135684-17159) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[103 (1574878242803810304)]} 0 0
   [junit4]   2> 1066920 INFO  (qtp1424715128-17176) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[103 (1574878242804858880)]} 0 0
   [junit4]   2> 1066922 INFO  (qtp997135684-17164) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[104 (1574878242804858880)]} 0 1
   [junit4]   2> 1066924 INFO  (qtp1424715128-17181) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[104 (1574878242806956032)]} 0 1
   [junit4]   2> 1066925 INFO  (qtp997135684-17165) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[105 (1574878242809053184)]} 0 0
   [junit4]   2> 1066925 INFO  (qtp1424715128-17182) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[105 (1574878242810101760)]} 0 0
   [junit4]   2> 1066927 INFO  (qtp997135684-17166) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[106 (1574878242810101760)]} 0 1
   [junit4]   2> 1066929 INFO  (qtp1424715128-17183) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[106 (1574878242812198912)]} 0 1
   [junit4]   2> 1066929 INFO  (qtp997135684-17159) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[107 (1574878242814296064)]} 0 0
   [junit4]   2> 1066930 INFO  (qtp1424715128-17176) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[107 (1574878242814296064)]} 0 0
   [junit4]   2> 1066931 INFO  (qtp997135684-17164) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[108 (1574878242815344640)]} 0 1
   [junit4]   2> 1066933 INFO  (qtp1424715128-17181) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[108 (1574878242817441792)]} 0 1
   [junit4]   2> 1066934 INFO  (qtp997135684-17165) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[109 (1574878242819538944)]} 0 0
   [junit4]   2> 1066934 INFO  (qtp1424715128-17182) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[109 (1574878242819538944)]} 0 0
   [junit4]   2> 1066936 INFO  (qtp997135684-17166) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[110 (1574878242820587520)]} 0 1
   [junit4]   2> 1066938 INFO  (qtp1424715128-17183) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[110 (1574878242821636096)]} 0 1
   [junit4]   2> 1066939 INFO  (qtp997135684-17159) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[111 (1574878242823733248)]} 0 0
   [junit4]   2> 1066939 INFO  (qtp1424715128-17176) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[111 (1574878242824781824)]} 0 0
   [junit4]   2> 1066941 INFO  (qtp997135684-17164) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[112 (1574878242824781824)]} 0 1
   [junit4]   2> 1066948 INFO  (qtp1424715128-17181) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[112 (1574878242826878976)]} 0 7
   [junit4]   2> 1066949 INFO  (qtp997135684-17165) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[113 (1574878242835267584)]} 0 0
   [junit4]   2> 1066949 INFO  (qtp1424715128-17182) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[113 (1574878242835267584)]} 0 0
   [junit4]   2> 1066951 INFO  (qtp997135684-17166) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[114 (1574878242835267585)]} 0 1
   [junit4]   2> 1066953 INFO  (qtp1424715128-17183) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[114 (1574878242838413312)]} 0 1
   [junit4]   2> 1066954 INFO  (qtp997135684-17159) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[115 (1574878242840510464)]} 0 0
   [junit4]   2> 1066954 INFO  (qtp1424715128-17176) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[115 (1574878242840510464)]} 0 0
   [junit4]   2> 1066957 INFO  (qtp997135684-17164) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[116 (1574878242841559040)]} 0 2
   [junit4]   2> 1066960 INFO  (qtp1424715128-17181) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[116 (1574878242843656192)]} 0 2
   [junit4]   2> 1066961 INFO  (qtp997135684-17165) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[117 (1574878242846801920)]} 0 0
   [junit4]   2> 1066961 INFO  (qtp1424715128-17182) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[117 (1574878242847850496)]} 0 0
   [junit4]   2> 1066963 INFO  (qtp997135684-17166) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[118 (1574878242847850496)]} 0 1
   [junit4]   2> 1066965 INFO  (qtp1424715128-17183) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[118 (1574878242849947648)]} 0 1
   [junit4]   2> 1066965 INFO  (qtp997135684-17159) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[119 (1574878242852044800)]} 0 0
   [junit4]   2> 1066966 INFO  (qtp1424715128-17176) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[119 (1574878242853093376)]} 0 0
   [junit4]   2> 1066969 INFO  (qtp997135684-17164) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[120 (1574878242853093376)]} 0 2
   [junit4]   2> 1066971 INFO  (qtp1424715128-17181) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[120 (1574878242856239104)]} 0 2
   [junit4]   2> 1066972 INFO  (qtp997135684-17165) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[121 (1574878242859384832)]} 0 0
   [junit4]   2> 1066972 INFO  (qtp1424715128-17182) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[121 (1574878242859384832)]} 0 0
   [junit4]   2> 1066975 INFO  (qtp997135684-17166) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[122 (1574878242860433408)]} 0 1
   [junit4]   2> 1066977 INFO  (qtp1424715128-17183) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[122 (1574878242862530560)]} 0 1
   [junit4]   2> 1066977 INFO  (qtp997135684-17159) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[123 (1574878242864627712)]} 0 0
   [junit4]   2> 1066978 INFO  (qtp1424715128-17176) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[123 (1574878242864627712)]} 0 0
   [junit4]   2> 1066980 INFO  (qtp997135684-17164) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[124 (1574878242865676288)]} 0 1
   [junit4]   2> 1066982 INFO  (qtp1424715128-17181) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[124 (1574878242867773440)]} 0 1
   [junit4]   2> 1066982 INFO  (qtp997135684-17165) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[125 (1574878242869870592)]} 0 0
   [junit4]   2> 1066982 INFO  (qtp1424715128-17182) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[125 (1574878242869870592)]} 0 0
   [junit4]   2> 1066985 INFO  (qtp997135684-17166) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[126 (1574878242870919168)]} 0 1
   [junit4]   2> 1066987 INFO  (qtp1424715128-17183) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[126 (1574878242873016320)]} 0 1
   [junit4]   2> 1066987 INFO  (qtp997135684-17159) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[127 (1574878242875113472)]} 0 0
   [junit4]   2> 1066988 INFO  (qtp1424715128-17176) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[127 (1574878242875113472)]} 0 0
   [junit4]   2> 1066990 INFO  (qtp997135684-17164) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[128 (1574878242876162048)]} 0 1
   [junit4]   2> 1066992 INFO  (qtp1424715128-17181) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[128 (1574878242878259200)]} 0 1
   [junit4]   2> 1066992 INFO  (qtp997135684-17165) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[129 (1574878242880356352)]} 0 0
   [junit4]   2> 1066992 INFO  (qtp1424715128-17182) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[129 (1574878242880356352)]} 0 0
   [junit4]   2> 1066995 INFO  (qtp997135684-17166) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[130 (1574878242881404928)]} 0 2
   [junit4]   2> 1066998 INFO  (qtp1424715128-17183) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[130 (1574878242883502080)]} 0 2
   [junit4]   2> 1066998 INFO  (qtp997135684-17159) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[131 (1574878242886647808)]} 0 0
   [junit4]   2> 1066999 INFO  (qtp1424715128-17176) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[131 (1574878242886647808)]} 0 0
   [junit4]   2> 1067000 INFO  (qtp997135684-17164) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[132 (1574878242887696384)]} 0 1
   [junit4]   2> 1067003 INFO  (qtp1424715128-17181) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[132 (1574878242888744960)]} 0 2
   [junit4]   2> 1067004 INFO  (qtp997135684-17165) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[133 (1574878242891890688)]} 0 0
   [junit4]   2> 1067004 INFO  (qtp1424715128-17182) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[133 (1574878242892939264)]} 0 0
   [junit4]   2> 1067009 INFO  (qtp997135684-17166) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[134 (1574878242893987840)]} 0 3
   [junit4]   2> 1067012 INFO  (qtp1424715128-17183) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[134 (1574878242898182144)]} 0 2
   [junit4]   2> 1067012 INFO  (qtp997135684-17159) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[135 (1574878242901327872)]} 0 0
   [junit4]   2> 1067013 INFO  (qtp1424715128-17176) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[135 (1574878242902376448)]} 0 0
   [junit4]   2> 1067015 INFO  (qtp997135684-17164) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[136 (1574878242902376448)]} 0 2
   [junit4]   2> 1067017 INFO  (qtp1424715128-17181) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[136 (1574878242904473600)]} 0 2
   [junit4]   2> 1067018 INFO  (qtp997135684-17165) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[137 (1574878242907619328)]} 0 0
   [junit4]   2> 1067018 INFO  (qtp1424715128-17182) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[137 (1574878242907619328)]} 0 0
   [junit4]   2> 1067021 INFO  (qtp997135684-17166) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[138 (1574878242908667904)]} 0 2
   [junit4]   2> 1067022 INFO  (qtp1424715128-17183) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[138 (1574878242910765056)]} 0 1
   [junit4]   2> 1067023 INFO  (qtp997135684-17159) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[139 (1574878242912862208)]} 0 0
   [junit4]   2> 1067023 INFO  (qtp1424715128-17176) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[139 (1574878242912862208)]} 0 0
   [junit4]   2> 1067025 INFO  (qtp997135684-17164) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[140 (1574878242912862209)]} 0 1
   [junit4]   2> 1067027 INFO  (qtp1424715128-17181) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[140 (1574878242914959360)]} 0 1
   [junit4]   2> 1067028 INFO  (qtp997135684-17165) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[141 (1574878242917056512)]} 0 0
   [junit4]   2> 1067028 INFO  (qtp1424715128-17182) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[141 (1574878242918105088)]} 0 0
   [junit4]   2> 1067030 INFO  (qtp997135684-17166) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[142 (1574878242918105088)]} 0 1
   [junit4]   2> 1067031 INFO  (qtp1424715128-17183) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[142 (1574878242920202240)]} 0 1
   [junit4]   2> 1067032 INFO  (qtp997135684-17159) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[143 (1574878242922299392)]} 0 0
   [junit4]   2> 1067032 INFO  (qtp1424715128-17176) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[143 (1574878242922299392)]} 0 0
   [junit4]   2> 1067034 INFO  (qtp997135684-17164) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[144 (1574878242922299393)]} 0 1
   [junit4]   2> 1067036 INFO  (qtp1424715128-17181) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[144 (1574878242924396544)]} 0 1
   [junit4]   2> 1067036 INFO  (qtp997135684-17165) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[145 (1574878242926493696)]} 0 0
   [junit4]   2> 1067037 INFO  (qtp1424715128-17182) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[145 (1574878242926493696)]} 0 0
   [junit4]   2> 1067038 INFO  (qtp997135684-17166) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[146 (1574878242927542272)]} 0 1
   [junit4]   2> 1067040 INFO  (qtp1424715128-17183) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[146 (1574878242929639424)]} 0 1
   [junit4]   2> 1067041 INFO  (qtp997135684-17159) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[147 (1574878242930688000)]} 0 0
   [junit4]   2> 1067041 INFO  (qtp1424715128-17176) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[147 (1574878242931736576)]} 0 0
   [junit4]   2> 1067043 INFO  (qtp997135684-17164) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[148 (1574878242931736576)]} 0 1
   [junit4]   2> 1067045 INFO  (qtp1424715128-17181) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[148 (1574878242933833728)]} 0 1
   [junit4]   2> 1067045 INFO  (qtp997135684-17165) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[149 (1574878242935930880)]} 0 0
   [junit4]   2> 1067046 INFO  (qtp1424715128-17182) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_rwi/e path=/update 
params={wt=javabin&version=2}{add=[149 (1574878242935930880)]} 0 0
   [junit4]   2> 1067046 INFO  (qtp997135684-17166) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1574878242936979456,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1067046 INFO  (qtp997135684-17166) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@7003d685 
commitCommandVersion:1574878242936979456
   [junit4]   2> 1067048 INFO  (qtp997135684-17166) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@4ce20bbf[collection1] main]
   [junit4]   2> 1067048 INFO  (qtp997135684-17166) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1067049 INFO  (searcherExecutor-4801-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@4ce20bbf[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_p(7.1.0):C49)
 Uninverting(_q(7.1.0):C2) Uninverting(_r(7.1.0):C2) Uninverting(_s(7.1.0):C2) 
Uninverting(_t(7.1.0):C2) Uninverting(_u(7.1.0)

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

topped ServerConnector@18e56443{HTTP/1.1,[http/1.1]}{127.0.0.1:٠}
   [junit4]   2> 1072056 INFO  
(TEST-TestDistributedSearch.test-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=512793110
   [junit4]   2> 1072056 INFO  
(TEST-TestDistributedSearch.test-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 1072057 INFO  
(TEST-TestDistributedSearch.test-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 1072057 INFO  
(TEST-TestDistributedSearch.test-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 1072057 INFO  
(TEST-TestDistributedSearch.test-seed#[B6ECC9258FCA2FBC]) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 1072057 INFO  (coreCloseExecutor-4819-thread-1) [    ] 
o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@273cbb6
   [junit4]   2> 1072057 INFO  (coreCloseExecutor-4819-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=41143222
   [junit4]   2> 1072057 INFO  
(TEST-TestDistributedSearch.test-seed#[B6ECC9258FCA2FBC]) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@66507d00{/_rwi/e,null,UNAVAILABLE}
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=TestDistributedSearch -Dtests.method=test 
-Dtests.seed=B6ECC9258FCA2FBC -Dtests.multiplier=3 -Dtests.slow=true 
-Dtests.locale=ar-OM -Dtests.timezone=Europe/Madrid -Dtests.asserts=true 
-Dtests.file.encoding=UTF-8
   [junit4] ERROR   6.52s J1 | TestDistributedSearch.test <<<
   [junit4]    > Throwable #1: 
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error 
from server at http://127.0.0.1:41115/_rwi/e/collection1: ERROR: [doc=1] Error 
adding field 'severity'='Not Available' msg=EnumFieldType requires 
docValues="true".
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([B6ECC9258FCA2FBC:3EB8F6FF21364244]: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.x-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_B6ECC9258FCA2FBC-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): 
{rnd_b=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
 a_s=PostingsFormat(name=Asserting), 
foo_sev_enum=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
 oddField_s=PostingsFormat(name=Asserting), 
SubjectTerms_mfacet=PostingsFormat(name=Memory), 
multiDefault=PostingsFormat(name=LuceneFixedGap), 
lowerfilt1and2=PostingsFormat(name=LuceneFixedGap), 
a_t=PostingsFormat(name=Memory), foo_b=PostingsFormat(name=Asserting), 
lowerfilt=PostingsFormat(name=LuceneFixedGap), 
id=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
 text=PostingsFormat(name=Asserting)}, 
docValues:{other_tl1=DocValuesFormat(name=Lucene70), 
range_facet_l_dv=DocValuesFormat(name=Lucene70), 
SubjectTerms_mfacet=DocValuesFormat(name=Lucene70), 
n_l1=DocValuesFormat(name=Lucene70), a_n_tdt=DocValuesFormat(name=Lucene70), 
multiDefault=DocValuesFormat(name=Memory), 
intDefault=DocValuesFormat(name=Lucene70), n_td1=DocValuesFormat(name=Memory), 
n_d1=DocValuesFormat(name=Lucene70), 
range_facet_l=DocValuesFormat(name=Lucene70), 
n_f1=DocValuesFormat(name=Memory), n_tl1=DocValuesFormat(name=Memory), 
a_s=DocValuesFormat(name=Direct), oddField_s=DocValuesFormat(name=Direct), 
n_tf1=DocValuesFormat(name=Lucene70), 
lowerfilt1and2=DocValuesFormat(name=Memory), 
a_t=DocValuesFormat(name=Lucene70), lowerfilt=DocValuesFormat(name=Memory), 
id=DocValuesFormat(name=Lucene70), text=DocValuesFormat(name=Direct), 
intDvoDefault=DocValuesFormat(name=Direct), 
timestamp=DocValuesFormat(name=Lucene70), 
foo_sev_enum=DocValuesFormat(name=Lucene70), 
n_dt1=DocValuesFormat(name=Memory), b_n_tdt=DocValuesFormat(name=Lucene70), 
n_ti1=DocValuesFormat(name=Lucene70), rnd_b=DocValuesFormat(name=Lucene70), 
_version_=DocValuesFormat(name=Lucene70), 
n_tdt1=DocValuesFormat(name=Lucene70), foo_b=DocValuesFormat(name=Direct), 
id_i1=DocValuesFormat(name=Memory), foo_d=DocValuesFormat(name=Lucene70), 
range_facet_i_dv=DocValuesFormat(name=Lucene70), 
foo_f=DocValuesFormat(name=Direct), a_i_ni_p=DocValuesFormat(name=Memory)}, 
maxPointsInLeafNode=1600, maxMBSortInHeap=7.549660328604626, 
sim=RandomSimilarity(queryNorm=true): {}, locale=ar-OM, timezone=Europe/Madrid
   [junit4]   2> NOTE: Linux 4.10.0-27-generic amd64/Oracle Corporation 9 
(64-bit)/cpus=8,threads=1,free=254002656,total=519569408
   [junit4]   2> NOTE: All tests run in this JVM: [TestBackupRepositoryFactory, 
ClassificationUpdateProcessorIntegrationTest, TestDynamicFieldResource, 
ChaosMonkeySafeLeaderTest, TestRandomFlRTGCloud, ReplicaListTransformerTest, 
TestComplexPhraseQParserPlugin, BasicAuthStandaloneTest, 
TestReplicationHandlerBackup, MetricsConfigTest, TestSizeLimitedDistributedMap, 
HttpPartitionTest, TestBM25SimilarityFactory, TestFieldCacheSortRandom, 
TestJavabinTupleStreamParser, JsonLoaderTest, TestDeleteCollectionOnDownNodes, 
SolrIndexMetricsTest, TestManagedSynonymFilterFactory, TestSolr4Spatial2, 
TestConfigSetsAPIExclusivity, TestConfigsApi, 
ChaosMonkeySafeLeaderWithPullReplicasTest, SolrCmdDistributorTest, 
TestSearchPerf, OverseerStatusTest, TestUpdate, TestReplicaProperties, 
TestXmlQParser, SolrCLIZkUtilsTest, ExitableDirectoryReaderTest, 
ShardRoutingTest, TestCloudSchemaless, SuggestComponentContextFilterQueryTest, 
TestSolrJ, CdcrRequestHandlerTest, HdfsUnloadDistributedZkTest, 
TestFieldTypeCollectionResource, TestCollectionAPI, LoggingHandlerTest, 
TestCloudRecovery, SampleTest, SpatialFilterTest, TestExactStatsCache, 
TermVectorComponentTest, IndexSchemaTest, SoftAutoCommitTest, 
DistributedVersionInfoTest, TestSolrConfigHandler, TestMissingGroups, 
AlternateDirectoryTest, CoreAdminHandlerTest, DistributedIntervalFacetingTest, 
TestSchemaResource, TestPartialUpdateDeduplication, BasicFunctionalityTest, 
TestDistributedGrouping, TestInitQParser, TestBlobHandler, 
SolrGraphiteReporterTest, TestRTimerTree, CdcrBootstrapTest, 
DistributedExpandComponentTest, TestTolerantUpdateProcessorRandomCloud, 
LukeRequestHandlerTest, TestExpandComponent, ImplicitSnitchTest, 
TestTrackingShardHandlerFactory, BlobRepositoryCloudTest, 
TestClusterStateMutator, WrapperMergePolicyFactoryTest, TestFastLRUCache, 
HttpSolrCallGetCoreTest, TestSolrCloudWithSecureImpersonation, 
DirectSolrSpellCheckerTest, TestEmbeddedSolrServerSchemaAPI, 
HdfsRecoverLeaseTest, BigEndianAscendingWordSerializerTest, ZkControllerTest, 
CdcrUpdateLogTest, TestInfoStreamLogging, TestQueryTypes, 
TestDelegationWithHadoopAuth, TestNonDefinedSimilarityFactory, 
TestUninvertingReader, TestCoreContainer, TestAuthenticationFramework, 
TestPointFields, ZkSolrClientTest, ConfigureRecoveryStrategyTest, 
TestFilteredDocIdSet, ManagedSchemaRoundRobinCloudTest, 
OverseerCollectionConfigSetProcessorTest, CacheHeaderTest, 
SpellCheckComponentTest, ConvertedLegacyTest, 
UpdateRequestProcessorFactoryTest, TestElisionMultitermQuery, 
LeaderFailureAfterFreshStartTest, TestMultiValuedNumericRangeQuery, 
TestExclusionRuleCollectionAccess, PropertiesRequestHandlerTest, 
DisMaxRequestHandlerTest, SpatialRPTFieldTypeTest, 
DistributedTermsComponentTest, DistanceFunctionTest, SmileWriterTest, 
TestConfigSetProperties, DistributedMLTComponentTest, DateRangeFieldTest, 
TestSweetSpotSimilarityFactory, SolrMetricReporterTest, 
SharedFSAutoReplicaFailoverTest, DistribDocExpirationUpdateProcessorTest, 
TestFuzzyAnalyzedSuggestions, TestPKIAuthenticationPlugin, TestStressLiveNodes, 
TestSolrIndexConfig, TestSubQueryTransformer, HighlighterTest, 
BasicDistributedZkTest, OpenCloseCoreStressTest, BasicZkTest, RecoveryZkTest, 
ClusterStateUpdateTest, TestRandomFaceting, LeaderElectionTest, 
TestRandomDVFaceting, ShardRoutingCustomTest, TestDistributedSearch]
   [junit4] Completed [360/727 (2!)] on J1 in 6.54s, 1 test, 1 error <<< 
FAILURES!

[...truncated 37760 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org

Reply via email to