Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Windows/6731/
Java: 64bit/jdk1.8.0_131 -XX:+UseCompressedOops -XX:+UseConcMarkSweepGC

1 tests failed.
FAILED:  org.apache.solr.update.AutoCommitTest.testMaxDocs

Error Message:
Exception during query

Stack Trace:
java.lang.RuntimeException: Exception during query
        at 
__randomizedtesting.SeedInfo.seed([6C635631E0A88893:D5E280EECC428C19]:0)
        at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:878)
        at 
org.apache.solr.update.AutoCommitTest.testMaxDocs(AutoCommitTest.java:225)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.lang.Thread.run(Thread.java:748)
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:14&qt=&start=0&rows=20&version=2.2
        at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:871)
        ... 40 more




Build Log:
[...truncated 12020 lines...]
   [junit4] Suite: org.apache.solr.update.AutoCommitTest
   [junit4]   2> Creating dataDir: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.update.AutoCommitTest_6C635631E0A88893-001\init-core-data-001
   [junit4]   2> 2018323 WARN  
(SUITE-AutoCommitTest-seed#[6C635631E0A88893]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=1 numCloses=1
   [junit4]   2> 2018326 INFO  
(SUITE-AutoCommitTest-seed#[6C635631E0A88893]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 2018333 INFO  
(SUITE-AutoCommitTest-seed#[6C635631E0A88893]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: 
@org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
   [junit4]   2> 2018334 INFO  
(SUITE-AutoCommitTest-seed#[6C635631E0A88893]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 2018336 INFO  
(SUITE-AutoCommitTest-seed#[6C635631E0A88893]-worker) [    ] 
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: 
[/C:/Users/jenkins/workspace/Lucene-Solr-master-Windows/solr/core/src/test-files/solr/collection1/lib,
 
/C:/Users/jenkins/workspace/Lucene-Solr-master-Windows/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 2018411 INFO  
(SUITE-AutoCommitTest-seed#[6C635631E0A88893]-worker) [    ] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 2018434 INFO  
(SUITE-AutoCommitTest-seed#[6C635631E0A88893]-worker) [    ] 
o.a.s.s.IndexSchema [null] Schema name=test
   [junit4]   2> 2018541 INFO  
(SUITE-AutoCommitTest-seed#[6C635631E0A88893]-worker) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 2018782 INFO  
(SUITE-AutoCommitTest-seed#[6C635631E0A88893]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@495fcaaa
   [junit4]   2> 2018810 INFO  
(SUITE-AutoCommitTest-seed#[6C635631E0A88893]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@495fcaaa
   [junit4]   2> 2018811 INFO  
(SUITE-AutoCommitTest-seed#[6C635631E0A88893]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@495fcaaa
   [junit4]   2> 2018920 INFO  (coreLoadExecutor-6802-thread-1) [    
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, 
from paths: 
[/C:/Users/jenkins/workspace/Lucene-Solr-master-Windows/solr/core/src/test-files/solr/collection1/lib,
 
/C:/Users/jenkins/workspace/Lucene-Solr-master-Windows/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 2019133 INFO  (coreLoadExecutor-6802-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 2019178 INFO  (coreLoadExecutor-6802-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 2019297 INFO  (coreLoadExecutor-6802-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 2019380 INFO  (coreLoadExecutor-6802-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from instancedir 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\collection1,
 trusted=true
   [junit4]   2> 2019380 INFO  (coreLoadExecutor-6802-thread-1) [    
x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@495fcaaa
   [junit4]   2> 2019381 INFO  (coreLoadExecutor-6802-thread-1) [    
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 2019381 INFO  (coreLoadExecutor-6802-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\collection1],
 
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.update.AutoCommitTest_6C635631E0A88893-001\init-core-data-001\]
   [junit4]   2> 2019399 INFO  (coreLoadExecutor-6802-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=18, maxMergeAtOnceExplicit=35, maxMergedSegmentMB=33.2529296875, 
floorSegmentMB=1.244140625, forceMergeDeletesPctAllowed=7.764115751465177, 
segmentsPerTier=25.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.6971967652752371
   [junit4]   2> 2020168 INFO  (coreLoadExecutor-6802-thread-1) [    
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 2020168 INFO  (coreLoadExecutor-6802-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 2020169 INFO  (coreLoadExecutor-6802-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2020169 INFO  (coreLoadExecutor-6802-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2020196 INFO  (coreLoadExecutor-6802-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=33, maxMergeAtOnceExplicit=14, maxMergedSegmentMB=52.921875, 
floorSegmentMB=1.994140625, forceMergeDeletesPctAllowed=24.363852401076702, 
segmentsPerTier=19.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 2020196 INFO  (coreLoadExecutor-6802-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@24231fc[collection1] 
main]
   [junit4]   2> 2020198 INFO  (coreLoadExecutor-6802-thread-1) [    
x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 2020234 INFO  (coreLoadExecutor-6802-thread-1) [    
x:collection1] o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 2020370 INFO  (coreLoadExecutor-6802-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 2020370 INFO  
(searcherExecutor-6803-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 2020370 INFO  (coreLoadExecutor-6802-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1572544400327704576
   [junit4]   2> 2020373 INFO  
(SUITE-AutoCommitTest-seed#[6C635631E0A88893]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 2020386 INFO  
(searcherExecutor-6803-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 2020386 INFO  
(searcherExecutor-6803-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 2020386 INFO  
(searcherExecutor-6803-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 2020392 INFO  
(searcherExecutor-6803-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 2020392 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6C635631E0A88893]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testMaxDocs
   [junit4]   2> 2020393 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6C635631E0A88893]) [    ] 
o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 2020394 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6C635631E0A88893]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@2a7fad16[collection1] realtime]
   [junit4]   2> 2020394 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6C635631E0A88893]) [    ] 
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 0
   [junit4]   2> 2020395 ERROR 
(TEST-AutoCommitTest.testMaxDocs-seed#[6C635631E0A88893]) [    ] 
o.a.s.c.CorePropertiesLocator Couldn't load core descriptor from 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\collection1\core.properties:java.nio.file.NoSuchFileException:
 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\collection1\core.properties
   [junit4]   2> 2020395 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6C635631E0A88893]) [    ] 
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: 
[/C:/Users/jenkins/workspace/Lucene-Solr-master-Windows/solr/core/src/test-files/solr/collection1/lib,
 
/C:/Users/jenkins/workspace/Lucene-Solr-master-Windows/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 2020395 INFO  
(searcherExecutor-6803-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 2020439 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6C635631E0A88893]) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 2020445 INFO  
(searcherExecutor-6803-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 2020458 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6C635631E0A88893]) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 2020471 INFO  
(searcherExecutor-6803-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 2020483 INFO  
(searcherExecutor-6803-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 2020483 INFO  
(searcherExecutor-6803-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@24231fc[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2020539 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6C635631E0A88893]) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 2020547 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6C635631E0A88893]) [    ] 
o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using configuration from 
instancedir 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\collection1
   [junit4]   2> 2020557 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 
'solr.core.collection1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@495fcaaa
   [junit4]   2> 2020557 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\collection1],
 
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.update.AutoCommitTest_6C635631E0A88893-001\init-core-data-001\]
   [junit4]   2> 2020864 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2020865 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2020865 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@7dde78e5[collection1] main]
   [junit4]   2> 2020866 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 2020904 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 2020994 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 2020994 INFO  
(searcherExecutor-6808-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 2020995 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1572544400983064576
   [junit4]   2> 2020997 INFO  
(searcherExecutor-6808-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 2020999 INFO  
(searcherExecutor-6808-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 2020999 INFO  
(searcherExecutor-6808-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 2021000 INFO  
(searcherExecutor-6808-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 2021001 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=15, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.46413013237020206]
   [junit4]   2> 2021001 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 2021001 INFO  
(searcherExecutor-6808-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 2021002 INFO  
(searcherExecutor-6808-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 2021002 INFO  
(searcherExecutor-6808-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 2021002 INFO  
(searcherExecutor-6808-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 2021004 INFO  
(searcherExecutor-6808-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@7dde78e5[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2021004 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@790a700e[collection1] main]
   [junit4]   2> 2021004 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@211e31a0
   [junit4]   2> 2021005 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=555626912
   [junit4]   2> 2021011 INFO  
(searcherExecutor-6808-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@790a700e[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2021013 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[0 
(1572544400998793216)]} 0 2
   [junit4]   2> 2021013 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[1 
(1572544401001938944)]} 0 3
   [junit4]   2> 2021014 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[2 
(1572544401002987520)]} 0 4
   [junit4]   2> 2021014 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[3 
(1572544401002987521)]} 0 4
   [junit4]   2> 2021014 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[4 
(1572544401002987522)]} 0 4
   [junit4]   2> 2021014 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[5 
(1572544401002987523)]} 0 4
   [junit4]   2> 2021014 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[6 
(1572544401002987524)]} 0 4
   [junit4]   2> 2021014 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[7 
(1572544401002987525)]} 0 4
   [junit4]   2> 2021014 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[8 
(1572544401002987526)]} 0 5
   [junit4]   2> 2021014 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[9 
(1572544401002987527)]} 0 5
   [junit4]   2> 2021014 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[10 
(1572544401002987528)]} 0 5
   [junit4]   2> 2021014 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[11 
(1572544401002987529)]} 0 5
   [junit4]   2> 2021014 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[12 
(1572544401002987530)]} 0 5
   [junit4]   2> 2021033 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[13 
(1572544401002987531)]} 0 23
   [junit4]   2> 2021035 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:1&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=2
   [junit4]   2> 2021041 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[14 
(1572544401030250496)]} 0 31
   [junit4]   2> 2021041 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[15 
(1572544401031299072)]} 0 31
   [junit4]   2> 2021041 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:14&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
   [junit4]   2> 2021041 ERROR 
(TEST-AutoCommitTest.testMaxDocs-seed#[6C635631E0A88893]) [    x:collection1] 
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:14&qt=&start=0&rows=20&version=2.2
   [junit4]   2> 2021042 ERROR 
(TEST-AutoCommitTest.testMaxDocs-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.SolrTestCaseJ4 REQUEST FAILED: 
q=id:14&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:14&qt=&start=0&rows=20&version=2.2
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:871)
   [junit4]   2>        at 
org.apache.solr.update.AutoCommitTest.testMaxDocs(AutoCommitTest.java:225)
   [junit4]   2>        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native 
Method)
   [junit4]   2>        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
   [junit4]   2>        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   [junit4]   2>        at java.lang.reflect.Method.invoke(Method.java:498)
   [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 
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.lang.Thread.run(Thread.java:748)
   [junit4]   2> 
   [junit4]   2> 2021042 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.SolrTestCaseJ4 ###Ending testMaxDocs
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=AutoCommitTest 
-Dtests.method=testMaxDocs -Dtests.seed=6C635631E0A88893 -Dtests.slow=true 
-Dtests.locale=ja-JP -Dtests.timezone=America/Argentina/ComodRivadavia 
-Dtests.asserts=true -Dtests.file.encoding=Cp1252
   [junit4] ERROR   0.67s J0 | AutoCommitTest.testMaxDocs <<<
   [junit4]    > Throwable #1: java.lang.RuntimeException: Exception during 
query
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([6C635631E0A88893:D5E280EECC428C19]:0)
   [junit4]    >        at 
org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:878)
   [junit4]    >        at 
org.apache.solr.update.AutoCommitTest.testMaxDocs(AutoCommitTest.java:225)
   [junit4]    >        at java.lang.Thread.run(Thread.java:748)
   [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:14&qt=&start=0&rows=20&version=2.2
   [junit4]    >        at 
org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:871)
   [junit4]    >        ... 40 more
   [junit4]   2> 2021045 INFO  (commitScheduler-6811-thread-1) [    
x:collection1] o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 2021048 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.SolrTestCaseJ4 ###Starting testMaxTime
   [junit4]   2> 2021069 INFO  (commitScheduler-6811-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@1e36e163[collection1] main]
   [junit4]   2> 2021071 INFO  
(searcherExecutor-6808-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@1e36e163[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):c16)))}
   [junit4]   2> 2021071 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 2021071 INFO  (commitScheduler-6811-thread-1) [    
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 2021071 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@74f0950e[collection1] realtime]
   [junit4]   2> 2021071 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6C635631E0A88893]) [    x:collection1] 
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 26
   [junit4]   2> 2021077 ERROR 
(TEST-AutoCommitTest.testMaxTime-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.c.CorePropertiesLocator Couldn't load core descriptor from 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\collection1\core.properties:java.nio.file.NoSuchFileException:
 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\collection1\core.properties
   [junit4]   2> 2021079 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: 
[/C:/Users/jenkins/workspace/Lucene-Solr-master-Windows/solr/core/src/test-files/solr/collection1/lib,
 
/C:/Users/jenkins/workspace/Lucene-Solr-master-Windows/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 2021157 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 2021175 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 2021263 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 2021278 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using configuration from 
instancedir 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\collection1
   [junit4]   2> 2021291 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 
'solr.core.collection1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@495fcaaa
   [junit4]   2> 2021291 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\collection1],
 
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.update.AutoCommitTest_6C635631E0A88893-001\init-core-data-001\]
   [junit4]   2> 2021464 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2021464 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2021466 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@b9ba09f[collection1] main]
   [junit4]   2> 2021468 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 2021470 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 2021485 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 2021485 INFO  
(searcherExecutor-6812-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 2021486 INFO  
(searcherExecutor-6812-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 2021486 INFO  
(searcherExecutor-6812-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 2021486 INFO  
(searcherExecutor-6812-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 2021487 INFO  
(searcherExecutor-6812-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 2021487 INFO  
(searcherExecutor-6812-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 2021488 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=42, maxMergeAtOnceExplicit=17, maxMergedSegmentMB=47.9052734375, 
floorSegmentMB=1.9208984375, forceMergeDeletesPctAllowed=3.2942542564801967, 
segmentsPerTier=44.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 2021488 INFO  
(searcherExecutor-6812-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 2021489 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 2021489 INFO  
(searcherExecutor-6812-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 2021489 INFO  
(searcherExecutor-6812-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 2021493 INFO  
(searcherExecutor-6812-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@b9ba09f[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2021493 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@1b3931f6[collection1] main]
   [junit4]   2> 2021494 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@2c208ba1
   [junit4]   2> 2021495 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=740330401
   [junit4]   2> 2021496 INFO  
(searcherExecutor-6812-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@1b3931f6[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2021505 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[529 
(1572544401511546880)]} 0 5
   [junit4]   2> 2021505 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6C635631E0A88893]) [    x:collection1] 
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> 2023007 INFO  (commitScheduler-6815-thread-1) [    
x:collection1] o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 2023046 INFO  (commitScheduler-6815-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@33a54d1f[collection1] main]
   [junit4]   2> 2023047 INFO  
(searcherExecutor-6812-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@33a54d1f[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(8.0.0):c1)))}
   [junit4]   2> 2023049 INFO  (commitScheduler-6815-thread-1) [    
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 2023267 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[530 
(1572544403362283520)]} 0 1767
   [junit4]   2> 2023267 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:529&qt=&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0
   [junit4]   2> 2023270 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6C635631E0A88893]) [    x:collection1] 
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=1
   [junit4]   2> 2023278 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{delete=[529 (-1572544403376963584)]} 0 0
   [junit4]   2> 2023281 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:529&qt=&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0
   [junit4]   2> 2024789 INFO  (commitScheduler-6815-thread-1) [    
x:collection1] o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 2025688 INFO  (commitScheduler-6815-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@29714a3a[collection1] main]
   [junit4]   2> 2025721 INFO  
(searcherExecutor-6812-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@29714a3a[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(8.0.0):c1)))}
   [junit4]   2> 2025721 INFO  (commitScheduler-6815-thread-1) [    
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 2025794 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[550 
(1572544406015180800)]} 0 4295
   [junit4]   2> 2025796 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6C635631E0A88893]) [    x:collection1] 
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> 2025857 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1572544406081241088)]} 0 4357
   [junit4]   2> 2025873 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1572544406081241089)]} 0 4374
   [junit4]   2> 2025874 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1572544406099066880)]} 0 4375
   [junit4]   2> 2025874 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1572544406099066881)]} 0 4375
   [junit4]   2> 2025875 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1572544406099066882)]} 0 4376
   [junit4]   2> 2025875 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1572544406100115456)]} 0 4376
   [junit4]   2> 2025876 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1572544406101164032)]} 0 4377
   [junit4]   2> 2025876 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1572544406101164033)]} 0 4377
   [junit4]   2> 2025876 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1572544406101164034)]} 0 4377
   [junit4]   2> 2025876 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1572544406101164035)]} 0 4378
   [junit4]   2> 2025878 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:500&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
   [junit4]   2> 2027295 INFO  (commitScheduler-6815-thread-1) [    
x:collection1] o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 2027583 INFO  (commitScheduler-6815-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@13d13f04[collection1] main]
   [junit4]   2> 2027584 INFO  (commitScheduler-6815-thread-1) [    
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 2027586 INFO  
(searcherExecutor-6812-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@13d13f04[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(8.0.0):c1)
 Uninverting(_3(8.0.0):c11/9:delGen=1)))}
   [junit4]   2> 2027831 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[531 
(1572544408118624256)]} 0 6333
   [junit4]   2> 2027833 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:500&qt=&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0
   [junit4]   2> 2027833 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6C635631E0A88893]) [    x:collection1] 
