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

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([F0768A11149B5600:49F75CCE3871528A]:0)
        at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:878)
        at 
org.apache.solr.update.AutoCommitTest.testMaxDocs(AutoCommitTest.java:225)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.base/java.lang.reflect.Method.invoke(Method.java:564)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.base/java.lang.Thread.run(Thread.java:844)
Caused by: java.lang.RuntimeException: REQUEST FAILED: 
xpath=//result[@numFound=1]
        xml response was: <?xml version="1.0" encoding="UTF-8"?>
<response>
<lst name="responseHeader"><int name="status">0</int><int 
name="QTime">0</int></lst><result name="response" numFound="0" 
start="0"></result>
</response>

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




Build Log:
[...truncated 11954 lines...]
   [junit4] Suite: org.apache.solr.update.AutoCommitTest
   [junit4]   2> Creating dataDir: 
/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/build/solr-core/test/J0/temp/solr.update.AutoCommitTest_F0768A11149B5600-001/init-core-data-001
   [junit4]   2> 1067750 WARN  
(SUITE-AutoCommitTest-seed#[F0768A11149B5600]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=1181 numCloses=1181
   [junit4]   2> 1067750 INFO  
(SUITE-AutoCommitTest-seed#[F0768A11149B5600]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 1067750 INFO  
(SUITE-AutoCommitTest-seed#[F0768A11149B5600]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via: 
@org.apache.solr.util.RandomizeSSL(reason="", ssl=0.0/0.0, value=0.0/0.0, 
clientAuth=0.0/0.0)
   [junit4]   2> 1067750 INFO  
(SUITE-AutoCommitTest-seed#[F0768A11149B5600]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 1067751 INFO  
(SUITE-AutoCommitTest-seed#[F0768A11149B5600]-worker) [    ] 
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: 
[/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/core/src/test-files/solr/collection1/lib,
 
/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1067768 INFO  
(SUITE-AutoCommitTest-seed#[F0768A11149B5600]-worker) [    ] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1067778 INFO  
(SUITE-AutoCommitTest-seed#[F0768A11149B5600]-worker) [    ] 
o.a.s.s.IndexSchema [null] Schema name=test
   [junit4]   2> 1067817 INFO  
(SUITE-AutoCommitTest-seed#[F0768A11149B5600]-worker) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1067840 INFO  
(SUITE-AutoCommitTest-seed#[F0768A11149B5600]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3ca058c
   [junit4]   2> 1067842 INFO  
(SUITE-AutoCommitTest-seed#[F0768A11149B5600]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3ca058c
   [junit4]   2> 1067843 INFO  
(SUITE-AutoCommitTest-seed#[F0768A11149B5600]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3ca058c
   [junit4]   2> 1067843 INFO  (coreLoadExecutor-3850-thread-1) [    ] 
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: 
[/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/core/src/test-files/solr/collection1/lib,
 
/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1067858 INFO  (coreLoadExecutor-3850-thread-1) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1067868 INFO  (coreLoadExecutor-3850-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1067914 INFO  (coreLoadExecutor-3850-thread-1) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1067919 INFO  (coreLoadExecutor-3850-thread-1) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from 
instancedir 
/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/core/src/test-files/solr/collection1,
 trusted=true
   [junit4]   2> 1067920 INFO  (coreLoadExecutor-3850-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 
'solr.core.collection1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@3ca058c
   [junit4]   2> 1067920 INFO  (coreLoadExecutor-3850-thread-1) [    ] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 1067920 INFO  (coreLoadExecutor-3850-thread-1) [    ] 
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/core/src/test-files/solr/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/build/solr-core/test/J0/temp/solr.update.AutoCommitTest_F0768A11149B5600-001/init-core-data-001/]
   [junit4]   2> 1067921 INFO  (coreLoadExecutor-3850-thread-1) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=11, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.0]
   [junit4]   2> 1067948 INFO  (coreLoadExecutor-3850-thread-1) [    ] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1067948 INFO  (coreLoadExecutor-3850-thread-1) [    ] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1067948 INFO  (coreLoadExecutor-3850-thread-1) [    ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1067948 INFO  (coreLoadExecutor-3850-thread-1) [    ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1067949 INFO  (coreLoadExecutor-3850-thread-1) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=16, maxMergeAtOnceExplicit=12, maxMergedSegmentMB=12.5458984375, 
floorSegmentMB=1.7333984375, forceMergeDeletesPctAllowed=15.724612048924758, 
segmentsPerTier=11.0, maxCFSSegmentSizeMB=1.9521484375, noCFSRatio=0.0
   [junit4]   2> 1067949 INFO  (coreLoadExecutor-3850-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@40ebe4ae[collection1] main]
   [junit4]   2> 1067949 INFO  (coreLoadExecutor-3850-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1067970 INFO  (coreLoadExecutor-3850-thread-1) [    ] 
o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 1068028 INFO  (coreLoadExecutor-3850-thread-1) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1068029 INFO  (searcherExecutor-3851-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1068029 INFO  (coreLoadExecutor-3850-thread-1) [    ] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1573678598346244096
   [junit4]   2> 1068029 INFO  (searcherExecutor-3851-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1068029 INFO  (searcherExecutor-3851-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1068029 INFO  (searcherExecutor-3851-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 1068029 INFO  (searcherExecutor-3851-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1068030 INFO  (searcherExecutor-3851-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1068030 INFO  (searcherExecutor-3851-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1068031 INFO  (searcherExecutor-3851-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 1068031 INFO  
(SUITE-AutoCommitTest-seed#[F0768A11149B5600]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 1068031 INFO  (searcherExecutor-3851-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 1068032 INFO  (searcherExecutor-3851-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@40ebe4ae[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1068032 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[F0768A11149B5600]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testMaxDocs
   [junit4]   2> 1068033 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1068033 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[F0768A11149B5600]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@6557a9c0[collection1] realtime]
   [junit4]   2> 1068033 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[F0768A11149B5600]) [    ] 
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> 1068033 ERROR 
(TEST-AutoCommitTest.testMaxDocs-seed#[F0768A11149B5600]) [    ] 
o.a.s.c.CorePropertiesLocator Couldn't load core descriptor from 
/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/core/src/test-files/solr/collection1/core.properties:java.nio.file.NoSuchFileException:
 
/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/core/src/test-files/solr/collection1/core.properties
   [junit4]   2> 1068034 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[F0768A11149B5600]) [    ] 
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: 
[/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/core/src/test-files/solr/collection1/lib,
 
/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1068056 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[F0768A11149B5600]) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1068074 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[F0768A11149B5600]) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1068157 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[F0768A11149B5600]) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1068166 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[F0768A11149B5600]) [    ] 
o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using configuration from 
instancedir 
/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/core/src/test-files/solr/collection1
   [junit4]   2> 1068181 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[F0768A11149B5600]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 
'solr.core.collection1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@3ca058c
   [junit4]   2> 1068181 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[F0768A11149B5600]) [    ] 
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/core/src/test-files/solr/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/build/solr-core/test/J0/temp/solr.update.AutoCommitTest_F0768A11149B5600-001/init-core-data-001/]
   [junit4]   2> 1068226 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1068226 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1068227 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[F0768A11149B5600]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@622f0c2e[collection1] main]
   [junit4]   2> 1068228 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[F0768A11149B5600]) [    ] 
o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1068229 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[F0768A11149B5600]) [    ] 
o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 1068231 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[F0768A11149B5600]) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1068231 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1573678598558056448
   [junit4]   2> 1068236 INFO  (searcherExecutor-3856-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1068236 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=17, maxMergeAtOnceExplicit=33, maxMergedSegmentMB=14.873046875, 
floorSegmentMB=1.8994140625, forceMergeDeletesPctAllowed=22.75040880210543, 
segmentsPerTier=29.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 1068236 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 1068236 INFO  (searcherExecutor-3856-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1068236 INFO  (searcherExecutor-3856-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1068236 INFO  (searcherExecutor-3856-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 1068237 INFO  (searcherExecutor-3856-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1068237 INFO  (searcherExecutor-3856-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1068237 INFO  (searcherExecutor-3856-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1068237 INFO  (searcherExecutor-3856-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 1068238 INFO  (searcherExecutor-3856-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 1068239 INFO  (searcherExecutor-3856-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@622f0c2e[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1068239 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[F0768A11149B5600]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@58a83df7[collection1] main]
   [junit4]   2> 1068240 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[F0768A11149B5600]) [    ] 
o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@386744f4
   [junit4]   2> 1068240 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[F0768A11149B5600]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=946291956
   [junit4]   2> 1068248 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[0 
(1573678598574833664)]} 0 1
   [junit4]   2> 1068248 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[1 
(1573678598575882240)]} 0 1
   [junit4]   2> 1068249 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[2 
(1573678598575882241)]} 0 2
   [junit4]   2> 1068249 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[3 
(1573678598576930816)]} 0 2
   [junit4]   2> 1068249 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[4 
(1573678598576930817)]} 0 2
   [junit4]   2> 1068250 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[5 
(1573678598577979392)]} 0 4
   [junit4]   2> 1068250 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[6 
(1573678598577979393)]} 0 4
   [junit4]   2> 1068251 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[7 
(1573678598579027968)]} 0 4
   [junit4]   2> 1068251 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[8 
(1573678598579027969)]} 0 4
   [junit4]   2> 1068250 INFO  (searcherExecutor-3856-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@58a83df7[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1068270 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[9 
(1573678598598950912)]} 0 23
   [junit4]   2> 1068270 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[10 
(1573678598598950913)]} 0 24
   [junit4]   2> 1068270 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[11 
(1573678598598950914)]} 0 24
   [junit4]   2> 1068271 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[12 
(1573678598599999488)]} 0 24
   [junit4]   2> 1068271 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[13 
(1573678598599999489)]} 0 24
   [junit4]   2> 1068271 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[F0768A11149B5600]) [    ] 
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> 1068272 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[14 
(1573678598601048064)]} 0 26
   [junit4]   2> 1068273 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[15 
(1573678598602096640)]} 0 26
   [junit4]   2> 1068273 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[F0768A11149B5600]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:14&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
   [junit4]   2> 1068313 ERROR 
(TEST-AutoCommitTest.testMaxDocs-seed#[F0768A11149B5600]) [    ] 
o.a.s.SolrTestCaseJ4 REQUEST FAILED: xpath=//result[@numFound=1]
   [junit4]   2>        xml response was: <?xml version="1.0" encoding="UTF-8"?>
   [junit4]   2> <response>
   [junit4]   2> <lst name="responseHeader"><int name="status">0</int><int 
name="QTime">0</int></lst><result name="response" numFound="0" 
start="0"></result>
   [junit4]   2> </response>
   [junit4]   2> 
   [junit4]   2>        request was:q=id:14&qt=&start=0&rows=20&version=2.2
   [junit4]   2> 1068313 ERROR 
(TEST-AutoCommitTest.testMaxDocs-seed#[F0768A11149B5600]) [    ] 
o.a.s.SolrTestCaseJ4 REQUEST FAILED: 
q=id:14&qt=&start=0&rows=20&version=2.2:java.lang.RuntimeException: REQUEST 
FAILED: xpath=//result[@numFound=1]
   [junit4]   2>        xml response was: <?xml version="1.0" encoding="UTF-8"?>
   [junit4]   2> <response>
   [junit4]   2> <lst name="responseHeader"><int name="status">0</int><int 
name="QTime">0</int></lst><result name="response" numFound="0" 
start="0"></result>
   [junit4]   2> </response>
   [junit4]   2> 
   [junit4]   2>        request was:q=id:14&qt=&start=0&rows=20&version=2.2
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:871)
   [junit4]   2>        at 
org.apache.solr.update.AutoCommitTest.testMaxDocs(AutoCommitTest.java:225)
   [junit4]   2>        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   [junit4]   2>        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
   [junit4]   2>        at 
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   [junit4]   2>        at 
java.base/java.lang.reflect.Method.invoke(Method.java:564)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
   [junit4]   2>        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
   [junit4]   2>        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
   [junit4]   2>        at java.base/java.lang.Thread.run(Thread.java:844)
   [junit4]   2> 
   [junit4]   2> 1068314 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[F0768A11149B5600]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testMaxDocs
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=AutoCommitTest 
-Dtests.method=testMaxDocs -Dtests.seed=F0768A11149B5600 -Dtests.multiplier=3 
-Dtests.slow=true -Dtests.locale=en-SB -Dtests.timezone=Asia/Srednekolymsk 
-Dtests.asserts=true -Dtests.file.encoding=UTF-8
   [junit4] ERROR   0.28s J0 | AutoCommitTest.testMaxDocs <<<
   [junit4]    > Throwable #1: java.lang.RuntimeException: Exception during 
query
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([F0768A11149B5600:49F75CCE3871528A]:0)
   [junit4]    >        at 
org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:878)
   [junit4]    >        at 
org.apache.solr.update.AutoCommitTest.testMaxDocs(AutoCommitTest.java:225)
   [junit4]    >        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   [junit4]    >        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
   [junit4]    >        at 
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   [junit4]    >        at 
java.base/java.lang.reflect.Method.invoke(Method.java:564)
   [junit4]    >        at java.base/java.lang.Thread.run(Thread.java:844)
   [junit4]    > Caused by: java.lang.RuntimeException: REQUEST FAILED: 
xpath=//result[@numFound=1]
   [junit4]    >        xml response was: <?xml version="1.0" encoding="UTF-8"?>
   [junit4]    > <response>
   [junit4]    > <lst name="responseHeader"><int name="status">0</int><int 
name="QTime">0</int></lst><result name="response" numFound="0" 
start="0"></result>
   [junit4]    > </response>
   [junit4]    >        request was:q=id:14&qt=&start=0&rows=20&version=2.2
   [junit4]    >        at 
org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:871)
   [junit4]    >        ... 39 more
   [junit4]   2> 1068317 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[F0768A11149B5600]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testCommitWithin
   [junit4]   2> 1068317 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1068317 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[F0768A11149B5600]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@1505e5cd[collection1] realtime]
   [junit4]   2> 1068317 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[F0768A11149B5600]) [    ] 
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> 1068318 ERROR 
(TEST-AutoCommitTest.testCommitWithin-seed#[F0768A11149B5600]) [    ] 
o.a.s.c.CorePropertiesLocator Couldn't load core descriptor from 
/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/core/src/test-files/solr/collection1/core.properties:java.nio.file.NoSuchFileException:
 
/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/core/src/test-files/solr/collection1/core.properties
   [junit4]   2> 1068318 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[F0768A11149B5600]) [    ] 
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: 
[/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/core/src/test-files/solr/collection1/lib,
 
/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1068326 INFO  (commitScheduler-3859-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 1068326 INFO  (commitScheduler-3859-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@6699a9d6[collection1] main]
   [junit4]   2> 1068326 INFO  (commitScheduler-3859-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1068327 INFO  (searcherExecutor-3856-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@6699a9d6[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1068348 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[F0768A11149B5600]) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1068367 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[F0768A11149B5600]) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1068517 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[F0768A11149B5600]) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1068525 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[F0768A11149B5600]) [    ] 
o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using configuration from 
instancedir 
/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/core/src/test-files/solr/collection1
   [junit4]   2> 1068537 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[F0768A11149B5600]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 
'solr.core.collection1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@3ca058c
   [junit4]   2> 1068537 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[F0768A11149B5600]) [    ] 
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/core/src/test-files/solr/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/build/solr-core/test/J0/temp/solr.update.AutoCommitTest_F0768A11149B5600-001/init-core-data-001/]
   [junit4]   2> 1068627 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1068627 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1068630 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[F0768A11149B5600]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@74dcbaab[collection1] main]
   [junit4]   2> 1068630 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[F0768A11149B5600]) [    ] 
o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1068631 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[F0768A11149B5600]) [    ] 
o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 1068632 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[F0768A11149B5600]) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1068633 INFO  (searcherExecutor-3860-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1068634 INFO  (searcherExecutor-3860-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1068634 INFO  (searcherExecutor-3860-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1068634 INFO  (searcherExecutor-3860-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 1068634 INFO  (searcherExecutor-3860-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1068634 INFO  (searcherExecutor-3860-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1068634 INFO  (searcherExecutor-3860-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1068635 INFO  (searcherExecutor-3860-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 1068635 INFO  (searcherExecutor-3860-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 1068635 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=31, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.5382241585955753]
   [junit4]   2> 1068636 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 1068636 INFO  (searcherExecutor-3860-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@74dcbaab[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1068636 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[F0768A11149B5600]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@854ca89[collection1] main]
   [junit4]   2> 1068636 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[F0768A11149B5600]) [    ] 
o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@6b20c7c
   [junit4]   2> 1068637 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[F0768A11149B5600]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=112331900
   [junit4]   2> 1068637 INFO  (searcherExecutor-3860-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@854ca89[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1068639 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[529 
(1573678598985875456)]} 0 0
   [junit4]   2> 1068639 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[F0768A11149B5600]) [    ] 
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> 1072639 INFO  (commitScheduler-3863-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 1072644 INFO  (commitScheduler-3863-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@195f243[collection1] main]
   [junit4]   2> 1072644 INFO  (commitScheduler-3863-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1072645 INFO  (searcherExecutor-3860-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@195f243[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(7.0.0):C1)))}
   [junit4]   2> 1072893 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[530 
(1573678603446517760)]} 0 4254
   [junit4]   2> 1072894 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[F0768A11149B5600]) [    ] 
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> 1072894 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[529 
(-1573678603447566336)]} 0 4255
   [junit4]   2> 1072894 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[F0768A11149B5600]) [    ] 
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> 1074894 INFO  (commitScheduler-3863-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 1074895 INFO  (commitScheduler-3863-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@5c4977ad[collection1] main]
   [junit4]   2> 1074896 INFO  (commitScheduler-3863-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1074897 INFO  (searcherExecutor-3860-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@5c4977ad[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(7.0.0):C1)))}
   [junit4]   2> 1075146 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[F0768A11149B5600]) [    ] 
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> 1075146 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[F0768A11149B5600]) [    ] 
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> 1075147 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1573678605810008064)]} 0 6508
   [junit4]   2> 1075147 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1573678605810008065)]} 0 6508
   [junit4]   2> 1075147 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1573678605810008066)]} 0 6509
   [junit4]   2> 1075148 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1573678605811056640)]} 0 6509
   [junit4]   2> 1075148 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1573678605811056641)]} 0 6509
   [junit4]   2> 1075148 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1573678605811056642)]} 0 6509
   [junit4]   2> 1075148 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1573678605811056643)]} 0 6509
   [junit4]   2> 1075148 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1573678605811056644)]} 0 6509
   [junit4]   2> 1075148 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1573678605811056645)]} 0 6509
   [junit4]   2> 1075148 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1573678605811056646)]} 0 6509
   [junit4]   2> 1075148 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[F0768A11149B5600]) [    ] 
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> 1075148 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1573678605811056647)]} 0 6509
   [junit4]   2> 1075149 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1573678605811056648)]} 0 6510
   [junit4]   2> 1075149 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1573678605812105216)]} 0 6510
   [junit4]   2> 1075149 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1573678605812105217)]} 0 6510
   [junit4]   2> 1075149 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1573678605812105218)]} 0 6510
   [junit4]   2> 1075149 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1573678605812105219)]} 0 6510
   [junit4]   2> 1075149 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1573678605812105220)]} 0 6510
   [junit4]   2> 1075149 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1573678605812105221)]} 0 6510
   [junit4]   2> 1075149 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1573678605812105222)]} 0 6510
   [junit4]   2> 1075149 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1573678605812105223)]} 0 6510
   [junit4]   2> 1075149 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[F0768A11149B5600]) [    ] 
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> 1076149 INFO  (commitScheduler-3863-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 1076150 INFO  (commitScheduler-3863-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@4e5a1a45[collection1] main]
   [junit4]   2> 1076150 INFO  (commitScheduler-3863-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1076151 INFO  (searcherExecutor-3860-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@4e5a1a45[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_3(7.0.0):C10/9:delGen=1)))}
   [junit4]   2> 1076400 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[F0768A11149B5600]) [    ] 
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> 1076400 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[F0768A11149B5600]) [    ] 
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> 1076400 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[F0768A11149B5600]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testCommitWithin
   [junit4]   2> 1076402 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[F0768A11149B5600]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testMaxTime
   [junit4]   2> 1076402 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1076402 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[F0768A11149B5600]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@66ed5e21[collection1] realtime]
   [junit4]   2> 1076402 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[F0768A11149B5600]) [    ] 
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> 1076402 ERROR 
(TEST-AutoCommitTest.testMaxTime-seed#[F0768A11149B5600]) [    ] 
o.a.s.c.CorePropertiesLocator Couldn't load core descriptor from 
/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/core/src/test-files/solr/collection1/core.properties:java.nio.file.NoSuchFileException:
 
/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/core/src/test-files/solr/collection1/core.properties
   [junit4]   2> 1076403 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[F0768A11149B5600]) [    ] 
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: 
[/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/core/src/test-files/solr/collection1/lib,
 
/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1076418 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[F0768A11149B5600]) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1076431 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[F0768A11149B5600]) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1076498 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[F0768A11149B5600]) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1076505 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[F0768A11149B5600]) [    ] 
o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using configuration from 
instancedir 
/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/core/src/test-files/solr/collection1
   [junit4]   2> 1076519 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[F0768A11149B5600]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 
