Build: http://jenkins.thetaphi.de/job/Lucene-Solr-6.x-Linux/603/
Java: 32bit/jdk-9-ea+116 -client -XX:+UseG1GC

2 tests failed.
FAILED:  org.apache.solr.cloud.HttpPartitionTest.test

Error Message:
Doc with id=2 not found in http://127.0.0.1:41585/c8n_1x2_leader_session_loss 
due to: Path not found: /id; rsp={doc=null}

Stack Trace:
java.lang.AssertionError: Doc with id=2 not found in 
http://127.0.0.1:41585/c8n_1x2_leader_session_loss due to: Path not found: /id; 
rsp={doc=null}
        at 
__randomizedtesting.SeedInfo.seed([A7F6C4B67E2BEAED:2FA2FB6CD0D78715]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.assertTrue(Assert.java:43)
        at 
org.apache.solr.cloud.HttpPartitionTest.assertDocExists(HttpPartitionTest.java:604)
        at 
org.apache.solr.cloud.HttpPartitionTest.assertDocsExistInAllReplicas(HttpPartitionTest.java:559)
        at 
org.apache.solr.cloud.HttpPartitionTest.testLeaderZkSessionLoss(HttpPartitionTest.java:507)
        at 
org.apache.solr.cloud.HttpPartitionTest.test(HttpPartitionTest.java:120)
        at 
jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native 
Method)
        at 
jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
        at 
jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(java.base@9-ea/Method.java:531)
        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 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:992)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:967)
        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(java.base@9-ea/Thread.java:804)


FAILED:  org.apache.solr.update.AutoCommitTest.testMaxTime

Error Message:
expected:<3> but was:<4>

Stack Trace:
java.lang.AssertionError: expected:<3> but was:<4>
        at 
__randomizedtesting.SeedInfo.seed([A7F6C4B67E2BEAED:3D02B954E0B176D1]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.failNotEquals(Assert.java:647)
        at org.junit.Assert.assertEquals(Assert.java:128)
        at org.junit.Assert.assertEquals(Assert.java:472)
        at org.junit.Assert.assertEquals(Assert.java:456)
        at 
org.apache.solr.update.AutoCommitTest.testMaxTime(AutoCommitTest.java:275)
        at 
jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native 
Method)
        at 
jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
        at 
jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(java.base@9-ea/Method.java:531)
        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(java.base@9-ea/Thread.java:804)




Build Log:
[...truncated 11492 lines...]
   [junit4] Suite: org.apache.solr.update.AutoCommitTest
   [junit4]   2> Creating dataDir: 
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.update.AutoCommitTest_A7F6C4B67E2BEAED-001/init-core-data-001
   [junit4]   2> 959607 INFO  
