Build: https://builds.apache.org/job/Lucene-Solr-Tests-master/1861/

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([78861F52FEB5AA09:C107C98DD25FAE83]:0)
        at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:890)
        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=standard&start=0&rows=20&version=2.2
        at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:883)
        ... 40 more




Build Log:
[...truncated 11807 lines...]
   [junit4] Suite: org.apache.solr.update.AutoCommitTest
   [junit4]   2> Creating dataDir: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.update.AutoCommitTest_78861F52FEB5AA09-001/init-core-data-001
   [junit4]   2> 817838 WARN  
(SUITE-AutoCommitTest-seed#[78861F52FEB5AA09]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=13 numCloses=13
   [junit4]   2> 817838 INFO  
(SUITE-AutoCommitTest-seed#[78861F52FEB5AA09]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields
   [junit4]   2> 817840 INFO  
(SUITE-AutoCommitTest-seed#[78861F52FEB5AA09]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: 
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
   [junit4]   2> 817840 INFO  
(SUITE-AutoCommitTest-seed#[78861F52FEB5AA09]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 817841 INFO  
(SUITE-AutoCommitTest-seed#[78861F52FEB5AA09]-worker) [    ] 
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/lib,
 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 817904 INFO  
(SUITE-AutoCommitTest-seed#[78861F52FEB5AA09]-worker) [    ] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 817950 INFO  
(SUITE-AutoCommitTest-seed#[78861F52FEB5AA09]-worker) [    ] 
o.a.s.s.IndexSchema [null] Schema name=test
   [junit4]   2> 818177 INFO  
(SUITE-AutoCommitTest-seed#[78861F52FEB5AA09]-worker) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 818236 INFO  
(SUITE-AutoCommitTest-seed#[78861F52FEB5AA09]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2b3d2548
   [junit4]   2> 818242 INFO  
(SUITE-AutoCommitTest-seed#[78861F52FEB5AA09]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2b3d2548
   [junit4]   2> 818242 INFO  
(SUITE-AutoCommitTest-seed#[78861F52FEB5AA09]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2b3d2548
   [junit4]   2> 818244 INFO  (coreLoadExecutor-2864-thread-1) [    
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, 
from paths: 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/lib,
 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 818279 INFO  (coreLoadExecutor-2864-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 818337 INFO  (coreLoadExecutor-2864-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 818472 INFO  (coreLoadExecutor-2864-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 818505 INFO  (coreLoadExecutor-2864-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from instancedir 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1,
 trusted=true
   [junit4]   2> 818505 INFO  (coreLoadExecutor-2864-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@2b3d2548
   [junit4]   2> 818505 INFO  (coreLoadExecutor-2864-thread-1) [    
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 818505 INFO  (coreLoadExecutor-2864-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1],
 
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.update.AutoCommitTest_78861F52FEB5AA09-001/init-core-data-001/]
   [junit4]   2> 818507 INFO  (coreLoadExecutor-2864-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=16, maxMergeAtOnceExplicit=38, maxMergedSegmentMB=97.3037109375, 
floorSegmentMB=1.9638671875, forceMergeDeletesPctAllowed=4.8147043461876535, 
segmentsPerTier=43.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 818570 INFO  (coreLoadExecutor-2864-thread-1) [    
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 818570 INFO  (coreLoadExecutor-2864-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 818571 INFO  (coreLoadExecutor-2864-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 818571 INFO  (coreLoadExecutor-2864-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 818572 INFO  (coreLoadExecutor-2864-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=44, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.3417086885026339]
   [junit4]   2> 818573 INFO  (coreLoadExecutor-2864-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@26139caf[collection1] main]
   [junit4]   2> 818574 INFO  (coreLoadExecutor-2864-thread-1) [    
x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 818606 INFO  (coreLoadExecutor-2864-thread-1) [    
x:collection1] o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 818762 INFO  (coreLoadExecutor-2864-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 818762 INFO  
(searcherExecutor-2865-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 818762 INFO  (coreLoadExecutor-2864-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1569986145136148480
   [junit4]   2> 818763 INFO  
(searcherExecutor-2865-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 818763 INFO  
(searcherExecutor-2865-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 818763 INFO  
(searcherExecutor-2865-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 818766 INFO  
(SUITE-AutoCommitTest-seed#[78861F52FEB5AA09]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 818767 INFO  
(searcherExecutor-2865-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 818769 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[78861F52FEB5AA09]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testMaxTime
   [junit4]   2> 818770 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[78861F52FEB5AA09]) [    ] 
o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 818770 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[78861F52FEB5AA09]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@16d15715[collection1] realtime]
   [junit4]   2> 818771 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[78861F52FEB5AA09]) [    ] 
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> 818771 ERROR 
(TEST-AutoCommitTest.testMaxTime-seed#[78861F52FEB5AA09]) [    ] 
o.a.s.c.CorePropertiesLocator Couldn't load core descriptor from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/core.properties:java.nio.file.NoSuchFileException:
 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/core.properties
   [junit4]   2> 818772 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[78861F52FEB5AA09]) [    ] 
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/lib,
 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 818776 INFO  
(searcherExecutor-2865-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 818776 INFO  
(searcherExecutor-2865-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 818777 INFO  
(searcherExecutor-2865-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 818777 INFO  
(searcherExecutor-2865-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 818778 INFO  
(searcherExecutor-2865-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@26139caf[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 818806 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[78861F52FEB5AA09]) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 818838 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[78861F52FEB5AA09]) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 818968 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[78861F52FEB5AA09]) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 818975 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[78861F52FEB5AA09]) [    ] 
o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using configuration from 
instancedir 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1
   [junit4]   2> 818997 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[78861F52FEB5AA09]) [    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@2b3d2548
   [junit4]   2> 818997 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1],
 
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.update.AutoCommitTest_78861F52FEB5AA09-001/init-core-data-001/]
   [junit4]   2> 819063 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 819063 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 819064 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@71784262[collection1] main]
   [junit4]   2> 819065 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 819066 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 819070 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 819070 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1569986145459109888
   [junit4]   2> 819071 INFO  
(searcherExecutor-2870-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 819072 INFO  
(searcherExecutor-2870-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 819073 INFO  
(searcherExecutor-2870-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 819073 INFO  
(searcherExecutor-2870-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 819073 INFO  
(searcherExecutor-2870-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 819073 INFO  
(searcherExecutor-2870-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 819073 INFO  
(searcherExecutor-2870-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 819074 INFO  
(searcherExecutor-2870-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 819074 INFO  
(searcherExecutor-2870-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 819077 INFO  
(searcherExecutor-2870-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@71784262[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 819078 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=49, maxMergeAtOnceExplicit=26, maxMergedSegmentMB=90.171875, 
floorSegmentMB=2.0908203125, forceMergeDeletesPctAllowed=24.33738490441122, 
segmentsPerTier=40.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.7293910074718359
   [junit4]   2> 819078 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 819078 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@19631d3[collection1] main]
   [junit4]   2> 819079 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@194d3f5e
   [junit4]   2> 819081 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=424492894
   [junit4]   2> 819084 INFO  
(searcherExecutor-2870-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@19631d3[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 819094 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[529 
(1569986145482178560)]} 0 2
   [junit4]   2> 819094 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:529&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 
QTime=0
   [junit4]   2> 820603 INFO  (commitScheduler-2873-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> 820615 INFO  (commitScheduler-2873-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@1057cf31[collection1] main]
   [junit4]   2> 820615 INFO  (commitScheduler-2873-thread-1) [    
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 820617 INFO  
(searcherExecutor-2870-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@1057cf31[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):c1)))}
   [junit4]   2> 820849 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[530 
(1569986147323478016)]} 0 1757
   [junit4]   2> 820850 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:529&qt=standard&start=0&rows=20&version=2.2} hits=1 status=0 
QTime=0
   [junit4]   2> 820850 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:530&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 
QTime=0
   [junit4]   2> 820851 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{delete=[529 (-1569986147326623744)]} 0 0
   [junit4]   2> 820851 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:529&qt=standard&start=0&rows=20&version=2.2} hits=1 status=0 
QTime=0
   [junit4]   2> 822349 INFO  (commitScheduler-2873-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> 822353 INFO  (commitScheduler-2873-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@440559ee[collection1] main]
   [junit4]   2> 822353 INFO  (commitScheduler-2873-thread-1) [    
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 822355 INFO  
(searcherExecutor-2870-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@440559ee[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(7.0.0):c1)))}
   [junit4]   2> 822604 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[550 
(1569986149163728896)]} 0 3512
   [junit4]   2> 822604 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:529&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 
QTime=0
   [junit4]   2> 822605 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1569986149165826048)]} 0 3513
   [junit4]   2> 822606 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1569986149165826049)]} 0 3514
   [junit4]   2> 822606 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1569986149166874624)]} 0 3514
   [junit4]   2> 822606 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1569986149166874625)]} 0 3514
   [junit4]   2> 822606 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1569986149166874626)]} 0 3514
   [junit4]   2> 822607 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1569986149166874627)]} 0 3515
   [junit4]   2> 822607 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1569986149167923200)]} 0 3515
   [junit4]   2> 822607 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1569986149167923201)]} 0 3515
   [junit4]   2> 822607 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1569986149167923202)]} 0 3515
   [junit4]   2> 822614 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1569986149167923203)]} 0 3522
   [junit4]   2> 822615 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:500&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 
QTime=0
   [junit4]   2> 824104 INFO  (commitScheduler-2873-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> 824109 INFO  (commitScheduler-2873-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@1cfbb8b1[collection1] main]
   [junit4]   2> 824109 INFO  (commitScheduler-2873-thread-1) [    
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 824111 INFO  
(searcherExecutor-2870-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@1cfbb8b1[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(7.0.0):c1)
 Uninverting(_2(7.0.0):c11/9:delGen=1)))}
   [junit4]   2> 824123 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[531 
(1569986150755467264)]} 0 5031
   [junit4]   2> 824123 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:500&qt=standard&start=0&rows=20&version=2.2} hits=1 status=0 
QTime=0
   [junit4]   2> 824124 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.SolrTestCaseJ4 ###Ending testMaxTime
   [junit4]   2> 824128 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.SolrTestCaseJ4 ###Starting testMaxDocs
   [junit4]   2> 824128 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 824128 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@7f927a2[collection1] realtime]
   [junit4]   2> 824129 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[78861F52FEB5AA09]) [    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 0
   [junit4]   2> 824129 ERROR 
(TEST-AutoCommitTest.testMaxDocs-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.c.CorePropertiesLocator Couldn't load core descriptor from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/core.properties:java.nio.file.NoSuchFileException:
 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/core.properties
   [junit4]   2> 824130 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/lib,
 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 824187 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 824236 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 824377 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 824384 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using configuration from 
instancedir 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1
   [junit4]   2> 824402 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[78861F52FEB5AA09]) [    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@2b3d2548
   [junit4]   2> 824403 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1],
 
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.update.AutoCommitTest_78861F52FEB5AA09-001/init-core-data-001/]
   [junit4]   2> 824467 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 824468 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 824472 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@8c53aad[collection1] main]
   [junit4]   2> 824472 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 824473 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 824477 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 824482 INFO  
