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

2 tests failed.
FAILED:  
org.apache.solr.cloud.TestLeaderInitiatedRecoveryThread.testPublishDownState

Error Message:
expected:<29> but was:<30>

Stack Trace:
java.lang.AssertionError: expected:<29> but was:<30>
        at 
__randomizedtesting.SeedInfo.seed([9DA66FD612ADD799:C3DBCD28B6B09E64]: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.cloud.TestLeaderInitiatedRecoveryThread.testPublishDownState(TestLeaderInitiatedRecoveryThread.java:118)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:985)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:960)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at java.lang.Thread.run(Thread.java:745)


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

Error Message:
Exception during query

Stack Trace:
java.lang.RuntimeException: Exception during query
        at 
__randomizedtesting.SeedInfo.seed([9DA66FD612ADD799:277400AE9183398C]:0)
        at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:813)
        at 
org.apache.solr.update.AutoCommitTest.testCommitWithin(AutoCommitTest.java:353)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at java.lang.Thread.run(Thread.java:745)
Caused by: java.lang.RuntimeException: REQUEST FAILED: 
xpath=//result[@numFound=1]
        xml response was: <?xml version="1.0" encoding="UTF-8"?>
<response>
<lst name="responseHeader"><int name="status">0</int><int 
name="QTime">0</int></lst><result name="response" numFound="0" 
start="0"></result>
</response>

        request was:q=id:529&qt=standard&start=0&rows=20&version=2.2
        at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:806)
        ... 40 more




Build Log:
[...truncated 11287 lines...]
   [junit4] Suite: org.apache.solr.update.AutoCommitTest
   [junit4]   2> Creating dataDir: 
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest_9DA66FD612ADD799-001/init-core-data-001
   [junit4]   2> 839220 INFO  