(SUITE-AutoCommitTest-seed#[A7F6C4B67E2BEAED]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false)
   [junit4]   2> 959607 INFO  
(SUITE-AutoCommitTest-seed#[A7F6C4B67E2BEAED]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 959607 INFO  
(SUITE-AutoCommitTest-seed#[A7F6C4B67E2BEAED]-worker) [    ] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/collection1'
   [junit4]   2> 959607 INFO  
(SUITE-AutoCommitTest-seed#[A7F6C4B67E2BEAED]-worker) [    ] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 959607 INFO  
(SUITE-AutoCommitTest-seed#[A7F6C4B67E2BEAED]-worker) [    ] 
o.a.s.c.SolrResourceLoader using system property solr.solr.home: 
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr
   [junit4]   2> 959608 INFO  
(SUITE-AutoCommitTest-seed#[A7F6C4B67E2BEAED]-worker) [    ] 
o.a.s.c.SolrResourceLoader Adding 
'file:/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes/'
 to classloader
   [junit4]   2> 959608 INFO  
(SUITE-AutoCommitTest-seed#[A7F6C4B67E2BEAED]-worker) [    ] 
o.a.s.c.SolrResourceLoader Adding 
'file:/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/collection1/lib/README'
 to classloader
   [junit4]   2> 959622 INFO  
(SUITE-AutoCommitTest-seed#[A7F6C4B67E2BEAED]-worker) [    ] o.a.s.c.SolrConfig 
current version of requestparams : -1
   [junit4]   2> 959630 INFO  
(SUITE-AutoCommitTest-seed#[A7F6C4B67E2BEAED]-worker) [    ] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 6.1.0
   [junit4]   2> 959647 INFO  
(SUITE-AutoCommitTest-seed#[A7F6C4B67E2BEAED]-worker) [    ] o.a.s.c.SolrConfig 
Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 959651 INFO  
(SUITE-AutoCommitTest-seed#[A7F6C4B67E2BEAED]-worker) [    ] 
o.a.s.s.IndexSchema [null] Schema name=test
   [junit4]   2> 959722 INFO  
(SUITE-AutoCommitTest-seed#[A7F6C4B67E2BEAED]-worker) [    ] 
o.a.s.s.OpenExchangeRatesOrgProvider Initialized with 
rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 959727 INFO  
(SUITE-AutoCommitTest-seed#[A7F6C4B67E2BEAED]-worker) [    ] 
o.a.s.s.IndexSchema default search field in schema is text
   [junit4]   2> 959728 INFO  
(SUITE-AutoCommitTest-seed#[A7F6C4B67E2BEAED]-worker) [    ] 
o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 959731 INFO  
(SUITE-AutoCommitTest-seed#[A7F6C4B67E2BEAED]-worker) [    ] 
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 959732 INFO  
(SUITE-AutoCommitTest-seed#[A7F6C4B67E2BEAED]-worker) [    ] 
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 959733 INFO  
(SUITE-AutoCommitTest-seed#[A7F6C4B67E2BEAED]-worker) [    ] 
o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from 
open-exchange-rates.json
   [junit4]   2> 959733 INFO  
(SUITE-AutoCommitTest-seed#[A7F6C4B67E2BEAED]-worker) [    ] 
o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from 
open-exchange-rates.json
   [junit4]   2> 959733 INFO  
(SUITE-AutoCommitTest-seed#[A7F6C4B67E2BEAED]-worker) [    ] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 959733 INFO  
(SUITE-AutoCommitTest-seed#[A7F6C4B67E2BEAED]-worker) [    ] 
o.a.s.c.SolrResourceLoader using system property solr.solr.home: 
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr
   [junit4]   2> 959733 INFO  
(SUITE-AutoCommitTest-seed#[A7F6C4B67E2BEAED]-worker) [    ] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr'
   [junit4]   2> 959734 INFO  
(SUITE-AutoCommitTest-seed#[A7F6C4B67E2BEAED]-worker) [    ] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 959734 INFO  
(SUITE-AutoCommitTest-seed#[A7F6C4B67E2BEAED]-worker) [    ] 
o.a.s.c.SolrResourceLoader using system property solr.solr.home: 
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr
   [junit4]   2> 959734 INFO  
(SUITE-AutoCommitTest-seed#[A7F6C4B67E2BEAED]-worker) [    ] 
o.a.s.c.CoreContainer New CoreContainer 17723174
   [junit4]   2> 959734 INFO  
(SUITE-AutoCommitTest-seed#[A7F6C4B67E2BEAED]-worker) [    ] 
o.a.s.c.CoreContainer Loading cores into CoreContainer 
[instanceDir=/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr]
   [junit4]   2> 959734 WARN  
(SUITE-AutoCommitTest-seed#[A7F6C4B67E2BEAED]-worker) [    ] 
o.a.s.c.CoreContainer Couldn't add files from 
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/lib 
to classpath: 
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/lib
   [junit4]   2> 959734 INFO  
(SUITE-AutoCommitTest-seed#[A7F6C4B67E2BEAED]-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,useRetries : false,
   [junit4]   2> 959737 INFO  
(SUITE-AutoCommitTest-seed#[A7F6C4B67E2BEAED]-worker) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=30000&connTimeout=30000&retry=true
   [junit4]   2> 959738 INFO  
(SUITE-AutoCommitTest-seed#[A7F6C4B67E2BEAED]-worker) [    ] o.a.s.l.LogWatcher 
SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 959738 INFO  
(SUITE-AutoCommitTest-seed#[A7F6C4B67E2BEAED]-worker) [    ] o.a.s.l.LogWatcher 
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 959738 INFO  
(SUITE-AutoCommitTest-seed#[A7F6C4B67E2BEAED]-worker) [    ] 
o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for 
authorization module.
   [junit4]   2> 959738 INFO  
(SUITE-AutoCommitTest-seed#[A7F6C4B67E2BEAED]-worker) [    ] 
o.a.s.c.CoreContainer No authentication plugin used.
   [junit4]   2> 959738 INFO  
(SUITE-AutoCommitTest-seed#[A7F6C4B67E2BEAED]-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=/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.update.AutoCommitTest_A7F6C4B67E2BEAED-001/init-core-data-001,
 shard=shard1}
   [junit4]   2> 959738 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/collection1'
   [junit4]   2> 959739 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 959739 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.c.SolrResourceLoader using system property solr.solr.home: 
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr
   [junit4]   2> 959739 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.c.SolrResourceLoader Adding 
'file:/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes/'
 to classloader
   [junit4]   2> 959739 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.c.SolrResourceLoader Adding 
'file:/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/collection1/lib/README'
 to classloader
   [junit4]   2> 959750 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 959763 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.1.0
   [junit4]   2> 959780 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 959785 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 959859 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.s.OpenExchangeRatesOrgProvider Initialized with 
rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 959862 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.s.IndexSchema default search field in schema is text
   [junit4]   2> 959863 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 959866 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 959867 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 959869 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from 
open-exchange-rates.json
   [junit4]   2> 959869 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from 
open-exchange-rates.json
   [junit4]   2> 959870 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default 
properties: Can't find resource 'configsetprops.json' in classpath or 
'/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/collection1'
   [junit4]   2> 959870 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from 
instancedir 
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/collection1
   [junit4]   2> 959870 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 959870 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.update.AutoCommitTest_A7F6C4B67E2BEAED-001/init-core-data-001/]
   [junit4]   2> 959870 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX 
Server: com.sun.jmx.mbeanserver.JmxMBeanServer@76388d
   [junit4]   2> 959871 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.c.CachingDirectoryFactory return new directory for 
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.update.AutoCommitTest_A7F6C4B67E2BEAED-001/init-core-data-001
   [junit4]   2> 959871 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.c.SolrCore New index directory detected: old=null 
new=/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.update.AutoCommitTest_A7F6C4B67E2BEAED-001/init-core-data-001/index/
   [junit4]   2> 959871 WARN  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Solr index directory 
'/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.update.AutoCommitTest_A7F6C4B67E2BEAED-001/init-core-data-001/index'
 doesn't exist. Creating new index...
   [junit4]   2> 959871 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.c.CachingDirectoryFactory return new directory for 
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.update.AutoCommitTest_A7F6C4B67E2BEAED-001/init-core-data-001/index
   [junit4]   2> 959871 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: 
minMergeSize=0, mergeFactor=10, maxMergeSize=2032461234, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.1]
   [junit4]   2> 959872 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@100d25e 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@11e5cc0),segFN=segments_1,generation=1}
   [junit4]   2> 959872 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 959872 INFO  
(OldIndexDirectoryCleanupThreadForCore-collection1) [    ] o.a.s.c.SolrCore 
Looking for old index directories to cleanup for core collection1 in 
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.update.AutoCommitTest_A7F6C4B67E2BEAED-001/init-core-data-001/
   [junit4]   2> 959874 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain 
"dedupe"
   [junit4]   2> 959874 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.u.p.UpdateRequestProcessorChain inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 959874 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain 
"dedupe-allfields"
   [junit4]   2> 959874 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.u.p.UpdateRequestProcessorChain inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"dedupe-allfields"
   [junit4]   2> 959874 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain 
"stored_sig"
   [junit4]   2> 959874 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.u.p.UpdateRequestProcessorChain inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 959874 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain 
"uniq-fields"
   [junit4]   2> 959874 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.u.p.UpdateRequestProcessorChain inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 959874 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain 
"distrib-dup-test-chain-explicit"
   [junit4]   2> 959874 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain 
"distrib-dup-test-chain-implicit"
   [junit4]   2> 959874 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.u.p.UpdateRequestProcessorChain inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"distrib-dup-test-chain-implicit"
   [junit4]   2> 959874 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating 
implicit default
   [junit4]   2> 959876 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 959877 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 959877 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 959878 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 959880 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.c.PluginBag requestHandler : 'lazy' created with startup=lazy 
   [junit4]   2> 959881 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
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,/graph,/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> 959881 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.c.SolrCore Using default statsCache cache: 
org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 959881 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 959881 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 959882 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 959882 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 959882 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: 
minMergeSize=0, mergeFactor=10, maxMergeSize=2002259175, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.1]
   [junit4]   2> 959882 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@100d25e 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@11e5cc0),segFN=segments_1,generation=1}
   [junit4]   2> 959883 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 959883 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@9fe293[collection1] main]
   [junit4]   2> 959883 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.r.RestManager Initializing RestManager with initArgs: 
{storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
   [junit4]   2> 959883 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using InMemoryStorage
   [junit4]   2> 959883 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.r.RestManager Initializing 0 registered ManagedResources
   [junit4]   2> 959883 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 959951 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 960251 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 960251 INFO  (searcherExecutor-4896-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 960251 INFO  (searcherExecutor-4896-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 960251 INFO  (searcherExecutor-4896-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 960251 INFO  (searcherExecutor-4896-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 960252 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.u.UpdateLog Looking up max value of version field to seed version buckets
   [junit4]   2> 960252 INFO  (searcherExecutor-4896-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 960252 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.u.VersionInfo Refreshing highest value of _version_ for 65536 version 
buckets from index
   [junit4]   2> 960252 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.u.VersionInfo No terms found for _version_, cannot seed version bucket 
highest value from index
   [junit4]   2> 960252 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1533846002736300032
   [junit4]   2> 960252 INFO  (searcherExecutor-4896-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 960253 INFO  (searcherExecutor-4896-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 960253 INFO  (searcherExecutor-4896-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 960253 INFO  (searcherExecutor-4896-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 960253 INFO  (searcherExecutor-4896-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@9fe293[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 960254 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.u.UpdateLog Took 1.0ms to seed version buckets with highest version 
1533846002736300032
   [junit4]   2> 960254 INFO  (coreLoadExecutor-4895-thread-1) [    ] 
o.a.s.c.CoreContainer registering core: collection1
   [junit4]   2> 960255 INFO  
(SUITE-AutoCommitTest-seed#[A7F6C4B67E2BEAED]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 960257 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testMaxDocs
   [junit4]   2> 960258 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{deleteByQuery=*:* (-1533846002741542912)} 0 1
   [junit4]   2> 960260 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/collection1'
   [junit4]   2> 960260 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 960260 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.SolrResourceLoader using system property solr.solr.home: 
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr
   [junit4]   2> 960260 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.SolrResourceLoader Adding 
'file:/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes/'
 to classloader
   [junit4]   2> 960260 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.SolrResourceLoader Adding 
'file:/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/collection1/lib/README'
 to classloader
   [junit4]   2> 960275 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 960283 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.1.0
   [junit4]   2> 960301 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 960305 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 960380 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.s.OpenExchangeRatesOrgProvider Initialized with 
rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 960384 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.s.IndexSchema default search field in schema is text
   [junit4]   2> 960385 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 960388 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 960389 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 960390 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from 
open-exchange-rates.json
   [junit4]   2> 960390 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from 
open-exchange-rates.json
   [junit4]   2> 960391 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default 
properties: Can't find resource 'configsetprops.json' in classpath or 
'/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/collection1'
   [junit4]   2> 960391 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using configuration from 
instancedir 
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/collection1
   [junit4]   2> 960391 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.update.AutoCommitTest_A7F6C4B67E2BEAED-001/init-core-data-001/]
   [junit4]   2> 960391 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX 
Server: com.sun.jmx.mbeanserver.JmxMBeanServer@76388d
   [junit4]   2> 960392 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.SolrCore New index directory detected: old=null 
new=/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.update.AutoCommitTest_A7F6C4B67E2BEAED-001/init-core-data-001/index/
   [junit4]   2> 960392 INFO  
(OldIndexDirectoryCleanupThreadForCore-collection1) [    ] o.a.s.c.SolrCore 
Looking for old index directories to cleanup for core collection1 in 
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.update.AutoCommitTest_A7F6C4B67E2BEAED-001/init-core-data-001/
   [junit4]   2> 960394 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain 
"dedupe"
   [junit4]   2> 960394 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.UpdateRequestProcessorChain inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 960394 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain 
"dedupe-allfields"
   [junit4]   2> 960395 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.UpdateRequestProcessorChain inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"dedupe-allfields"
   [junit4]   2> 960395 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain 
"stored_sig"
   [junit4]   2> 960395 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.UpdateRequestProcessorChain inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 960395 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain 
"uniq-fields"
   [junit4]   2> 960395 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.UpdateRequestProcessorChain inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 960395 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain 
"distrib-dup-test-chain-explicit"
   [junit4]   2> 960395 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain 
"distrib-dup-test-chain-implicit"
   [junit4]   2> 960395 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.UpdateRequestProcessorChain inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"distrib-dup-test-chain-implicit"
   [junit4]   2> 960395 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating 
implicit default
   [junit4]   2> 960397 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 960398 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 960398 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 960399 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 960401 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.PluginBag requestHandler : 'lazy' created with startup=lazy 
   [junit4]   2> 960403 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
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,/graph,/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> 960403 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.SolrCore Using default statsCache cache: 
org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 960403 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 960403 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 960403 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@778a9b[collection1] main]
   [junit4]   2> 960403 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.r.RestManager Initializing RestManager with initArgs: 
{storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
   [junit4]   2> 960403 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using InMemoryStorage
   [junit4]   2> 960404 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.r.RestManager Initializing 0 registered ManagedResources
   [junit4]   2> 960404 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 960404 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 960406 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 960406 INFO  (searcherExecutor-4901-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 960406 INFO  (searcherExecutor-4901-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 960406 INFO  (searcherExecutor-4901-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 960406 INFO  (searcherExecutor-4901-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 960406 INFO  (searcherExecutor-4901-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 960406 INFO  (searcherExecutor-4901-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 960406 INFO  (searcherExecutor-4901-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 960406 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.UpdateLog Looking up max value of version field to seed version buckets
   [junit4]   2> 960406 INFO  (searcherExecutor-4901-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 960406 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.VersionInfo Refreshing highest value of _version_ for 65536 version 
buckets from index
   [junit4]   2> 960406 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.VersionInfo No terms found for _version_, cannot seed version bucket 
highest value from index
   [junit4]   2> 960407 INFO  (searcherExecutor-4901-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 960407 INFO  (searcherExecutor-4901-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@778a9b[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 960409 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.UpdateLog Took 2.0ms to seed version buckets with highest version 
1533846002741542912
   [junit4]   2> 960409 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.DefaultSolrCoreState Closing old IndexWriter... core=collection1
   [junit4]   2> 960409 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=35, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=1.0]
   [junit4]   2> 960410 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@100d25e 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@11e5cc0),segFN=segments_1,generation=1}
   [junit4]   2> 960410 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 960410 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 960410 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@10b486c[collection1] main]
   [junit4]   2> 960410 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.CoreContainer replacing core: collection1
   [junit4]   2> 960410 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@1e2e5fa
   [junit4]   2> 960410 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
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> 960410 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.SolrCore [collection1] Closing main searcher on request.
   [junit4]   2> 960410 INFO  (searcherExecutor-4901-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@10b486c[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 960418 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[0 
(1533846002909315072)]} 0 1
   [junit4]   2> 960418 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[1 
(1533846002910363648)]} 0 1
   [junit4]   2> 960419 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[2 
(1533846002911412224)]} 0 2
   [junit4]   2> 960419 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[3 
(1533846002911412225)]} 0 2
   [junit4]   2> 960420 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[4 
(1533846002912460800)]} 0 3
   [junit4]   2> 960420 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[5 
(1533846002912460801)]} 0 3
   [junit4]   2> 960421 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[6 
(1533846002912460802)]} 0 3
   [junit4]   2> 960421 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[7 
(1533846002913509376)]} 0 3
   [junit4]   2> 960421 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[8 
(1533846002913509377)]} 0 4
   [junit4]   2> 960421 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[9 
(1533846002913509378)]} 0 4
   [junit4]   2> 960421 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[10 
(1533846002913509379)]} 0 4
   [junit4]   2> 960421 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[11 
(1533846002913509380)]} 0 4
   [junit4]   2> 960421 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[12 
(1533846002913509381)]} 0 4
   [junit4]   2> 960422 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[13 
(1533846002913509382)]} 0 4
   [junit4]   2> 960422 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
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> 960422 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[14 
(1533846002914557952)]} 0 5
   [junit4]   2> 960423 INFO  (commitScheduler-4904-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 960426 INFO  (commitScheduler-4904-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@1e73b7d[collection1] main]
   [junit4]   2> 960426 INFO  (commitScheduler-4904-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 960427 INFO  (searcherExecutor-4901-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@1e73b7d[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.1.0):C15)))}
   [junit4]   2> 960673 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[15 
(1533846003177750528)]} 0 256
   [junit4]   2> 960674 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:14&qt=standard&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0
   [junit4]   2> 960674 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:15&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
   [junit4]   2> 960674 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testMaxDocs
   [junit4]   2> 960676 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testCommitWithin
   [junit4]   2> 960679 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@fd3581[collection1] realtime]
   [junit4]   2> 960679 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{deleteByQuery=*:* (-1533846003180896256)} 0 2
   [junit4]   2> 960679 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/collection1'
   [junit4]   2> 960679 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 960679 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.SolrResourceLoader using system property solr.solr.home: 
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr
   [junit4]   2> 960680 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.SolrResourceLoader Adding 
'file:/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes/'
 to classloader
   [junit4]   2> 960680 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.SolrResourceLoader Adding 
'file:/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/collection1/lib/README'
 to classloader
   [junit4]   2> 960695 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 960703 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.1.0
   [junit4]   2> 960722 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 960726 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 960812 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.s.OpenExchangeRatesOrgProvider Initialized with 
rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 960817 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.s.IndexSchema default search field in schema is text
   [junit4]   2> 960818 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 960821 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 960822 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 960823 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from 
open-exchange-rates.json
   [junit4]   2> 960823 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from 
open-exchange-rates.json
   [junit4]   2> 960824 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default 
properties: Can't find resource 'configsetprops.json' in classpath or 
'/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/collection1'
   [junit4]   2> 960824 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using configuration from 
instancedir 
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/collection1
   [junit4]   2> 960825 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.update.AutoCommitTest_A7F6C4B67E2BEAED-001/init-core-data-001/]
   [junit4]   2> 960825 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX 
Server: com.sun.jmx.mbeanserver.JmxMBeanServer@76388d
   [junit4]   2> 960825 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.SolrCore New index directory detected: old=null 
new=/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.update.AutoCommitTest_A7F6C4B67E2BEAED-001/init-core-data-001/index/
   [junit4]   2> 960826 INFO  
(OldIndexDirectoryCleanupThreadForCore-collection1) [    ] o.a.s.c.SolrCore 
Looking for old index directories to cleanup for core collection1 in 
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.update.AutoCommitTest_A7F6C4B67E2BEAED-001/init-core-data-001/
   [junit4]   2> 960830 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain 
"dedupe"
   [junit4]   2> 960830 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.UpdateRequestProcessorChain inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 960830 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain 
"dedupe-allfields"
   [junit4]   2> 960830 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.UpdateRequestProcessorChain inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"dedupe-allfields"
   [junit4]   2> 960830 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain 
"stored_sig"
   [junit4]   2> 960830 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.UpdateRequestProcessorChain inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 960830 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain 
"uniq-fields"
   [junit4]   2> 960830 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.UpdateRequestProcessorChain inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 960830 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain 
"distrib-dup-test-chain-explicit"
   [junit4]   2> 960830 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain 
"distrib-dup-test-chain-implicit"
   [junit4]   2> 960830 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.UpdateRequestProcessorChain inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"distrib-dup-test-chain-implicit"
   [junit4]   2> 960830 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating 
implicit default
   [junit4]   2> 960832 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 960833 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 960833 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 960834 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 960837 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.PluginBag requestHandler : 'lazy' created with startup=lazy 
   [junit4]   2> 960838 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
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,/graph,/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> 960838 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.SolrCore Using default statsCache cache: 
org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 960839 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 960839 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 960840 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@1ff5cc7[collection1] main]
   [junit4]   2> 960840 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.r.RestManager Initializing RestManager with initArgs: 
{storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
   [junit4]   2> 960840 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using InMemoryStorage
   [junit4]   2> 960841 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.r.RestManager Initializing 0 registered ManagedResources
   [junit4]   2> 960841 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 960841 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 960842 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 960842 INFO  (searcherExecutor-4905-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 960843 INFO  (searcherExecutor-4905-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 960843 INFO  (searcherExecutor-4905-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 960843 INFO  (searcherExecutor-4905-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 960843 INFO  (searcherExecutor-4905-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 960843 INFO  (searcherExecutor-4905-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 960843 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.UpdateLog Looking up max value of version field to seed version buckets
   [junit4]   2> 960843 INFO  (searcherExecutor-4905-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 960843 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.VersionInfo Refreshing highest value of _version_ for 65536 version 
buckets from index
   [junit4]   2> 960843 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.VersionInfo No terms found for _version_, cannot seed version bucket 
highest value from index
   [junit4]   2> 960843 INFO  (searcherExecutor-4905-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 960844 INFO  (searcherExecutor-4905-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 960844 INFO  (searcherExecutor-4905-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@1ff5cc7[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 960845 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.UpdateLog Took 1.0ms to seed version buckets with highest version 
1533846003180896256
   [junit4]   2> 960845 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.DefaultSolrCoreState Closing old IndexWriter... core=collection1
   [junit4]   2> 960846 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@100d25e 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@11e5cc0),segFN=segments_1,generation=1}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@100d25e 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@11e5cc0),segFN=segments_2,generation=2}
   [junit4]   2> 960846 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 2
   [junit4]   2> 960846 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=50, maxMergeAtOnceExplicit=12, maxMergedSegmentMB=95.2734375, 
floorSegmentMB=1.72265625, forceMergeDeletesPctAllowed=26.97795974568051, 
segmentsPerTier=24.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.6685215644779672
   [junit4]   2> 960846 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@100d25e 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@11e5cc0),segFN=segments_2,generation=2}
   [junit4]   2> 960846 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 2
   [junit4]   2> 960846 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 960847 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@2f53ae[collection1] main]
   [junit4]   2> 960847 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.CoreContainer replacing core: collection1
   [junit4]   2> 960847 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@1cc6e48
   [junit4]   2> 960847 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.DirectUpdateHandler2 closing 
DirectUpdateHandler2{commits=1,autocommits=0,soft autocommit maxDocs=14,soft 
autocommits=1,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=16,adds=1,deletesById=0,deletesByQuery=1,errors=0,cumulative_adds=16,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=0,transaction_logs_total_size=0,transaction_logs_total_number=0}
   [junit4]   2> 960847 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.SolrCore [collection1] Closing main searcher on request.
   [junit4]   2> 960847 INFO  (searcherExecutor-4905-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@2f53ae[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 960855 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[529 
(1533846003367542784)]} 0 1
   [junit4]   2> 960855 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
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> 964855 INFO  (commitScheduler-4908-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 964857 INFO  (commitScheduler-4908-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@9628a2[collection1] main]
   [junit4]   2> 964857 INFO  (commitScheduler-4908-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 964857 INFO  (searcherExecutor-4905-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@9628a2[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(6.1.0):C1)))}
   [junit4]   2> 964859 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[530 
(1533846007566041088)]} 0 4005
   [junit4]   2> 964859 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
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> 964860 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[529 
(-1533846007568138240)]} 0 4006
   [junit4]   2> 964860 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
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> 965860 INFO  (commitScheduler-4908-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 965862 INFO  (commitScheduler-4908-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@d4d4b5[collection1] main]
   [junit4]   2> 965862 INFO  (commitScheduler-4908-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 965863 INFO  (searcherExecutor-4905-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@d4d4b5[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_3(6.1.0):C1)))}
   [junit4]   2> 966111 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
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> 966112 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:530&qt=standard&start=0&rows=20&version=2.2} hits=1 status=0 
QTime=0
   [junit4]   2> 966113 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1533846008880955392)]} 0 5258
   [junit4]   2> 966113 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1533846008882003968)]} 0 5259
   [junit4]   2> 966113 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1533846008882003969)]} 0 5259
   [junit4]   2> 966113 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1533846008882003970)]} 0 5259
   [junit4]   2> 966113 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1533846008882003971)]} 0 5259
   [junit4]   2> 966114 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1533846008883052544)]} 0 5259
   [junit4]   2> 966114 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1533846008883052545)]} 0 5260
   [junit4]   2> 966114 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1533846008883052546)]} 0 5260
   [junit4]   2> 966114 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1533846008883052547)]} 0 5260
   [junit4]   2> 966114 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1533846008883052548)]} 0 5260
   [junit4]   2> 966115 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
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> 966115 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1533846008884101120)]} 0 5261
   [junit4]   2> 966115 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1533846008884101121)]} 0 5261
   [junit4]   2> 966115 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1533846008884101122)]} 0 5261
   [junit4]   2> 966115 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1533846008884101123)]} 0 5261
   [junit4]   2> 966116 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1533846008885149696)]} 0 5261
   [junit4]   2> 966116 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1533846008885149697)]} 0 5262
   [junit4]   2> 966116 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1533846008885149698)]} 0 5262
   [junit4]   2> 966116 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1533846008885149699)]} 0 5262
   [junit4]   2> 966116 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1533846008885149700)]} 0 5262
   [junit4]   2> 966116 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1533846008885149701)]} 0 5262
   [junit4]   2> 966116 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:530&qt=standard&start=0&rows=20&version=2.2} hits=1 status=0 