'solr.core.collection1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@3ca058c
   [junit4]   2> 1076519 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[F0768A11149B5600]) [    ] 
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/core/src/test-files/solr/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/build/solr-core/test/J0/temp/solr.update.AutoCommitTest_F0768A11149B5600-001/init-core-data-001/]
   [junit4]   2> 1076557 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1076557 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1076558 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[F0768A11149B5600]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@10a34784[collection1] main]
   [junit4]   2> 1076558 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[F0768A11149B5600]) [    ] 
o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1076562 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[F0768A11149B5600]) [    ] 
o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 1076564 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[F0768A11149B5600]) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1076564 INFO  (searcherExecutor-3864-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1076565 INFO  (searcherExecutor-3864-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1076565 INFO  (searcherExecutor-3864-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1076565 INFO  (searcherExecutor-3864-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 1076565 INFO  (searcherExecutor-3864-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1076565 INFO  (searcherExecutor-3864-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1076565 INFO  (searcherExecutor-3864-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1076566 INFO  (searcherExecutor-3864-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 1076566 INFO  (searcherExecutor-3864-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 1076566 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=40, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.28085923065453394]
   [junit4]   2> 1076566 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 1076568 INFO  (searcherExecutor-3864-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@10a34784[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1076568 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[F0768A11149B5600]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@6cde244c[collection1] main]
   [junit4]   2> 1076568 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[F0768A11149B5600]) [    ] 
o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@77d35832
   [junit4]   2> 1076568 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[F0768A11149B5600]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=2010339378
   [junit4]   2> 1076569 INFO  (searcherExecutor-3864-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@6cde244c[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1076572 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[529 
(1573678607304228864)]} 0 0
   [junit4]   2> 1076572 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[F0768A11149B5600]) [    ] 
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> 1078072 INFO  (commitScheduler-3867-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 1078074 INFO  (commitScheduler-3867-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@75af31a9[collection1] main]
   [junit4]   2> 1078074 INFO  (commitScheduler-3867-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1078075 INFO  (searcherExecutor-3864-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@75af31a9[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(7.0.0):C1)))}
   [junit4]   2> 1078078 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[530 
(1573678608883384320)]} 0 1507
   [junit4]   2> 1078079 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[F0768A11149B5600]) [    ] 
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> 1078079 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[F0768A11149B5600]) [    ] 
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> 1078080 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{delete=[529 (-1573678608885481472)]} 0 0
   [junit4]   2> 1078080 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[F0768A11149B5600]) [    ] 
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> 1079579 INFO  (commitScheduler-3867-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 1079580 INFO  (commitScheduler-3867-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@6ccb9c2b[collection1] main]
   [junit4]   2> 1079580 INFO  (commitScheduler-3867-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1079581 INFO  (searcherExecutor-3864-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@6ccb9c2b[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_5(7.0.0):C1)))}
   [junit4]   2> 1079581 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[550 
(1573678610459394048)]} 0 3009
   [junit4]   2> 1079582 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[F0768A11149B5600]) [    ] 
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> 1079582 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1573678610460442624)]} 0 3010
   [junit4]   2> 1079582 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1573678610460442625)]} 0 3010
   [junit4]   2> 1079582 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1573678610460442626)]} 0 3010
   [junit4]   2> 1079582 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1573678610460442627)]} 0 3010
   [junit4]   2> 1079582 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1573678610460442628)]} 0 3010
   [junit4]   2> 1079582 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1573678610460442629)]} 0 3010
   [junit4]   2> 1079582 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1573678610460442630)]} 0 3010
   [junit4]   2> 1079582 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1573678610460442631)]} 0 3011
   [junit4]   2> 1079583 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1573678610460442632)]} 0 3011
   [junit4]   2> 1079583 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1573678610461491200)]} 0 3011
   [junit4]   2> 1079583 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[F0768A11149B5600]) [    ] 
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> 1081081 INFO  (commitScheduler-3867-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 1081083 INFO  (commitScheduler-3867-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@52fa64c2[collection1] main]
   [junit4]   2> 1081083 INFO  (commitScheduler-3867-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1081085 INFO  (searcherExecutor-3864-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@52fa64c2[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_5(7.0.0):C1)
 Uninverting(_6(7.0.0):C11/9:delGen=1)))}
   [junit4]   2> 1081334 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[F0768A11149B5600]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[531 
(1573678612297547776)]} 0 4762
   [junit4]   2> 1081334 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[F0768A11149B5600]) [    ] 
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> 1081334 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[F0768A11149B5600]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testMaxTime
   [junit4]   2> 1081335 INFO  