(SUITE-AutoCommitTest-seed#[9DA66FD612ADD799]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: 
@org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
   [junit4]   2> 839221 INFO  
(SUITE-AutoCommitTest-seed#[9DA66FD612ADD799]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 839221 INFO  
(SUITE-AutoCommitTest-seed#[9DA66FD612ADD799]-worker) [    ] 
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: 
[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/lib,
 
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 839254 INFO  
(SUITE-AutoCommitTest-seed#[9DA66FD612ADD799]-worker) [    ] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 839305 INFO  
(SUITE-AutoCommitTest-seed#[9DA66FD612ADD799]-worker) [    ] 
o.a.s.s.IndexSchema [null] Schema name=test
   [junit4]   2> 839372 WARN  
(SUITE-AutoCommitTest-seed#[9DA66FD612ADD799]-worker) [    ] 
o.a.s.s.IndexSchema [null] default search field in schema is text. WARNING: 
Deprecated, please use 'df' on request instead.
   [junit4]   2> 839374 INFO  
(SUITE-AutoCommitTest-seed#[9DA66FD612ADD799]-worker) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 839384 INFO  (coreLoadExecutor-3823-thread-1) [    ] 
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: 
[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/lib,
 
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 839421 INFO  (coreLoadExecutor-3823-thread-1) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 839504 INFO  (coreLoadExecutor-3823-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 839572 WARN  (coreLoadExecutor-3823-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] default search field in schema is text. 
WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 839573 INFO  (coreLoadExecutor-3823-thread-1) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 839584 INFO  (coreLoadExecutor-3823-thread-1) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from 
instancedir 
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1
   [junit4]   2> 839584 INFO  (coreLoadExecutor-3823-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1],
 
dataDir=[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest_9DA66FD612ADD799-001/init-core-data-001/]
   [junit4]   2> 839584 INFO  (coreLoadExecutor-3823-thread-1) [    
x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr 
mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@7524baa3
   [junit4]   2> 839585 INFO  (coreLoadExecutor-3823-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=39, maxMergeAtOnceExplicit=49, maxMergedSegmentMB=94.0654296875, 
floorSegmentMB=1.240234375, forceMergeDeletesPctAllowed=14.424651487488093, 
segmentsPerTier=16.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.5916756682897137
   [junit4]   2> 839598 INFO  (coreLoadExecutor-3823-thread-1) [    
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 839598 INFO  (coreLoadExecutor-3823-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 839600 INFO  (coreLoadExecutor-3823-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 839600 INFO  (coreLoadExecutor-3823-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 839603 INFO  (coreLoadExecutor-3823-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=46, maxMergeAtOnceExplicit=40, maxMergedSegmentMB=18.892578125, 
floorSegmentMB=2.1435546875, forceMergeDeletesPctAllowed=27.651345851896306, 
segmentsPerTier=35.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 839603 INFO  (coreLoadExecutor-3823-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@7cc66f56[collection1] main]
   [junit4]   2> 839603 INFO  (coreLoadExecutor-3823-thread-1) [    
x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 839617 INFO  (coreLoadExecutor-3823-thread-1) [    
x:collection1] o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 839643 INFO  (coreLoadExecutor-3823-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 839643 INFO  (coreLoadExecutor-3823-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1548311395635822592
   [junit4]   2> 839646 INFO  
(searcherExecutor-3824-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 839647 INFO  
(searcherExecutor-3824-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 839647 INFO  
(searcherExecutor-3824-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 839647 INFO  
(searcherExecutor-3824-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 839648 INFO  
(searcherExecutor-3824-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 839648 INFO  
(SUITE-AutoCommitTest-seed#[9DA66FD612ADD799]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 839648 INFO  
(searcherExecutor-3824-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 839648 INFO  
(searcherExecutor-3824-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 839652 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[9DA66FD612ADD799]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testMaxDocs
   [junit4]   2> 839654 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[9DA66FD612ADD799]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{deleteByQuery=*:* (-1548311395645259776)} 0 1
   [junit4]   2> 839657 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[9DA66FD612ADD799]) [    ] 
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: 
[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/lib,
 
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 839658 INFO  
(searcherExecutor-3824-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 839658 INFO  
(searcherExecutor-3824-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 839659 INFO  
(searcherExecutor-3824-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@7cc66f56[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 839707 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[9DA66FD612ADD799]) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 839726 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[9DA66FD612ADD799]) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 839792 WARN  
(TEST-AutoCommitTest.testMaxDocs-seed#[9DA66FD612ADD799]) [    ] 
o.a.s.s.IndexSchema [collection1] default search field in schema is text. 
WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 839795 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[9DA66FD612ADD799]) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 839802 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[9DA66FD612ADD799]) [    ] 
o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using configuration from 
instancedir 
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1
   [junit4]   2> 839802 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1],
 
dataDir=[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest_9DA66FD612ADD799-001/init-core-data-001/]
   [junit4]   2> 839802 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX 
Server: com.sun.jmx.mbeanserver.JmxMBeanServer@7524baa3
   [junit4]   2> 839888 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 839889 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 839889 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@61c5fbf8[collection1] main]
   [junit4]   2> 839889 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 839890 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 839895 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 839896 INFO  
(searcherExecutor-3829-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 839896 INFO  
(searcherExecutor-3829-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 839897 INFO  
(searcherExecutor-3829-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 839897 INFO  
(searcherExecutor-3829-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 839897 INFO  
(searcherExecutor-3829-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 839897 INFO  
(searcherExecutor-3829-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 839898 INFO  
(searcherExecutor-3829-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 839898 INFO  
(searcherExecutor-3829-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 839898 INFO  
(searcherExecutor-3829-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 839899 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=21, maxMergeAtOnceExplicit=19, maxMergedSegmentMB=59.3603515625, 
floorSegmentMB=0.8740234375, forceMergeDeletesPctAllowed=22.21789876247098, 
segmentsPerTier=25.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.3630028204263642
   [junit4]   2> 839904 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 839904 INFO  
(searcherExecutor-3829-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@61c5fbf8[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 839905 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@27bc1be8[collection1] main]
   [junit4]   2> 839905 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@432a738b
   [junit4]   2> 839905 INFO  
(searcherExecutor-3829-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@27bc1be8[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 839915 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[0 
(1548311395919986688)]} 0 0
   [junit4]   2> 839916 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[1 
(1548311395921035264)]} 0 1
   [junit4]   2> 839916 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[2 
(1548311395922083840)]} 0 1
   [junit4]   2> 839917 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[3 
(1548311395922083841)]} 0 2
   [junit4]   2> 839917 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[4 
(1548311395923132416)]} 0 2
   [junit4]   2> 839917 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[5 
(1548311395923132417)]} 0 3
   [junit4]   2> 839917 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[6 
(1548311395923132418)]} 0 3
   [junit4]   2> 839918 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[7 
(1548311395923132419)]} 0 3
   [junit4]   2> 839918 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[8 
(1548311395924180992)]} 0 3
   [junit4]   2> 839918 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[9 
(1548311395924180993)]} 0 3
   [junit4]   2> 839918 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[10 
(1548311395924180994)]} 0 4
   [junit4]   2> 839918 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[11 
(1548311395924180995)]} 0 4
   [junit4]   2> 839918 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[12 
(1548311395924180996)]} 0 4
   [junit4]   2> 839919 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[13 
(1548311395925229568)]} 0 4
   [junit4]   2> 839919 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:1&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
   [junit4]   2> 839920 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[14 
(1548311395926278144)]} 0 5
   [junit4]   2> 839922 INFO  (commitScheduler-3832-thread-1) [    
x:collection1] o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 839924 INFO  (commitScheduler-3832-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@31a49a33[collection1] main]
   [junit4]   2> 839924 INFO  (commitScheduler-3832-thread-1) [    
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 839925 INFO  
(searcherExecutor-3829-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@31a49a33[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):c15)))}
   [junit4]   2> 840171 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[15 
(1548311396189470720)]} 0 257
   [junit4]   2> 840172 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:14&qt=standard&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0
   [junit4]   2> 840172 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:15&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
   [junit4]   2> 840173 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.SolrTestCaseJ4 ###Ending testMaxDocs
   [junit4]   2> 840177 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[9DA66FD612ADD799]) [    
x:collection1] o.a.s.SolrTestCaseJ4 ###Starting testCommitWithin
   [junit4]   2> 840235 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[9DA66FD612ADD799]) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@a105335[collection1] 
realtime]
   [junit4]   2> 840235 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[9DA66FD612ADD799]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{deleteByQuery=*:* (-1548311396195762176)} 0 58
   [junit4]   2> 840236 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[9DA66FD612ADD799]) [    
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, 
from paths: 
[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/lib,
 
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 840267 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[9DA66FD612ADD799]) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 840287 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[9DA66FD612ADD799]) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 840376 WARN  
(TEST-AutoCommitTest.testCommitWithin-seed#[9DA66FD612ADD799]) [    
x:collection1] o.a.s.s.IndexSchema [collection1] default search field in schema 
is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 840379 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[9DA66FD612ADD799]) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 840386 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[9DA66FD612ADD799]) [    
x:collection1] o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using 
configuration from instancedir 
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1
   [junit4]   2> 840386 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[9DA66FD612ADD799]) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1],
 
dataDir=[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest_9DA66FD612ADD799-001/init-core-data-001/]
   [junit4]   2> 840386 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[9DA66FD612ADD799]) [    
x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr 
mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@7524baa3
   [junit4]   2> 840412 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[9DA66FD612ADD799]) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 840412 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[9DA66FD612ADD799]) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 840412 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[9DA66FD612ADD799]) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@4d81bfb[collection1] 
main]
   [junit4]   2> 840412 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[9DA66FD612ADD799]) [    
x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 840413 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[9DA66FD612ADD799]) [    
x:collection1] o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 840422 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[9DA66FD612ADD799]) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 840422 INFO  
(searcherExecutor-3833-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 840422 INFO  
(searcherExecutor-3833-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 840423 INFO  
(searcherExecutor-3833-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 840423 INFO  
(searcherExecutor-3833-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 840423 INFO  
(searcherExecutor-3833-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 840423 INFO  
(searcherExecutor-3833-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 840424 INFO  
(searcherExecutor-3833-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 840424 INFO  
(searcherExecutor-3833-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 840424 INFO  
(searcherExecutor-3833-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 840428 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[9DA66FD612ADD799]) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=47, maxMergeAtOnceExplicit=33, maxMergedSegmentMB=35.8095703125, 
floorSegmentMB=0.80078125, forceMergeDeletesPctAllowed=27.642714216989475, 
segmentsPerTier=23.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 840428 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[9DA66FD612ADD799]) [    
x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 840429 INFO  
(searcherExecutor-3833-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@4d81bfb[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 840429 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[9DA66FD612ADD799]) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@66048da7[collection1] main]
   [junit4]   2> 840429 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[9DA66FD612ADD799]) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@3b52c130
   [junit4]   2> 840437 INFO  
(searcherExecutor-3833-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@66048da7[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 840438 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[9DA66FD612ADD799]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[529 
(1548311396468391936)]} 0 2
   [junit4]   2> 840439 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[9DA66FD612ADD799]) [    
x:collection1] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:529&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 
QTime=0
   [junit4]   2> 840439 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[9DA66FD612ADD799]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[530 
(1548311396470489088)]} 0 3
   [junit4]   2> 840443 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[9DA66FD612ADD799]) [    
x:collection1] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:530&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 
QTime=4
   [junit4]   2> 840446 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[9DA66FD612ADD799]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[529 
(-1548311396475731968)]} 0 9
   [junit4]   2> 840446 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[9DA66FD612ADD799]) [    
x:collection1] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:529&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 
QTime=0
   [junit4]   2> 840447 ERROR 
(TEST-AutoCommitTest.testCommitWithin-seed#[9DA66FD612ADD799]) [    
x:collection1] o.a.s.SolrTestCaseJ4 REQUEST FAILED: xpath=//result[@numFound=1]
   [junit4]   2>        xml response was: <?xml version="1.0" encoding="UTF-8"?>
   [junit4]   2> <response>
   [junit4]   2> <lst name="responseHeader"><int name="status">0</int><int 
name="QTime">0</int></lst><result name="response" numFound="0" 
start="0"></result>
   [junit4]   2> </response>
   [junit4]   2> 
   [junit4]   2>        request 
was:q=id:529&qt=standard&start=0&rows=20&version=2.2
   [junit4]   2> 840447 ERROR 
(TEST-AutoCommitTest.testCommitWithin-seed#[9DA66FD612ADD799]) [    
x:collection1] o.a.s.SolrTestCaseJ4 REQUEST FAILED: 
q=id:529&qt=standard&start=0&rows=20&version=2.2:java.lang.RuntimeException: 
REQUEST FAILED: xpath=//result[@numFound=1]
   [junit4]   2>        xml response was: <?xml version="1.0" encoding="UTF-8"?>
   [junit4]   2> <response>
   [junit4]   2> <lst name="responseHeader"><int name="status">0</int><int 
name="QTime">0</int></lst><result name="response" numFound="0" 
start="0"></result>
   [junit4]   2> </response>
   [junit4]   2> 
   [junit4]   2>        request 
was:q=id:529&qt=standard&start=0&rows=20&version=2.2
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:806)
   [junit4]   2>        at 
org.apache.solr.update.AutoCommitTest.testCommitWithin(AutoCommitTest.java:353)
   [junit4]   2>        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native 
Method)
   [junit4]   2>        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
   [junit4]   2>        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   [junit4]   2>        at java.lang.reflect.Method.invoke(Method.java:498)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
   [junit4]   2>        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
   [junit4]   2>        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 
   [junit4]   2> 840447 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[9DA66FD612ADD799]) [    
x:collection1] o.a.s.SolrTestCaseJ4 ###Ending testCommitWithin
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=AutoCommitTest 
-Dtests.method=testCommitWithin -Dtests.seed=9DA66FD612ADD799 -Dtests.slow=true 
-Dtests.locale=zh-TW -Dtests.timezone=Europe/Vatican -Dtests.asserts=true 
-Dtests.file.encoding=US-ASCII
   [junit4] ERROR   0.28s J1 | AutoCommitTest.testCommitWithin <<<
   [junit4]    > Throwable #1: java.lang.RuntimeException: Exception during 
query
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([9DA66FD612ADD799:277400AE9183398C]:0)
   [junit4]    >        at 
org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:813)
   [junit4]    >        at 
org.apache.solr.update.AutoCommitTest.testCommitWithin(AutoCommitTest.java:353)
   [junit4]    >        at java.lang.Thread.run(Thread.java:745)
   [junit4]    > Caused by: java.lang.RuntimeException: REQUEST FAILED: 
xpath=//result[@numFound=1]
   [junit4]    >        xml response was: <?xml version="1.0" encoding="UTF-8"?>
   [junit4]    > <response>
   [junit4]    > <lst name="responseHeader"><int name="status">0</int><int 
name="QTime">0</int></lst><result name="response" numFound="0" 
start="0"></result>
   [junit4]    > </response>
   [junit4]    >        request 
was:q=id:529&qt=standard&start=0&rows=20&version=2.2
   [junit4]    >        at 
org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:806)
   [junit4]    >        ... 40 more
   [junit4]   2> 840457 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.SolrTestCaseJ4 ###Starting testMaxTime
   [junit4]   2> 840460 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@3a34e65b[collection1] realtime]
   [junit4]   2> 840460 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{deleteByQuery=*:* (-1548311396489363456)} 0 2
   [junit4]   2> 840461 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: 
[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/lib,
 
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 840491 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 840523 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 840659 WARN  
(TEST-AutoCommitTest.testMaxTime-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.s.IndexSchema [collection1] default search field in schema is text. 
WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 840660 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 840667 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using configuration from 
instancedir 
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1
   [junit4]   2> 840668 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1],
 
dataDir=[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest_9DA66FD612ADD799-001/init-core-data-001/]
   [junit4]   2> 840668 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX 
Server: com.sun.jmx.mbeanserver.JmxMBeanServer@7524baa3
   [junit4]   2> 840684 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 840684 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 840684 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@5b6d72e6[collection1] main]
   [junit4]   2> 840684 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 840685 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 840690 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 840690 INFO  
(searcherExecutor-3837-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 840693 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=17, maxMergeAtOnceExplicit=27, maxMergedSegmentMB=65.0478515625, 
floorSegmentMB=1.533203125, forceMergeDeletesPctAllowed=9.175712838798887, 
segmentsPerTier=38.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.19684021332296828
   [junit4]   2> 840693 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 840693 WARN  
(TEST-AutoCommitTest.testMaxTime-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.c.SolrCore [collection1] PERFORMANCE WARNING: Overlapping 
onDeckSearchers=2
   [junit4]   2> 840694 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@1ee942e8[collection1] main]
   [junit4]   2> 840694 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@6389b974
   [junit4]   2> 840696 INFO  
(searcherExecutor-3837-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 840696 INFO  
(searcherExecutor-3837-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 840697 INFO  
(searcherExecutor-3837-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 840699 INFO  
(searcherExecutor-3837-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 840699 INFO  
(searcherExecutor-3837-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 840700 INFO  
(searcherExecutor-3837-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 840700 INFO  
(searcherExecutor-3837-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 840700 INFO  
(searcherExecutor-3837-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 840701 INFO  
(searcherExecutor-3837-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@5b6d72e6[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 840701 INFO  
(searcherExecutor-3837-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 840701 INFO  
(searcherExecutor-3837-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 840701 INFO  
(searcherExecutor-3837-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 840701 INFO  
(searcherExecutor-3837-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 840702 INFO  
(searcherExecutor-3837-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 840702 INFO  
(searcherExecutor-3837-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 840702 INFO  
(searcherExecutor-3837-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 840703 INFO  
(searcherExecutor-3837-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 840703 INFO  
(searcherExecutor-3837-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 840704 INFO  
(searcherExecutor-3837-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@1ee942e8[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 840711 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[529 
(1548311396754653184)]} 0 1
   [junit4]   2> 840711 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:529&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 
QTime=0
   [junit4]   2> 841712 INFO  (commitScheduler-3840-thread-1) [    
x:collection1] o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 841713 INFO  (commitScheduler-3840-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@3aebb8b6[collection1] main]
   [junit4]   2> 841713 INFO  (commitScheduler-3840-thread-1) [    
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 841714 INFO  
(searcherExecutor-3837-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@3aebb8b6[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_3(7.0.0):c1)))}
   [junit4]   2> 841964 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[530 
(1548311398069567488)]} 0 1255
   [junit4]   2> 841965 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:529&qt=standard&start=0&rows=20&version=2.2} hits=1 status=0 
QTime=0
   [junit4]   2> 841965 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:530&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 
QTime=0
   [junit4]   2> 841966 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{delete=[529 (-1548311398070616064)]} 0 0
   [junit4]   2> 841966 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:529&qt=standard&start=0&rows=20&version=2.2} hits=1 status=0 
QTime=0
   [junit4]   2> 842967 INFO  (commitScheduler-3840-thread-1) [    
x:collection1] o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 842969 INFO  (commitScheduler-3840-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@3b8f9fb7[collection1] main]
   [junit4]   2> 842969 INFO  (commitScheduler-3840-thread-1) [    
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 842970 INFO  
(searcherExecutor-3837-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@3b8f9fb7[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(7.0.0):c1)))}
   [junit4]   2> 843219 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[550 
(1548311399384481792)]} 0 2509
   [junit4]   2> 843219 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:529&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 
QTime=0
   [junit4]   2> 843219 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1548311399385530368)]} 0 2510
   [junit4]   2> 843220 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1548311399385530369)]} 0 2510
   [junit4]   2> 843220 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1548311399386578944)]} 0 2510
   [junit4]   2> 843220 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1548311399386578945)]} 0 2510
   [junit4]   2> 843220 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1548311399386578946)]} 0 2511
   [junit4]   2> 843220 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1548311399386578947)]} 0 2511
   [junit4]   2> 843220 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1548311399386578948)]} 0 2511
   [junit4]   2> 843220 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1548311399386578949)]} 0 2511
   [junit4]   2> 843221 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1548311399387627520)]} 0 2511
   [junit4]   2> 843221 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1548311399387627521)]} 0 2511
   [junit4]   2> 843221 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:500&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 