QTime=0
   [junit4]   2> 967116 INFO  (commitScheduler-4908-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 967118 INFO  (commitScheduler-4908-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@18e9e8d[collection1] main]
   [junit4]   2> 967118 INFO  (commitScheduler-4908-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 967119 INFO  (searcherExecutor-4905-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@18e9e8d[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(6.1.0):C10/9:delGen=1)))}
   [junit4]   2> 967368 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
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> 967369 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
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> 967369 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testCommitWithin
   [junit4]   2> 967371 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testMaxTime
   [junit4]   2> 967372 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@d4fca8[collection1] realtime]
   [junit4]   2> 967372 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{deleteByQuery=*:* (-1533846010202161152)} 0 1
   [junit4]   2> 967373 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/collection1'
   [junit4]   2> 967373 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 967373 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.SolrResourceLoader using system property solr.solr.home: 
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr
   [junit4]   2> 967373 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.SolrResourceLoader Adding 
'file:/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes/'
 to classloader
   [junit4]   2> 967373 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.SolrResourceLoader Adding 
'file:/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/collection1/lib/README'
 to classloader
   [junit4]   2> 967391 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 967399 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.1.0
   [junit4]   2> 967418 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 967422 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 967496 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.s.OpenExchangeRatesOrgProvider Initialized with 
rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 967502 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.s.IndexSchema default search field in schema is text
   [junit4]   2> 967503 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 967506 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 967507 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 967508 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from 
open-exchange-rates.json
   [junit4]   2> 967508 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from 
open-exchange-rates.json
   [junit4]   2> 967509 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default 
properties: Can't find resource 'configsetprops.json' in classpath or 
'/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/collection1'
   [junit4]   2> 967509 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using configuration from 
instancedir 
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/collection1
   [junit4]   2> 967509 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.update.AutoCommitTest_A7F6C4B67E2BEAED-001/init-core-data-001/]
   [junit4]   2> 967510 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX 
Server: com.sun.jmx.mbeanserver.JmxMBeanServer@76388d
   [junit4]   2> 967510 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.SolrCore New index directory detected: old=null 
new=/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.update.AutoCommitTest_A7F6C4B67E2BEAED-001/init-core-data-001/index/
   [junit4]   2> 967510 INFO  
(OldIndexDirectoryCleanupThreadForCore-collection1) [    ] o.a.s.c.SolrCore 
Looking for old index directories to cleanup for core collection1 in 
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.update.AutoCommitTest_A7F6C4B67E2BEAED-001/init-core-data-001/
   [junit4]   2> 967514 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain 
"dedupe"
   [junit4]   2> 967514 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.UpdateRequestProcessorChain inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 967514 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain 