o.a.s.SolrTestCaseJ4 ###Ending testMaxTime
   [junit4]   2> 2027839 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6C635631E0A88893]) [    
x:collection1] o.a.s.SolrTestCaseJ4 ###Starting testCommitWithin
   [junit4]   2> 2027840 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6C635631E0A88893]) [    
x:collection1] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL 
DOCUMENTS FROM INDEX
   [junit4]   2> 2027840 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6C635631E0A88893]) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@17c378c0[collection1] realtime]
   [junit4]   2> 2027840 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6C635631E0A88893]) [    
x:collection1] 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 1
   [junit4]   2> 2027850 ERROR 
(TEST-AutoCommitTest.testCommitWithin-seed#[6C635631E0A88893]) [    
x:collection1] o.a.s.c.CorePropertiesLocator Couldn't load core descriptor from 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\collection1\core.properties:java.nio.file.NoSuchFileException:
 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\collection1\core.properties
   [junit4]   2> 2027853 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6C635631E0A88893]) [    
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, 
from paths: 
[/C:/Users/jenkins/workspace/Lucene-Solr-master-Windows/solr/core/src/test-files/solr/collection1/lib,
 
/C:/Users/jenkins/workspace/Lucene-Solr-master-Windows/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 2028074 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6C635631E0A88893]) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 2028132 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6C635631E0A88893]) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 2028366 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6C635631E0A88893]) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 2028404 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6C635631E0A88893]) [    
x:collection1] o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using 
configuration from instancedir 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\collection1
   [junit4]   2> 2028430 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6C635631E0A88893]) [    
x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@495fcaaa
   [junit4]   2> 2028431 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6C635631E0A88893]) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\collection1],
 
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.update.AutoCommitTest_6C635631E0A88893-001\init-core-data-001\]
   [junit4]   2> 2028918 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6C635631E0A88893]) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2028918 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6C635631E0A88893]) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2028920 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6C635631E0A88893]) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@2f31709f[collection1] main]
   [junit4]   2> 2028922 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6C635631E0A88893]) [    
x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 2028968 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6C635631E0A88893]) [    
x:collection1] o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 2029059 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6C635631E0A88893]) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 2029059 INFO  
(searcherExecutor-6816-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 2029067 INFO  
(searcherExecutor-6816-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 2029067 INFO  
(searcherExecutor-6816-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 2029068 INFO  
(searcherExecutor-6816-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 2029069 INFO  
(searcherExecutor-6816-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 2029076 INFO  
(searcherExecutor-6816-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 2029077 INFO  
(searcherExecutor-6816-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 2029078 INFO  
(searcherExecutor-6816-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 2029078 INFO  
(searcherExecutor-6816-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 2029080 INFO  
(searcherExecutor-6816-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@2f31709f[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2029081 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6C635631E0A88893]) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=12, maxMergeAtOnceExplicit=32, maxMergedSegmentMB=99.123046875, 
floorSegmentMB=1.5283203125, forceMergeDeletesPctAllowed=6.359499889930872, 
segmentsPerTier=42.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.5767296482936356
   [junit4]   2> 2029082 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6C635631E0A88893]) [    
x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 2029082 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6C635631E0A88893]) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@54611e44[collection1] main]
   [junit4]   2> 2029083 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6C635631E0A88893]) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@3e7d9bfd
   [junit4]   2> 2029084 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6C635631E0A88893]) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=1048419325
   [junit4]   2> 2029085 INFO  
(searcherExecutor-6816-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@54611e44[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2029098 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6C635631E0A88893]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[529 
(1572544409478627328)]} 0 1
   [junit4]   2> 2029098 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6C635631E0A88893]) [    
x:collection1] 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> 2033099 INFO  (commitScheduler-6819-thread-1) [    
x:collection1] o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 2033119 INFO  (commitScheduler-6819-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@538d5c56[collection1] main]
   [junit4]   2> 2033122 INFO  