(searcherExecutor-2874-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 824482 INFO  
(searcherExecutor-2874-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 824482 INFO  
(searcherExecutor-2874-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 824482 INFO  
(searcherExecutor-2874-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 824482 INFO  
(searcherExecutor-2874-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 824483 INFO  
(searcherExecutor-2874-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 824483 INFO  
(searcherExecutor-2874-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 824483 INFO  
(searcherExecutor-2874-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 824484 INFO  
(searcherExecutor-2874-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 824487 INFO  
(searcherExecutor-2874-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@8c53aad[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 824487 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=26, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.6815476339259146]
   [junit4]   2> 824487 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 824487 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@1a3d78fc[collection1] main]
   [junit4]   2> 824488 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@7c7f8c5e
   [junit4]   2> 824488 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=2088733790
   [junit4]   2> 824492 INFO  
(searcherExecutor-2874-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@1a3d78fc[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 824493 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[0 
(1569986151145537536)]} 0 0
   [junit4]   2> 824494 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[1 
(1569986151146586112)]} 0 1
   [junit4]   2> 824507 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[2 
(1569986151157071872)]} 0 14
   [junit4]   2> 824513 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[3 
(1569986151161266176)]} 0 20
   [junit4]   2> 824513 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[4 
(1569986151166509056)]} 0 20
   [junit4]   2> 824514 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[5 
(1569986151166509057)]} 0 21
   [junit4]   2> 824523 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[6 
(1569986151176994816)]} 0 30
   [junit4]   2> 824523 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[7 
(1569986151176994817)]} 0 30
   [junit4]   2> 824524 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[8 
(1569986151176994818)]} 0 31
   [junit4]   2> 824524 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[9 
(1569986151178043392)]} 0 31
   [junit4]   2> 824524 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[10 
(1569986151178043393)]} 0 31
   [junit4]   2> 824528 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[11 
(1569986151178043394)]} 0 35
   [junit4]   2> 824529 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[12 
(1569986151183286272)]} 0 36
   [junit4]   2> 824529 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[13 
(1569986151183286273)]} 0 36
   [junit4]   2> 824529 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:1&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
   [junit4]   2> 824530 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[14 
(1569986151184334848)]} 0 37
   [junit4]   2> 824530 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[15 
(1569986151184334849)]} 0 37
   [junit4]   2> 824530 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:14&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
   [junit4]   2> 824531 ERROR 