"dedupe-allfields"
   [junit4]   2> 967514 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.UpdateRequestProcessorChain inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"dedupe-allfields"
   [junit4]   2> 967514 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain 
"stored_sig"
   [junit4]   2> 967514 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.UpdateRequestProcessorChain inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 967514 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain 
"uniq-fields"
   [junit4]   2> 967514 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.UpdateRequestProcessorChain inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 967515 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain 
"distrib-dup-test-chain-explicit"
   [junit4]   2> 967515 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain 
"distrib-dup-test-chain-implicit"
   [junit4]   2> 967515 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.p.UpdateRequestProcessorChain inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"distrib-dup-test-chain-implicit"
   [junit4]   2> 967515 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating 
implicit default
   [junit4]   2> 967516 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 967517 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 967517 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 967518 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 967521 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.PluginBag requestHandler : 'lazy' created with startup=lazy 
   [junit4]   2> 967523 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[A7F6C4B67E2BEAED]) [    ] 
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,/graph,/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> 967523 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.SolrCore Using default statsCache cache: 
org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 967523 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 967523 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 967524 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@f58203[collection1] main]
   [junit4]   2> 967524 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.r.RestManager Initializing RestManager with initArgs: 
{storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
   [junit4]   2> 967524 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using InMemoryStorage
   [junit4]   2> 967524 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.r.RestManager Initializing 0 registered ManagedResources
   [junit4]   2> 967524 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 967525 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 967526 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 967526 INFO  (searcherExecutor-4909-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 967526 INFO  (searcherExecutor-4909-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 967527 INFO  (searcherExecutor-4909-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 967527 INFO  (searcherExecutor-4909-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 967527 INFO  (searcherExecutor-4909-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 967527 INFO  (searcherExecutor-4909-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 967527 INFO  (searcherExecutor-4909-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 967527 INFO  (searcherExecutor-4909-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 967527 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.UpdateLog Looking up max value of version field to seed version buckets
   [junit4]   2> 967527 INFO  (searcherExecutor-4909-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 967527 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.VersionInfo Refreshing highest value of _version_ for 65536 version 
buckets from index
   [junit4]   2> 967528 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.u.VersionInfo No terms found for _version_, cannot seed version bucket 
highest value from index
   [junit4]   2> 967528 INFO  (s

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

json
   [junit4]   2>        3       /solr/collections/collection1/state.json
   [junit4]   2>        3       /solr/collections/c8n_1x3/state.json
   [junit4]   2>        3       
/solr/collections/c8n_1x2_leader_session_loss/state.json
   [junit4]   2>        2       /solr/collections/c8n_1x2/state.json
   [junit4]   2>        2       
/solr/collections/collMinRf_1x3/leader_elect/shard1/election/95865400008900617-core_node2-n_0000000000
   [junit4]   2>        2       /solr/collections/c8n_crud_1x2/state.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2>        6       /solr/collections
   [junit4]   2>        5       /solr/live_nodes
   [junit4]   2>        4       /solr/overseer/collection-queue-work
   [junit4]   2>        3       /solr/overseer/queue
   [junit4]   2>        3       /solr/overseer/queue-work
   [junit4]   2> 
   [junit4]   2> 1495937 WARN  
(TEST-HttpPartitionTest.test-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.SocketProxy Closing 4 connections to: http://127.0.0.1:41607/, target: 
http://127.0.0.1:40124/
   [junit4]   2> 1495937 WARN  
(TEST-HttpPartitionTest.test-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.SocketProxy Closing 9 connections to: http://127.0.0.1:41585/, target: 
http://127.0.0.1:39105/
   [junit4]   2> 1495937 WARN  
(TEST-HttpPartitionTest.test-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.SocketProxy Closing 16 connections to: http://127.0.0.1:34571/, target: 
http://127.0.0.1:40462/
   [junit4]   2> 1495937 WARN  
(TEST-HttpPartitionTest.test-seed#[A7F6C4B67E2BEAED]) [    ] 
o.a.s.c.SocketProxy Closing 18 connections to: http://127.0.0.1:44803/, target: 
http://127.0.0.1:33260/
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=HttpPartitionTest 
-Dtests.method=test -Dtests.seed=A7F6C4B67E2BEAED -Dtests.multiplier=3 
-Dtests.slow=true -Dtests.locale=ar-IQ -Dtests.timezone=Asia/Dhaka 
-Dtests.asserts=true -Dtests.file.encoding=US-ASCII
   [junit4] FAILURE  157s J2 | HttpPartitionTest.test <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: Doc with id=2 not 
found in http://127.0.0.1:41585/c8n_1x2_leader_session_loss due to: Path not 
found: /id; rsp={doc=null}
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([A7F6C4B67E2BEAED:2FA2FB6CD0D78715]:0)
   [junit4]    >        at 
org.apache.solr.cloud.HttpPartitionTest.assertDocExists(HttpPartitionTest.java:604)
   [junit4]    >        at 
org.apache.solr.cloud.HttpPartitionTest.assertDocsExistInAllReplicas(HttpPartitionTest.java:559)
   [junit4]    >        at 
org.apache.solr.cloud.HttpPartitionTest.testLeaderZkSessionLoss(HttpPartitionTest.java:507)
   [junit4]    >        at 
org.apache.solr.cloud.HttpPartitionTest.test(HttpPartitionTest.java:120)
   [junit4]    >        at 
jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native 
Method)
   [junit4]    >        at 
jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
   [junit4]    >        at 
jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
   [junit4]    >        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:992)
   [junit4]    >        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:967)
   [junit4]    >        at java.lang.Thread.run(java.base@9-ea/Thread.java:804)
   [junit4]   2> 1495939 INFO  
(SUITE-HttpPartitionTest-seed#[A7F6C4B67E2BEAED]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest_A7F6C4B67E2BEAED-001
   [junit4]   2> May 09, 2016 10:34:33 AM 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 2 leaked 
thread(s).
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene60): 
{range_facet_l_dv=Lucene50(blocksize=128), _version_=Lucene50(blocksize=128), 
multiDefault=PostingsFormat(name=Memory doPackFST= true), 
a_t=Lucene50(blocksize=128), intDefault=Lucene50(blocksize=128), 
id=Lucene50(blocksize=128), range_facet_i_dv=Lucene50(blocksize=128), 
text=PostingsFormat(name=Memory doPackFST= false), 
range_facet_l=Lucene50(blocksize=128), timestamp=Lucene50(blocksize=128)}, 
docValues:{range_facet_l_dv=DocValuesFormat(name=Memory), 
range_facet_i_dv=DocValuesFormat(name=Direct), 
timestamp=DocValuesFormat(name=Direct)}, maxPointsInLeafNode=1491, 
maxMBSortInHeap=7.141008497537163, sim=ClassicSimilarity, locale=ar-IQ, 
timezone=Asia/Dhaka
   [junit4]   2> NOTE: Linux 4.4.0-21-generic i386/Oracle Corporation 9-ea 
(32-bit)/cpus=12,threads=1,free=252389400,total=536870912
   [junit4]   2> NOTE: All tests run in this JVM: [TestBlobHandler, 
XmlUpdateRequestHandlerTest, BigEndianAscendingWordDeserializerTest, 
ExitableDirectoryReaderTest, HdfsThreadLeakTest, TestPivotHelperCode, 
AddBlockUpdateTest, DistributedQueryComponentCustomSortTest, 
TestDistributedMissingSort, TestReqParamsAPI, SuggesterTSTTest, 
TestCoreDiscovery, TestSolrQueryParser, TestBulkSchemaAPI, 
BasicAuthIntegrationTest, ExplicitHLLTest, CollectionsAPISolrJTest, 
CoreAdminRequestStatusTest, CdcrRequestHandlerTest, TestJmxMonitoredMap, 
LeaderElectionTest, ShowFileRequestHandlerTest, MigrateRouteKeyTest, 
TestSimpleQParserPlugin, OverriddenZkACLAndCredentialsProvidersTest, 
TestSolrDynamicMBean, DeleteInactiveReplicaTest, HighlighterConfigTest, 
TestRecovery, TermVectorComponentDistributedTest, BadComponentTest, 
ResponseHeaderTest, StatsComponentTest, TestPerFieldSimilarity, 
BlockJoinFacetSimpleTest, TestRequestStatusCollectionAPI, 
TestComplexPhraseQParserPlugin, TestTolerantUpdateProcessorCloud, 
HdfsCollectionsAPIDistributedZkTest, TestPKIAuthenticationPlugin, 
TestCollationFieldDocValues, FullSolrCloudDistribCmdsTest, 
FieldAnalysisRequestHandlerTest, TestFastWriter, TestElisionMultitermQuery, 
SimpleCollectionCreateDeleteTest, TestCloudInspectUtil, 
TestSolrConfigHandlerCloud, TestIndexingPerformance, 
TestPHPSerializedResponseWriter, HdfsWriteToMultipleCollectionsTest, 
SecurityConfHandlerTest, TestCloudManagedSchema, 
TestSolrQueryParserDefaultOperatorResource, RemoteQueryErrorTest, 
DirectUpdateHandlerTest, BasicDistributedZk2Test, MergeStrategyTest, 
TestTolerantSearch, ConnectionManagerTest, TestMiniSolrCloudCluster, 
EnumFieldTest, ZkStateReaderTest, TestGeoJSONResponseWriter, QueryParsingTest, 
SuggesterWFSTTest, TestSearchPerf, DistributedFacetPivotSmallAdvancedTest, 
TestSort, TestTrieFacet, HLLUtilTest, RequestHandlersTest, CleanupOldIndexTest, 
TestZkChroot, DebugComponentTest, RollingRestartTest, 
TestBlendedInfixSuggestions, SimpleMLTQParserTest, ClusterStateTest, 
TestSolrDeletionPolicy1, DirectUpdateHandlerOptimizeTest, TestJettySolrRunner, 
ChangedSchemaMergeTest, TestPostingsSolrHighlighter, AssignTest, 
TestCollationField, TestRawTransformer, TestJmxIntegration, 
TestNoOpRegenerator, TestSuggestSpellingConverter, CoreAdminHandlerTest, 
AnalyticsMergeStrategyTest, BufferStoreTest, TestMacros, ShardRoutingTest, 
TestReplicationHandler, AutoCommitTest, TestDistributedGrouping, TestFaceting, 
TestHashPartitioner, TestStressReorder, TestReload, HardAutoCommitTest, 
SimpleFacetsTest, SolrCoreTest, QueryElevationComponentTest, PeerSyncTest, 
BadIndexSchemaTest, ConvertedLegacyTest, BasicFunctionalityTest, TestLazyCores, 
TestIndexSearcher, HighlighterTest, SoftAutoCommitTest, 
DistributedQueryElevationComponentTest, SolrIndexSplitterTest, 
AnalysisAfterCoreReloadTest, SolrRequestParserTest, SpatialFilterTest, 
TestCSVLoader, SolrCoreCheckLockOnStartupTest, 
FieldMutatingUpdateProcessorTest, QueryEqualityTest, SortByFunctionTest, 
TestRemoteStreaming, DocValuesMultiTest, LukeRequestHandlerTest, 
StandardRequestHandlerTest, DirectSolrSpellCheckerTest, TestQueryTypes, 
DocumentBuilderTest, PathHierarchyTokenizerFactoryTest, TestArbitraryIndexDir, 
SolrPluginUtilsTest, ReturnFieldsTest, TestAnalyzedSuggestions, 
BinaryUpdateRequestHandlerTest, SearchHandlerTest, MultiTermTest, SampleTest, 
TestSolrCoreProperties, TestLuceneMatchVersion, TestCharFilters, 
SynonymTokenizerTest, TestXIncludeConfig, EchoParamsTest, 
TestSweetSpotSimilarityFactory, TestLMDirichletSimilarityFactory, 
ResourceLoaderTest, ScriptEngineTest, PluginInfoTest, PreAnalyzedFieldTest, 
PrimUtilsTest, DateFieldTest, TestSolrJ, ZkNodePropsTest, CircularListTest, 
SolrTestCaseJ4Test, TestCursorMarkWithoutUniqueKey, TestHighlightDedupGrouping, 
BaseCdcrDistributedZkTest, CloudExitableDirectoryReaderTest, 
CollectionReloadTest, CreateCollectionCleanupTest, 
DeleteLastCustomShardedReplicaTest, DeleteShardTest, 
DistribDocExpirationUpdateProcessorTest, HttpPartitionTest]
   [junit4] Completed [455/595 (2!)] on J2 in 156.96s, 1 test, 1 failure <<< 
FAILURES!

[...truncated 462 lines...]
BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/build.xml:740: The following 
error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/build.xml:684: The following 
error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/build.xml:59: The following error 
occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build.xml:233: The following 
error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/common-build.xml:529: The 
following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/lucene/common-build.xml:1457: The 
following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/lucene/common-build.xml:1014: 
There were test failures: 595 suites (10 ignored), 2405 tests, 2 failures, 117 
ignored (71 assumptions) [seed: A7F6C4B67E2BEAED]

Total time: 63 minutes 21 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


---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to