(searcherExecutor-6816-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@538d5c56[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_5(8.0.0):c1)))}
   [junit4]   2> 2033122 INFO  (commitScheduler-6819-thread-1) [    
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 2033264 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6C635631E0A88893]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[530 
(1572544413846994944)]} 0 4167
   [junit4]   2> 2033264 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6C635631E0A88893]) [    
x:collection1] 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> 2033266 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6C635631E0A88893]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[529 
(-1572544413850140672)]} 0 4169
   [junit4]   2> 2033266 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6C635631E0A88893]) [    
x:collection1] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:529&qt=&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0
   [junit4]   2> 2035288 INFO  (commitScheduler-6819-thread-1) [    
x:collection1] o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 2035601 INFO  (commitScheduler-6819-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@54fdc368[collection1] main]
   [junit4]   2> 2035604 INFO  (commitScheduler-6819-thread-1) [    
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 2035605 INFO  
(searcherExecutor-6816-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@54fdc368[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_6(8.0.0):c1)))}
   [junit4]   2> 2035641 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6C635631E0A88893]) [    
x:collection1] 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> 2035642 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6C635631E0A88893]) [    
x:collection1] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:530&qt=&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0
   [junit4]   2> 2035643 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6C635631E0A88893]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1572544416341557248)]} 0 6546
   [junit4]   2> 2035643 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6C635631E0A88893]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1572544416342605824)]} 0 6546
   [junit4]   2> 2035643 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6C635631E0A88893]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1572544416342605825)]} 0 6546
   [junit4]   2> 2035643 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6C635631E0A88893]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1572544416342605826)]} 0 6546
   [junit4]   2> 2035643 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6C635631E0A88893]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1572544416342605827)]} 0 6547
   [junit4]   2> 2035644 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6C635631E0A88893]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1572544416343654400)]} 0 6547
   [junit4]   2> 2035644 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6C635631E0A88893]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1572544416343654401)]} 0 6547
   [junit4]   2> 2035644 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6C635631E0A88893]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1572544416343654402)]} 0 6547
   [junit4]   2> 2035644 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6C635631E0A88893]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1572544416343654403)]} 0 6547
   [junit4]   2> 2035644 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6C635631E0A88893]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1572544416343654404)]} 0 6547
   [junit4]   2> 2035644 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6C635631E0A88893]) [    
x:collection1] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:500&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
   [junit4]   2> 2035645 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6C635631E0A88893]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1572544416344702976)]} 0 6548
   [junit4]   2> 2035645 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6C635631E0A88893]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1572544416344702977)]} 0 6548
   [junit4]   2> 2035645 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6C635631E0A88893]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1572544416344702978)]} 0 6548
   [junit4]   2> 2035645 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6C635631E0A88893]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1572544416344702979)]} 0 6548
   [junit4]   2> 2035645 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6C635631E0A88893]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1572544416344702980)]} 0 6548
   [junit4]   2> 2035645 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6C635631E0A88893]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1572544416344702981)]} 0 6548
   [junit4]   2> 2035645 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6C635631E0A88893]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1572544416344702982)]} 0 6548
   [junit4]   2> 2035645 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6C635631E0A88893]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1572544416344702983)]} 0 6548
   [junit4]   2> 2035645 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6C635631E0A88893]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1572544416344702984)]} 0 6548
   [junit4]   2> 2035646 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6C635631E0A88893]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1572544416344702985)]} 0 6549
   [junit4]   2> 2035646 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6C635631E0A88893]) [    
x:collection1] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:530&qt=&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0
   [junit4]   2> 2036646 INFO  (commitScheduler-6819-thread-1) [    
x:collection1] o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 2036648 INFO  (commitScheduler-6819-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@51976937[collection1] main]
   [junit4]   2> 2036648 INFO  (commitScheduler-6819-thread-1) [    
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 2036649 INFO  
(searcherExecutor-6816-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@51976937[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_7(8.0.0):c10/9:delGen=1)))}
   [junit4]   2> 2036649 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6C635631E0A88893]) [    
x:collection1] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:500&qt=&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0
   [junit4]   2> 2036652 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6C635631E0A88893]) [    
x:collection1] 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> 2036653 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6C635631E0A88893]) [    
x:collection1] o.a.s.SolrTestCaseJ4 ###Ending testCommitWithin
   [junit4]   2> 2036653 INFO  