QTime=0
   [junit4]   2> 844223 INFO  (commitScheduler-3840-thread-1) [    
x:collection1] o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 844226 INFO  (commitScheduler-3840-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@19ad4a6a[collection1] main]
   [junit4]   2> 844226 INFO  (commitScheduler-3840-thread-1) [    
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 844227 INFO  
(searcherExecutor-3837-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@19ad4a6a[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(7.0.0):c1)
 Uninverting(_5(7.0.0):c11/9:delGen=1)))}
   [junit4]   2> 844477 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[531 
(1548311400703590400)]} 0 3767
   [junit4]   2> 844477 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:500&qt=standard&start=0&rows=20&version=2.2} hits=1 status=0 
QTime=0
   [junit4]   2> 844477 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[9DA66FD612ADD799]) [    x:collection1] 
o.a.s.SolrTestCaseJ4 ###Ending testMaxTime
   [junit4]   2> 844478 INFO  
(SUITE-AutoCommitTest-seed#[9DA66FD612ADD799]-worker) [    x:collection1] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> 844478 INFO  
(SUITE-AutoCommitTest-seed#[9DA66FD612ADD799]-worker) [    x:collection1] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1753853289
   [junit4]   2> 844478 INFO  
(coreCloseExecutor-3841-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@67dd4bcf
   [junit4]   2> 844478 INFO  
(coreCloseExecutor-3841-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter close.
   [junit4]   2> 844478 INFO  
(coreCloseExecutor-3841-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@78717d24
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest_9DA66FD612ADD799-001
   [junit4]   2> NOTE: test params are: codec=CheapBastard, 
sim=RandomSimilarity(queryNorm=false): {}, locale=zh-TW, timezone=Europe/Vatican
   [junit4]   2> NOTE: SunOS 5.11 amd64/Oracle Corporation 1.8.0_102 
(64-bit)/cpus=3,threads=1,free=185113352,total=536870912
   [junit4]   2> NOTE: All tests run in this JVM: [TestSortByMinMaxFunction, 
SolrIndexSplitterTest, DateMathParserTest, TermVectorComponentTest, 
CircularListTest, TestStressCloudBlindAtomicUpdates, RuleEngineTest, 
HLLSerializationTest, TestRecoveryHdfs, TestQuerySenderListener, 
TestSolrIndexConfig, TestOmitPositions, SortByFunctionTest, 
RemoteQueryErrorTest, CdcrReplicationHandlerTest, 
FieldMutatingUpdateProcessorTest, TestPKIAuthenticationPlugin, 
PreAnalyzedFieldTest, UUIDFieldTest, TestSolrCoreSnapshots, HdfsNNFailoverTest, 
SuggestComponentContextFilterQueryTest, CSVRequestHandlerTest, 
TestDefaultStatsCache, TestComponentsName, 
HdfsTlogReplayBufferedWhileIndexingTest, TermVectorComponentDistributedTest, 
SolrCmdDistributorTest, TestUniqueKeyFieldResource, CdcrVersionReplicationTest, 
TestDynamicLoading, CoreAdminHandlerTest, TestDefaultSearchFieldResource, 
TestReversedWildcardFilterFactory, CloneFieldUpdateProcessorFactoryTest, 
TestCloudInspectUtil, TestConfigSetImmutable, TestRealTimeGet, 
TestMacroExpander, DeleteNodeTest, TestLRUStatsCache, TestNumericTerms32, 
TestSolr4Spatial, DistributedExpandComponentTest, BlockJoinFacetSimpleTest, 
TestSubQueryTransformerCrossCore, TestClusterStateMutator, 
TestSolrDynamicMBean, TestPivotHelperCode, CollectionReloadTest, 
SortSpecParsingTest, TestSimpleTrackingShardHandler, ResourceLoaderTest, 
PreAnalyzedUpdateProcessorTest, TestFieldResource, MinimalSchemaTest, 
ConfigSetsAPITest, CollectionTooManyReplicasTest, 
TestPHPSerializedResponseWriter, TestAtomicUpdateErrorCases, TestConfigSets, 
SimpleCollectionCreateDeleteTest, TestManagedSchemaAPI, TestSQLHandler, 
TestRawResponseWriter, HdfsBasicDistributedZkTest, DistribCursorPagingTest, 
URLClassifyProcessorTest, TestExceedMaxTermLength, SpellingQueryConverterTest, 
ConjunctionSolrSpellCheckerTest, TestFieldCacheWithThreads, 
TestValueSourceCache, SpellPossibilityIteratorTest, 
CoreMergeIndexesAdminHandlerTest, TestSystemIdResolver, TestQueryWrapperFilter, 
TestEmbeddedSolrServerConstructors, TestFieldCacheSortRandom, 
TestShardHandlerFactory, NotRequiredUniqueKeyTest, ChaosMonkeySafeLeaderTest, 
TestBinaryResponseWriter, JSONWriterTest, RequestHandlersTest, 
RegexBoostProcessorTest, SaslZkACLProviderTest, BufferStoreTest, 
AliasIntegrationTest, TestSolrDeletionPolicy2, TestWriterPerf, 
CoreAdminCreateDiscoverTest, TestCollationFieldDocValues, ExplicitHLLTest, 
CollectionsAPIDistributedZkTest, TestMaxScoreQueryParser, 
TestSlowCompositeReaderWrapper, TestRecovery, TestRebalanceLeaders, 
DistribJoinFromCollectionTest, TestFastWriter, TestRangeQuery, 
DirectUpdateHandlerOptimizeTest, FacetPivotSmallTest, DateRangeFieldTest, 
NoCacheHeaderTest, HdfsDirectoryFactoryTest, OpenCloseCoreStressTest, 
TestQueryTypes, TestSchemaManager, TestReload, 
TestSolrQueryParserDefaultOperatorResource, AutoCommitTest]
   [junit4] Completed [228/638 (1!)] on J1 in 5.29s, 3 tests, 1 error <<< 
FAILURES!

[...truncated 814 lines...]
   [junit4] Suite: org.apache.solr.cloud.TestLeaderInitiatedRecoveryThread
   [junit4]   2> Creating dataDir: 
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.TestLeaderInitiatedRecoveryThread_9DA66FD612ADD799-001/init-core-data-001
   [junit4]   2> 2358094 INFO  
(SUITE-TestLeaderInitiatedRecoveryThread-seed#[9DA66FD612ADD799]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: 
@org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl=None)
   [junit4]   2> 2358094 INFO  
(SUITE-TestLeaderInitiatedRecoveryThread-seed#[9DA66FD612ADD799]-worker) [    ] 
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /rzm/w
   [junit4]   2> 2358100 INFO  
(TEST-TestLeaderInitiatedRecoveryThread.testPublishDownState-seed#[9DA66FD612ADD799])
 [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 2358101 INFO  (Thread-6969) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 2358101 INFO  (Thread-6969) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 2358201 INFO  
(TEST-TestLeaderInitiatedRecoveryThread.testPublishDownState-seed#[9DA66FD612ADD799])
 [    ] o.a.s.c.ZkTestServer start zk server on port:61258
   [junit4]   2> 2358231 INFO  
(TEST-TestLeaderInitiatedRecoveryThread.testPublishDownState-seed#[9DA66FD612ADD799])
 [    ] o.a.s.c.AbstractZkTestCase put 
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
 to /configs/conf1/solrconfig.xml
   [junit4]   2> 2358236 INFO  
(TEST-TestLeaderInitiatedRecoveryThread.testPublishDownState-seed#[9DA66FD612ADD799])
 [    ] o.a.s.c.AbstractZkTestCase put 
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/conf/schema.xml
 to /configs/conf1/schema.xml
   [junit4]   2> 2358240 INFO  
(TEST-TestLeaderInitiatedRecoveryThread.testPublishDownState-seed#[9DA66FD612ADD799])
 [    ] o.a.s.c.AbstractZkTestCase put 
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
 to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 2358243 INFO  
(TEST-TestLeaderInitiatedRecoveryThread.testPublishDownState-seed#[9DA66FD612ADD799])
 [    ] o.a.s.c.AbstractZkTestCase put 
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
 to /configs/conf1/stopwords.txt
   [junit4]   2> 2358247 INFO  
(TEST-TestLeaderInitiatedRecoveryThread.testPublishDownState-seed#[9DA66FD612ADD799])
 [    ] o.a.s.c.AbstractZkTestCase put 
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/conf/protwords.txt
 to /configs/conf1/protwords.txt
   [junit4]   2> 2358250 INFO  
(TEST-TestLeaderInitiatedRecoveryThread.testPublishDownState-seed#[9DA66FD612ADD799])
 [    ] o.a.s.c.AbstractZkTestCase put 
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/conf/currency.xml
 to /configs/conf1/currency.xml
   [junit4]   2> 2358253 INFO  
(TEST-TestLeaderInitiatedRecoveryThread.testPublishDownState-seed#[9DA66FD612ADD799])
 [    ] o.a.s.c.AbstractZkTestCase put 
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
 to /configs/conf1/enumsConfig.xml
   [junit4]   2> 2358256 INFO  
(TEST-TestLeaderInitiatedRecoveryThread.testPublishDownState-seed#[9DA66FD612ADD799])
 [    ] o.a.s.c.AbstractZkTestCase put 
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
 to /configs/conf1/open-exchange-rates.json
   [junit4]   2> 2358259 INFO  
(TEST-TestLeaderInitiatedRecoveryThread.testPublishDownState-seed#[9DA66FD612ADD799])
 [    ] o.a.s.c.AbstractZkTestCase put 
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
 to /configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 2358263 INFO  
(TEST-TestLeaderInitiatedRecoveryThread.testPublishDownState-seed#[9DA66FD612ADD799])
 [    ] o.a.s.c.AbstractZkTestCase put 
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
 to /configs/conf1/old_synonyms.txt
   [junit4]   2> 2358266 INFO  
(TEST-TestLeaderInitiatedRecoveryThread.testPublishDownState-seed#[9DA66FD612ADD799])
 [    ] o.a.s.c.AbstractZkTestCase put 
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
 to /configs/conf1/synonyms.txt
   [junit4]   2> 2358466 INFO  
(TEST-TestLeaderInitiatedRecoveryThread.testPublishDownState-seed#[9DA66FD612ADD799])
 [    ] o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.TestLeaderInitiatedRecoveryThread_9DA66FD612ADD799-001/control-001/cores/collection1
   [junit4]   2> 2358467 INFO  
(TEST-TestLeaderInitiatedRecoveryThread.testPublishDownState-seed#[9DA66FD612ADD799])
 [    ] o.e.j.s.Server jetty-9.3.8.v20160314
   [junit4]   2> 2358468 INFO  
(TEST-TestLeaderInitiatedRecoveryThread.testPublishDownState-seed#[9DA66FD612ADD799])
 [    ] o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@3f5fd535{/rzm/w,null,AVAILABLE}
   [junit4]   2> 2358471 INFO  
(TEST-TestLeaderInitiatedRecoveryThread.testPublishDownState-seed#[9DA66FD612ADD799])
 [    ] o.e.j.s.ServerConnector Started 
ServerConnector@6912c4dd{HTTP/1.1,[http/1.1]}{127.0.0.1:49303}
   [junit4]   2> 2358471 INFO  
(TEST-TestLeaderInitiatedRecoveryThread.testPublishDownState-seed#[9DA66FD612ADD799])
 [    ] o.e.j.s.Server Started @2362606ms
   [junit4]   2> 2358471 INFO  
(TEST-TestLeaderInitiatedRecoveryThread.testPublishDownState-seed#[9DA66FD612ADD799])
 [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.TestLeaderInitiatedRecoveryThread_9DA66FD612ADD799-001/tempDir-001/control/data,
 hostContext=/rzm/w, hostPort=49303, 
coreRootDirectory=/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/../../../../../../../../../../export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.TestLeaderInitiatedRecoveryThread_9DA66FD612ADD799-001/control-001/cores}
   [junit4]   2> 2358471 ERROR 
(TEST-TestLeaderInitiatedRecoveryThread.testPublishDownState-seed#[9DA66FD612ADD799])
 [    ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging 
may be missing or incomplete.
   [junit4]   2> 2358471 INFO  
(TEST-TestLeaderInitiatedRecoveryThread.testPublishDownState-seed#[9DA66FD612ADD799])
 [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? 
version 7.0.0
   [junit4]   2> 2358472 INFO  
(TEST-TestLeaderInitiatedRecoveryThread.testPublishDownState-seed#[9DA66FD612ADD799])
 [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on 
port null
   [junit4]   2> 2358472 INFO  
(TEST-TestLeaderInitiatedRecoveryThread.testPublishDownState-seed#[9DA66FD612ADD799])
 [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 2358472 INFO  
(TEST-TestLeaderInitiatedRecoveryThread.testPublishDownState-seed#[9DA66FD612ADD799])
 [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2016-10-16T02:52:10.646Z
   [junit4]   2> 2358479 INFO  
(TEST-TestLeaderInitiatedRecoveryThread.testPublishDownState-seed#[9DA66FD612ADD799])
 [    ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in 
ZooKeeper)
   [junit4]   2> 2358479 INFO  
(TEST-TestLeaderInitiatedRecoveryThread.testPublishDownState-seed#[9DA66FD612ADD799])
 [    ] o.a.s.c.SolrXmlConfig Loading container configuration from 
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.TestLeaderInitiatedRecoveryThread_9DA66FD612ADD799-001/control-001/solr.xml
   [junit4]   2> 2358490 INFO  
(TEST-TestLeaderInitiatedRecoveryThread.testPublishDownState-seed#[9DA66FD612ADD799])
 [    ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:61258/solr
   [junit4]   2> 2358569 INFO  
(TEST-TestLeaderInitiatedRecoveryThread.testPublishDownState-seed#[9DA66FD612ADD799])
 [n:127.0.0.1:49303_rzm%2Fw    ] o.a.s.c.OverseerElectionContext I am going to 
be the leader 127.0.0.1:49303_rzm%2Fw
   [junit4]   2> 2358571 INFO  
(TEST-TestLeaderInitiatedRecoveryThread.testPublishDownState-seed#[9DA66FD612ADD799])
 [n:127.0.0.1:49303_rzm%2Fw    ] o.a.s.c.Overseer Overseer 
(id=96769561741033476-127.0.0.1:49303_rzm%2Fw-n_0000000000) starting
   [junit4]   2> 2358589 INFO  
(TEST-TestLeaderInitiatedRecoveryThread.testPublishDownState-seed#[9DA66FD612ADD799])
 [n:127.0.0.1:49303_rzm%2Fw    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:49303_rzm%2Fw
   [junit4]   2> 2358599 INFO  
(OverseerStateUpdate-96769561741033476-127.0.0.1:49303_rzm%2Fw-n_0000000000) 
[n:127.0.0.1:49303_rzm%2Fw    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 2358651 INFO  
(TEST-TestLeaderInitiatedRecoveryThread.testPublishDownState-seed#[9DA66FD612ADD799])
 [n:127.0.0.1:49303_rzm%2Fw    ] o.a.s.c.CorePropertiesLocator Found 1 core 
definitions underneath 
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/../../../../../../../../../../export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.TestLeaderInitiatedRecoveryThread_9DA66FD612ADD799-001/control-001/cores
   [junit4]   2> 2358651 INFO  
(TEST-TestLeaderInitiatedRecoveryThread.testPublishDownState-seed#[9DA66FD612ADD799])
 [n:127.0.0.1:49303_rzm%2Fw    ] o.a.s.c.CorePropertiesLocator Cores are: 
[collection1]
   [junit4]   2> 2358666 INFO  
(OverseerStateUpdate-96769561741033476-127.0.0.1:49303_rzm%2Fw-n_0000000000) 
[n:127.0.0.1:49303_rzm%2Fw    ] o.a.s.c.o.ReplicaMutator Assigning new node to 
shard shard=shard1
   [junit4]   2> 2359714 WARN  
(coreLoadExecutor-9987-thread-1-processing-n:127.0.0.1:49303_rzm%2Fw) 
[n:127.0.0.1:49303_rzm%2Fw c:control_collection   x:collection1] o.a.s.c.Config 
Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> 
instead.
   [junit4]   2> 2359716 INFO  
(coreLoadExecutor-9987-thread-1-processing-n:127.0.0.1:49303_rzm%2Fw) 
[n:127.0.0.1:49303_rzm%2Fw c:control_collection   x:collection1] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 2359742 INFO  
(coreLoadExecutor-9987-thread-1-processing-n:127.0.0.1:49303_rzm%2Fw) 
[n:127.0.0.1:49303_rzm%2Fw c:control_collection   x:collection1] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 2359887 WARN  
(coreLoadExecutor-9987-thread-1-processing-n:127.0.0.1:49303_rzm%2Fw) 
[n:127.0.0.1:49303_rzm%2Fw c:control_collection   x:collection1] 
o.a.s.s.IndexSchema [collection1] default search field in schema is text. 
WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 2359894 INFO  
(coreLoadExecutor-9987-thread-1-processing-n:127.0.0.1:49303_rzm%2Fw) 
[n:127.0.0.1:49303_rzm%2Fw c:control_collection   x:collection1] 
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 2359989 INFO  
(coreLoadExecutor-9987-thread-1-processing-n:127.0.0.1:49303_rzm%2Fw) 
[n:127.0.0.1:49303_rzm%2Fw c:control_collection   x:collection1] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from 
collection control_collection
   [junit4]   2> 2359989 INFO  
(coreLoadExecutor-9987-thread-1-processing-n:127.0.0.1:49303_rzm%2Fw) 
[n:127.0.0.1:49303_rzm%2Fw c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.TestLeaderInitiatedRecoveryThread_9DA66FD612ADD799-001/control-001/cores/collection1],
 
dataDir=[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/../../../../../../../../../../export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.TestLeaderInitiatedRecoveryThread_9DA66FD612ADD799-001/control-001/cores/collection1/data/]
   [junit4]   2> 2359989 INFO  
(coreLoadExecutor-9987-thread-1-processing-n:127.0.0.1:49303_rzm%2Fw) 
[n:127.0.0.1:49303_rzm%2Fw c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr 
mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@7524baa3
   [junit4]   2> 2359990 INFO  
(coreLoadExecutor-9987-thread-1-processing-n:127.0.0.1:49303_rzm%2Fw) 
[n:127.0.0.1:49303_rzm%2Fw c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=34, maxMergeAtOnceExplicit=17, maxMergedSegmentMB=3.060546875, 
floorSegmentMB=0.4423828125, forceMergeDeletesPctAllowed=26.571765994373607, 
segmentsPerTier=32.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.6666144455787576
   [junit4]   2> 2359994 WARN  
(coreLoadExecutor-9987-thread-1-processing-n:127.0.0.1:49303_rzm%2Fw) 
[n:127.0.0.1:49303_rzm%2Fw c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler 
{type = requestHandler,name = /dump,class = DumpRequestHandler,args = 
{defaults={a=A,b=B}}}
   [junit4]   2> 2360003 INFO  
(coreLoadExecutor-9987-thread-1-processing-n:127.0.0.1:49303_rzm%2Fw) 
[n:127.0.0.1:49303_rzm%2Fw c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 2360004 INFO  
(coreLoadExecutor-9987-thread-1-processing-n:127.0.0.1:49303_rzm%2Fw) 
[n:127.0.0.1:49303_rzm%2Fw c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 2360018 INFO  
(coreLoadExecutor-9987-thread-1-processing-n:127.0.0.1:49303_rzm%2Fw) 
[n:127.0.0.1:49303_rzm%2Fw c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2360018 INFO  
(coreLoadExecutor-9987-thread-1-processing-n:127.0.0.1:49303_rzm%2Fw) 
[n:127.0.0.1:49303_rzm%2Fw c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2360019 INFO  
(coreLoadExecutor-9987-thread-1-processing-n:127.0.0.1:49303_rzm%2Fw) 
[n:127.0.0.1:49303_rzm%2Fw c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: 
minMergeSize=0, mergeFactor=10, maxMergeSize=2041638891, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.1]
   [junit4]   2> 2360019 INFO  
(coreLoadExecutor-9987-thread-1-processing-n:127.0.0.1:49303_rzm%2Fw) 
[n:127.0.0.1:49303_rzm%2Fw c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@1e87dcfc[collection1] main]
   [junit4]   2> 2360029 INFO  
(coreLoadExecutor-9987-thread-1-processing-n:127.0.0.1:49303_rzm%2Fw) 
[n:127.0.0.1:49303_rzm%2Fw c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO 
with znodeBase: /configs/conf1
   [junit4]   2> 2360030 INFO  
(coreLoadExecutor-9987-thread-1-processing-n:127.0.0.1:49303_rzm%2Fw) 
[n:127.0.0.1:49303_rzm%2Fw c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.r.ManagedResourceStorage Loaded null at path 
_rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 2360030 INFO  
(coreLoadExecutor-9987-thread-1-processing-n:127.0.0.1:49303_rzm%2Fw) 
[n:127.0.0.1:49303_rzm%2Fw c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 2360031 INFO  
(coreLoadExecutor-9987-thread-1-processing-n:127.0.0.1:49303_rzm%2Fw) 
[n:127.0.0.1:49303_rzm%2Fw c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1548312989878190080
   [junit4]   2> 2360034 INFO  
(searcherExecutor-9988-thread-1-processing-n:127.0.0.1:49303_rzm%2Fw 
x:collection1 s:shard1 c:control_collection r:core_node1) 
[n:127.0.0.1:49303_rzm%2Fw c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@1e87dcfc[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2360056 INFO  
(coreZkRegister-9980-thread-1-processing-n:127.0.0.1:49303_rzm%2Fw 
x:collection1 s:shard1 c:control_collection r:core_node1) 
[n:127.0.0.1:49303_rzm%2Fw c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to 
continue.
   [junit4]   2> 2360056 INFO  
(coreZkRegister-9980-thread-1-processing-n:127.0.0.1:49303_rzm%2Fw 
x:collection1 s:shard1 c:control_collection r:core_node1) 
[n:127.0.0.1:49303_rzm%2Fw c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try 
and sync
   [junit4]   2> 2360056 INFO  
(coreZkRegister-9980-thread-1-processing-n:127.0.0.1:49303_rzm%2Fw 
x:collection1 s:shard1 c:control_collection r:core_node1) 
[n:127.0.0.1:49303_rzm%2Fw c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.SyncStrategy Sync replicas to 
http://127.0.0.1:49303/rzm/w/collection1/
   [junit4]   2> 2360056 INFO  
(coreZkRegister-9980-thread-1-processing-n:127.0.0.1:49303_rzm%2Fw 
x:collection1 s:shard1 c:control_collection r:core_node1) 
[n:127.0.0.1:49303_rzm%2Fw c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
   [junit4]   2> 2360056 INFO  
(coreZkRegister-9980-thread-1-processing-n:127.0.0.1:49303_rzm%2Fw 
x:collection1 s:shard1 c:control_collection r:core_node1) 
[n:127.0.0.1:49303_rzm%2Fw c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.SyncStrategy http://127.0.0.1:49303/rzm/w/collection1/ 
has no replicas
   [junit4]   2> 2360066 INFO  
(coreZkRegister-9980-thread-1-processing-n:127.0.0.1:49303_rzm%2Fw 
x:collection1 s:shard1 c:control_collection r:core_node1) 
[n:127.0.0.1:49303_rzm%2Fw c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:49303/rzm/w/collection1/ shard1
   [junit4]   2> 2360183 INFO  
(TEST-TestLeaderInitiatedRecoveryThread.testPublishDownState-seed#[9DA66FD612ADD799])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 2360204 INFO  
(TEST-TestLeaderInitiatedRecoveryThread.testPublishDownState-seed#[9DA66FD612ADD799])
 [    ] o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause 
connection loss:false
   [junit4]   2> 2360204 INFO  
(TEST-TestLeaderInitiatedRecoveryThread.testPublishDownState-seed#[9DA66FD612ADD799])
 [    ] o.a.s.c.AbstractFullDistribZkTestBase Creating collection1 with 
stateFormat=2
   [junit4]   2> 2360227 INFO  
(coreZkRegister-9980-thread-1-processing-n:127.0.0.1:49303_rzm%2Fw 
x:collection1 s:shard1 c:control_collection r:core_node1) 
[n:127.0.0.1:49303_rzm%2Fw c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.ZkController I am the leader, no recovery necessary
   [junit4]   2> 2360732 INFO  
(TEST-TestLeaderInitiatedRecoveryThread.testPublishDownState-seed#[9DA66FD612ADD799])
 [    ] o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.TestLeaderInitiatedRecoveryThread_9DA66FD612ADD799-001/shard-1-001/cores/collection1
   [junit4]   2> 2360733 INFO  
(TEST-TestLeaderInitiatedRecoveryThread.testPublishDownState-seed#[9DA66FD612ADD799])
 [    ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory 
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.TestLeaderInitiatedRecoveryThread_9DA66FD612ADD799-001/shard-1-001
   [junit4]   2> 2360734 INFO  
(TEST-TestLeaderInitiatedRecoveryThread.testPublishDownState-seed#[9DA66FD612ADD799])
 [    ] o.e.j.s.Server jetty-9.3.8.v20160314
   [junit4]   2> 2360736 INFO  
(TEST-TestLeaderInitiatedRecoveryThread.testPublishDownState-seed#[9DA66FD612ADD799])
 [    ] o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@5bd0cf32{/rzm/w,null,AVAILABLE}
   [junit4]   2> 2360737 INFO  
(TEST-TestLeaderInitiatedRecoveryThread.testPublishDownState-seed#[9DA66FD612ADD799])
 [    ] o.e.j.s.ServerConnector Started 
ServerConnector@7e6be6fc{HTTP/1.1,[http/1.1]}{127.0.0.1:37299}
   [junit4]   2> 2360737 INFO  
(TEST-TestLeaderInitiatedRecoveryThread.testPublishDownState-seed#[9DA66FD612ADD799])
 [    ] o.e.j.s.Server Started @2364873ms
   [junit4]   2> 2360738 INFO  
(TEST-TestLeaderInitiatedRecoveryThread.testPublishDownState-seed#[9DA66FD612ADD799])
 [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.TestLeaderInitiatedRecoveryThread_9DA66FD612ADD799-001/tempDir-001/jetty1,
 solrconfig=solrconfig.xml, hostContext=/rzm/w, hostPort=37299, 
coreRootDirectory=/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.TestLeaderInitiatedRecoveryThread_9DA66FD612ADD799-001/shard-1-001/cores}
   [junit4]   2> 2360738 ERROR 
(TEST-TestLeaderInitiatedRecoveryThread.testPublishDownState-seed#[9DA66FD612ADD799])
 [    ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging 
may be missing or incomplete.
   [junit4]   2> 2360738 INFO  
(TEST-TestLeaderInitiatedRecoveryThread.testPublishDownState-seed#[9DA66FD612ADD799])
 [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? 
version 7.0.0
   [junit4]   2> 2360738 INFO  
(TEST-TestLeaderInitiatedRecoveryThread.testPublishDownState-seed#[9DA66FD612ADD799])
 [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on 
port null
   [junit4]   2> 2360738 INFO  
(TEST-TestLeaderInitiatedRecoveryThread.testPublishDownState-seed#[9DA66FD612ADD799])
 [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 2360738 INFO  
(TEST-TestLeaderInitiatedRecoveryThread.testPublishDownState-seed#[9DA66FD612ADD799])
 [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2016-10-16T02:52:12.912Z
   [junit4]   2> 2360757 INFO  
(TEST-TestLeaderInitiatedRecoveryThread.testPublishDownState-seed#[9DA66FD612ADD799])
 [    ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in 
ZooKeeper)
   [junit4]   2> 2360757 INFO  
(TEST-TestLeaderInitiatedRecoveryThread.testPublishDownState-seed#[9DA66FD612ADD799])
 [    ] o.a.s.c.SolrXmlConfig Loading container configuration from 
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.TestLeaderInitiatedRecoveryThread_9DA66FD612ADD799-001/shard-1-001/solr.xml
   [junit4]   2> 2360776 INFO  
(TEST-TestLeaderInitiatedRecoveryThread.testPublishDownState-seed#[9DA66FD612ADD799])
 [    ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:61258/solr
   [junit4]   2> 2360803 INFO  
(TEST-TestLeaderInitiatedRecoveryThread.testPublishDownState-seed#[9DA66FD612ADD799])
 [n:127.0.0.1:37299_rzm%2Fw    ] o.a.s.c.c.ZkStateReader Updated live nodes 
from ZooKeeper... (0) -> (1)
   [junit4]   2> 2360813 INFO  
(TEST-TestLeaderInitiatedRecoveryThread.testPublishDownState-seed#[9DA66FD612ADD799])
 [n:127.0.0.1:37299_rzm%2Fw    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:37299_rzm%2Fw
   [junit4]   2> 2360821 INFO  
(zkCallback-3673-thread-4-processing-n:127.0.0.1:49303_rzm%2Fw) 
[n:127.0.0.1:49303_rzm%2Fw    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (2)
   [junit4]   2> 2360821 INFO  (zkCallback-3677-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 2360822 INFO  
(zkCallback-3683-thread-2-processing-n:127.0.0.1:37299_rzm%2Fw) 
[n:127.0.0.1:37299_rzm%2Fw    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (2)
   [junit4]   2> 2360858 INFO  
(TEST-TestLeaderInitiatedRecoveryThread.testPublishDownState-seed#[9DA66FD612ADD799])
 [n:127.0.0.1:37299_rzm%2Fw    ] o.a.s.c.CorePropertiesLocator Found 1 core 
definitions underneath 
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/

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

1:37299_rzm%2Fw-n_0000000001) am no longer a leader.
   [junit4]   2> 2374497 WARN  
(zkCallback-3683-thread-1-processing-n:127.0.0.1:37299_rzm%2Fw) 
[n:127.0.0.1:37299_rzm%2Fw    ] o.a.s.c.c.ZkStateReader ZooKeeper watch 
triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for 
/live_nodes]
   [junit4]   2> 2374519 INFO  
(TEST-TestLeaderInitiatedRecoveryThread.testPublishDownState-seed#[9DA66FD612ADD799])
 [    ] o.e.j.s.ServerConnector Stopped 
ServerConnector@7e6be6fc{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 2374521 INFO  
(TEST-TestLeaderInitiatedRecoveryThread.testPublishDownState-seed#[9DA66FD612ADD799])
 [    ] o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@5bd0cf32{/rzm/w,null,UNAVAILABLE}
   [junit4]   2> 2374525 INFO  
(TEST-TestLeaderInitiatedRecoveryThread.testPublishDownState-seed#[9DA66FD612ADD799])
 [    ] o.a.s.c.ChaosMonkey monkey: stop shard! 54685
   [junit4]   2> 2374533 INFO  
(TEST-TestLeaderInitiatedRecoveryThread.testPublishDownState-seed#[9DA66FD612ADD799])
 [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:61258 61258
   [junit4]   2> 2374551 INFO  (Thread-6969) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:61258 61258
   [junit4]   2> 2374566 WARN  (Thread-6969) [    ] o.a.s.c.ZkTestServer Watch 
limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2>        4       /solr/aliases.json
   [junit4]   2>        4       /solr/clusterprops.json
   [junit4]   2>        3       /solr/security.json
   [junit4]   2>        3       /solr/configs/conf1
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2>        4       /solr/clusterstate.json
   [junit4]   2>        2       /solr/collections/collection1/state.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2>        21      /solr/overseer/queue
   [junit4]   2>        15      /solr/overseer/collection-queue-work
   [junit4]   2>        6       /solr/overseer/queue-work
   [junit4]   2>        4       /solr/live_nodes
   [junit4]   2>        4       /solr/collections
   [junit4]   2> 
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=TestLeaderInitiatedRecoveryThread 
-Dtests.method=testPublishDownState -Dtests.seed=9DA66FD612ADD799 
-Dtests.slow=true -Dtests.locale=ms-MY -Dtests.timezone=America/Monterrey 
-Dtests.asserts=true -Dtests.file.encoding=US-ASCII
   [junit4] FAILURE 16.5s J1 | 
TestLeaderInitiatedRecoveryThread.testPublishDownState <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: expected:<29> but 
was:<30>
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([9DA66FD612ADD799:C3DBCD28B6B09E64]:0)
   [junit4]    >        at 
org.apache.solr.cloud.TestLeaderInitiatedRecoveryThread.testPublishDownState(TestLeaderInitiatedRecoveryThread.java:118)
   [junit4]    >        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:985)
   [junit4]    >        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:960)
   [junit4]    >        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 2374568 INFO  
(SUITE-TestLeaderInitiatedRecoveryThread-seed#[9DA66FD612ADD799]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.TestLeaderInitiatedRecoveryThread_9DA66FD612ADD799-001
   [junit4]   2> Oct 16, 2016 2:52:26 AM 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 1 leaked 
thread(s).
   [junit4]   2> NOTE: test params are: codec=CheapBastard, 
sim=ClassicSimilarity, locale=ms-MY, timezone=America/Monterrey
   [junit4]   2> NOTE: SunOS 5.11 amd64/Oracle Corporation 1.8.0_102 
(64-bit)/cpus=3,threads=1,free=279559568,total=536870912
   [junit4]   2> NOTE: All tests run in this JVM: [TestSortByMinMaxFunction, 
SolrIndexSplitterTest, DateMathParserTest, TermVectorComponentTest, 
CircularListTest, TestStressCloudBlindAtomicUpdates, RuleEngineTest, 
HLLSerializationTest, TestRecoveryHdfs, TestQuerySenderListener, 
TestSolrIndexConfig, TestOmitPositions, SortByFunctionTest, 
RemoteQueryErrorTest, CdcrReplicationHandlerTest, 
FieldMutatingUpdateProcessorTest, TestPKIAuthenticationPlugin, 
PreAnalyzedFieldTest, UUIDFieldTest, TestSolrCoreSnapshots, HdfsNNFailoverTest, 
SuggestComponentContextFilterQueryTest, CSVRequestHandlerTest, 
TestDefaultStatsCache, TestComponentsName, 
HdfsTlogReplayBufferedWhileIndexingTest, TermVectorComponentDistributedTest, 
SolrCmdDistributorTest, TestUniqueKeyFieldResource, CdcrVersionReplicationTest, 
TestDynamicLoading, CoreAdminHandlerTest, TestDefaultSearchFieldResource, 
TestReversedWildcardFilterFactory, CloneFieldUpdateProcessorFactoryTest, 
TestCloudInspectUtil, TestConfigSetImmutable, TestRealTimeGet, 
TestMacroExpander, DeleteNodeTest, TestLRUStatsCache, TestNumericTerms32, 
TestSolr4Spatial, DistributedExpandComponentTest, BlockJoinFacetSimpleTest, 
TestSubQueryTransformerCrossCore, TestClusterStateMutator, 
TestSolrDynamicMBean, TestPivotHelperCode, CollectionReloadTest, 
SortSpecParsingTest, TestSimpleTrackingShardHandler, ResourceLoaderTest, 
PreAnalyzedUpdateProcessorTest, TestFieldResource, MinimalSchemaTest, 
ConfigSetsAPITest, CollectionTooManyReplicasTest, 
TestPHPSerializedResponseWriter, TestAtomicUpdateErrorCases, TestConfigSets, 
SimpleCollectionCreateDeleteTest, TestManagedSchemaAPI, TestSQLHandler, 
TestRawResponseWriter, HdfsBasicDistributedZkTest, DistribCursorPagingTest, 
URLClassifyProcessorTest, TestExceedMaxTermLength, SpellingQueryConverterTest, 
ConjunctionSolrSpellCheckerTest, TestFieldCacheWithThreads, 
TestValueSourceCache, SpellPossibilityIteratorTest, 
CoreMergeIndexesAdminHandlerTest, TestSystemIdResolver, TestQueryWrapperFilter, 
TestEmbeddedSolrServerConstructors, TestFieldCacheSortRandom, 
TestShardHandlerFactory, NotRequiredUniqueKeyTest, ChaosMonkeySafeLeaderTest, 
TestBinaryResponseWriter, JSONWriterTest, RequestHandlersTest, 
RegexBoostProcessorTest, SaslZkACLProviderTest, BufferStoreTest, 
AliasIntegrationTest, TestSolrDeletionPolicy2, TestWriterPerf, 
CoreAdminCreateDiscoverTest, TestCollationFieldDocValues, ExplicitHLLTest, 
CollectionsAPIDistributedZkTest, TestMaxScoreQueryParser, 
TestSlowCompositeReaderWrapper, TestRecovery, TestRebalanceLeaders, 
DistribJoinFromCollectionTest, TestFastWriter, TestRangeQuery, 
DirectUpdateHandlerOptimizeTest, FacetPivotSmallTest, DateRangeFieldTest, 
NoCacheHeaderTest, HdfsDirectoryFactoryTest, OpenCloseCoreStressTest, 
TestQueryTypes, TestSchemaManager, TestReload, 
TestSolrQueryParserDefaultOperatorResource, AutoCommitTest, TestTestInjection, 
ClusterStateTest, TestAuthenticationFramework, TestDFRSimilarityFactory, 
CurrencyFieldOpenExchangeTest, HdfsChaosMonkeySafeLeaderTest, SparseHLLTest, 
StatsReloadRaceTest, TestSolrConfigHandlerCloud, TestDistribDocBasedVersion, 
BlockJoinFacetDistribTest, OverriddenZkACLAndCredentialsProvidersTest, 
TestStressUserVersions, TestTolerantUpdateProcessorCloud, TestBadConfig, 
TestSuggestSpellingConverter, BasicZkTest, BlobRepositoryCloudTest, 
TestMiniSolrCloudClusterSSL, DistributedTermsComponentTest, 
OverseerModifyCollectionTest, TestConfig, TestMiniSolrCloudCluster, 
TestManagedSynonymFilterFactory, TestXmlQParser, 
TestExclusionRuleCollectionAccess, UpdateParamsTest, BasicDistributedZk2Test, 
TestFieldCache, TestFoldingMultitermQuery, AsyncCallRequestStatusResponseTest, 
OverseerStatusTest, TestNRTOpen, TestSha256AuthenticationProvider, 
TestSizeLimitedDistributedMap, DeleteShardTest, TestIndexingPerformance, 
DefaultValueUpdateProcessorTest, TestPerFieldSimilarityWithDefaultOverride, 
BasicDistributedZkTest, UnloadDistributedZkTest, SyncSliceTest, RecoveryZkTest, 
TestReplicationHandler, TestRandomDVFaceting, ShardRoutingCustomTest, 
TestDistributedGrouping, TestHashPartitioner, ZkControllerTest, 
TestStressReorder, TestJoin, TestCoreContainer, SimpleFacetsTest, 
SpellCheckComponentTest, TestGroupingSearch, BadIndexSchemaTest, 
ConvertedLegacyTest, TestFiltering, TestFunctionQuery, BasicFunctionalityTest, 
DirectUpdateHandlerTest, TestIndexSearcher, TestCoreDiscovery, 
TestExtendedDismaxParser, SolrRequestParserTest, DocValuesTest, TestQueryUtils, 
FileBasedSpellCheckerTest, DocumentBuilderTest, FastVectorHighlighterTest, 
LoggingHandlerTest, ReturnFieldsTest, TestCSVResponseWriter, QueryParsingTest, 
UniqFieldsUpdateProcessorFactoryTest, JsonLoaderTest, HighlighterConfigTest, 
ResponseLogComponentTest, SolrIndexConfigTest, BadComponentTest, 
TestStressRecovery, TestMergePolicyConfig, TestDocSet, TestBinaryField, 
TestSearchPerf, NumericFieldsTest, OutputWriterTest, 
TestFuzzyAnalyzedSuggestions, ExternalFileFieldSortTest, 
TestSolrCoreProperties, TestLuceneMatchVersion, TestPhraseSuggestions, 
TestCodecSupport, EchoParamsTest, TestLMDirichletSimilarityFactory, 
TestLMJelinekMercerSimilarityFactory, TestIBSimilarityFactory, 
TestBM25SimilarityFactory, TestJmxMonitoredMap, TimeZoneUtilsTest, 
TestFastOutputStream, ScriptEngineTest, OpenExchangeRatesOrgProviderTest, 
TestFastLRUCache, DateFieldTest, DOMUtilTest, RAMDirectoryFactoryTest, 
TestLRUCache, TestUtils, TestDocumentBuilder, ZkNodePropsTest, SliceStateTest, 
SystemInfoHandlerTest, CursorPagingTest, TestCrossCoreJoin, 
TestCursorMarkWithoutUniqueKey, TestDistributedMissingSort, AssignTest, 
BaseCdcrDistributedZkTest, CdcrBootstrapTest, CollectionsAPISolrJTest, 
DeleteInactiveReplicaTest, DeleteLastCustomShardedReplicaTest, 
DeleteReplicaTest, HttpPartitionTest, ReplicationFactorTest, 
RestartWhileUpdatingTest, RollingRestartTest, SolrXmlInZkTest, 
TestCloudDeleteByQuery, TestCloudPseudoReturnFields, TestConfigSetsAPI, 
TestConfigSetsAPIZkFailure, TestHdfsCloudBackupRestore, 
TestLeaderInitiatedRecoveryThread]
   [junit4] Completed [484/638 (2!)] on J1 in 16.80s, 1 test, 1 failure <<< 
FAILURES!

[...truncated 60835 lines...]

---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org

Reply via email to