You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2016/10/06 15:37:34 UTC

[JENKINS] Lucene-Solr-6.x-Solaris (64bit/jdk1.8.0) - Build # 435 - Still Unstable!

Build: https://jenkins.thetaphi.de/job/Lucene-Solr-6.x-Solaris/435/
Java: 64bit/jdk1.8.0 -XX:-UseCompressedOops -XX:+UseG1GC

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

Error Message:
Exception during query

Stack Trace:
java.lang.RuntimeException: Exception during query
	at __randomizedtesting.SeedInfo.seed([C2C2811B21090BC:B6FE4769313E7EA9]:0)
	at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:813)
	at org.apache.solr.update.AutoCommitTest.testCommitWithin(AutoCommitTest.java:353)
	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:1764)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
	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:367)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
	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:367)
	at java.lang.Thread.run(Thread.java:745)
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=standard&start=0&rows=20&version=2.2
	at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:806)
	... 40 more




Build Log:
[...truncated 11670 lines...]
   [junit4] Suite: org.apache.solr.update.AutoCommitTest
   [junit4]   2> Creating dataDir: /export/home/jenkins/workspace/Lucene-Solr-6.x-Solaris/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest_C2C2811B21090BC-001/init-core-data-001
   [junit4]   2> 1596351 INFO  (SUITE-AutoCommitTest-seed#[C2C2811B21090BC]-worker) [    ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
   [junit4]   2> 1596352 INFO  (SUITE-AutoCommitTest-seed#[C2C2811B21090BC]-worker) [    ] o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 1596353 INFO  (SUITE-AutoCommitTest-seed#[C2C2811B21090BC]-worker) [    ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/export/home/jenkins/workspace/Lucene-Solr-6.x-Solaris/solr/core/src/test-files/solr/collection1/lib, /export/home/jenkins/workspace/Lucene-Solr-6.x-Solaris/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1596396 WARN  (SUITE-AutoCommitTest-seed#[C2C2811B21090BC]-worker) [    ] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
   [junit4]   2> 1596398 INFO  (SUITE-AutoCommitTest-seed#[C2C2811B21090BC]-worker) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.3.0
   [junit4]   2> 1596431 INFO  (SUITE-AutoCommitTest-seed#[C2C2811B21090BC]-worker) [    ] o.a.s.s.IndexSchema [null] Schema name=test
   [junit4]   2> 1596595 WARN  (SUITE-AutoCommitTest-seed#[C2C2811B21090BC]-worker) [    ] o.a.s.s.IndexSchema [null] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 1596598 INFO  (SUITE-AutoCommitTest-seed#[C2C2811B21090BC]-worker) [    ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1596610 INFO  (SUITE-AutoCommitTest-seed#[C2C2811B21090BC]-worker) [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=30000&connTimeout=30000&retry=true
   [junit4]   2> 1596614 INFO  (coreLoadExecutor-5854-thread-1) [    ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/export/home/jenkins/workspace/Lucene-Solr-6.x-Solaris/solr/core/src/test-files/solr/collection1/lib, /export/home/jenkins/workspace/Lucene-Solr-6.x-Solaris/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1596642 WARN  (coreLoadExecutor-5854-thread-1) [    ] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
   [junit4]   2> 1596643 INFO  (coreLoadExecutor-5854-thread-1) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.3.0
   [junit4]   2> 1596664 INFO  (coreLoadExecutor-5854-thread-1) [    ] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1596847 WARN  (coreLoadExecutor-5854-thread-1) [    ] o.a.s.s.IndexSchema [collection1] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 1596849 INFO  (coreLoadExecutor-5854-thread-1) [    ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1596857 INFO  (coreLoadExecutor-5854-thread-1) [    ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /export/home/jenkins/workspace/Lucene-Solr-6.x-Solaris/solr/core/src/test-files/solr/collection1
   [junit4]   2> 1596857 INFO  (coreLoadExecutor-5854-thread-1) [    x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/export/home/jenkins/workspace/Lucene-Solr-6.x-Solaris/solr/core/src/test-files/solr/collection1], dataDir=[/export/home/jenkins/workspace/Lucene-Solr-6.x-Solaris/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest_C2C2811B21090BC-001/init-core-data-001/]
   [junit4]   2> 1596857 INFO  (coreLoadExecutor-5854-thread-1) [    x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@57c75c38
   [junit4]   2> 1596858 INFO  (coreLoadExecutor-5854-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=36, maxMergeAtOnceExplicit=22, maxMergedSegmentMB=41.9384765625, floorSegmentMB=1.4560546875, forceMergeDeletesPctAllowed=26.611174845021683, segmentsPerTier=38.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7985059270350227
   [junit4]   2> 1596874 INFO  (coreLoadExecutor-5854-thread-1) [    x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1596875 INFO  (coreLoadExecutor-5854-thread-1) [    x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1596876 INFO  (coreLoadExecutor-5854-thread-1) [    x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1596876 INFO  (coreLoadExecutor-5854-thread-1) [    x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1596877 INFO  (coreLoadExecutor-5854-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=48, maxMergeAtOnceExplicit=40, maxMergedSegmentMB=32.818359375, floorSegmentMB=0.765625, forceMergeDeletesPctAllowed=29.878024508138747, segmentsPerTier=49.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5329995786460127
   [junit4]   2> 1596877 INFO  (coreLoadExecutor-5854-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@9ad8e91[collection1] main]
   [junit4]   2> 1596877 INFO  (coreLoadExecutor-5854-thread-1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1596881 INFO  (coreLoadExecutor-5854-thread-1) [    x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 1596922 INFO  (coreLoadExecutor-5854-thread-1) [    x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1596922 INFO  (searcherExecutor-5855-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1596923 INFO  (searcherExecutor-5855-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1596923 INFO  (searcherExecutor-5855-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1596923 INFO  (searcherExecutor-5855-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
   [junit4]   2> 1596923 INFO  (coreLoadExecutor-5854-thread-1) [    x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1547452060388032512
   [junit4]   2> 1596923 INFO  (searcherExecutor-5855-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1596924 INFO  (searcherExecutor-5855-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1596925 INFO  (searcherExecutor-5855-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1596925 INFO  (searcherExecutor-5855-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 1596926 INFO  (searcherExecutor-5855-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 1596926 INFO  (searcherExecutor-5855-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@9ad8e91[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1596927 INFO  (SUITE-AutoCommitTest-seed#[C2C2811B21090BC]-worker) [    ] o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 1596931 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[C2C2811B21090BC]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testMaxDocs
   [junit4]   2> 1596933 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[C2C2811B21090BC]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{deleteByQuery=*:* (-1547452060396421120)} 0 1
   [junit4]   2> 1596935 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[C2C2811B21090BC]) [    ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/export/home/jenkins/workspace/Lucene-Solr-6.x-Solaris/solr/core/src/test-files/solr/collection1/lib, /export/home/jenkins/workspace/Lucene-Solr-6.x-Solaris/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1596971 WARN  (TEST-AutoCommitTest.testMaxDocs-seed#[C2C2811B21090BC]) [    ] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
   [junit4]   2> 1596973 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[C2C2811B21090BC]) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.3.0
   [junit4]   2> 1597014 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[C2C2811B21090BC]) [    ] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1597155 WARN  (TEST-AutoCommitTest.testMaxDocs-seed#[C2C2811B21090BC]) [    ] o.a.s.s.IndexSchema [collection1] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 1597159 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[C2C2811B21090BC]) [    ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1597171 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[C2C2811B21090BC]) [    ] o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using configuration from instancedir /export/home/jenkins/workspace/Lucene-Solr-6.x-Solaris/solr/core/src/test-files/solr/collection1
   [junit4]   2> 1597171 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/export/home/jenkins/workspace/Lucene-Solr-6.x-Solaris/solr/core/src/test-files/solr/collection1], dataDir=[/export/home/jenkins/workspace/Lucene-Solr-6.x-Solaris/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest_C2C2811B21090BC-001/init-core-data-001/]
   [junit4]   2> 1597172 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@57c75c38
   [junit4]   2> 1597203 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1597203 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1597204 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@7e6bc80b[collection1] main]
   [junit4]   2> 1597205 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1597206 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 1597213 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1597214 INFO  (searcherExecutor-5860-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1597214 INFO  (searcherExecutor-5860-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1597214 INFO  (searcherExecutor-5860-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1597214 INFO  (searcherExecutor-5860-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
   [junit4]   2> 1597215 INFO  (searcherExecutor-5860-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1597216 INFO  (searcherExecutor-5860-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1597216 INFO  (searcherExecutor-5860-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1597217 INFO  (searcherExecutor-5860-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 1597217 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=19, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5887387035944357]
   [junit4]   2> 1597217 INFO  (searcherExecutor-5860-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 1597218 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 1597219 INFO  (searcherExecutor-5860-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@7e6bc80b[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1597219 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@9e9ec18[collection1] main]
   [junit4]   2> 1597220 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@6d50f0b5
   [junit4]   2> 1597221 INFO  (searcherExecutor-5860-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@9e9ec18[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1597237 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[0 (1547452060716236800)]} 0 1
   [junit4]   2> 1597237 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[1 (1547452060717285376)]} 0 1
   [junit4]   2> 1597238 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[2 (1547452060717285377)]} 0 2
   [junit4]   2> 1597238 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[3 (1547452060718333952)]} 0 2
   [junit4]   2> 1597238 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[4 (1547452060718333953)]} 0 2
   [junit4]   2> 1597238 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[5 (1547452060718333954)]} 0 2
   [junit4]   2> 1597239 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[6 (1547452060719382528)]} 0 3
   [junit4]   2> 1597239 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[7 (1547452060719382529)]} 0 3
   [junit4]   2> 1597239 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[8 (1547452060719382530)]} 0 3
   [junit4]   2> 1597239 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[9 (1547452060719382531)]} 0 3
   [junit4]   2> 1597239 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[10 (1547452060719382532)]} 0 3
   [junit4]   2> 1597240 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[11 (1547452060719382533)]} 0 4
   [junit4]   2> 1597240 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[12 (1547452060720431104)]} 0 4
   [junit4]   2> 1597241 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[13 (1547452060720431105)]} 0 5
   [junit4]   2> 1597241 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:1&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
   [junit4]   2> 1597242 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[14 (1547452060721479680)]} 0 6
   [junit4]   2> 1597244 INFO  (commitScheduler-5863-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> 1597247 INFO  (commitScheduler-5863-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1e949b61[collection1] main]
   [junit4]   2> 1597249 INFO  (commitScheduler-5863-thread-1) [    x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1597249 INFO  (searcherExecutor-5860-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1e949b61[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.3.0):c15)))}
   [junit4]   2> 1597493 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[15 (1547452060985720832)]} 0 258
   [junit4]   2> 1597494 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:14&qt=standard&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0
   [junit4]   2> 1597495 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:15&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
   [junit4]   2> 1597495 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.SolrTestCaseJ4 ###Ending testMaxDocs
   [junit4]   2> 1597501 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.SolrTestCaseJ4 ###Starting testCommitWithin
   [junit4]   2> 1597507 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@22528e60[collection1] realtime]
   [junit4]   2> 1597508 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{deleteByQuery=*:* (-1547452060994109440)} 0 6
   [junit4]   2> 1597509 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/export/home/jenkins/workspace/Lucene-Solr-6.x-Solaris/solr/core/src/test-files/solr/collection1/lib, /export/home/jenkins/workspace/Lucene-Solr-6.x-Solaris/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1597557 WARN  (TEST-AutoCommitTest.testCommitWithin-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
   [junit4]   2> 1597560 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.3.0
   [junit4]   2> 1597602 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1597748 WARN  (TEST-AutoCommitTest.testCommitWithin-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.s.IndexSchema [collection1] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 1597751 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1597760 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using configuration from instancedir /export/home/jenkins/workspace/Lucene-Solr-6.x-Solaris/solr/core/src/test-files/solr/collection1
   [junit4]   2> 1597760 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/export/home/jenkins/workspace/Lucene-Solr-6.x-Solaris/solr/core/src/test-files/solr/collection1], dataDir=[/export/home/jenkins/workspace/Lucene-Solr-6.x-Solaris/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest_C2C2811B21090BC-001/init-core-data-001/]
   [junit4]   2> 1597760 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@57c75c38
   [junit4]   2> 1597800 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1597801 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1597802 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@14dfb2d8[collection1] main]
   [junit4]   2> 1597802 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1597803 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 1597811 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1597812 INFO  (searcherExecutor-5864-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1597813 INFO  (searcherExecutor-5864-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1597813 INFO  (searcherExecutor-5864-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1597813 INFO  (searcherExecutor-5864-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
   [junit4]   2> 1597813 INFO  (searcherExecutor-5864-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1597814 INFO  (searcherExecutor-5864-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1597814 INFO  (searcherExecutor-5864-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1597815 INFO  (searcherExecutor-5864-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 1597815 INFO  (searcherExecutor-5864-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 1597817 INFO  (searcherExecutor-5864-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@14dfb2d8[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1597818 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=22, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.4541869239802362]
   [junit4]   2> 1597818 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 1597819 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@756ae577[collection1] main]
   [junit4]   2> 1597819 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@3bbddcbe
   [junit4]   2> 1597832 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[529 (1547452061340139520)]} 0 1
   [junit4]   2> 1597832 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:529&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
   [junit4]   2> 1597834 INFO  (searcherExecutor-5864-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@756ae577[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1597835 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[530 (1547452061343285248)]} 0 4
   [junit4]   2> 1597835 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:530&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
   [junit4]   2> 1597835 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[529 (-1547452061344333824)]} 0 4
   [junit4]   2> 1597836 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:529&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
   [junit4]   2> 1597836 ERROR (TEST-AutoCommitTest.testCommitWithin-seed#[C2C2811B21090BC]) [    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=standard&start=0&rows=20&version=2.2
   [junit4]   2> 1597837 ERROR (TEST-AutoCommitTest.testCommitWithin-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.SolrTestCaseJ4 REQUEST FAILED: q=id:529&qt=standard&start=0&rows=20&version=2.2:java.lang.RuntimeException: REQUEST FAILED: xpath=//result[@numFound=1]
   [junit4]   2> 	xml response was: <?xml version="1.0" encoding="UTF-8"?>
   [junit4]   2> <response>
   [junit4]   2> <lst name="responseHeader"><int name="status">0</int><int name="QTime">0</int></lst><result name="response" numFound="0" start="0"></result>
   [junit4]   2> </response>
   [junit4]   2> 
   [junit4]   2> 	request was:q=id:529&qt=standard&start=0&rows=20&version=2.2
   [junit4]   2> 	at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:806)
   [junit4]   2> 	at org.apache.solr.update.AutoCommitTest.testCommitWithin(AutoCommitTest.java:353)
   [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:1764)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
   [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:367)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
   [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:367)
   [junit4]   2> 	at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 
   [junit4]   2> 1597837 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.SolrTestCaseJ4 ###Ending testCommitWithin
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=AutoCommitTest -Dtests.method=testCommitWithin -Dtests.seed=C2C2811B21090BC -Dtests.slow=true -Dtests.locale=sk-SK -Dtests.timezone=Chile/EasterIsland -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
   [junit4] ERROR   0.35s J1 | AutoCommitTest.testCommitWithin <<<
   [junit4]    > Throwable #1: java.lang.RuntimeException: Exception during query
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([C2C2811B21090BC:B6FE4769313E7EA9]:0)
   [junit4]    > 	at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:813)
   [junit4]    > 	at org.apache.solr.update.AutoCommitTest.testCommitWithin(AutoCommitTest.java:353)
   [junit4]    > 	at java.lang.Thread.run(Thread.java:745)
   [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=standard&start=0&rows=20&version=2.2
   [junit4]    > 	at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:806)
   [junit4]    > 	... 40 more
   [junit4]   2> 1597847 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.SolrTestCaseJ4 ###Starting testMaxTime
   [junit4]   2> 1597850 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@40a76c86[collection1] realtime]
   [junit4]   2> 1597850 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{deleteByQuery=*:* (-1547452061356916736)} 0 3
   [junit4]   2> 1597851 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/export/home/jenkins/workspace/Lucene-Solr-6.x-Solaris/solr/core/src/test-files/solr/collection1/lib, /export/home/jenkins/workspace/Lucene-Solr-6.x-Solaris/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1597899 WARN  (TEST-AutoCommitTest.testMaxTime-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
   [junit4]   2> 1597901 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.3.0
   [junit4]   2> 1597928 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1598118 WARN  (TEST-AutoCommitTest.testMaxTime-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.s.IndexSchema [collection1] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 1598121 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1598156 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using configuration from instancedir /export/home/jenkins/workspace/Lucene-Solr-6.x-Solaris/solr/core/src/test-files/solr/collection1
   [junit4]   2> 1598156 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/export/home/jenkins/workspace/Lucene-Solr-6.x-Solaris/solr/core/src/test-files/solr/collection1], dataDir=[/export/home/jenkins/workspace/Lucene-Solr-6.x-Solaris/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest_C2C2811B21090BC-001/init-core-data-001/]
   [junit4]   2> 1598156 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@57c75c38
   [junit4]   2> 1598186 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1598186 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1598186 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1de5619b[collection1] main]
   [junit4]   2> 1598187 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1598188 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 1598194 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1598196 INFO  (searcherExecutor-5868-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1598197 INFO  (searcherExecutor-5868-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1598197 INFO  (searcherExecutor-5868-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1598197 INFO  (searcherExecutor-5868-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
   [junit4]   2> 1598199 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=35, maxMergeAtOnceExplicit=37, maxMergedSegmentMB=13.693359375, floorSegmentMB=0.662109375, forceMergeDeletesPctAllowed=22.15092180037206, segmentsPerTier=15.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1380002999351751
   [junit4]   2> 1598199 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 1598199 WARN  (TEST-AutoCommitTest.testMaxTime-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.c.SolrCore [collection1] PERFORMANCE WARNING: Overlapping onDeckSearchers=2
   [junit4]   2> 1598199 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@734025fd[collection1] main]
   [junit4]   2> 1598200 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@38ec66ef
   [junit4]   2> 1598202 INFO  (searcherExecutor-5868-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1598202 INFO  (searcherExecutor-5868-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1598203 INFO  (searcherExecutor-5868-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1598204 INFO  (searcherExecutor-5868-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 1598205 INFO  (searcherExecutor-5868-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 1598206 INFO  (searcherExecutor-5868-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1de5619b[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1598206 INFO  (searcherExecutor-5868-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1598207 INFO  (searcherExecutor-5868-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1598207 INFO  (searcherExecutor-5868-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1598207 INFO  (searcherExecutor-5868-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
   [junit4]   2> 1598208 INFO  (searcherExecutor-5868-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1598208 INFO  (searcherExecutor-5868-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1598209 INFO  (searcherExecutor-5868-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1598209 INFO  (searcherExecutor-5868-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 1598210 INFO  (searcherExecutor-5868-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 1598213 INFO  (searcherExecutor-5868-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@734025fd[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1598250 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[529 (1547452061778444288)]} 0 4
   [junit4]   2> 1598252 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:529&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 QTime=2
   [junit4]   2> 1599251 INFO  (commitScheduler-5871-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> 1599253 INFO  (commitScheduler-5871-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@39f4b02e[collection1] main]
   [junit4]   2> 1599254 INFO  (commitScheduler-5871-thread-1) [    x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1599255 INFO  (searcherExecutor-5868-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@39f4b02e[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_3(6.3.0):c1)))}
   [junit4]   2> 1599258 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[530 (1547452062835408896)]} 0 1013
   [junit4]   2> 1599258 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:529&qt=standard&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0
   [junit4]   2> 1599259 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:530&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
   [junit4]   2> 1599259 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{delete=[529 (-1547452062837506048)]} 0 0
   [junit4]   2> 1599260 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:529&qt=standard&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0
   [junit4]   2> 1600259 INFO  (commitScheduler-5871-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> 1600262 INFO  (commitScheduler-5871-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@3f3057e1[collection1] main]
   [junit4]   2> 1600262 INFO  (commitScheduler-5871-thread-1) [    x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1600264 INFO  (searcherExecutor-5868-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@3f3057e1[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(6.3.0):c1)))}
   [junit4]   2> 1600265 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[550 (1547452063891324928)]} 0 2020
   [junit4]   2> 1600265 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:529&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
   [junit4]   2> 1600268 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1547452063893422080)]} 0 2023
   [junit4]   2> 1600269 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1547452063895519232)]} 0 2023
   [junit4]   2> 1600269 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1547452063896567808)]} 0 2024
   [junit4]   2> 1600269 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1547452063896567809)]} 0 2024
   [junit4]   2> 1600269 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1547452063896567810)]} 0 2024
   [junit4]   2> 1600269 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1547452063896567811)]} 0 2024
   [junit4]   2> 1600270 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1547452063896567812)]} 0 2025
   [junit4]   2> 1600270 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1547452063897616384)]} 0 2025
   [junit4]   2> 1600270 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1547452063897616385)]} 0 2025
   [junit4]   2> 1600270 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1547452063897616386)]} 0 2025
   [junit4]   2> 1600271 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:500&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
   [junit4]   2> 1601266 INFO  (commitScheduler-5871-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> 1601268 INFO  (commitScheduler-5871-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@2db643e5[collection1] main]
   [junit4]   2> 1601269 INFO  (commitScheduler-5871-thread-1) [    x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1601270 INFO  (searcherExecutor-5868-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@2db643e5[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(6.3.0):c1) Uninverting(_5(6.3.0):c11/9:delGen=1)))}
   [junit4]   2> 1601273 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[531 (1547452064948289536)]} 0 3028
   [junit4]   2> 1601274 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:500&qt=standard&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0
   [junit4]   2> 1601274 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[C2C2811B21090BC]) [    x:collection1] o.a.s.SolrTestCaseJ4 ###Ending testMaxTime
   [junit4]   2> 1601275 INFO  (SUITE-AutoCommitTest-seed#[C2C2811B21090BC]-worker) [    x:collection1] o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> 1601275 INFO  (SUITE-AutoCommitTest-seed#[C2C2811B21090BC]-worker) [    x:collection1] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1961179563
   [junit4]   2> 1601276 INFO  (coreCloseExecutor-5872-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@6795e461
   [junit4]   2> 1601276 INFO  (coreCloseExecutor-5872-thread-1-processing-x:collection1) [    x:collection1] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter close.
   [junit4]   2> 1601276 INFO  (coreCloseExecutor-5872-thread-1-processing-x:collection1) [    x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@2f1f4b23
   [junit4]   2> NOTE: leaving temporary files on disk at: /export/home/jenkins/workspace/Lucene-Solr-6.x-Solaris/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest_C2C2811B21090BC-001
   [junit4]   2> NOTE: test params are: codec=CheapBastard, sim=ClassicSimilarity, locale=sk-SK, timezone=Chile/EasterIsland
   [junit4]   2> NOTE: SunOS 5.11 amd64/Oracle Corporation 1.8.0_102 (64-bit)/cpus=3,threads=1,free=305158808,total=536870912
   [junit4]   2> NOTE: All tests run in this JVM: [TestSolrQueryParserDefaultOperatorResource, ZkStateReaderTest, TestMinMaxOnMultiValuedField, TestConfigSetProperties, BlockJoinFacetSimpleTest, TestReloadDeadlock, SolrIndexConfigTest, LoggingHandlerTest, CSVRequestHandlerTest, DistributedQueryComponentCustomSortTest, TestHdfsUpdateLog, TestSimpleQParserPlugin, HighlighterMaxOffsetTest, SortByFunctionTest, TestReload, TestSchemaVersionResource, TestUtils, PeerSyncReplicationTest, TestMiniSolrCloudCluster, BadIndexSchemaTest, TestFoldingMultitermQuery, OverriddenZkACLAndCredentialsProvidersTest, TestSystemIdResolver, TestWriterPerf, TestReRankQParserPlugin, ShowFileRequestHandlerTest, TestPerFieldSimilarityClassic, TestAuthenticationFramework, DistribCursorPagingTest, TestDocSet, JSONWriterTest, DistributedTermsComponentTest, TestSearchPerf, DeleteShardTest, IndexSchemaTest, HdfsBasicDistributedZk2Test, TestDynamicLoading, TestManagedResource, TestManagedSchemaAPI, DistributedIntervalFacetingTest, TestInfoStreamLogging, NoCacheHeaderTest, CoreAdminRequestStatusTest, TestRuleBasedAuthorizationPlugin, LeaderInitiatedRecoveryOnShardRestartTest, TestAuthorizationFramework, CoreAdminHandlerTest, TestLegacyFieldCache, TestUniqueKeyFieldResource, BasicAuthIntegrationTest, TestAtomicUpdateErrorCases, MergeStrategyTest, SolrInfoMBeanTest, HdfsRecoverLeaseTest, TestQueryUtils, SignatureUpdateProcessorFactoryTest, CdcrVersionReplicationTest, DateRangeFieldTest, QueryParsingTest, ReplicationFactorTest, TestConfig, TestValueSourceCache, BasicFunctionalityTest, TestReversedWildcardFilterFactory, TestConfigOverlay, CdcrBootstrapTest, HdfsUnloadDistributedZkTest, SearchHandlerTest, TestHighFrequencyDictionaryFactory, TestRandomFaceting, TestSolrQueryParser, CollectionTooManyReplicasTest, DirectUpdateHandlerOptimizeTest, DefaultValueUpdateProcessorTest, UpdateRequestProcessorFactoryTest, TestShardHandlerFactory, ResourceLoaderTest, SpellPossibilityIteratorTest, BlockDirectoryTest, AnalyticsQueryTest, TestQuerySenderListener, TestSolrConfigHandlerConcurrent, TestFieldSortValues, DateMathParserTest, DistributedFacetPivotLongTailTest, TestQuerySenderNoQuery, LukeRequestHandlerTest, TestDocBasedVersionConstraints, TestExclusionRuleCollectionAccess, HLLUtilTest, TestComplexPhraseQParserPlugin, TestTrieFacet, TestIndexingPerformance, SpatialHeatmapFacetsTest, EchoParamsTest, TestSchemaManager, TestCoreDiscovery, TestObjectReleaseTracker, TestPHPSerializedResponseWriter, TestRawResponseWriter, UpdateParamsTest, ScriptEngineTest, TestJsonRequest, RulesTest, TestFuzzyAnalyzedSuggestions, TriLevelCompositeIdRoutingTest, TestRequestForwarding, SuggesterWFSTTest, HighlighterConfigTest, TestOverriddenPrefixQueryForCustomFieldType, TestExactStatsCache, MBeansHandlerTest, RAMDirectoryFactoryTest, TestSizeLimitedDistributedMap, RemoteQueryErrorTest, ParsingFieldUpdateProcessorsTest, TestFiltering, TestLocalFSCloudBackupRestore, CdcrReplicationHandlerTest, TestJoin, SuggesterTSTTest, TestSolrQueryResponse, SegmentsInfoRequestHandlerTest, CoreSorterTest, TestLMJelinekMercerSimilarityFactory, BasicDistributedZk2Test, TestSortByMinMaxFunction, BitVectorTest, BigEndianAscendingWordDeserializerTest, CollectionsAPIDistributedZkTest, HdfsRestartWhileUpdatingTest, TestScoreJoinQPNoScore, TestDistribDocBasedVersion, SimpleCollectionCreateDeleteTest, CreateCollectionCleanupTest, TestFieldCacheVsDocValues, ShardRoutingCustomTest, TestAnalyzeInfixSuggestions, TestLMDirichletSimilarityFactory, TestTolerantUpdateProcessorRandomCloud, TestLeaderInitiatedRecoveryThread, SliceStateTest, OverseerModifyCollectionTest, TestRangeQuery, TestSolrCloudWithKerberosAlt, TestSSLRandomization, TestDistribIDF, TestStandardQParsers, TestReqParamsAPI, DistributedFacetPivotSmallTest, SyncSliceTest, RecoveryZkTest, ClusterStateUpdateTest, TestZkChroot, ZkCLITest, AutoCommitTest]
   [junit4] Completed [333/637 (1!)] on J1 in 4.98s, 3 tests, 1 error <<< FAILURES!

[...truncated 61324 lines...]