(TEST-AutoCommitTest.testMaxDocs-seed#[78861F52FEB5AA09]) [    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=standard&start=0&rows=20&version=2.2
   [junit4]   2> 824531 ERROR 
(TEST-AutoCommitTest.testMaxDocs-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.SolrTestCaseJ4 REQUEST FAILED: 
q=id:14&qt=standard&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=standard&start=0&rows=20&version=2.2
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:883)
   [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> 824532 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[78861F52FEB5AA09]) [    x:collection1] 
o.a.s.SolrTestCaseJ4 ###Ending testMaxDocs
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=AutoCommitTest 
-Dtests.method=testMaxDocs -Dtests.seed=78861F52FEB5AA09 -Dtests.multiplier=2 
-Dtests.slow=true -Dtests.locale=hi-IN -Dtests.timezone=Pacific/Port_Moresby 
-Dtests.asserts=true -Dtests.file.encoding=UTF-8
   [junit4] ERROR   0.41s J2 | AutoCommitTest.testMaxDocs <<<
   [junit4]    > Throwable #1: java.lang.RuntimeException: Exception during 
query
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([78861F52FEB5AA09:C107C98DD25FAE83]:0)
   [junit4]    >        at 
org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:890)
   [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=standard&start=0&rows=20&version=2.2
   [junit4]    >        at 
org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:883)
   [junit4]    >        ... 40 more
   [junit4]   2> 824540 INFO  (commitScheduler-2877-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> 824553 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[78861F52FEB5AA09]) [    
x:collection1] o.a.s.SolrTestCaseJ4 ###Starting testCommitWithin
   [junit4]   2> 824567 INFO  (commitScheduler-2877-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@d0d0957[collection1] 
main]
   [junit4]   2> 824568 INFO  (commitScheduler-2877-thread-1) [    
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 824572 INFO  
(searcherExecutor-2874-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@d0d0957[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(7.0.0):c16)))}
   [junit4]   2> 824572 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[78861F52FEB5AA09]) [    
x:collection1] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL 
DOCUMENTS FROM INDEX
   [junit4]   2> 824584 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[78861F52FEB5AA09]) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@3e005e98[collection1] realtime]
   [junit4]   2> 824584 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[78861F52FEB5AA09]) [    
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 30
   [junit4]   2> 824585 ERROR 
(TEST-AutoCommitTest.testCommitWithin-seed#[78861F52FEB5AA09]) [    
x:collection1] o.a.s.c.CorePropertiesLocator Couldn't load core descriptor from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/core.properties:java.nio.file.NoSuchFileException:
 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/core.properties
   [junit4]   2> 824585 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[78861F52FEB5AA09]) [    
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, 
from paths: 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/lib,
 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 824687 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[78861F52FEB5AA09]) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 824768 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[78861F52FEB5AA09]) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 825107 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[78861F52FEB5AA09]) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 825113 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[78861F52FEB5AA09]) [    
x:collection1] o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using 
configuration from instancedir 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1
   [junit4]   2> 825136 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[78861F52FEB5AA09]) [    
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@2b3d2548
   [junit4]   2> 825136 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[78861F52FEB5AA09]) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1],
 
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.update.AutoCommitTest_78861F52FEB5AA09-001/init-core-data-001/]
   [junit4]   2> 825304 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[78861F52FEB5AA09]) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 825304 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[78861F52FEB5AA09]) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 825306 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[78861F52FEB5AA09]) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@6291c443[collection1] main]
   [junit4]   2> 825307 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[78861F52FEB5AA09]) [    
x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 825308 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[78861F52FEB5AA09]) [    
x:collection1] o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 825311 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[78861F52FEB5AA09]) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 825315 INFO  
(searcherExecutor-2878-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 825316 INFO  
(searcherExecutor-2878-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 825316 INFO  
(searcherExecutor-2878-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 825316 INFO  
(searcherExecutor-2878-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 825317 INFO  
(searcherExecutor-2878-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 825317 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[78861F52FEB5AA09]) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=25, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.4119635650670469]
   [junit4]   2> 825317 INFO  
(searcherExecutor-2878-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 825318 INFO  
(searcherExecutor-2878-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 825318 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[78861F52FEB5AA09]) [    
x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 825318 INFO  
(searcherExecutor-2878-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 825318 INFO  
(searcherExecutor-2878-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 825321 INFO  
(searcherExecutor-2878-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@6291c443[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 825324 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[78861F52FEB5AA09]) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@6be86903[collection1] main]
   [junit4]   2> 825325 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[78861F52FEB5AA09]) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@17492ce0
   [junit4]   2> 825326 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[78861F52FEB5AA09]) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=390671584
   [junit4]   2> 825338 INFO  
(searcherExecutor-2878-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@6be86903[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 825351 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[78861F52FEB5AA09]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[529 
(1569986152033681408)]} 0 10
   [junit4]   2> 825352 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[78861F52FEB5AA09]) [    
x:collection1] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:529&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 
QTime=0
   [junit4]   2> 829342 INFO  (commitScheduler-2881-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> 829348 INFO  (commitScheduler-2881-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@4e23a626[collection1] main]
   [junit4]   2> 829348 INFO  (commitScheduler-2881-thread-1) [    
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 829350 INFO  
(searcherExecutor-2878-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@4e23a626[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_5(7.0.0):c1)))}
   [junit4]   2> 829360 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[78861F52FEB5AA09]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[530 
(1569986156247908352)]} 0 4020
   [junit4]   2> 829360 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[78861F52FEB5AA09]) [    
x:collection1] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:530&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 
QTime=0
   [junit4]   2> 829361 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[78861F52FEB5AA09]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[529 
(-1569986156250005504)]} 0 4021
   [junit4]   2> 829361 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[78861F52FEB5AA09]) [    
x:collection1] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:529&qt=standard&start=0&rows=20&version=2.2} hits=1 status=0 
QTime=0
   [junit4]   2> 831361 INFO  (commitScheduler-2881-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> 831365 INFO  (commitScheduler-2881-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@347b3b56[collection1] main]
   [junit4]   2> 831365 INFO  (commitScheduler-2881-thread-1) [    
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 831367 INFO  
(searcherExecutor-2878-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@347b3b56[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_6(7.0.0):c1)))}
   [junit4]   2> 831613 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[78861F52FEB5AA09]) [    
x:collection1] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:529&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 
QTime=0
   [junit4]   2> 831613 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[78861F52FEB5AA09]) [    
x:collection1] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:530&qt=standard&start=0&rows=20&version=2.2} hits=1 status=0 
QTime=0
   [junit4]   2> 831615 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[78861F52FEB5AA09]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1569986158612447232)]} 0 6274
   [junit4]   2> 831615 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[78861F52FEB5AA09]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1569986158613495808)]} 0 6274
   [junit4]   2> 831615 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[78861F52FEB5AA09]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1569986158613495809)]} 0 6275
   [junit4]   2> 831615 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[78861F52FEB5AA09]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1569986158613495810)]} 0 6275
   [junit4]   2> 831615 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[78861F52FEB5AA09]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1569986158613495811)]} 0 6275
   [junit4]   2> 831616 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[78861F52FEB5AA09]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1569986158614544384)]} 0 6275
   [junit4]   2> 831616 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[78861F52FEB5AA09]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1569986158614544385)]} 0 6276
   [junit4]   2> 831616 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[78861F52FEB5AA09]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1569986158614544386)]} 0 6276
   [junit4]   2> 831616 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[78861F52FEB5AA09]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1569986158614544387)]} 0 6276
   [junit4]   2> 831616 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[78861F52FEB5AA09]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1569986158614544388)]} 0 6276
   [junit4]   2> 831617 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[78861F52FEB5AA09]) [    
x:collection1] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:500&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 
QTime=0
   [junit4]   2> 831618 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[78861F52FEB5AA09]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1569986158615592960)]} 0 6277
   [junit4]   2> 831618 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[78861F52FEB5AA09]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1569986158616641536)]} 0 6277
   [junit4]   2> 831618 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[78861F52FEB5AA09]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1569986158616641537)]} 0 6277
   [junit4]   2> 831618 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[78861F52FEB5AA09]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1569986158616641538)]} 0 6278
   [junit4]   2> 831618 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[78861F52FEB5AA09]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1569986158616641539)]} 0 6278
   [junit4]   2> 831618 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[78861F52FEB5AA09]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1569986158616641540)]} 0 6278
   [junit4]   2> 831618 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[78861F52FEB5AA09]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1569986158616641541)]} 0 6278
   [junit4]   2> 831619 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[78861F52FEB5AA09]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1569986158616641542)]} 0 6278
   [junit4]   2> 831619 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[78861F52FEB5AA09]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1569986158617690112)]} 0 6278
   [junit4]   2> 831619 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[78861F52FEB5AA09]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1569986158617690113)]} 0 6279
   [junit4]   2> 831619 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[78861F52FEB5AA09]) [    
x:collection1] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:530&qt=standard&start=0&rows=20&version=2.2} hits=1 status=0 
QTime=0
   [junit4]   2> 832618 INFO  (commitScheduler-2881-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> 832625 INFO  (commitScheduler-2881-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@702f65bf[collection1] main]
   [junit4]   2> 832626 INFO  (commitScheduler-2881-thread-1) [    
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 832628 INFO  
(searcherExecutor-2878-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@702f65bf[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_7(7.0.0):c10/9:delGen=1)))}
   [junit4]   2> 832628 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[78861F52FEB5AA09]) [    
x:collection1] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:500&qt=standard&start=0&rows=20&version=2.2} hits=1 status=0 
QTime=0
   [junit4]   2> 832629 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[78861F52FEB5AA09]) [    
x:collection1] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:530&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 
QTime=0
   [junit4]   2> 832629 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[78861F52FEB5AA09]) [    
x:collection1] o.a.s.SolrTestCaseJ4 ###Ending testCommitWithin
   [junit4]   2> 832630 INFO  
