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/04/12 06:06:36 UTC

[JENKINS] Lucene-Solr-master-Solaris (64bit/jdk1.8.0) - Build # 515 - Still Failing!

Build: http://jenkins.thetaphi.de/job/Lucene-Solr-master-Solaris/515/
Java: 64bit/jdk1.8.0 -XX:-UseCompressedOops -XX:+UseConcMarkSweepGC

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

Error Message:
Exception during query

Stack Trace:
java.lang.RuntimeException: Exception during query
	at __randomizedtesting.SeedInfo.seed([AAA627074DC8AC4E:1327F1D86122A8C4]:0)
	at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:780)
	at org.apache.solr.update.AutoCommitTest.testMaxDocs(AutoCommitTest.java:198)
	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:14&qt=standard&start=0&rows=20&version=2.2
	at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:773)
	... 40 more




Build Log:
[...truncated 11532 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/J0/temp/solr.update.AutoCommitTest_AAA627074DC8AC4E-001/init-core-data-001
   [junit4]   2> 1747684 INFO  (SUITE-AutoCommitTest-seed#[AAA627074DC8AC4E]-worker) [    ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false)
   [junit4]   2> 1747684 INFO  (SUITE-AutoCommitTest-seed#[AAA627074DC8AC4E]-worker) [    ] o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 1747684 INFO  (SUITE-AutoCommitTest-seed#[AAA627074DC8AC4E]-worker) [    ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1'
   [junit4]   2> 1747685 INFO  (SUITE-AutoCommitTest-seed#[AAA627074DC8AC4E]-worker) [    ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1747685 INFO  (SUITE-AutoCommitTest-seed#[AAA627074DC8AC4E]-worker) [    ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr
   [junit4]   2> 1747685 INFO  (SUITE-AutoCommitTest-seed#[AAA627074DC8AC4E]-worker) [    ] o.a.s.c.SolrResourceLoader Adding 'file:/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
   [junit4]   2> 1747685 INFO  (SUITE-AutoCommitTest-seed#[AAA627074DC8AC4E]-worker) [    ] o.a.s.c.SolrResourceLoader Adding 'file:/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/lib/README' to classloader
   [junit4]   2> 1747709 INFO  (SUITE-AutoCommitTest-seed#[AAA627074DC8AC4E]-worker) [    ] o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 1747717 INFO  (SUITE-AutoCommitTest-seed#[AAA627074DC8AC4E]-worker) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1747735 INFO  (SUITE-AutoCommitTest-seed#[AAA627074DC8AC4E]-worker) [    ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 1747739 INFO  (SUITE-AutoCommitTest-seed#[AAA627074DC8AC4E]-worker) [    ] o.a.s.s.IndexSchema [null] Schema name=test
   [junit4]   2> 1747830 INFO  (SUITE-AutoCommitTest-seed#[AAA627074DC8AC4E]-worker) [    ] o.a.s.s.OpenExchangeRatesOrgProvider Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 1747836 INFO  (SUITE-AutoCommitTest-seed#[AAA627074DC8AC4E]-worker) [    ] o.a.s.s.IndexSchema default search field in schema is text
   [junit4]   2> 1747837 INFO  (SUITE-AutoCommitTest-seed#[AAA627074DC8AC4E]-worker) [    ] o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 1747841 INFO  (SUITE-AutoCommitTest-seed#[AAA627074DC8AC4E]-worker) [    ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 1747842 INFO  (SUITE-AutoCommitTest-seed#[AAA627074DC8AC4E]-worker) [    ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 1747844 INFO  (SUITE-AutoCommitTest-seed#[AAA627074DC8AC4E]-worker) [    ] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 1747844 INFO  (SUITE-AutoCommitTest-seed#[AAA627074DC8AC4E]-worker) [    ] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 1747844 INFO  (SUITE-AutoCommitTest-seed#[AAA627074DC8AC4E]-worker) [    ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1747844 INFO  (SUITE-AutoCommitTest-seed#[AAA627074DC8AC4E]-worker) [    ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr
   [junit4]   2> 1747845 INFO  (SUITE-AutoCommitTest-seed#[AAA627074DC8AC4E]-worker) [    ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr'
   [junit4]   2> 1747845 INFO  (SUITE-AutoCommitTest-seed#[AAA627074DC8AC4E]-worker) [    ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1747845 INFO  (SUITE-AutoCommitTest-seed#[AAA627074DC8AC4E]-worker) [    ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr
   [junit4]   2> 1747845 INFO  (SUITE-AutoCommitTest-seed#[AAA627074DC8AC4E]-worker) [    ] o.a.s.c.CoreContainer New CoreContainer 131620399
   [junit4]   2> 1747845 INFO  (SUITE-AutoCommitTest-seed#[AAA627074DC8AC4E]-worker) [    ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr]
   [junit4]   2> 1747845 WARN  (SUITE-AutoCommitTest-seed#[AAA627074DC8AC4E]-worker) [    ] o.a.s.c.CoreContainer Couldn't add files from /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/lib to classpath: /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/lib
   [junit4]   2> 1747845 INFO  (SUITE-AutoCommitTest-seed#[AAA627074DC8AC4E]-worker) [    ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 600000,connTimeout : 60000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,
   [junit4]   2> 1747859 INFO  (SUITE-AutoCommitTest-seed#[AAA627074DC8AC4E]-worker) [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
   [junit4]   2> 1747860 INFO  (SUITE-AutoCommitTest-seed#[AAA627074DC8AC4E]-worker) [    ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 1747860 INFO  (SUITE-AutoCommitTest-seed#[AAA627074DC8AC4E]-worker) [    ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 1747860 INFO  (SUITE-AutoCommitTest-seed#[AAA627074DC8AC4E]-worker) [    ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module.
   [junit4]   2> 1747860 INFO  (SUITE-AutoCommitTest-seed#[AAA627074DC8AC4E]-worker) [    ] o.a.s.c.CoreContainer No authentication plugin used.
   [junit4]   2> 1747861 INFO  (SUITE-AutoCommitTest-seed#[AAA627074DC8AC4E]-worker) [    ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml, loadOnStartup=true, configSetProperties=configsetprops.json, collection=collection1, dataDir=/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.update.AutoCommitTest_AAA627074DC8AC4E-001/init-core-data-001, shard=shard1}
   [junit4]   2> 1747862 INFO  (coreLoadExecutor-5810-thread-1) [    ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1'
   [junit4]   2> 1747862 INFO  (coreLoadExecutor-5810-thread-1) [    ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1747862 INFO  (coreLoadExecutor-5810-thread-1) [    ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr
   [junit4]   2> 1747862 INFO  (coreLoadExecutor-5810-thread-1) [    ] o.a.s.c.SolrResourceLoader Adding 'file:/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
   [junit4]   2> 1747862 INFO  (coreLoadExecutor-5810-thread-1) [    ] o.a.s.c.SolrResourceLoader Adding 'file:/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/lib/README' to classloader
   [junit4]   2> 1747881 INFO  (coreLoadExecutor-5810-thread-1) [    ] o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 1747888 INFO  (coreLoadExecutor-5810-thread-1) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1747907 INFO  (coreLoadExecutor-5810-thread-1) [    ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 1747911 INFO  (coreLoadExecutor-5810-thread-1) [    ] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1748034 INFO  (coreLoadExecutor-5810-thread-1) [    ] o.a.s.s.OpenExchangeRatesOrgProvider Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 1748038 INFO  (coreLoadExecutor-5810-thread-1) [    ] o.a.s.s.IndexSchema default search field in schema is text
   [junit4]   2> 1748039 INFO  (coreLoadExecutor-5810-thread-1) [    ] o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 1748042 INFO  (coreLoadExecutor-5810-thread-1) [    ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 1748045 INFO  (coreLoadExecutor-5810-thread-1) [    ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 1748046 INFO  (coreLoadExecutor-5810-thread-1) [    ] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 1748046 INFO  (coreLoadExecutor-5810-thread-1) [    ] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 1748048 INFO  (coreLoadExecutor-5810-thread-1) [    ] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or '/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1'
   [junit4]   2> 1748048 INFO  (coreLoadExecutor-5810-thread-1) [    ] 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> 1748048 INFO  (coreLoadExecutor-5810-thread-1) [    x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 1748048 INFO  (coreLoadExecutor-5810-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/J0/temp/solr.update.AutoCommitTest_AAA627074DC8AC4E-001/init-core-data-001/]
   [junit4]   2> 1748048 INFO  (coreLoadExecutor-5810-thread-1) [    x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@65fe3b78
   [junit4]   2> 1748049 INFO  (coreLoadExecutor-5810-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.update.AutoCommitTest_AAA627074DC8AC4E-001/init-core-data-001
   [junit4]   2> 1748049 INFO  (coreLoadExecutor-5810-thread-1) [    x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.update.AutoCommitTest_AAA627074DC8AC4E-001/init-core-data-001/index/
   [junit4]   2> 1748049 WARN  (coreLoadExecutor-5810-thread-1) [    x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory '/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.update.AutoCommitTest_AAA627074DC8AC4E-001/init-core-data-001/index' doesn't exist. Creating new index...
   [junit4]   2> 1748049 INFO  (coreLoadExecutor-5810-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.update.AutoCommitTest_AAA627074DC8AC4E-001/init-core-data-001/index
   [junit4]   2> 1748049 INFO  (coreLoadExecutor-5810-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=11, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
   [junit4]   2> 1748050 INFO  (coreLoadExecutor-5810-thread-1) [    x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(RAMDirectory@45d519c0 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@44ee5da1),segFN=segments_1,generation=1}
   [junit4]   2> 1748050 INFO  (coreLoadExecutor-5810-thread-1) [    x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 1748051 INFO  (OldIndexDirectoryCleanupThreadForCore-collection1) [    x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.update.AutoCommitTest_AAA627074DC8AC4E-001/init-core-data-001/
   [junit4]   2> 1748053 INFO  (coreLoadExecutor-5810-thread-1) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe"
   [junit4]   2> 1748053 INFO  (coreLoadExecutor-5810-thread-1) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 1748053 INFO  (coreLoadExecutor-5810-thread-1) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe-allfields"
   [junit4]   2> 1748054 INFO  (coreLoadExecutor-5810-thread-1) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
   [junit4]   2> 1748054 INFO  (coreLoadExecutor-5810-thread-1) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "stored_sig"
   [junit4]   2> 1748054 INFO  (coreLoadExecutor-5810-thread-1) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 1748054 INFO  (coreLoadExecutor-5810-thread-1) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 1748054 INFO  (coreLoadExecutor-5810-thread-1) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 1748054 INFO  (coreLoadExecutor-5810-thread-1) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
   [junit4]   2> 1748054 INFO  (coreLoadExecutor-5810-thread-1) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 1748054 INFO  (coreLoadExecutor-5810-thread-1) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 1748054 INFO  (coreLoadExecutor-5810-thread-1) [    x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 1748056 INFO  (coreLoadExecutor-5810-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1748057 INFO  (coreLoadExecutor-5810-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1748058 INFO  (coreLoadExecutor-5810-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1748060 INFO  (coreLoadExecutor-5810-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1748063 INFO  (coreLoadExecutor-5810-thread-1) [    x:collection1] o.a.s.c.PluginBag requestHandler : 'lazy' created with startup=lazy 
   [junit4]   2> 1748065 INFO  (coreLoadExecutor-5810-thread-1) [    x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,spellCheckCompRH,lazy,/update/json/docs,/admin/luke,/export,spellCheckWithWordbreak_Direct,tvrh,/get,/admin/properties,/update/json,mltrh,/admin/threads,/search-facet-def,/update/csv,/sql,/search-facet-invariants,/admin/segments,spellCheckCompRH1,/mlt,/admin/system,/replication,dismax,defaults,/config,/stream,/schema,/admin/plugins,/admin/logging,spellCheckWithWordbreak,mock,/admin/ping,/update,/admin/file,/terms,spellCheckCompRH_Direct,/debug/dump
   [junit4]   2> 1748065 INFO  (coreLoadExecutor-5810-thread-1) [    x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 1748065 INFO  (coreLoadExecutor-5810-thread-1) [    x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1748065 INFO  (coreLoadExecutor-5810-thread-1) [    x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1748066 INFO  (coreLoadExecutor-5810-thread-1) [    x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1748066 INFO  (coreLoadExecutor-5810-thread-1) [    x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1748066 INFO  (coreLoadExecutor-5810-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=29, maxMergeAtOnceExplicit=33, maxMergedSegmentMB=99.392578125, floorSegmentMB=1.0048828125, forceMergeDeletesPctAllowed=20.70095047291798, segmentsPerTier=13.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 1748066 INFO  (coreLoadExecutor-5810-thread-1) [    x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(RAMDirectory@45d519c0 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@44ee5da1),segFN=segments_1,generation=1}
   [junit4]   2> 1748066 INFO  (coreLoadExecutor-5810-thread-1) [    x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 1748066 INFO  (coreLoadExecutor-5810-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@185b32b4[collection1] main]
   [junit4]   2> 1748067 INFO  (coreLoadExecutor-5810-thread-1) [    x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
   [junit4]   2> 1748067 INFO  (coreLoadExecutor-5810-thread-1) [    x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using InMemoryStorage
   [junit4]   2> 1748067 INFO  (coreLoadExecutor-5810-thread-1) [    x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
   [junit4]   2> 1748067 INFO  (coreLoadExecutor-5810-thread-1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1748097 INFO  (coreLoadExecutor-5810-thread-1) [    x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 1748176 INFO  (coreLoadExecutor-5810-thread-1) [    x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1748176 INFO  (searcherExecutor-5811-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1748177 INFO  (searcherExecutor-5811-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1748177 INFO  (searcherExecutor-5811-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1748177 INFO  (searcherExecutor-5811-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
   [junit4]   2> 1748177 INFO  (coreLoadExecutor-5810-thread-1) [    x:collection1] o.a.s.u.UpdateLog Looking up max value of version field to seed version buckets
   [junit4]   2> 1748177 INFO  (coreLoadExecutor-5810-thread-1) [    x:collection1] o.a.s.u.VersionInfo Refreshing highest value of _version_ for 65536 version buckets from index
   [junit4]   2> 1748177 INFO  (coreLoadExecutor-5810-thread-1) [    x:collection1] o.a.s.u.VersionInfo No terms found for _version_, cannot seed version bucket highest value from index
   [junit4]   2> 1748177 INFO  (coreLoadExecutor-5810-thread-1) [    x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1531374427814494208
   [junit4]   2> 1748178 INFO  (searcherExecutor-5811-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1748179 INFO  (searcherExecutor-5811-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1748179 INFO  (searcherExecutor-5811-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1748180 INFO  (coreLoadExecutor-5810-thread-1) [    x:collection1] o.a.s.u.UpdateLog Took 2.0ms to seed version buckets with highest version 1531374427814494208
   [junit4]   2> 1748180 INFO  (searcherExecutor-5811-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 1748180 INFO  (coreLoadExecutor-5810-thread-1) [    x:collection1] o.a.s.c.CoreContainer registering core: collection1
   [junit4]   2> 1748180 INFO  (searcherExecutor-5811-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 1748181 INFO  (searcherExecutor-5811-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@185b32b4[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1748182 INFO  (SUITE-AutoCommitTest-seed#[AAA627074DC8AC4E]-worker) [    ] o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 1748185 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testMaxTime
   [junit4]   2> 1748187 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{deleteByQuery=*:* (-1531374427822882816)} 0 1
   [junit4]   2> 1748189 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1'
   [junit4]   2> 1748189 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1748189 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr
   [junit4]   2> 1748189 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    ] o.a.s.c.SolrResourceLoader Adding 'file:/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
   [junit4]   2> 1748189 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    ] o.a.s.c.SolrResourceLoader Adding 'file:/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/lib/README' to classloader
   [junit4]   2> 1748215 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    ] o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 1748223 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1748242 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 1748247 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    ] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1748338 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    ] o.a.s.s.OpenExchangeRatesOrgProvider Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 1748344 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    ] o.a.s.s.IndexSchema default search field in schema is text
   [junit4]   2> 1748345 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    ] o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 1748348 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 1748350 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 1748351 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    ] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 1748351 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    ] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 1748353 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    ] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or '/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1'
   [junit4]   2> 1748354 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    ] 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> 1748354 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    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/J0/temp/solr.update.AutoCommitTest_AAA627074DC8AC4E-001/init-core-data-001/]
   [junit4]   2> 1748354 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@65fe3b78
   [junit4]   2> 1748354 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.update.AutoCommitTest_AAA627074DC8AC4E-001/init-core-data-001/index/
   [junit4]   2> 1748355 INFO  (OldIndexDirectoryCleanupThreadForCore-collection1) [    x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.update.AutoCommitTest_AAA627074DC8AC4E-001/init-core-data-001/
   [junit4]   2> 1748358 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe"
   [junit4]   2> 1748358 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 1748358 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe-allfields"
   [junit4]   2> 1748358 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
   [junit4]   2> 1748359 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "stored_sig"
   [junit4]   2> 1748359 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 1748359 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 1748359 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 1748359 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
   [junit4]   2> 1748359 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 1748359 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 1748359 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 1748361 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1748363 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1748364 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1748364 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1748369 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.c.PluginBag requestHandler : 'lazy' created with startup=lazy 
   [junit4]   2> 1748371 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,spellCheckCompRH,lazy,/update/json/docs,/admin/luke,/export,spellCheckWithWordbreak_Direct,tvrh,/get,/admin/properties,/update/json,mltrh,/admin/threads,/search-facet-def,/update/csv,/sql,/search-facet-invariants,/admin/segments,spellCheckCompRH1,/mlt,/admin/system,/replication,dismax,defaults,/config,/stream,/schema,/admin/plugins,/admin/logging,spellCheckWithWordbreak,mock,/admin/ping,/update,/admin/file,/terms,spellCheckCompRH_Direct,/debug/dump
   [junit4]   2> 1748371 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 1748372 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1748372 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1748372 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@5eaf7ef0[collection1] main]
   [junit4]   2> 1748372 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
   [junit4]   2> 1748372 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using InMemoryStorage
   [junit4]   2> 1748372 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
   [junit4]   2> 1748372 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1748373 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 1748376 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1748376 INFO  (searcherExecutor-5816-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1748377 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.UpdateLog Looking up max value of version field to seed version buckets
   [junit4]   2> 1748377 INFO  (searcherExecutor-5816-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1748377 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.VersionInfo Refreshing highest value of _version_ for 65536 version buckets from index
   [junit4]   2> 1748377 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.VersionInfo No terms found for _version_, cannot seed version bucket highest value from index
   [junit4]   2> 1748377 INFO  (searcherExecutor-5816-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1748377 INFO  (searcherExecutor-5816-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
   [junit4]   2> 1748377 INFO  (searcherExecutor-5816-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1748378 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.UpdateLog Took 1.0ms to seed version buckets with highest version 1531374427822882816
   [junit4]   2> 1748379 INFO  (searcherExecutor-5816-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1748379 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.DefaultSolrCoreState Closing old IndexWriter... core=collection1
   [junit4]   2> 1748380 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=23, maxMergeAtOnceExplicit=22, maxMergedSegmentMB=61.27734375, floorSegmentMB=0.2509765625, forceMergeDeletesPctAllowed=2.20990800649027, segmentsPerTier=14.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.20396667321970094
   [junit4]   2> 1748380 INFO  (searcherExecutor-5816-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1748381 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(RAMDirectory@45d519c0 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@44ee5da1),segFN=segments_1,generation=1}
   [junit4]   2> 1748381 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 1748382 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 1748382 INFO  (searcherExecutor-5816-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 1748382 WARN  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.c.SolrCore [collection1] PERFORMANCE WARNING: Overlapping onDeckSearchers=2
   [junit4]   2> 1748382 INFO  (searcherExecutor-5816-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 1748382 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@5756345d[collection1] main]
   [junit4]   2> 1748383 INFO  (searcherExecutor-5816-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@5eaf7ef0[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1748384 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.c.CoreContainer replacing core: collection1
   [junit4]   2> 1748384 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@51f75cfd
   [junit4]   2> 1748384 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.DirectUpdateHandler2 closing DirectUpdateHandler2{commits=0,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=1,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=0,transaction_logs_total_size=0,transaction_logs_total_number=0}
   [junit4]   2> 1748385 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.c.SolrCore [collection1] Closing main searcher on request.
   [junit4]   2> 1748389 INFO  (searcherExecutor-5816-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@5756345d[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1748419 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[529 (1531374428066152448)]} 0 2
   [junit4]   2> 1748419 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    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> 1749419 INFO  (commitScheduler-5819-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> 1749423 INFO  (commitScheduler-5819-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@350ee6b8[collection1] main]
   [junit4]   2> 1749423 INFO  (commitScheduler-5819-thread-1) [    x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1749424 INFO  (searcherExecutor-5816-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@350ee6b8[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C1)))}
   [junit4]   2> 1749673 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[530 (1531374429383163904)]} 0 1257
   [junit4]   2> 1749674 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    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> 1749675 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    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> 1749675 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{delete=[529 (-1531374429385261056)]} 0 0
   [junit4]   2> 1749676 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    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> 1750675 INFO  (commitScheduler-5819-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> 1750677 INFO  (commitScheduler-5819-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1b0866dc[collection1] main]
   [junit4]   2> 1750677 INFO  (commitScheduler-5819-thread-1) [    x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1750678 INFO  (searcherExecutor-5816-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1b0866dc[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(7.0.0):C1)))}
   [junit4]   2> 1750679 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[550 (1531374430436982784)]} 0 2262
   [junit4]   2> 1750679 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    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> 1750679 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1531374430438031360)]} 0 2263
   [junit4]   2> 1750680 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1531374430439079936)]} 0 2263
   [junit4]   2> 1750680 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1531374430439079937)]} 0 2263
   [junit4]   2> 1750680 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1531374430439079938)]} 0 2263
   [junit4]   2> 1750680 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1531374430439079939)]} 0 2264
   [junit4]   2> 1750680 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1531374430439079940)]} 0 2264
   [junit4]   2> 1750680 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1531374430439079941)]} 0 2264
   [junit4]   2> 1750680 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1531374430439079942)]} 0 2264
   [junit4]   2> 1750681 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1531374430440128512)]} 0 2264
   [junit4]   2> 1750681 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1531374430440128513)]} 0 2264
   [junit4]   2> 1750681 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    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> 1751680 INFO  (commitScheduler-5819-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> 1751683 INFO  (commitScheduler-5819-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@57431a6d[collection1] main]
   [junit4]   2> 1751683 INFO  (commitScheduler-5819-thread-1) [    x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1751684 INFO  (searcherExecutor-5816-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@57431a6d[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(7.0.0):C1) Uninverting(_2(7.0.0):C11/9:delGen=1)))}
   [junit4]   2> 1751933 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[531 (1531374431752945664)]} 0 3517
   [junit4]   2> 1751933 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    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> 1751934 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.SolrTestCaseJ4 ###Ending testMaxTime
   [junit4]   2> 1751937 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.SolrTestCaseJ4 ###Starting testMaxDocs
   [junit4]   2> 1751941 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@2f40c0e0[collection1] realtime]
   [junit4]   2> 1751941 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{deleteByQuery=*:* (-1531374431757139968)} 0 4
   [junit4]   2> 1751941 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1'
   [junit4]   2> 1751941 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1751941 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.c.SolrResourceLoader using system property solr.solr.home: /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr
   [junit4]   2> 1751942 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.c.SolrResourceLoader Adding 'file:/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
   [junit4]   2> 1751942 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.c.SolrResourceLoader Adding 'file:/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/lib/README' to classloader
   [junit4]   2> 1751967 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 1751975 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1751991 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 1751996 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1752255 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 1752260 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.s.IndexSchema default search field in schema is text
   [junit4]   2> 1752261 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 1752264 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 1752266 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 1752267 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 1752268 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 1752271 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or '/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1'
   [junit4]   2> 1752271 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    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> 1752271 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    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/J0/temp/solr.update.AutoCommitTest_AAA627074DC8AC4E-001/init-core-data-001/]
   [junit4]   2> 1752271 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@65fe3b78
   [junit4]   2> 1752271 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.update.AutoCommitTest_AAA627074DC8AC4E-001/init-core-data-001/index/
   [junit4]   2> 1752275 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe"
   [junit4]   2> 1752276 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 1752276 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe-allfields"
   [junit4]   2> 1752276 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
   [junit4]   2> 1752276 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "stored_sig"
   [junit4]   2> 1752276 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 1752276 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 1752276 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 1752276 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
   [junit4]   2> 1752276 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 1752276 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 1752276 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 1752278 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1752280 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1752281 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1752282 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1752283 INFO  (OldIndexDirectoryCleanupThreadForCore-collection1) [    x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.update.AutoCommitTest_AAA627074DC8AC4E-001/init-core-data-001/
   [junit4]   2> 1752287 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.c.PluginBag requestHandler : 'lazy' created with startup=lazy 
   [junit4]   2> 1752290 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,spellCheckCompRH,lazy,/update/json/docs,/admin/luke,/export,spellCheckWithWordbreak_Direct,tvrh,/get,/admin/properties,/update/json,mltrh,/admin/threads,/search-facet-def,/update/csv,/sql,/search-facet-invariants,/admin/segments,spellCheckCompRH1,/mlt,/admin/system,/replication,dismax,defaults,/config,/stream,/schema,/admin/plugins,/admin/logging,spellCheckWithWordbreak,mock,/admin/ping,/update,/admin/file,/terms,spellCheckCompRH_Direct,/debug/dump
   [junit4]   2> 1752290 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 1752291 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1752291 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1752291 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@295c869d[collection1] main]
   [junit4]   2> 1752291 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
   [junit4]   2> 1752292 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using InMemoryStorage
   [junit4]   2> 1752292 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
   [junit4]   2> 1752292 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1752292 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 1752295 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1752296 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.UpdateLog Looking up max value of version field to seed version buckets
   [junit4]   2> 1752296 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.VersionInfo Refreshing highest value of _version_ for 65536 version buckets from index
   [junit4]   2> 1752296 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.VersionInfo No terms found for _version_, cannot seed version bucket highest value from index
   [junit4]   2> 1752298 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.UpdateLog Took 1.0ms to seed version buckets with highest version 1531374431757139968
   [junit4]   2> 1752300 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.DefaultSolrCoreState Closing old IndexWriter... core=collection1
   [junit4]   2> 1752300 INFO  (searcherExecutor-5820-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1752300 INFO  (searcherExecutor-5820-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1752301 INFO  (searcherExecutor-5820-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1752301 INFO  (searcherExecutor-5820-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
   [junit4]   2> 1752301 INFO  (searcherExecutor-5820-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1752301 INFO  (searcherExecutor-5820-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1752302 INFO  (searcherExecutor-5820-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1752302 INFO  (searcherExecutor-5820-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 1752302 INFO  (searcherExecutor-5820-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 1752303 INFO  (searcherExecutor-5820-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@295c869d[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1752303 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(RAMDirectory@45d519c0 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@44ee5da1),segFN=segments_1,generation=1}
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(RAMDirectory@45d519c0 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@44ee5da1),segFN=segments_2,generation=2}
   [junit4]   2> 1752304 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 2
   [junit4]   2> 1752304 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=27, maxMergeAtOnceExplicit=47, maxMergedSegmentMB=41.529296875, floorSegmentMB=1.1064453125, forceMergeDeletesPctAllowed=22.336999967915034, segmentsPerTier=34.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 1752304 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(RAMDirectory@45d519c0 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@44ee5da1),segFN=segments_2,generation=2}
   [junit4]   2> 1752304 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 2
   [junit4]   2> 1752305 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 1752305 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@2b3d9d96[collection1] main]
   [junit4]   2> 1752305 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.c.CoreContainer replacing core: collection1
   [junit4]   2> 1752305 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@2807340e
   [junit4]   2> 1752305 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.DirectUpdateHandler2 closing DirectUpdateHandler2{commits=3,autocommits=0,soft autocommit maxTime=1000ms,soft autocommits=3,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=14,adds=1,deletesById=0,deletesByQuery=1,errors=0,cumulative_adds=14,cumulative_deletesById=1,cumulative_deletesByQuery=1,cumulative_errors=0,transaction_logs_total_size=0,transaction_logs_total_number=0}
   [junit4]   2> 1752306 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.c.SolrCore [collection1] Closing main searcher on request.
   [junit4]   2> 1752313 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[0 (1531374432151404544)]} 0 0
   [junit4]   2> 1752313 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[1 (1531374432151404545)]} 0 0
   [junit4]   2> 1752314 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[2 (1531374432152453120)]} 0 1
   [junit4]   2> 1752314 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[3 (1531374432152453121)]} 0 1
   [junit4]   2> 1752314 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[4 (1531374432152453122)]} 0 1
   [junit4]   2> 1752319 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[5 (1531374432152453123)]} 0 6
   [junit4]   2> 1752319 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[6 (1531374432157696000)]} 0 6
   [junit4]   2> 1752319 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[7 (1531374432157696001)]} 0 6
   [junit4]   2> 1752319 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[8 (1531374432157696002)]} 0 7
   [junit4]   2> 1752320 INFO  (searcherExecutor-5820-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@2b3d9d96[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1752380 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[9 (1531374432220610560)]} 0 67
   [junit4]   2> 1752380 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[10 (1531374432221659136)]} 0 67
   [junit4]   2> 1752380 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[11 (1531374432221659137)]} 0 67
   [junit4]   2> 1752380 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[12 (1531374432221659138)]} 0 67
   [junit4]   2> 1752380 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[13 (1531374432221659139)]} 0 67
   [junit4]   2> 1752392 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    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> 1752392 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[14 (1531374432234242048)]} 0 79
   [junit4]   2> 1752392 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[15 (1531374432234242049)]} 0 80
   [junit4]   2> 1752393 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:14&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
   [junit4]   2> 1752393 ERROR (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.SolrTestCaseJ4 REQUEST FAILED: xpath=//result[@numFound=1]
   [junit4]   2> 	xml response was: <?xml version="1.0" encoding="UTF-8"?>
   [junit4]   2> <response>
   [junit4]   2> <lst name="responseHeader"><int name="status">0</int><int name="QTime">0</int></lst><result name="response" numFound="0" start="0"></result>
   [junit4]   2> </response>
   [junit4]   2> 
   [junit4]   2> 	request was:q=id:14&qt=standard&start=0&rows=20&version=2.2
   [junit4]   2> 1752393 ERROR (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.SolrTestCaseJ4 REQUEST FAILED: q=id:14&qt=standard&start=0&rows=20&version=2.2:java.lang.RuntimeException: REQUEST FAILED: xpath=//result[@numFound=1]
   [junit4]   2> 	xml response was: <?xml version="1.0" encoding="UTF-8"?>
   [junit4]   2> <response>
   [junit4]   2> <lst name="responseHeader"><int name="status">0</int><int name="QTime">0</int></lst><result name="response" numFound="0" start="0"></result>
   [junit4]   2> </response>
   [junit4]   2> 
   [junit4]   2> 	request was:q=id:14&qt=standard&start=0&rows=20&version=2.2
   [junit4]   2> 	at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:773)
   [junit4]   2> 	at org.apache.solr.update.AutoCommitTest.testMaxDocs(AutoCommitTest.java:198)
   [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> 1752394 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.SolrTestCaseJ4 ###Ending testMaxDocs
   [junit4]   2> 1752395 INFO  (commitScheduler-5823-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> 1752413 INFO  (commitScheduler-5823-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@4270619a[collection1] main]
   [junit4]   2> 1752418 INFO  (commitScheduler-5823-thread-1) [    x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1752419 INFO  (searcherExecutor-5820-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@4270619a[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(7.0.0):C16)))}
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=AutoCommitTest -Dtests.method=testMaxDocs -Dtests.seed=AAA627074DC8AC4E -Dtests.slow=true -Dtests.locale=pt-BR -Dtests.timezone=America/Cambridge_Bay -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
   [junit4] ERROR   0.49s J0 | AutoCommitTest.testMaxDocs <<<
   [junit4]    > Throwable #1: java.lang.RuntimeException: Exception during query
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([AAA627074DC8AC4E:1327F1D86122A8C4]:0)
   [junit4]    > 	at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:780)
   [junit4]    > 	at org.apache.solr.update.AutoCommitTest.testMaxDocs(AutoCommitTest.java:198)
   [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:14&qt=standard&start=0&rows=20&version=2.2
   [junit4]    > 	at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:773)
   [junit4]    > 	... 40 more
   [junit4]   2> 1752431 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.SolrTestCaseJ4 ###Starting testCommitWithin
   [junit4]   2> 1752446 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1d7efa52[collection1] realtime]
   [junit4]   2> 1752447 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{deleteByQuery=*:* (-1531374432283525120)} 0 15
   [junit4]   2> 1752447 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1'
   [junit4]   2> 1752450 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1752451 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.c.SolrResourceLoader using system property solr.solr.home: /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr
   [junit4]   2> 1752452 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.c.SolrResourceLoader Adding 'file:/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
   [junit4]   2> 1752452 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.c.SolrResourceLoader Adding 'file:/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/lib/README' to classloader
   [junit4]   2> 1752527 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 1752541 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1752607 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 1752623 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1752868 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 1752872 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.s.IndexSchema default search field in schema is text
   [junit4]   2> 1752873 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 1752876 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 1752877 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 1752878 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 1752879 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 1752881 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or '/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1'
   [junit4]   2> 1752881 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[AAA627074DC8AC4E]) [    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> 1752881 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[AAA627074DC8AC4E]) [    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/J0/temp/solr.update.AutoCommitTest_AAA627074DC8AC4E-001/init-core-data-001/]
   [junit4]   2> 1752881 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@65fe3b78
   [junit4]   2> 1752943 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.update.AutoCommitTest_AAA627074DC8AC4E-001/init-core-data-001/index/
   [junit4]   2> 1752946 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe"
   [junit4]   2> 1752946 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 1752946 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe-allfields"
   [junit4]   2> 1752947 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
   [junit4]   2> 1752947 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "stored_sig"
   [junit4]   2> 1752947 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 1752947 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 1752947 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 1752947 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
   [junit4]   2> 1752947 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[AAA627074DC8AC4E]) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 1752947 INFO  (TEST-AutoCommitTest.testCommitWithin-seed

[...truncated too long message...]

rrors=0,transaction_logs_total_size=0,transaction_logs_total_number=0}
   [junit4]   2> 1760562 INFO  (coreCloseExecutor-5828-thread-1-processing-x:collection1) [    x:collection1] o.a.s.u.SolrCoreState Closing SolrCoreState
   [junit4]   2> 1760562 INFO  (coreCloseExecutor-5828-thread-1-processing-x:collection1) [    x:collection1] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 1760562 INFO  (coreCloseExecutor-5828-thread-1-processing-x:collection1) [    x:collection1] o.a.s.u.DefaultSolrCoreState closing IndexWriter with IndexWriterCloser
   [junit4]   2> 1760562 INFO  (coreCloseExecutor-5828-thread-1-processing-x:collection1) [    x:collection1] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter close.
   [junit4]   2> 1760563 INFO  (coreCloseExecutor-5828-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(RAMDirectory@45d519c0 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@44ee5da1),segFN=segments_3,generation=3}
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(RAMDirectory@45d519c0 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@44ee5da1),segFN=segments_4,generation=4}
   [junit4]   2> 1760564 INFO  (coreCloseExecutor-5828-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 4
   [junit4]   2> 1760564 INFO  (coreCloseExecutor-5828-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Closing main searcher on request.
   [junit4]   2> 1760592 INFO  (coreCloseExecutor-5828-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.CachingDirectoryFactory Closing MockDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 1760593 INFO  (coreCloseExecutor-5828-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.CachingDirectoryFactory looking to close /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.update.AutoCommitTest_AAA627074DC8AC4E-001/init-core-data-001/index [CachedDir<<refCount=0;path=/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.update.AutoCommitTest_AAA627074DC8AC4E-001/init-core-data-001/index;done=false>>]
   [junit4]   2> 1760593 INFO  (coreCloseExecutor-5828-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory, CoreContainer#isShutdown=true
   [junit4]   2> 1760593 INFO  (coreCloseExecutor-5828-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.update.AutoCommitTest_AAA627074DC8AC4E-001/init-core-data-001/index
   [junit4]   2> 1760593 INFO  (coreCloseExecutor-5828-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.CachingDirectoryFactory looking to close /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.update.AutoCommitTest_AAA627074DC8AC4E-001/init-core-data-001 [CachedDir<<refCount=0;path=/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.update.AutoCommitTest_AAA627074DC8AC4E-001/init-core-data-001;done=false>>]
   [junit4]   2> 1760594 INFO  (coreCloseExecutor-5828-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory, CoreContainer#isShutdown=true
   [junit4]   2> 1760594 INFO  (coreCloseExecutor-5828-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.update.AutoCommitTest_AAA627074DC8AC4E-001/init-core-data-001
   [junit4]   2> NOTE: leaving temporary files on disk at: /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.update.AutoCommitTest_AAA627074DC8AC4E-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene60): {range_facet_l_dv=PostingsFormat(name=LuceneVarGapFixedInterval), _version_=PostingsFormat(name=MockRandom), field_t=PostingsFormat(name=LuceneVarGapFixedInterval), multiDefault=FST50, subject=FST50, intDefault=PostingsFormat(name=MockRandom), id=PostingsFormat(name=LuceneVarGapFixedInterval), range_facet_i_dv=FST50, text=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), range_facet_l=FST50, timestamp=FST50}, docValues:{range_facet_l_dv=DocValuesFormat(name=Memory), range_facet_i_dv=DocValuesFormat(name=Lucene54), timestamp=DocValuesFormat(name=Lucene54)}, maxPointsInLeafNode=458, maxMBSortInHeap=5.825562199664969, sim=ClassicSimilarity, locale=pt-BR, timezone=America/Cambridge_Bay
   [junit4]   2> NOTE: SunOS 5.11 amd64/Oracle Corporation 1.8.0_72 (64-bit)/cpus=3,threads=1,free=251903440,total=518979584
   [junit4]   2> NOTE: All tests run in this JVM: [TestJsonRequest, TestXmlQParser, TestMiniSolrCloudCluster, TestSolrDeletionPolicy1, TestReplicaProperties, TestFastLRUCache, TestQueryWrapperFilter, TestDynamicFieldCollectionResource, AnalysisErrorHandlingTest, TestSolrXml, RuleEngineTest, StandardRequestHandlerTest, DocumentBuilderTest, TestNoOpRegenerator, AnalysisAfterCoreReloadTest, SystemInfoHandlerTest, TestSurroundQueryParser, JSONWriterTest, LeaderElectionTest, HardAutoCommitTest, TestDistributedStatsComponentCardinality, PeerSyncTest, XmlUpdateRequestHandlerTest, BadCopyFieldTest, LeaderInitiatedRecoveryOnShardRestartTest, TestPhraseSuggestions, TestRawTransformer, TestRecoveryHdfs, VMParamsZkACLAndCredentialsProvidersTest, SolrCoreTest, UUIDFieldTest, DisMaxRequestHandlerTest, DistributedDebugComponentTest, OverseerRolesTest, AlternateDirectoryTest, TestSchemaSimilarityResource, TestStressLucene, TestLFUCache, TestRTimerTree, TermsComponentTest, TestCopyFieldCollectionResource, TestMinMaxOnMultiValuedField, TestReloadAndDeleteDocs, BlockJoinFacetSimpleTest, TestCryptoKeys, BlockCacheTest, TestComponentsName, TestExtendedDismaxParser, MergeStrategyTest, ScriptEngineTest, RecoveryZkTest, TestMergePolicyConfig, SliceStateTest, TestLRUCache, TestUseDocValuesAsStored2, CursorPagingTest, RestartWhileUpdatingTest, TestGeoJSONResponseWriter, JavabinLoaderTest, SolrRequestParserTest, TestMaxScoreQueryParser, TestHashPartitioner, CollectionsAPIAsyncDistributedZkTest, TestLazyCores, TolerantUpdateProcessorTest, TestSortByMinMaxFunction, TestIBSimilarityFactory, DocValuesMultiTest, BasicDistributedZkTest, TestGroupingSearch, DistributedQueryElevationComponentTest, SoftAutoCommitTest, SortSpecParsingTest, TestFieldSortValues, FacetPivotSmallTest, TestRequestStatusCollectionAPI, TestImplicitCoreProperties, PrimitiveFieldTypeTest, ConjunctionSolrSpellCheckerTest, CloudExitableDirectoryReaderTest, TestRestoreCore, CollectionStateFormat2Test, RegexBoostProcessorTest, TestChildDocTransformer, RemoteQueryErrorTest, RequiredFieldsTest, TestFreeTextSuggestions, ShardSplitTest, BufferStoreTest, TestDistributedSearch, HdfsWriteToMultipleCollectionsTest, TestCodecSupport, TestBlobHandler, TestReplicationHandler, HLLSerializationTest, SuggesterFSTTest, IndexSchemaTest, TestPerFieldSimilarityWithDefaultOverride, PathHierarchyTokenizerFactoryTest, ReturnFieldsTest, TestSha256AuthenticationProvider, SolrCloudExampleTest, URLClassifyProcessorTest, HighlighterTest, TimeZoneUtilsTest, TestFunctionQuery, SchemaVersionSpecificBehaviorTest, TestStressUserVersions, SparseHLLTest, TestRandomRequestDistribution, ZkControllerTest, TestBulkSchemaConcurrent, TestPartialUpdateDeduplication, TestComplexPhraseQParserPlugin, DistributedSpellCheckComponentTest, TestUpdate, PreAnalyzedFieldTest, BadComponentTest, DirectSolrSpellCheckerTest, HdfsSyncSliceTest, TestDFISimilarityFactory, QueryElevationComponentTest, HdfsNNFailoverTest, AssignTest, TestJmxMonitoredMap, ZkCLITest, TestIntervalFaceting, TestTolerantUpdateProcessorCloud, SuggestComponentContextFilterQueryTest, CurrencyFieldXmlFileTest, BlockJoinFacetDistribTest, BigEndianAscendingWordSerializerTest, TestClusterStateMutator, ExternalFileFieldSortTest, IgnoreCommitOptimizeUpdateProcessorFactoryTest, TestExceedMaxTermLength, DistributedQueryComponentOptimizationTest, HdfsChaosMonkeySafeLeaderTest, SyncSliceTest, OpenCloseCoreStressTest, OverseerTest, LeaderElectionIntegrationTest, ClusterStateUpdateTest, TestRandomDVFaceting, AutoCommitTest]
   [junit4] Completed [307/584 (1!)] on J0 in 12.93s, 3 tests, 1 error <<< FAILURES!

[...truncated 913 lines...]
BUILD FAILED
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/build.xml:740: The following error occurred while executing this line:
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/build.xml:684: The following error occurred while executing this line:
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/build.xml:59: The following error occurred while executing this line:
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build.xml:233: The following error occurred while executing this line:
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/common-build.xml:529: The following error occurred while executing this line:
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/common-build.xml:1457: The following error occurred while executing this line:
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/common-build.xml:1014: There were test failures: 584 suites (10 ignored), 2356 tests, 1 error, 85 ignored (70 assumptions) [seed: AAA627074DC8AC4E]

Total time: 78 minutes 47 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
[WARNINGS] Skipping publisher since build result is FAILURE
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any