(SUITE-AutoCommitTest-seed#[6C635631E0A88893]-worker) [    x:collection1] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> 2036653 INFO  
(SUITE-AutoCommitTest-seed#[6C635631E0A88893]-worker) [    x:collection1] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1087325556
   [junit4]   2> 2036653 INFO  
(SUITE-AutoCommitTest-seed#[6C635631E0A88893]-worker) [    x:collection1] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 2036654 INFO  
(SUITE-AutoCommitTest-seed#[6C635631E0A88893]-worker) [    x:collection1] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 2036655 INFO  
(SUITE-AutoCommitTest-seed#[6C635631E0A88893]-worker) [    x:collection1] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 2036655 INFO  
(SUITE-AutoCommitTest-seed#[6C635631E0A88893]-worker) [    x:collection1] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 2036655 INFO  
(coreCloseExecutor-6820-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@3f78d814
   [junit4]   2> 2036656 INFO  
(coreCloseExecutor-6820-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter close.
   [junit4]   2> 2036656 INFO  
(coreCloseExecutor-6820-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@454075e0 commitCommandVersion:0
   [junit4]   2> 2036658 INFO  
(coreCloseExecutor-6820-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=1064884244
   [junit4]   2> NOTE: leaving temporary files on disk at: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.update.AutoCommitTest_6C635631E0A88893-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): 
{field_t=PostingsFormat(name=Memory), multiDefault=Lucene50(blocksize=128), 
subject=Lucene50(blocksize=128), id=PostingsFormat(name=Asserting), 
text=PostingsFormat(name=Memory)}, 
docValues:{range_facet_l_dv=DocValuesFormat(name=Lucene70), 
_version_=DocValuesFormat(name=Direct), 
intDefault=DocValuesFormat(name=Direct), id_i1=DocValuesFormat(name=Memory), 
range_facet_i_dv=DocValuesFormat(name=Direct), 
intDvoDefault=DocValuesFormat(name=Lucene70), 
range_facet_l=DocValuesFormat(name=Direct), 
timestamp=DocValuesFormat(name=Direct)}, maxPointsInLeafNode=433, 
maxMBSortInHeap=6.502541791345657, sim=RandomSimilarity(queryNorm=false): {}, 
locale=ja-JP, timezone=America/Argentina/ComodRivadavia
   [junit4]   2> NOTE: Windows 10 10.0 amd64/Oracle Corporation 1.8.0_131 
(64-bit)/cpus=3,threads=1,free=130248320,total=313053184
   [junit4]   2> NOTE: All tests run in this JVM: [DisMaxRequestHandlerTest, 
TestXmlQParser, TestReplicationHandlerBackup, SortSpecParsingTest, 
DistributedFacetPivotWhiteBoxTest, WordBreakSolrSpellCheckerTest, 
TestMaxTokenLenTokenizer, DateMathParserTest, DeleteNodeTest, 
TestReloadAndDeleteDocs, HdfsLockFactoryTest, TestSurroundQueryParser, 
TestFoldingMultitermQuery, TestCloudNestedDocsSort, SolrCloudReportersTest, 
SecurityConfHandlerTest, TestLMDirichletSimilarityFactory, DateFieldTest, 
TestPseudoReturnFields, TestSQLHandlerNonCloud, HighlighterTest, 
TestCSVResponseWriter, OutputWriterTest, TestCoreContainer, SolrTestCaseJ4Test, 
TestCodecSupport, TestIBSimilarityFactory, TestDocBasedVersionConstraints, 
TestDistribDocBasedVersion, TestFunctionQuery, SoftAutoCommitTest, 
OverseerModifyCollectionTest, TestUpdate, TestImplicitCoreProperties, 
TestReversedWildcardFilterFactory, SaslZkACLProviderTest, TestManagedSchema, 
PrimUtilsTest, TestRandomCollapseQParserPlugin, 
TestTolerantUpdateProcessorRandomCloud, 
ClassificationUpdateProcessorFactoryTest, TestFieldCacheVsDocValues, 
TestCursorMarkWithoutUniqueKey, DeleteInactiveReplicaTest, 
SharedFSAutoReplicaFailoverTest, AtomicUpdateProcessorFactoryTest, 
DistributedFacetPivotLargeTest, TestClassNameShortening, 
TestDynamicFieldCollectionResource, HLLSerializationTest, 
TestMultiWordSynonyms, TestManagedSynonymGraphFilterFactory, 
HdfsDirectoryFactoryTest, ParsingFieldUpdateProcessorsTest, TestConfigReload, 
TestManagedStopFilterFactory, DeleteShardTest, TestNamedUpdateProcessors, 
TestSchemaManager, TestFieldCacheSort, ExplicitHLLTest, 
SolrGangliaReporterTest, CollectionTooManyReplicasTest, TestLFUCache, 
TestExactSharedStatsCache, CollectionsAPISolrJTest, 
TestExclusionRuleCollectionAccess, TestOnReconnectListenerSupport, 
HdfsBasicDistributedZk2Test, TestLockTree, ZkCLITest, TestDefaultStatsCache, 
TestShortCircuitedRequests, TestSolrFieldCacheBean, SimpleFacetsTest, 
CircularListTest, JSONWriterTest, ScriptEngineTest, TestRTimerTree, 
TestSolrCloudWithSecureImpersonation, TestManagedSchemaThreadSafety, 
SpatialFilterTest, TestSweetSpotSimilarityFactory, BlockJoinFacetSimpleTest, 
XsltUpdateRequestHandlerTest, TestLegacyTerms, TestGraphTermsQParserPlugin, 
TestTolerantSearch, OverriddenZkACLAndCredentialsProvidersTest, 
TestPullReplica, PathHierarchyTokenizerFactoryTest, TestReplicationHandler, 
TestPerFieldSimilarityWithDefaultOverride, BufferStoreTest, TestNumericTerms64, 
TestStressReorder, BigEndianAscendingWordSerializerTest, 
SolrMetricReporterTest, HdfsThreadLeakTest, ForceLeaderTest, CdcrUpdateLogTest, 
RecoveryZkTest, BinaryUpdateRequestHandlerTest, DirectoryFactoryTest, 
TestFuzzyAnalyzedSuggestions, BooleanFieldTest, MinimalSchemaTest, 
TestPayloadScoreQParserPlugin, ManagedSchemaRoundRobinCloudTest, DocValuesTest, 
PeerSyncReplicationTest, HdfsRecoverLeaseTest, TestFieldCache, 
TestRandomDVFaceting, LeaderFailureAfterFreshStartTest, RollingRestartTest, 
TestCollapseQParserPlugin, SpellCheckCollatorWithCollapseTest, 
XmlUpdateRequestHandlerTest, CleanupOldIndexTest, FastVectorHighlighterTest, 
ZkControllerTest, BasicAuthStandaloneTest, RAMDirectoryFactoryTest, 
SolrInfoBeanTest, TestReRankQParserPlugin, HdfsUnloadDistributedZkTest, 
CheckHdfsIndexTest, TestLazyCores, SubstringBytesRefFilterTest, 
TriLevelCompositeIdRoutingTest, TestPivotHelperCode, 
TestOverriddenPrefixQueryForCustomFieldType, SpatialHeatmapFacetsTest, 
TestConfigSets, SuggesterTest, SliceStateTest, TestBinaryField, 
CreateCollectionCleanupTest, TestOmitPositions, 
DefaultValueUpdateProcessorTest, TestQuerySenderNoQuery, 
TestSchemaNameResource, RemoteQueryErrorTest, NotRequiredUniqueKeyTest, 
ChaosMonkeyNothingIsSafeTest, TestFreeTextSuggestions, 
TestComplexPhraseQParserPlugin, TestPushWriter, RequestHandlersTest, 
TestSolrDeletionPolicy2, ImplicitSnitchTest, TestSolrXml, MergeStrategyTest, 
ZkStateReaderTest, TestHdfsUpdateLog, BasicDistributedZkTest, NodeMutatorTest, 
CursorMarkTest, TestGraphMLResponseWriter, UUIDFieldTest, TestRawTransformer, 
ResponseLogComponentTest, TestRequestForwarding, 
HdfsChaosMonkeyNothingIsSafeTest, SimplePostToolTest, DistribCursorPagingTest, 
JvmMetricsTest, BlockJoinFacetDistribTest, TestSubQueryTransformerCrossCore, 
DistributedQueryComponentOptimizationTest, TestBinaryResponseWriter, 
OverseerTest, ChaosMonkeySafeLeaderTest, UnloadDistributedZkTest, 
SyncSliceTest, ZkSolrClientTest, AutoCommitTest]
   [junit4] Completed [375/727 (1!)] on J0 in 18.39s, 3 tests, 1 error <<< 
FAILURES!

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

Reply via email to