[JENKINS] Lucene-Solr-Tests-master - Build # 1988 - Unstable

Previous Topic Next Topic
 
classic Classic list List threaded Threaded
1 message Options
Reply | Threaded
Open this post in threaded view
|  
Report Content as Inappropriate

[JENKINS] Lucene-Solr-Tests-master - Build # 1988 - Unstable

Apache Jenkins Server-2
Build: https://builds.apache.org/job/Lucene-Solr-Tests-master/1988/

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

Error Message:
Exception during query

Stack Trace:
java.lang.RuntimeException: Exception during query
        at __randomizedtesting.SeedInfo.seed([25220CFC2519FFF:98A65D2D5CCB03C3]:0)
        at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:878)
        at org.apache.solr.update.AutoCommitTest.testMaxTime(AutoCommitTest.java:270)
        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:529&qt=&start=0&rows=20&version=2.2
        at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:871)
        ... 40 more




Build Log:
[...truncated 12003 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/J0/temp/solr.update.AutoCommitTest_25220CFC2519FFF-001/init-core-data-001
   [junit4]   2> 1294041 WARN  (SUITE-AutoCommitTest-seed#[25220CFC2519FFF]-worker) [    ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=66 numCloses=66
   [junit4]   2> 1294041 INFO  (SUITE-AutoCommitTest-seed#[25220CFC2519FFF]-worker) [    ] o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 1294042 INFO  (SUITE-AutoCommitTest-seed#[25220CFC2519FFF]-worker) [    ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
   [junit4]   2> 1294043 INFO  (SUITE-AutoCommitTest-seed#[25220CFC2519FFF]-worker) [    ] o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 1294043 INFO  (SUITE-AutoCommitTest-seed#[25220CFC2519FFF]-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> 1294066 INFO  (SUITE-AutoCommitTest-seed#[25220CFC2519FFF]-worker) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 1294086 INFO  (SUITE-AutoCommitTest-seed#[25220CFC2519FFF]-worker) [    ] o.a.s.s.IndexSchema [null] Schema name=test
   [junit4]   2> 1294186 INFO  (SUITE-AutoCommitTest-seed#[25220CFC2519FFF]-worker) [    ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1294211 INFO  (SUITE-AutoCommitTest-seed#[25220CFC2519FFF]-worker) [    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@38f0d6d2
   [junit4]   2> 1294214 INFO  (SUITE-AutoCommitTest-seed#[25220CFC2519FFF]-worker) [    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@38f0d6d2
   [junit4]   2> 1294214 INFO  (SUITE-AutoCommitTest-seed#[25220CFC2519FFF]-worker) [    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@38f0d6d2
   [junit4]   2> 1294215 INFO  (coreLoadExecutor-5036-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> 1294237 INFO  (coreLoadExecutor-5036-thread-1) [    x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 1294265 INFO  (coreLoadExecutor-5036-thread-1) [    x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1294357 INFO  (coreLoadExecutor-5036-thread-1) [    x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1294362 INFO  (coreLoadExecutor-5036-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> 1294362 INFO  (coreLoadExecutor-5036-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@38f0d6d2
   [junit4]   2> 1294362 INFO  (coreLoadExecutor-5036-thread-1) [    x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 1294362 INFO  (coreLoadExecutor-5036-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/J0/temp/solr.update.AutoCommitTest_25220CFC2519FFF-001/init-core-data-001/]
   [junit4]   2> 1294363 INFO  (coreLoadExecutor-5036-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=351503433, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
   [junit4]   2> 1294404 INFO  (coreLoadExecutor-5036-thread-1) [    x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1294404 INFO  (coreLoadExecutor-5036-thread-1) [    x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1294405 INFO  (coreLoadExecutor-5036-thread-1) [    x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1294405 INFO  (coreLoadExecutor-5036-thread-1) [    x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1294405 INFO  (coreLoadExecutor-5036-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=37, maxMergeAtOnceExplicit=16, maxMergedSegmentMB=61.67578125, floorSegmentMB=2.0859375, forceMergeDeletesPctAllowed=17.624064916244937, segmentsPerTier=15.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.4677625917254714
   [junit4]   2> 1294406 INFO  (coreLoadExecutor-5036-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@72d02402[collection1] main]
   [junit4]   2> 1294406 INFO  (coreLoadExecutor-5036-thread-1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1294413 INFO  (coreLoadExecutor-5036-thread-1) [    x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 1294433 INFO  (coreLoadExecutor-5036-thread-1) [    x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1294433 INFO  (searcherExecutor-5037-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1294433 INFO  (coreLoadExecutor-5036-thread-1) [    x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1573024629939765248
   [junit4]   2> 1294433 INFO  (searcherExecutor-5037-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1294433 INFO  (searcherExecutor-5037-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1294433 INFO  (searcherExecutor-5037-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
   [junit4]   2> 1294434 INFO  (searcherExecutor-5037-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1294434 INFO  (searcherExecutor-5037-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1294434 INFO  (searcherExecutor-5037-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1294434 INFO  (searcherExecutor-5037-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 1294434 INFO  (searcherExecutor-5037-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 1294443 INFO  (searcherExecutor-5037-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@72d02402[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1294445 INFO  (SUITE-AutoCommitTest-seed#[25220CFC2519FFF]-worker) [    ] o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 1294447 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[25220CFC2519FFF]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testMaxDocs
   [junit4]   2> 1294447 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[25220CFC2519FFF]) [    ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1294448 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[25220CFC2519FFF]) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@5404f2e8[collection1] realtime]
   [junit4]   2> 1294448 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[25220CFC2519FFF]) [    ] 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> 1294448 ERROR (TEST-AutoCommitTest.testMaxDocs-seed#[25220CFC2519FFF]) [    ] 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> 1294449 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[25220CFC2519FFF]) [    ] 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> 1294479 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[25220CFC2519FFF]) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 1294500 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[25220CFC2519FFF]) [    ] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1294602 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[25220CFC2519FFF]) [    ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1294608 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[25220CFC2519FFF]) [    ] 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> 1294623 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[25220CFC2519FFF]) [    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@38f0d6d2
   [junit4]   2> 1294623 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[25220CFC2519FFF]) [    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/J0/temp/solr.update.AutoCommitTest_25220CFC2519FFF-001/init-core-data-001/]
   [junit4]   2> 1294670 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1294670 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1294671 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@10c16a45[collection1] main]
   [junit4]   2> 1294672 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1294672 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 1294674 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1294674 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1573024630192472064
   [junit4]   2> 1294677 INFO  (searcherExecutor-5042-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1294677 INFO  (searcherExecutor-5042-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1294677 INFO  (searcherExecutor-5042-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1294677 INFO  (searcherExecutor-5042-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
   [junit4]   2> 1294677 INFO  (searcherExecutor-5042-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1294677 INFO  (searcherExecutor-5042-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1294678 INFO  (searcherExecutor-5042-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1294678 INFO  (searcherExecutor-5042-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 1294678 INFO  (searcherExecutor-5042-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 1294680 INFO  (searcherExecutor-5042-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@10c16a45[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1294683 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=1982912243, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
   [junit4]   2> 1294684 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 1294684 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@290b5c77[collection1] main]
   [junit4]   2> 1294684 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@723053b7
   [junit4]   2> 1294686 INFO  (searcherExecutor-5042-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@290b5c77[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1294686 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=1915769783
   [junit4]   2> 1294700 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[0 (1573024630218686464)]} 0 1
   [junit4]   2> 1294700 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[1 (1573024630219735040)]} 0 1
   [junit4]   2> 1294700 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[2 (1573024630219735041)]} 0 2
   [junit4]   2> 1294701 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[3 (1573024630219735042)]} 0 2
   [junit4]   2> 1294710 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[4 (1573024630220783616)]} 0 11
   [junit4]   2> 1294714 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[5 (1573024630234415104)]} 0 16
   [junit4]   2> 1294715 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[6 (1573024630235463680)]} 0 16
   [junit4]   2> 1294715 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[7 (1573024630235463681)]} 0 17
   [junit4]   2> 1294715 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[8 (1573024630235463682)]} 0 17
   [junit4]   2> 1294716 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[9 (1573024630235463683)]} 0 17
   [junit4]   2> 1294716 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[10 (1573024630236512256)]} 0 17
   [junit4]   2> 1294716 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[11 (1573024630236512257)]} 0 17
   [junit4]   2> 1294716 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[12 (1573024630236512258)]} 0 17
   [junit4]   2> 1294716 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[13 (1573024630236512259)]} 0 17
   [junit4]   2> 1294717 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[25220CFC2519FFF]) [    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=0
   [junit4]   2> 1294727 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[14 (1573024630248046592)]} 0 28
   [junit4]   2> 1294732 INFO  (commitScheduler-5045-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> 1294735 INFO  (commitScheduler-5045-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@3f3c8933[collection1] main]
   [junit4]   2> 1294736 INFO  (commitScheduler-5045-thread-1) [    x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1294737 INFO  (searcherExecutor-5042-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@3f3c8933[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):C15)))}
   [junit4]   2> 1294978 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[15 (1573024630510190592)]} 0 279
   [junit4]   2> 1294978 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[25220CFC2519FFF]) [    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=1 status=0 QTime=0
   [junit4]   2> 1294979 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:15&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
   [junit4]   2> 1294979 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.SolrTestCaseJ4 ###Ending testMaxDocs
   [junit4]   2> 1294981 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.SolrTestCaseJ4 ###Starting testMaxTime
   [junit4]   2> 1294981 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1294981 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@7ad7edd8[collection1] realtime]
   [junit4]   2> 1294982 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[25220CFC2519FFF]) [    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> 1294982 ERROR (TEST-AutoCommitTest.testMaxTime-seed#[25220CFC2519FFF]) [    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> 1294982 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[25220CFC2519FFF]) [    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> 1295025 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 1295054 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1295156 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1295162 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[25220CFC2519FFF]) [    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> 1295172 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[25220CFC2519FFF]) [    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@38f0d6d2
   [junit4]   2> 1295172 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[25220CFC2519FFF]) [    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/J0/temp/solr.update.AutoCommitTest_25220CFC2519FFF-001/init-core-data-001/]
   [junit4]   2> 1295210 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1295210 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1295211 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1a1deb8b[collection1] main]
   [junit4]   2> 1295211 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1295212 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 1295214 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1295216 INFO  (searcherExecutor-5046-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1295216 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=11, maxMergeAtOnceExplicit=14, maxMergedSegmentMB=36.6767578125, floorSegmentMB=1.55078125, forceMergeDeletesPctAllowed=13.575459445118234, segmentsPerTier=31.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.8229500758684704
   [junit4]   2> 1295216 INFO  (searcherExecutor-5046-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1295216 INFO  (searcherExecutor-5046-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1295216 INFO  (searcherExecutor-5046-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
   [junit4]   2> 1295217 INFO  (searcherExecutor-5046-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1295217 INFO  (searcherExecutor-5046-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1295217 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 1295217 INFO  (searcherExecutor-5046-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1295217 INFO  (searcherExecutor-5046-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 1295217 INFO  (searcherExecutor-5046-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 1295219 INFO  (searcherExecutor-5046-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1a1deb8b[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1295219 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@410e5deb[collection1] main]
   [junit4]   2> 1295220 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@7a2f95b8
   [junit4]   2> 1295220 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=2049938872
   [junit4]   2> 1295223 INFO  (searcherExecutor-5046-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@410e5deb[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1295231 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[529 (1573024630767091712)]} 0 9
   [junit4]   2> 1295231 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[25220CFC2519FFF]) [    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> 1295231 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[530 (1573024630776528896)]} 0 9
   [junit4]   2> 1295232 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[25220CFC2519FFF]) [    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> 1295232 ERROR (TEST-AutoCommitTest.testMaxTime-seed#[25220CFC2519FFF]) [    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:529&qt=&start=0&rows=20&version=2.2
   [junit4]   2> 1295232 ERROR (TEST-AutoCommitTest.testMaxTime-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.SolrTestCaseJ4 REQUEST FAILED: q=id:529&qt=&start=0&rows=20&version=2.2:java.lang.RuntimeException: REQUEST FAILED: xpath=//result[@numFound=1]
   [junit4]   2> xml response was: <?xml version="1.0" encoding="UTF-8"?>
   [junit4]   2> <response>
   [junit4]   2> <lst name="responseHeader"><int name="status">0</int><int name="QTime">0</int></lst><result name="response" numFound="0" start="0"></result>
   [junit4]   2> </response>
   [junit4]   2>
   [junit4]   2> request was:q=id:529&qt=&start=0&rows=20&version=2.2
   [junit4]   2> at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:871)
   [junit4]   2> at org.apache.solr.update.AutoCommitTest.testMaxTime(AutoCommitTest.java:270)
   [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> 1295233 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.SolrTestCaseJ4 ###Ending testMaxTime
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=AutoCommitTest -Dtests.method=testMaxTime -Dtests.seed=25220CFC2519FFF -Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=es-US -Dtests.timezone=America/Hermosillo -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
   [junit4] ERROR   0.26s J0 | AutoCommitTest.testMaxTime <<<
   [junit4]    > Throwable #1: java.lang.RuntimeException: Exception during query
   [junit4]    > at __randomizedtesting.SeedInfo.seed([25220CFC2519FFF:98A65D2D5CCB03C3]:0)
   [junit4]    > at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:878)
   [junit4]    > at org.apache.solr.update.AutoCommitTest.testMaxTime(AutoCommitTest.java:270)
   [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:529&qt=&start=0&rows=20&version=2.2
   [junit4]    > at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:871)
   [junit4]    > ... 40 more
   [junit4]   2> 1295237 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.SolrTestCaseJ4 ###Starting testCommitWithin
   [junit4]   2> 1295237 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1295238 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@6e547cc9[collection1] realtime]
   [junit4]   2> 1295238 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[25220CFC2519FFF]) [    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> 1295238 ERROR (TEST-AutoCommitTest.testCommitWithin-seed#[25220CFC2519FFF]) [    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> 1295238 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[25220CFC2519FFF]) [    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> 1295264 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 1295308 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1295411 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1295418 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[25220CFC2519FFF]) [    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> 1295445 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[25220CFC2519FFF]) [    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@38f0d6d2
   [junit4]   2> 1295445 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[25220CFC2519FFF]) [    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/J0/temp/solr.update.AutoCommitTest_25220CFC2519FFF-001/init-core-data-001/]
   [junit4]   2> 1295487 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1295487 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1295488 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@6bf7a1e[collection1] main]
   [junit4]   2> 1295489 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1295489 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 1295491 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1295493 INFO  (searcherExecutor-5050-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1295493 INFO  (searcherExecutor-5050-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1295493 INFO  (searcherExecutor-5050-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1295493 INFO  (searcherExecutor-5050-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
   [junit4]   2> 1295493 INFO  (searcherExecutor-5050-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1295494 INFO  (searcherExecutor-5050-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1295494 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=31, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
   [junit4]   2> 1295494 INFO  (searcherExecutor-5050-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1295494 INFO  (searcherExecutor-5050-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 1295494 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 1295494 INFO  (searcherExecutor-5050-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 1295496 INFO  (searcherExecutor-5050-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@6bf7a1e[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1295496 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@578894d5[collection1] main]
   [junit4]   2> 1295496 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@2d68f57b
   [junit4]   2> 1295497 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=761853307
   [junit4]   2> 1295498 INFO  (searcherExecutor-5050-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@578894d5[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1295502 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[529 (1573024631059644416)]} 0 0
   [junit4]   2> 1295502 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[25220CFC2519FFF]) [    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> 1299502 INFO  (commitScheduler-5053-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> 1299504 INFO  (commitScheduler-5053-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@5f7f85c5[collection1] main]
   [junit4]   2> 1299505 INFO  (commitScheduler-5053-thread-1) [    x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1299506 INFO  (searcherExecutor-5050-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@5f7f85c5[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_3(8.0.0):C1)))}
   [junit4]   2> 1299755 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[530 (1573024635519238144)]} 0 4253
   [junit4]   2> 1299755 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[25220CFC2519FFF]) [    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> 1299755 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[529 (-1573024635520286720)]} 0 4254
   [junit4]   2> 1299756 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[25220CFC2519FFF]) [    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> 1301756 INFO  (commitScheduler-5053-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> 1301770 INFO  (commitScheduler-5053-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@6f057a6e[collection1] main]
   [junit4]   2> 1301772 INFO  (searcherExecutor-5050-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@6f057a6e[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(8.0.0):C1)))}
   [junit4]   2> 1301772 INFO  (commitScheduler-5053-thread-1) [    x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1302009 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[25220CFC2519FFF]) [    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> 1302009 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[25220CFC2519FFF]) [    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> 1302010 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1573024637884825600)]} 0 6508
   [junit4]   2> 1302010 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1573024637884825601)]} 0 6508
   [junit4]   2> 1302010 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1573024637884825602)]} 0 6509
   [junit4]   2> 1302010 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1573024637884825603)]} 0 6509
   [junit4]   2> 1302010 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1573024637884825604)]} 0 6509
   [junit4]   2> 1302011 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1573024637885874176)]} 0 6509
   [junit4]   2> 1302011 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1573024637885874177)]} 0 6509
   [junit4]   2> 1302011 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1573024637885874178)]} 0 6509
   [junit4]   2> 1302011 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1573024637885874179)]} 0 6509
   [junit4]   2> 1302011 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1573024637885874180)]} 0 6509
   [junit4]   2> 1302011 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[25220CFC2519FFF]) [    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> 1302012 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 (-1573024637885874181)]} 0 6510
   [junit4]   2> 1302012 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 (-1573024637886922752)]} 0 6510
   [junit4]   2> 1302012 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 (-1573024637886922753)]} 0 6510
   [junit4]   2> 1302012 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 (-1573024637886922754)]} 0 6510
   [junit4]   2> 1302012 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 (-1573024637886922755)]} 0 6510
   [junit4]   2> 1302012 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 (-1573024637886922756)]} 0 6510
   [junit4]   2> 1302012 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 (-1573024637886922757)]} 0 6511
   [junit4]   2> 1302012 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 (-1573024637886922758)]} 0 6511
   [junit4]   2> 1302012 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 (-1573024637886922759)]} 0 6511
   [junit4]   2> 1302012 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 (-1573024637886922760)]} 0 6511
   [junit4]   2> 1302013 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[25220CFC2519FFF]) [    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> 1303012 INFO  (commitScheduler-5053-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> 1303014 INFO  (commitScheduler-5053-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@526fa11f[collection1] main]
   [junit4]   2> 1303014 INFO  (commitScheduler-5053-thread-1) [    x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1303016 INFO  (searcherExecutor-5050-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@526fa11f[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_5(8.0.0):C10/9:delGen=1)))}
   [junit4]   2> 1303264 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[25220CFC2519FFF]) [    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> 1303264 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[25220CFC2519FFF]) [    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> 1303264 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[25220CFC2519FFF]) [    x:collection1] o.a.s.SolrTestCaseJ4 ###Ending testCommitWithin
   [junit4]   2> 1303265 INFO  (SUITE-AutoCommitTest-seed#[25220CFC2519FFF]-worker) [    x:collection1] o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> 1303265 INFO  (SUITE-AutoCommitTest-seed#[25220CFC2519FFF]-worker) [    x:collection1] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1868822006
   [junit4]   2> 1303265 INFO  (SUITE-AutoCommitTest-seed#[25220CFC2519FFF]-worker) [    x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
   [junit4]   2> 1303266 INFO  (SUITE-AutoCommitTest-seed#[25220CFC2519FFF]-worker) [    x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
   [junit4]   2> 1303267 INFO  (SUITE-AutoCommitTest-seed#[25220CFC2519FFF]-worker) [    x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
   [junit4]   2> 1303267 INFO  (SUITE-AutoCommitTest-seed#[25220CFC2519FFF]-worker) [    x:collection1] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
   [junit4]   2> 1303267 INFO  (coreCloseExecutor-5054-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@197aa09a
   [junit4]   2> 1303268 INFO  (coreCloseExecutor-5054-thread-1-processing-x:collection1) [    x:collection1] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter close.
   [junit4]   2> 1303268 INFO  (coreCloseExecutor-5054-thread-1-processing-x:collection1) [    x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@488ce056 commitCommandVersion:0
   [junit4]   2> 1303274 INFO  (coreCloseExecutor-5054-thread-1-processing-x:collection1) [    x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=427466906
   [junit4]   2> NOTE: leaving temporary files on disk at: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.update.AutoCommitTest_25220CFC2519FFF-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): {range_facet_l_dv=BlockTreeOrds(blocksize=128), field_t=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), multiDefault=PostingsFormat(name=Memory), subject=PostingsFormat(name=Memory), intDefault=PostingsFormat(name=Memory), id_i1=PostingsFormat(name=Memory), id=BlockTreeOrds(blocksize=128), range_facet_i_dv=PostingsFormat(name=Memory), text=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), range_facet_l=PostingsFormat(name=Memory), timestamp=PostingsFormat(name=Memory)}, docValues:{range_facet_l_dv=DocValuesFormat(name=Memory), _version_=DocValuesFormat(name=Asserting), intDefault=DocValuesFormat(name=Asserting), id_i1=DocValuesFormat(name=Lucene70), range_facet_i_dv=DocValuesFormat(name=Asserting), intDvoDefault=DocValuesFormat(name=Direct), range_facet_l=DocValuesFormat(name=Asserting), timestamp=DocValuesFormat(name=Asserting)}, maxPointsInLeafNode=1125, maxMBSortInHeap=5.375370396898211, sim=RandomSimilarity(queryNorm=false): {}, locale=es-US, timezone=America/Hermosillo
   [junit4]   2> NOTE: Linux 3.13.0-88-generic amd64/Oracle Corporation 1.8.0_131 (64-bit)/cpus=4,threads=1,free=300243600,total=531628032
   [junit4]   2> NOTE: All tests run in this JVM: [RankQueryTest, ResponseHeaderTest, WordBreakSolrSpellCheckerTest, TestRawTransformer, OverseerStatusTest, SolrCoreTest, PluginInfoTest, TestCustomSort, TestHighlightDedupGrouping, TestExtendedDismaxParser, TestSSLRandomization, ConfigureRecoveryStrategyTest, TestMaxTokenLenTokenizer, XmlUpdateRequestHandlerTest, TestFaceting, NodeMutatorTest, TestBulkSchemaAPI, HdfsLockFactoryTest, OpenExchangeRatesOrgProviderTest, TestSolrCloudWithSecureImpersonation, TestSubQueryTransformer, BlockDirectoryTest, UpdateParamsTest, TestClassicSimilarityFactory, CdcrBootstrapTest, TestDocSet, OverseerCollectionConfigSetProcessorTest, IgnoreCommitOptimizeUpdateProcessorFactoryTest, EchoParamsTest, DistribDocExpirationUpdateProcessorTest, SynonymTokenizerTest, V2StandaloneTest, TestPrepRecovery, TestSizeLimitedDistributedMap, TestUseDocValuesAsStored2, ReplicationFactorTest, TestFieldCacheReopen, AtomicUpdatesTest, TestCollationFieldDocValues, TestLegacyFieldReuse, DistributedExpandComponentTest, TestSolrConfigHandler, TolerantUpdateProcessorTest, TestAnalyzeInfixSuggestions, TestBlobHandler, TestRangeQuery, TestIBSimilarityFactory, BlockJoinFacetSimpleTest, SolrCloudReportersTest, TestQuerySenderNoQuery, ExitableDirectoryReaderTest, DistributedSpellCheckComponentTest, DebugComponentTest, TestCrossCoreJoin, DistributedFacetPivotWhiteBoxTest, HdfsChaosMonkeySafeLeaderTest, SmileWriterTest, TestXmlQParserPlugin, TestStressUserVersions, TestGraphTermsQParserPlugin, PKIAuthenticationIntegrationTest, AddBlockUpdateTest, TestStressLiveNodes, MoveReplicaHDFSUlogDirTest, DataDrivenBlockJoinTest, BlobRepositoryCloudTest, TestSolrCLIRunExample, ConnectionReuseTest, TestCloudJSONFacetJoinDomain, TestMacroExpander, TestSolrCoreParser, SuggesterWFSTTest, TestDocumentBuilder, QueryElevationComponentTest, TestSQLHandler, TestBinaryField, TestNumericTokenStream, CursorMarkTest, TestConfigSetProperties, TestFieldResource, CreateCollectionCleanupTest, HighlighterConfigTest, ChaosMonkeyNothingIsSafeTest, DeleteLastCustomShardedReplicaTest, BitVectorTest, TestLegacyNumericRangeQueryBuilder, ExternalFileFieldSortTest, MetricsConfigTest, TestReplicationHandler, MBeansHandlerTest, TestClusterStateMutator, TestRandomFlRTGCloud, EnumFieldTest, ZkNodePropsTest, TestCSVLoader, TestIndexingPerformance, TestFunctionQuery, CursorPagingTest, TestSolrDeletionPolicy1, TestReplicaProperties, SolrPluginUtilsTest, PropertiesRequestHandlerTest, PeerSyncTest, TestExpandComponent, BadCopyFieldTest, FieldAnalysisRequestHandlerTest, CurrencyFieldTypeTest, OutputWriterTest, TestSolr4Spatial, HdfsSyncSliceTest, TestDocBasedVersionConstraints, TestLRUStatsCache, TestWriterPerf, TestMultiValuedNumericRangeQuery, SuggestComponentContextFilterQueryTest, TestImpersonationWithHadoopAuth, TestBadConfig, TestPHPSerializedResponseWriter, ChaosMonkeySafeLeaderTest, UnloadDistributedZkTest, CollectionsAPIDistributedZkTest, SyncSliceTest, LeaderElectionIntegrationTest, BasicZkTest, RecoveryZkTest, FullSolrCloudDistribCmdsTest, TestRandomFaceting, LeaderElectionTest, ZkSolrClientTest, TestZkChroot, TestRandomDVFaceting, ZkCLITest, ShardRoutingCustomTest, TestDistributedSearch, AutoCommitTest]
   [junit4] Completed [356/728 (1!)] on J0 in 9.25s, 3 tests, 1 error <<< FAILURES!

[...truncated 44426 lines...]


---------------------------------------------------------------------
To unsubscribe, e-mail: [hidden email]
For additional commands, e-mail: [hidden email]
Loading...