(SUITE-AutoCommitTest-seed#[78861F52FEB5AA09]-worker) [    x:collection1] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> 832630 INFO  
(SUITE-AutoCommitTest-seed#[78861F52FEB5AA09]-worker) [    x:collection1] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1696385284
   [junit4]   2> 832630 INFO  
(SUITE-AutoCommitTest-seed#[78861F52FEB5AA09]-worker) [    x:collection1] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 832634 INFO  
(SUITE-AutoCommitTest-seed#[78861F52FEB5AA09]-worker) [    x:collection1] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 832636 INFO  
(SUITE-AutoCommitTest-seed#[78861F52FEB5AA09]-worker) [    x:collection1] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 832638 INFO  
(SUITE-AutoCommitTest-seed#[78861F52FEB5AA09]-worker) [    x:collection1] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 832642 INFO  
(coreCloseExecutor-2882-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@1395bef1
   [junit4]   2> 832643 INFO  
(coreCloseExecutor-2882-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter close.
   [junit4]   2> 832643 INFO  
(coreCloseExecutor-2882-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@748248e0 commitCommandVersion:0
   [junit4]   2> 832647 INFO  
(coreCloseExecutor-2882-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=328580849
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.update.AutoCommitTest_78861F52FEB5AA09-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): 
{field_t=BlockTreeOrds(blocksize=128), 
multiDefault=PostingsFormat(name=LuceneVarGapDocFreqInterval), 
subject=PostingsFormat(name=LuceneVarGapDocFreqInterval), 
id=Lucene50(blocksize=128), text=BlockTreeOrds(blocksize=128)}, 
docValues:{range_facet_l_dv=DocValuesFormat(name=Asserting), 
_version_=DocValuesFormat(name=Lucene70), 
intDefault=DocValuesFormat(name=Lucene70), 
range_facet_i_dv=DocValuesFormat(name=Lucene70), 
intDvoDefault=DocValuesFormat(name=Lucene70), 
range_facet_l=DocValuesFormat(name=Lucene70), 
timestamp=DocValuesFormat(name=Lucene70)}, maxPointsInLeafNode=134, 
maxMBSortInHeap=7.196479733656719, sim=RandomSimilarity(queryNorm=false): {}, 
locale=hi-IN, timezone=Pacific/Port_Moresby
   [junit4]   2> NOTE: Linux 3.13.0-88-generic amd64/Oracle Corporation 
1.8.0_131 (64-bit)/cpus=4,threads=1,free=280578816,total=493355008
   [junit4]   2> NOTE: All tests run in this JVM: [TestSort, 
CurrencyFieldXmlFileTest, TestCollationField, HdfsChaosMonkeyNothingIsSafeTest, 
TestMacros, TestStressUserVersions, TestStressReorder, BJQParserTest, 
TestSchemaResource, DataDrivenBlockJoinTest, TestInPlaceUpdatesDistrib, 
CleanupOldIndexTest, EchoParamsTest, V2StandaloneTest, 
TestExtendedDismaxParser, TestUseDocValuesAsStored2, TestTolerantSearch, 
SolrMetricReporterTest, DistributedSuggestComponentTest, SaslZkACLProviderTest, 
BinaryUpdateRequestHandlerTest, TestPolicyCloud, TestClassicSimilarityFactory, 
RecoveryZkTest, TriLevelCompositeIdRoutingTest, 
OpenExchangeRatesOrgProviderTest, StatsReloadRaceTest, TestCustomSort, 
TestRandomCollapseQParserPlugin, ResponseHeaderTest, DirectoryFactoryTest, 
TestSubQueryTransformerCrossCore, TestSolrQueryResponse, 
TestPHPSerializedResponseWriter, TestDistributedMissingSort, 
TestXmlQParserPlugin, DirectUpdateHandlerOptimizeTest, 
StatelessScriptUpdateProcessorFactoryTest, OverseerTest, 
TestPayloadCheckQParserPlugin, TestMergePolicyConfig, AtomicUpdatesTest, 
SuggesterWFSTTest, TestPushWriter, PluginInfoTest, TestGraphTermsQParserPlugin, 
TestSolrDeletionPolicy1, HdfsTlogReplayBufferedWhileIndexingTest, 
SolrTestCaseJ4Test, TestDocBasedVersionConstraints, UnloadDistributedZkTest, 
TestDeleteCollectionOnDownNodes, TestMultiValuedNumericRangeQuery, TestNRTOpen, 
RulesTest, CdcrReplicationHandlerTest, ReplicaListTransformerTest, 
HdfsRestartWhileUpdatingTest, TestSolrCoreParser, SimpleFacetsTest, 
FieldAnalysisRequestHandlerTest, TestClassNameShortening, SynonymTokenizerTest, 
TestSolrQueryParser, TestFastOutputStream, StatsComponentTest, 
RemoteQueryErrorTest, TestSerializedLuceneMatchVersion, TestSimpleTextCodec, 
SolrGraphiteReporterTest, TestPhraseSuggestions, SolrCloudReportersTest, 
TestGroupingSearch, TestExpandComponent, TestNumericTerms32, 
DistribCursorPagingTest, TestSimpleQParserPlugin, BaseCdcrDistributedZkTest, 
PreAnalyzedFieldManagedSchemaCloudTest, DocValuesMultiTest, TestRecovery, 
CollectionsAPISolrJTest, TestWriterPerf, OutputWriterTest, TestRecoveryHdfs, 
CachingDirectoryFactoryTest, TestJsonRequest, AutoCommitTest]
   [junit4] Completed [291/725 (1!)] on J2 in 14.86s, 3 tests, 1 error <<< 
FAILURES!

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

Reply via email to