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/12/16 13:20:00 UTC

[JENKINS] Lucene-Solr-master-Solaris (64bit/jdk1.8.0) - Build # 1015 - Unstable!

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

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

Error Message:
Exception during query

Stack Trace:
java.lang.RuntimeException: Exception during query
	at __randomizedtesting.SeedInfo.seed([A2458486BB3F2FAB:38B1F96425A5B397]:0)
	at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:818)
	at org.apache.solr.update.AutoCommitTest.testMaxTime(AutoCommitTest.java:270)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:498)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:811)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:462)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java: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:811)
	... 40 more




Build Log:
[...truncated 11641 lines...]
   [junit4] Suite: org.apache.solr.update.AutoCommitTest
   [junit4]   2> Creating dataDir: /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest_A2458486BB3F2FAB-001/init-core-data-001
   [junit4]   2> 1755483 INFO  (SUITE-AutoCommitTest-seed#[A2458486BB3F2FAB]-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> 1755483 INFO  (SUITE-AutoCommitTest-seed#[A2458486BB3F2FAB]-worker) [    ] o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 1755484 INFO  (SUITE-AutoCommitTest-seed#[A2458486BB3F2FAB]-worker) [    ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/lib, /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1755513 WARN  (SUITE-AutoCommitTest-seed#[A2458486BB3F2FAB]-worker) [    ] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
   [junit4]   2> 1755515 INFO  (SUITE-AutoCommitTest-seed#[A2458486BB3F2FAB]-worker) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1755537 INFO  (SUITE-AutoCommitTest-seed#[A2458486BB3F2FAB]-worker) [    ] o.a.s.s.IndexSchema [null] Schema name=test
   [junit4]   2> 1755617 WARN  (SUITE-AutoCommitTest-seed#[A2458486BB3F2FAB]-worker) [    ] o.a.s.s.IndexSchema [null] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 1755619 INFO  (SUITE-AutoCommitTest-seed#[A2458486BB3F2FAB]-worker) [    ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1755627 INFO  (coreLoadExecutor-6385-thread-1) [    x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/lib, /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1755652 WARN  (coreLoadExecutor-6385-thread-1) [    x:collection1] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
   [junit4]   2> 1755654 INFO  (coreLoadExecutor-6385-thread-1) [    x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1755674 INFO  (coreLoadExecutor-6385-thread-1) [    x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1755755 WARN  (coreLoadExecutor-6385-thread-1) [    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> 1755756 INFO  (coreLoadExecutor-6385-thread-1) [    x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1755763 INFO  (coreLoadExecutor-6385-thread-1) [    x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1
   [junit4]   2> 1755763 INFO  (coreLoadExecutor-6385-thread-1) [    x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1], dataDir=[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest_A2458486BB3F2FAB-001/init-core-data-001/]
   [junit4]   2> 1755763 INFO  (coreLoadExecutor-6385-thread-1) [    x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@65a653b6
   [junit4]   2> 1755763 INFO  (coreLoadExecutor-6385-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=30, maxMergeAtOnceExplicit=22, maxMergedSegmentMB=23.9140625, floorSegmentMB=0.86328125, forceMergeDeletesPctAllowed=22.171055842305233, segmentsPerTier=16.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 1755775 INFO  (coreLoadExecutor-6385-thread-1) [    x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1755775 INFO  (coreLoadExecutor-6385-thread-1) [    x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1755776 INFO  (coreLoadExecutor-6385-thread-1) [    x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1755776 INFO  (coreLoadExecutor-6385-thread-1) [    x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1755777 INFO  (coreLoadExecutor-6385-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=34, maxMergeAtOnceExplicit=14, maxMergedSegmentMB=23.541015625, floorSegmentMB=1.146484375, forceMergeDeletesPctAllowed=25.607058444457927, segmentsPerTier=40.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7419724014231417
   [junit4]   2> 1755777 INFO  (coreLoadExecutor-6385-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@fc5b943[collection1] main]
   [junit4]   2> 1755777 INFO  (coreLoadExecutor-6385-thread-1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1755784 INFO  (coreLoadExecutor-6385-thread-1) [    x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 1755831 INFO  (coreLoadExecutor-6385-thread-1) [    x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1755831 INFO  (searcherExecutor-6386-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1755831 INFO  (searcherExecutor-6386-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1755831 INFO  (searcherExecutor-6386-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1755831 INFO  (coreLoadExecutor-6385-thread-1) [    x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1553875881776119808
   [junit4]   2> 1755831 INFO  (searcherExecutor-6386-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
   [junit4]   2> 1755832 INFO  (searcherExecutor-6386-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1755833 INFO  (searcherExecutor-6386-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1755833 INFO  (searcherExecutor-6386-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1755833 INFO  (searcherExecutor-6386-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 1755834 INFO  (searcherExecutor-6386-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 1755834 INFO  (searcherExecutor-6386-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@fc5b943[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1755835 INFO  (SUITE-AutoCommitTest-seed#[A2458486BB3F2FAB]-worker) [    ] o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 1755838 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A2458486BB3F2FAB]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testMaxDocs
   [junit4]   2> 1755839 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A2458486BB3F2FAB]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{deleteByQuery=*:* (-1553875881783459840)} 0 1
   [junit4]   2> 1755841 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A2458486BB3F2FAB]) [    ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/lib, /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1755870 WARN  (TEST-AutoCommitTest.testMaxDocs-seed#[A2458486BB3F2FAB]) [    ] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
   [junit4]   2> 1755870 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A2458486BB3F2FAB]) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1755889 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A2458486BB3F2FAB]) [    ] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1755973 WARN  (TEST-AutoCommitTest.testMaxDocs-seed#[A2458486BB3F2FAB]) [    ] o.a.s.s.IndexSchema [collection1] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 1755975 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A2458486BB3F2FAB]) [    ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1755982 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A2458486BB3F2FAB]) [    ] o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using configuration from instancedir /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1
   [junit4]   2> 1755982 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1], dataDir=[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest_A2458486BB3F2FAB-001/init-core-data-001/]
   [junit4]   2> 1755982 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@65a653b6
   [junit4]   2> 1755998 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1755998 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1755999 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@7f8aa6c4[collection1] main]
   [junit4]   2> 1755999 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1756000 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 1756003 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1756003 INFO  (searcherExecutor-6391-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1756004 INFO  (searcherExecutor-6391-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1756004 INFO  (searcherExecutor-6391-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1756004 INFO  (searcherExecutor-6391-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
   [junit4]   2> 1756004 INFO  (searcherExecutor-6391-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1756004 INFO  (searcherExecutor-6391-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1756005 INFO  (searcherExecutor-6391-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1756005 INFO  (searcherExecutor-6391-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 1756005 INFO  (searcherExecutor-6391-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 1756006 INFO  (searcherExecutor-6391-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@7f8aa6c4[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1756007 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=22, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.22953680774284227]
   [junit4]   2> 1756007 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 1756007 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@5bc371b0[collection1] main]
   [junit4]   2> 1756008 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@7341f847
   [junit4]   2> 1756009 INFO  (searcherExecutor-6391-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@5bc371b0[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1756018 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[0 (1553875881972203520)]} 0 1
   [junit4]   2> 1756019 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[1 (1553875881973252096)]} 0 1
   [junit4]   2> 1756019 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[2 (1553875881973252097)]} 0 2
   [junit4]   2> 1756020 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[3 (1553875881974300672)]} 0 2
   [junit4]   2> 1756020 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[4 (1553875881974300673)]} 0 3
   [junit4]   2> 1756020 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[5 (1553875881974300674)]} 0 3
   [junit4]   2> 1756021 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[6 (1553875881975349248)]} 0 3
   [junit4]   2> 1756021 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[7 (1553875881975349249)]} 0 3
   [junit4]   2> 1756021 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[8 (1553875881975349250)]} 0 4
   [junit4]   2> 1756021 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[9 (1553875881975349251)]} 0 4
   [junit4]   2> 1756021 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[10 (1553875881975349252)]} 0 4
   [junit4]   2> 1756021 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[11 (1553875881975349253)]} 0 4
   [junit4]   2> 1756022 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[12 (1553875881976397824)]} 0 4
   [junit4]   2> 1756022 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[13 (1553875881976397825)]} 0 4
   [junit4]   2> 1756022 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A2458486BB3F2FAB]) [    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> 1756023 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[14 (1553875881977446400)]} 0 5
   [junit4]   2> 1756025 INFO  (commitScheduler-6394-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> 1756027 INFO  (commitScheduler-6394-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@41341d70[collection1] main]
   [junit4]   2> 1756027 INFO  (commitScheduler-6394-thread-1) [    x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1756028 INFO  (searcherExecutor-6391-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@41341d70[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C15)))}
   [junit4]   2> 1756275 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[15 (1553875882240638976)]} 0 257
   [junit4]   2> 1756275 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A2458486BB3F2FAB]) [    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> 1756276 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A2458486BB3F2FAB]) [    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> 1756276 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.SolrTestCaseJ4 ###Ending testMaxDocs
   [junit4]   2> 1756280 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.SolrTestCaseJ4 ###Starting testMaxTime
   [junit4]   2> 1756282 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@308592fc[collection1] realtime]
   [junit4]   2> 1756282 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{deleteByQuery=*:* (-1553875882246930432)} 0 2
   [junit4]   2> 1756283 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/lib, /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1756313 WARN  (TEST-AutoCommitTest.testMaxTime-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
   [junit4]   2> 1756314 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1756334 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1756421 WARN  (TEST-AutoCommitTest.testMaxTime-seed#[A2458486BB3F2FAB]) [    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> 1756423 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1756430 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using configuration from instancedir /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1
   [junit4]   2> 1756431 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1], dataDir=[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest_A2458486BB3F2FAB-001/init-core-data-001/]
   [junit4]   2> 1756431 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@65a653b6
   [junit4]   2> 1756448 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1756448 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1756449 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@265cbc5[collection1] main]
   [junit4]   2> 1756450 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1756450 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 1756453 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1756454 INFO  (searcherExecutor-6395-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1756454 INFO  (searcherExecutor-6395-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1756454 INFO  (searcherExecutor-6395-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1756454 INFO  (searcherExecutor-6395-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
   [junit4]   2> 1756454 INFO  (searcherExecutor-6395-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1756455 INFO  (searcherExecutor-6395-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1756455 INFO  (searcherExecutor-6395-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1756455 INFO  (searcherExecutor-6395-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 1756456 INFO  (searcherExecutor-6395-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 1756456 INFO  (searcherExecutor-6395-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@265cbc5[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1756457 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=1519856392, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
   [junit4]   2> 1756458 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 1756458 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@155c1194[collection1] main]
   [junit4]   2> 1756458 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@27af15a5
   [junit4]   2> 1756466 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[529 (1553875882440916992)]} 0 0
   [junit4]   2> 1756466 INFO  (searcherExecutor-6395-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@155c1194[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1756466 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A2458486BB3F2FAB]) [    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> 1756467 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[530 (1553875882443014144)]} 0 1
   [junit4]   2> 1756467 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A2458486BB3F2FAB]) [    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> 1756467 ERROR (TEST-AutoCommitTest.testMaxTime-seed#[A2458486BB3F2FAB]) [    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> 1756468 ERROR (TEST-AutoCommitTest.testMaxTime-seed#[A2458486BB3F2FAB]) [    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:811)
   [junit4]   2> 	at org.apache.solr.update.AutoCommitTest.testMaxTime(AutoCommitTest.java:270)
   [junit4]   2> 	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   [junit4]   2> 	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
   [junit4]   2> 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   [junit4]   2> 	at java.lang.reflect.Method.invoke(Method.java:498)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
   [junit4]   2> 	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:811)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:462)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
   [junit4]   2> 	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
   [junit4]   2> 	at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 
   [junit4]   2> 1756468 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.SolrTestCaseJ4 ###Ending testMaxTime
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=AutoCommitTest -Dtests.method=testMaxTime -Dtests.seed=A2458486BB3F2FAB -Dtests.slow=true -Dtests.locale=en-MT -Dtests.timezone=America/St_Kitts -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
   [junit4] ERROR   0.19s J1 | AutoCommitTest.testMaxTime <<<
   [junit4]    > Throwable #1: java.lang.RuntimeException: Exception during query
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([A2458486BB3F2FAB:38B1F96425A5B397]:0)
   [junit4]    > 	at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:818)
   [junit4]    > 	at org.apache.solr.update.AutoCommitTest.testMaxTime(AutoCommitTest.java:270)
   [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:811)
   [junit4]    > 	... 40 more
   [junit4]   2> 1756474 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.SolrTestCaseJ4 ###Starting testCommitWithin
   [junit4]   2> 1756476 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@12e4f200[collection1] realtime]
   [junit4]   2> 1756476 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{deleteByQuery=*:* (-1553875882450354176)} 0 2
   [junit4]   2> 1756476 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/lib, /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1756508 WARN  (TEST-AutoCommitTest.testCommitWithin-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
   [junit4]   2> 1756509 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1756531 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1756680 WARN  (TEST-AutoCommitTest.testCommitWithin-seed#[A2458486BB3F2FAB]) [    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> 1756680 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1756691 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using configuration from instancedir /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1
   [junit4]   2> 1756691 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1], dataDir=[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest_A2458486BB3F2FAB-001/init-core-data-001/]
   [junit4]   2> 1756691 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@65a653b6
   [junit4]   2> 1756706 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1756706 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1756707 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@14748227[collection1] main]
   [junit4]   2> 1756707 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1756707 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 1756710 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1756710 INFO  (searcherExecutor-6399-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1756711 INFO  (searcherExecutor-6399-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1756711 INFO  (searcherExecutor-6399-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1756711 INFO  (searcherExecutor-6399-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
   [junit4]   2> 1756712 INFO  (searcherExecutor-6399-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1756712 INFO  (searcherExecutor-6399-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1756712 INFO  (searcherExecutor-6399-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1756713 INFO  (searcherExecutor-6399-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 1756713 INFO  (searcherExecutor-6399-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 1756714 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=4, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5172392990293222]
   [junit4]   2> 1756714 INFO  (searcherExecutor-6399-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@14748227[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1756714 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 1756714 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@64085976[collection1] main]
   [junit4]   2> 1756714 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@db277e8
   [junit4]   2> 1756715 INFO  (searcherExecutor-6399-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@64085976[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1756722 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[529 (1553875882709352448)]} 0 0
   [junit4]   2> 1756722 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A2458486BB3F2FAB]) [    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> 1760722 INFO  (commitScheduler-6402-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> 1760725 INFO  (commitScheduler-6402-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@6c9674c0[collection1] main]
   [junit4]   2> 1760725 INFO  (commitScheduler-6402-thread-1) [    x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1760725 INFO  (searcherExecutor-6399-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@6c9674c0[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_3(7.0.0):C1)))}
   [junit4]   2> 1760746 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[530 (1553875886928822272)]} 0 4026
   [junit4]   2> 1760746 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A2458486BB3F2FAB]) [    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> 1760746 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[529 (-1553875886929870848)]} 0 4027
   [junit4]   2> 1760746 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A2458486BB3F2FAB]) [    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> 1762748 INFO  (commitScheduler-6402-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> 1762750 INFO  (commitScheduler-6402-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@645249bb[collection1] main]
   [junit4]   2> 1762750 INFO  (commitScheduler-6402-thread-1) [    x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1762751 INFO  (searcherExecutor-6399-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@645249bb[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(7.0.0):C1)))}
   [junit4]   2> 1762759 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A2458486BB3F2FAB]) [    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> 1762759 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:530&qt=standard&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0
   [junit4]   2> 1762760 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1553875889041702912)]} 0 6042
   [junit4]   2> 1762760 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1553875889041702913)]} 0 6042
   [junit4]   2> 1762761 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1553875889041702914)]} 0 6042
   [junit4]   2> 1762761 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1553875889042751488)]} 0 6042
   [junit4]   2> 1762761 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1553875889042751489)]} 0 6042
   [junit4]   2> 1762761 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1553875889042751490)]} 0 6043
   [junit4]   2> 1762761 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1553875889042751491)]} 0 6043
   [junit4]   2> 1762761 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1553875889042751492)]} 0 6043
   [junit4]   2> 1762761 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1553875889042751493)]} 0 6043
   [junit4]   2> 1762762 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1553875889043800064)]} 0 6043
   [junit4]   2> 1762762 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A2458486BB3F2FAB]) [    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> 1762762 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 (-1553875889043800065)]} 0 6044
   [junit4]   2> 1762762 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 (-1553875889043800066)]} 0 6044
   [junit4]   2> 1762762 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 (-1553875889043800067)]} 0 6044
   [junit4]   2> 1762762 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 (-1553875889043800068)]} 0 6044
   [junit4]   2> 1762763 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 (-1553875889044848640)]} 0 6044
   [junit4]   2> 1762763 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 (-1553875889044848641)]} 0 6044
   [junit4]   2> 1762763 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 (-1553875889044848642)]} 0 6044
   [junit4]   2> 1762763 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 (-1553875889044848643)]} 0 6045
   [junit4]   2> 1762763 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 (-1553875889044848644)]} 0 6045
   [junit4]   2> 1762763 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 (-1553875889044848645)]} 0 6045
   [junit4]   2> 1762763 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:530&qt=standard&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0
   [junit4]   2> 1763764 INFO  (commitScheduler-6402-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> 1763765 INFO  (commitScheduler-6402-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@13e79544[collection1] main]
   [junit4]   2> 1763766 INFO  (commitScheduler-6402-thread-1) [    x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1763766 INFO  (searcherExecutor-6399-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@13e79544[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_5(7.0.0):C10/9:delGen=1)))}
   [junit4]   2> 1764017 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A2458486BB3F2FAB]) [    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> 1764018 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A2458486BB3F2FAB]) [    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> 1764018 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A2458486BB3F2FAB]) [    x:collection1] o.a.s.SolrTestCaseJ4 ###Ending testCommitWithin
   [junit4]   2> 1764018 INFO  (SUITE-AutoCommitTest-seed#[A2458486BB3F2FAB]-worker) [    x:collection1] o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> 1764018 INFO  (SUITE-AutoCommitTest-seed#[A2458486BB3F2FAB]-worker) [    x:collection1] o.a.s.c.CoreContainer Shutting down CoreContainer instance=908470592
   [junit4]   2> 1764019 INFO  (coreCloseExecutor-6403-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@616eb82c
   [junit4]   2> 1764019 INFO  (coreCloseExecutor-6403-thread-1-processing-x:collection1) [    x:collection1] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter close.
   [junit4]   2> 1764019 INFO  (coreCloseExecutor-6403-thread-1-processing-x:collection1) [    x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@2d3fd229
   [junit4]   2> NOTE: leaving temporary files on disk at: /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest_A2458486BB3F2FAB-001
   [junit4]   2> NOTE: test params are: codec=FastCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=FAST, chunkSize=16076, maxDocsPerChunk=7, blockSize=510), termVectorsFormat=CompressingTermVectorsFormat(compressionMode=FAST, chunkSize=16076, blockSize=510)), sim=RandomSimilarity(queryNorm=true): {}, locale=en-MT, timezone=America/St_Kitts
   [junit4]   2> NOTE: SunOS 5.11 amd64/Oracle Corporation 1.8.0_112 (64-bit)/cpus=3,threads=1,free=215820152,total=536870912
   [junit4]   2> NOTE: All tests run in this JVM: [TestSolrFieldCacheMBean, NotRequiredUniqueKeyTest, TestSolrConfigHandlerConcurrent, DistributedQueryComponentCustomSortTest, RollingRestartTest, DefaultValueUpdateProcessorTest, TestFreeTextSuggestions, CollectionsAPISolrJTest, TestPushWriter, AsyncCallRequestStatusResponseTest, TestRecovery, TestSolrQueryParserDefaultOperatorResource, DistributedFacetPivotLongTailTest, HighlighterConfigTest, TestInitQParser, TestFieldSortValues, MultiThreadedOCPTest, AddSchemaFieldsUpdateProcessorFactoryTest, SolrInfoMBeanTest, TestSolr4Spatial, TestCollationFieldDocValues, DeleteNodeTest, ResponseLogComponentTest, DistributedFacetPivotSmallTest, TolerantUpdateProcessorTest, BasicAuthStandaloneTest, PreAnalyzedFieldManagedSchemaCloudTest, TestReversedWildcardFilterFactory, CSVRequestHandlerTest, SharedFSAutoReplicaFailoverTest, TestScoreJoinQPNoScore, OverseerModifyCollectionTest, TestRTimerTree, TestSchemaVersionResource, TestBlendedInfixSuggestions, DistributedFacetExistsSmallTest, SpatialHeatmapFacetsTest, TestSolrIndexConfig, TestReload, TestBinaryResponseWriter, TestLeaderElectionZkExpiry, TestFastWriter, ReplicaListTransformerTest, HdfsCollectionsAPIDistributedZkTest, LoggingHandlerTest, TestFoldingMultitermQuery, TestSolrDeletionPolicy2, RegexBoostProcessorTest, DistributedTermsComponentTest, LeaderFailureAfterFreshStartTest, CheckHdfsIndexTest, HdfsChaosMonkeyNothingIsSafeTest, IndexSchemaTest, TestConfigSetsAPI, TestRuleBasedAuthorizationPlugin, DistributedDebugComponentTest, FieldMutatingUpdateProcessorTest, HdfsLockFactoryTest, CoreAdminHandlerTest, CoreAdminRequestStatusTest, BasicDistributedZk2Test, ZkStateReaderTest, TestManagedResource, TestDeleteCollectionOnDownNodes, TestCrossCoreJoin, TestSlowCompositeReaderWrapper, TestAuthenticationFramework, SaslZkACLProviderTest, TestCorePropertiesReload, TestExpandComponent, TestLocalFSCloudBackupRestore, SuggesterTest, BlockCacheTest, TestQueryWrapperFilter, CdcrReplicationHandlerTest, AliasIntegrationTest, TestSolrCloudSnapshots, TestStressUserVersions, FullHLLTest, CoreSorterTest, TestAtomicUpdateErrorCases, TestPHPSerializedResponseWriter, ShardRoutingCustomTest, TestConfig, TestLuceneMatchVersion, SortSpecParsingTest, TestUninvertingReader, TestConfigSetProperties, TestGraphTermsQParserPlugin, TestJsonRequest, SegmentsInfoRequestHandlerTest, TestJoin, TestTrie, SuggesterTSTTest, ClassificationUpdateProcessorFactoryTest, AnalysisErrorHandlingTest, SuggesterWFSTTest, TestSystemIdResolver, TestFieldTypeResource, TestSolrCoreProperties, HdfsRecoverLeaseTest, RequestLoggingTest, TestDocSet, TestRestoreCore, FileBasedSpellCheckerTest, TestStressRecovery, TestWriterPerf, ParsingFieldUpdateProcessorsTest, DistanceUnitsTest, ConvertedLegacyTest, TestRealTimeGet, TestShortCircuitedRequests, TestInfoStreamLogging, DistribCursorPagingTest, BufferStoreTest, TestTrackingShardHandlerFactory, JsonLoaderTest, FieldAnalysisRequestHandlerTest, TestChildDocTransformer, URLClassifyProcessorTest, PeerSyncReplicationTest, HLLUtilTest, TestShardHandlerFactory, TestIndexSearcher, OverriddenZkACLAndCredentialsProvidersTest, CdcrBootstrapTest, SpellCheckCollatorTest, SolrIndexSplitterTest, RAMDirectoryFactoryTest, ResourceLoaderTest, TestSchemaResource, TestConfigReload, TestRawTransformer, TestManagedSchemaAPI, ChaosMonkeySafeLeaderTest, BasicFunctionalityTest, TestDownShardTolerantSearch, DateMathParserTest, TestSearchPerf, TestGraphMLResponseWriter, DocExpirationUpdateProcessorFactoryTest, TestHdfsUpdateLog, TestRequestForwarding, ShowFileRequestHandlerTest, ExitableDirectoryReaderTest, TestFuzzyAnalyzedSuggestions, TestSolrCloudWithDelegationTokens, SpellCheckComponentTest, RemoteQueryErrorTest, SimpleMLTQParserTest, MergeStrategyTest, TestFieldCacheSortRandom, TestQueryTypes, ExternalFileFieldSortTest, CollectionTooManyReplicasTest, SolrCloudExampleTest, TestClusterProperties, CollectionsAPIDistributedZkTest, OpenCloseCoreStressTest, OverseerTest, LeaderElectionIntegrationTest, BasicZkTest, RecoveryZkTest, FullSolrCloudDistribCmdsTest, ClusterStateUpdateTest, TestRandomFaceting, ZkSolrClientTest, TestZkChroot, TestDistributedSearch, AutoCommitTest]
   [junit4] Completed [335/660 (1!)] on J1 in 8.56s, 3 tests, 1 error <<< FAILURES!

[...truncated 63448 lines...]