(SUITE-AutoCommitTest-seed#[F0768A11149B5600]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> 1081335 INFO  
(SUITE-AutoCommitTest-seed#[F0768A11149B5600]-worker) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=2060327206
   [junit4]   2> 1081335 INFO  
(SUITE-AutoCommitTest-seed#[F0768A11149B5600]-worker) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 1081335 INFO  
(SUITE-AutoCommitTest-seed#[F0768A11149B5600]-worker) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 1081336 INFO  
(SUITE-AutoCommitTest-seed#[F0768A11149B5600]-worker) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 1081336 INFO  
(SUITE-AutoCommitTest-seed#[F0768A11149B5600]-worker) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 1081336 INFO  (coreCloseExecutor-3868-thread-1) [    ] 
o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@733210c7
   [junit4]   2> 1081336 INFO  (coreCloseExecutor-3868-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter close.
   [junit4]   2> 1081336 INFO  (coreCloseExecutor-3868-thread-1) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@60178093 commitCommandVersion:0
   [junit4]   2> 1081338 INFO  (coreCloseExecutor-3868-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=1932660935
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/build/solr-core/test/J0/temp/solr.update.AutoCommitTest_F0768A11149B5600-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): 
{field_t=PostingsFormat(name=LuceneFixedGap), 
multiDefault=PostingsFormat(name=LuceneVarGapFixedInterval), 
subject=PostingsFormat(name=LuceneVarGapFixedInterval), 
id=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
 text=PostingsFormat(name=LuceneFixedGap)}, 
docValues:{range_facet_l_dv=DocValuesFormat(name=Lucene70), 
_version_=DocValuesFormat(name=Memory), 
intDefault=DocValuesFormat(name=Memory), id_i1=DocValuesFormat(name=Lucene70), 
range_facet_i_dv=DocValuesFormat(name=Memory), 
intDvoDefault=DocValuesFormat(name=Asserting), 
range_facet_l=DocValuesFormat(name=Memory), 
timestamp=DocValuesFormat(name=Memory)}, maxPointsInLeafNode=1087, 
maxMBSortInHeap=6.676928008088401, sim=RandomSimilarity(queryNorm=true): {}, 
locale=en-SB, timezone=Asia/Srednekolymsk
   [junit4]   2> NOTE: Linux 4.10.0-26-generic amd64/Oracle Corporation 9 
(64-bit)/cpus=8,threads=1,free=87828472,total=522190848
   [junit4]   2> NOTE: All tests run in this JVM: [TestDocSet, TestSQLHandler, 
TestSizeLimitedDistributedMap, TestConfigSetsAPI, 
CoreMergeIndexesAdminHandlerTest, TestBlobHandler, BasicAuthIntegrationTest, 
BigEndianAscendingWordDeserializerTest, TestHashQParserPlugin, HLLUtilTest, 
DateRangeFieldTest, TestHighFrequencyDictionaryFactory, 
TestExceedMaxTermLength, TestSSLRandomization, HdfsUnloadDistributedZkTest, 
ConfigureRecoveryStrategyTest, TestSchemaResource, ExitableDirectoryReaderTest, 
TestSchemalessBufferedUpdates, TestMacros, SSLMigrationTest, AssignTest, 
FieldMutatingUpdateProcessorTest, TestMultiValuedNumericRangeQuery, 
PropertiesRequestHandlerTest, MigrateRouteKeyTest, TestPushWriter, 
TestSolrQueryParser, TestLuceneMatchVersion, ParsingFieldUpdateProcessorsTest, 
TestDownShardTolerantSearch, TestFieldCacheSort, SolrCloudReportersTest, 
RecoveryAfterSoftCommitTest, UpdateParamsTest, TestManagedSchemaThreadSafety, 
TestAuthenticationFramework, DeleteLastCustomShardedReplicaTest, 
TestInfoStreamLogging, TestInPlaceUpdatesStandalone, HttpPartitionTest, 
DistributedFacetPivotWhiteBoxTest, TestManagedSynonymFilterFactory, 
OverseerCollectionConfigSetProcessorTest, TestSmileRequest, 
ConjunctionSolrSpellCheckerTest, SharedFSAutoReplicaFailoverTest, 
DistributedExpandComponentTest, TestIndexingPerformance, OverseerStatusTest, 
HighlighterConfigTest, TestUnifiedSolrHighlighter, HdfsRecoverLeaseTest, 
ReplicationFactorTest, AddSchemaFieldsUpdateProcessorFactoryTest, 
TestComponentsName, TestFieldCacheWithThreads, TestAuthorizationFramework, 
SolrMetricReporterTest, DeleteShardTest, BufferStoreTest, 
DistributedSuggestComponentTest, MoveReplicaHDFSUlogDirTest, 
ImplicitSnitchTest, ManagedSchemaRoundRobinCloudTest, TestConfigSetProperties, 
SolrRequestParserTest, SortSpecParsingTest, SpellingQueryConverterTest, 
TestCryptoKeys, StatsReloadRaceTest, TestLeaderElectionWithEmptyReplica, 
BooleanFieldTest, FieldAnalysisRequestHandlerTest, CloudMLTQParserTest, 
TestTrackingShardHandlerFactory, CdcrBootstrapTest, TestBinaryField, 
UUIDUpdateProcessorFallbackTest, LargeFieldTest, PluginInfoTest, 
TestRealTimeGet, TestConfigsApi, TestDocTermOrds, ExplicitHLLTest, 
BlobRepositoryCloudTest, V2StandaloneTest, TestRandomFlRTGCloud, 
TestPHPSerializedResponseWriter, TestReloadDeadlock, BasicDistributedZkTest, 
TestLegacyFieldReuse, ConcurrentDeleteAndCreateCollectionTest, 
DistributedVersionInfoTest, TestCSVResponseWriter, TestStressLucene, 
TestSolrFieldCacheBean, TestWriterPerf, DistributedFacetPivotLongTailTest, 
DistributedQueryElevationComponentTest, TestPayloadScoreQParserPlugin, 
TestSolrCoreSnapshots, TestComplexPhraseLeadingWildcard, 
AnalyticsMergeStrategyTest, TestRandomFaceting, WrapperMergePolicyFactoryTest, 
TestBackupRepositoryFactory, QueryElevationComponentTest, TestNoOpRegenerator, 
TestNumericTerms64, MetricsConfigTest, TemplateUpdateProcessorTest, 
TestBinaryResponseWriter, TestTrieFacet, TestClusterStateMutator, 
SolrIndexSplitterTest, CollectionTooManyReplicasTest, HdfsSyncSliceTest, 
MBeansHandlerTest, OpenCloseCoreStressTest, OverseerTest, ShardRoutingTest, 
ClusterStateUpdateTest, LeaderElectionTest, ZkSolrClientTest, TestZkChroot, 
TestRandomDVFaceting, AutoCommitTest]
   [junit4] Completed [347/727 (1!)] on J0 in 13.60s, 3 tests, 1 error <<< 
FAILURES!

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

Reply via email to