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

2 tests failed.
FAILED:  
org.apache.solr.cloud.TestSolrCloudWithDelegationTokens.testDelegationTokenCancelFail

Error Message:
expected:<200> but was:<404>

Stack Trace:
java.lang.AssertionError: expected:<200> but was:<404>
        at 
__randomizedtesting.SeedInfo.seed([DEFA52CDF876677E:B64567E728EC7592]: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.TestSolrCloudWithDelegationTokens.cancelDelegationToken(TestSolrCloudWithDelegationTokens.java:137)
        at 
org.apache.solr.cloud.TestSolrCloudWithDelegationTokens.testDelegationTokenCancelFail(TestSolrCloudWithDelegationTokens.java:282)
        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)


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

Error Message:
Exception during query

Stack Trace:
java.lang.RuntimeException: Exception during query
        at 
__randomizedtesting.SeedInfo.seed([DEFA52CDF876677E:440E2F2F66ECFB42]:0)
        at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:813)
        at 
org.apache.solr.update.AutoCommitTest.testMaxTime(AutoCommitTest.java:270)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java: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 11508 lines...]
   [junit4] Suite: org.apache.solr.update.AutoCommitTest
   [junit4]   2> Creating dataDir: 
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.update.AutoCommitTest_DEFA52CDF876677E-001/init-core-data-001
   [junit4]   2> 1769083 INFO  
(SUITE-AutoCommitTest-seed#[DEFA52CDF876677E]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via: 
@org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
   [junit4]   2> 1769084 INFO  
(SUITE-AutoCommitTest-seed#[DEFA52CDF876677E]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 1769085 INFO  
(SUITE-AutoCommitTest-seed#[DEFA52CDF876677E]-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> 1769165 WARN  
(SUITE-AutoCommitTest-seed#[DEFA52CDF876677E]-worker) [    ] o.a.s.c.Config 
Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> 
instead.
   [junit4]   2> 1769167 INFO  
(SUITE-AutoCommitTest-seed#[DEFA52CDF876677E]-worker) [    ] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1769201 INFO  
(SUITE-AutoCommitTest-seed#[DEFA52CDF876677E]-worker) [    ] 
o.a.s.s.IndexSchema [null] Schema name=test
   [junit4]   2> 1769305 WARN  
(SUITE-AutoCommitTest-seed#[DEFA52CDF876677E]-worker) [    ] 
o.a.s.s.IndexSchema [null] default search field in schema is text. WARNING: 
Deprecated, please use 'df' on request instead.
   [junit4]   2> 1769308 INFO  
(SUITE-AutoCommitTest-seed#[DEFA52CDF876677E]-worker) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1769350 INFO  (coreLoadExecutor-7755-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> 1769393 WARN  (coreLoadExecutor-7755-thread-1) [    ] 
o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use 
<mergePolicyFactory> instead.
   [junit4]   2> 1769395 INFO  (coreLoadExecutor-7755-thread-1) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1769432 INFO  (coreLoadExecutor-7755-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1769573 WARN  (coreLoadExecutor-7755-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> 1769576 INFO  (coreLoadExecutor-7755-thread-1) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1769600 INFO  (coreLoadExecutor-7755-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> 1769600 INFO  (coreLoadExecutor-7755-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1],
 
dataDir=[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.update.AutoCommitTest_DEFA52CDF876677E-001/init-core-data-001/]
   [junit4]   2> 1769600 INFO  (coreLoadExecutor-7755-thread-1) [    
x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr 
mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@4d024f13
   [junit4]   2> 1769602 INFO  (coreLoadExecutor-7755-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=17, maxMergeAtOnceExplicit=25, maxMergedSegmentMB=98.0751953125, 
floorSegmentMB=0.4404296875, forceMergeDeletesPctAllowed=21.258642316234642, 
segmentsPerTier=48.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 1769645 INFO  (coreLoadExecutor-7755-thread-1) [    
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1769646 INFO  (coreLoadExecutor-7755-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 1769647 INFO  (coreLoadExecutor-7755-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1769647 INFO  (coreLoadExecutor-7755-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1769647 INFO  (coreLoadExecutor-7755-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=33, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.7539501182255992]
   [junit4]   2> 1769648 INFO  (coreLoadExecutor-7755-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@53581a15[collection1] main]
   [junit4]   2> 1769648 INFO  (coreLoadExecutor-7755-thread-1) [    
x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1769686 INFO  (coreLoadExecutor-7755-thread-1) [    
x:collection1] o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 1769730 INFO  (coreLoadExecutor-7755-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1769731 INFO  
(searcherExecutor-7756-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1769737 INFO  
(searcherExecutor-7756-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1769737 INFO  
(searcherExecutor-7756-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1769737 INFO  
(searcherExecutor-7756-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 1769738 INFO  (coreLoadExecutor-7755-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1546828609779400704
   [junit4]   2> 1769740 INFO  
(searcherExecutor-7756-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1769742 INFO  
(searcherExecutor-7756-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1769743 INFO  
(searcherExecutor-7756-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1769744 INFO  
(searcherExecutor-7756-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 1769744 INFO  
(searcherExecutor-7756-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 1769746 INFO  
(SUITE-AutoCommitTest-seed#[DEFA52CDF876677E]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 1769749 INFO  
(searcherExecutor-7756-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@53581a15[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1769833 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[DEFA52CDF876677E]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testCommitWithin
   [junit4]   2> 1769842 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[DEFA52CDF876677E]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{deleteByQuery=*:* (-1546828609879015424)} 0 8
   [junit4]   2> 1769850 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[DEFA52CDF876677E]) [    ] 
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> 1769908 WARN  
(TEST-AutoCommitTest.testCommitWithin-seed#[DEFA52CDF876677E]) [    ] 
o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use 
<mergePolicyFactory> instead.
   [junit4]   2> 1769910 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[DEFA52CDF876677E]) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1769941 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[DEFA52CDF876677E]) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1770091 WARN  
(TEST-AutoCommitTest.testCommitWithin-seed#[DEFA52CDF876677E]) [    ] 
o.a.s.s.IndexSchema [collection1] default search field in schema is text. 
WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 1770095 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[DEFA52CDF876677E]) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1770107 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[DEFA52CDF876677E]) [    ] 
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> 1770108 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[DEFA52CDF876677E]) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1],
 
dataDir=[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.update.AutoCommitTest_DEFA52CDF876677E-001/init-core-data-001/]
   [junit4]   2> 1770108 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[DEFA52CDF876677E]) [    
x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr 
mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@4d024f13
   [junit4]   2> 1770136 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[DEFA52CDF876677E]) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1770136 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[DEFA52CDF876677E]) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1770137 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[DEFA52CDF876677E]) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@464c786d[collection1] main]
   [junit4]   2> 1770137 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[DEFA52CDF876677E]) [    
x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1770138 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[DEFA52CDF876677E]) [    
x:collection1] o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 1770146 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[DEFA52CDF876677E]) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1770146 INFO  
(searcherExecutor-7761-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1770147 INFO  
(searcherExecutor-7761-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1770147 INFO  
(searcherExecutor-7761-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1770147 INFO  
(searcherExecutor-7761-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 1770148 INFO  
(searcherExecutor-7761-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1770148 INFO  
(searcherExecutor-7761-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1770149 INFO  
(searcherExecutor-7761-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1770150 INFO  
(searcherExecutor-7761-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 1770150 INFO  
(searcherExecutor-7761-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 1770151 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[DEFA52CDF876677E]) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=24, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.0]
   [junit4]   2> 1770152 INFO  
(searcherExecutor-7761-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@464c786d[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1770152 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[DEFA52CDF876677E]) [    
x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 1770152 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[DEFA52CDF876677E]) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@16cac2bf[collection1] main]
   [junit4]   2> 1770152 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[DEFA52CDF876677E]) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@6406ad95
   [junit4]   2> 1770153 INFO  
(searcherExecutor-7761-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@16cac2bf[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1770165 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[DEFA52CDF876677E]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[529 
(1546828610226094080)]} 0 1
   [junit4]   2> 1770166 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[DEFA52CDF876677E]) [    
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> 1774167 INFO  (commitScheduler-7764-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> 1774170 INFO  (commitScheduler-7764-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@1d6d8ba3[collection1] main]
   [junit4]   2> 1774170 INFO  (commitScheduler-7764-thread-1) [    
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1774173 INFO  
(searcherExecutor-7761-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@1d6d8ba3[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):c1)))}
   [junit4]   2> 1774187 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[DEFA52CDF876677E]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[530 
(1546828614443466752)]} 0 4024
   [junit4]   2> 1774188 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[DEFA52CDF876677E]) [    
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> 1774188 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[DEFA52CDF876677E]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[529 
(-1546828614445563904)]} 0 4025
   [junit4]   2> 1774189 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[DEFA52CDF876677E]) [    
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> 1776189 INFO  (commitScheduler-7764-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> 1776191 INFO  (commitScheduler-7764-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@56d0dc34[collection1] main]
   [junit4]   2> 1776192 INFO  (commitScheduler-7764-thread-1) [    
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1776193 INFO  
(searcherExecutor-7761-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@56d0dc34[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(7.0.0):c1)))}
   [junit4]   2> 1776194 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[DEFA52CDF876677E]) [    
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> 1776195 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[DEFA52CDF876677E]) [    
x:collection1] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:530&qt=standard&start=0&rows=20&version=2.2} hits=1 status=0 
QTime=0
   [junit4]   2> 1776196 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[DEFA52CDF876677E]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1546828616551104512)]} 0 6033
   [junit4]   2> 1776197 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[DEFA52CDF876677E]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1546828616552153088)]} 0 6034
   [junit4]   2> 1776197 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[DEFA52CDF876677E]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1546828616552153089)]} 0 6034
   [junit4]   2> 1776197 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[DEFA52CDF876677E]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1546828616552153090)]} 0 6034
   [junit4]   2> 1776197 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[DEFA52CDF876677E]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1546828616552153091)]} 0 6034
   [junit4]   2> 1776197 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[DEFA52CDF876677E]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1546828616552153092)]} 0 6034
   [junit4]   2> 1776198 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[DEFA52CDF876677E]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1546828616553201664)]} 0 6034
   [junit4]   2> 1776198 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[DEFA52CDF876677E]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1546828616553201665)]} 0 6035
   [junit4]   2> 1776198 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[DEFA52CDF876677E]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1546828616553201666)]} 0 6035
   [junit4]   2> 1776198 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[DEFA52CDF876677E]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1546828616553201667)]} 0 6035
   [junit4]   2> 1776198 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[DEFA52CDF876677E]) [    
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> 1776199 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[DEFA52CDF876677E]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1546828616553201668)]} 0 6035
   [junit4]   2> 1776199 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[DEFA52CDF876677E]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1546828616554250240)]} 0 6036
   [junit4]   2> 1776199 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[DEFA52CDF876677E]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1546828616554250241)]} 0 6036
   [junit4]   2> 1776199 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[DEFA52CDF876677E]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1546828616554250242)]} 0 6036
   [junit4]   2> 1776199 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[DEFA52CDF876677E]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1546828616554250243)]} 0 6036
   [junit4]   2> 1776199 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[DEFA52CDF876677E]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1546828616554250244)]} 0 6036
   [junit4]   2> 1776199 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[DEFA52CDF876677E]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1546828616554250245)]} 0 6036
   [junit4]   2> 1776199 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[DEFA52CDF876677E]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1546828616554250246)]} 0 6036
   [junit4]   2> 1776200 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[DEFA52CDF876677E]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1546828616554250247)]} 0 6036
   [junit4]   2> 1776200 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[DEFA52CDF876677E]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1546828616555298816)]} 0 6036
   [junit4]   2> 1776200 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[DEFA52CDF876677E]) [    
x:collection1] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:530&qt=standard&start=0&rows=20&version=2.2} hits=1 status=0 
QTime=0
   [junit4]   2> 1777199 INFO  (commitScheduler-7764-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> 1777206 INFO  (commitScheduler-7764-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@4644f043[collection1] main]
   [junit4]   2> 1777207 INFO  (commitScheduler-7764-thread-1) [    
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1777210 INFO  
(searcherExecutor-7761-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@4644f043[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(7.0.0):c10/9:delGen=1)))}
   [junit4]   2> 1777456 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[DEFA52CDF876677E]) [    
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> 1777457 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[DEFA52CDF876677E]) [    
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> 1777457 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[DEFA52CDF876677E]) [    
x:collection1] o.a.s.SolrTestCaseJ4 ###Ending testCommitWithin
   [junit4]   2> 1777462 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[DEFA52CDF876677E]) [    x:collection1] 
o.a.s.SolrTestCaseJ4 ###Starting testMaxTime
   [junit4]   2> 1777464 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[DEFA52CDF876677E]) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@42e86df8[collection1] realtime]
   [junit4]   2> 1777464 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[DEFA52CDF876677E]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{deleteByQuery=*:* (-1546828617878601728)} 0 2
   [junit4]   2> 1777465 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[DEFA52CDF876677E]) [    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> 1777513 WARN  
(TEST-AutoCommitTest.testMaxTime-seed#[DEFA52CDF876677E]) [    x:collection1] 
o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use 
<mergePolicyFactory> instead.
   [junit4]   2> 1777514 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[DEFA52CDF876677E]) [    x:collection1] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1777541 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[DEFA52CDF876677E]) [    x:collection1] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1777638 WARN  
(TEST-AutoCommitTest.testMaxTime-seed#[DEFA52CDF876677E]) [    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> 1777641 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[DEFA52CDF876677E]) [    x:collection1] 
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1777657 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[DEFA52CDF876677E]) [    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> 1777658 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[DEFA52CDF876677E]) [    x:collection1] 
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1],
 
dataDir=[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.update.AutoCommitTest_DEFA52CDF876677E-001/init-core-data-001/]
   [junit4]   2> 1777658 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[DEFA52CDF876677E]) [    x:collection1] 
o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX 
Server: com.sun.jmx.mbeanserver.JmxMBeanServer@4d024f13
   [junit4]   2> 1777682 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[DEFA52CDF876677E]) [    x:collection1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1777682 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[DEFA52CDF876677E]) [    x:collection1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1777683 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[DEFA52CDF876677E]) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@1e6edce8[collection1] main]
   [junit4]   2> 1777683 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[DEFA52CDF876677E]) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1777685 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[DEFA52CDF876677E]) [    x:collection1] 
o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 1777689 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[DEFA52CDF876677E]) [    x:collection1] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1777690 INFO  
(searcherExecutor-7765-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1777691 INFO  
(searcherExecutor-7765-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1777691 INFO  
(searcherExecutor-7765-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1777691 INFO  
(searcherExecutor-7765-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 1777691 INFO  
(searcherExecutor-7765-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1777692 INFO  
(searcherExecutor-7765-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1777693 INFO  
(searcherExecutor-7765-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1777694 INFO  
(searcherExecutor-7765-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 1777694 INFO  
(searcherExecutor-7765-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 1777695 INFO  
(searcherExecutor-7765-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@1e6edce8[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1777696 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[DEFA52CDF876677E]) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=6, maxMergeAtOnceExplicit=5, maxMergedSegmentMB=1.599609375, 
floorSegmentMB=2.1142578125, forceMergeDeletesPctAllowed=20.33086706123135, 
segmentsPerTier=27.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 1777696 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[DEFA52CDF876677E]) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 1777697 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[DEFA52CDF876677E]) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@225da0e9[collection1] main]
   [junit4]   2> 1777697 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[DEFA52CDF876677E]) [    x:collection1] 
o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@76929e2e
   [junit4]   2> 1777705 INFO  
(searcherExecutor-7765-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@225da0e9[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1777706 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[DEFA52CDF876677E]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[529 
(1546828618133405696)]} 0 1
   [junit4]   2> 1777706 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[DEFA52CDF876677E]) [    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> 1777707 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[DEFA52CDF876677E]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[530 
(1546828618135502848)]} 0 2
   [junit4]   2> 1777707 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[DEFA52CDF876677E]) [    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> 1777708 ERROR 
(TEST-AutoCommitTest.testMaxTime-seed#[DEFA52CDF876677E]) [    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> 1777709 ERROR 
(TEST-AutoCommitTest.testMaxTime-seed#[DEFA52CDF876677E]) [    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.testMaxTime(AutoCommitTest.java:270)
   [junit4]   2>        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native 
Method)
   [junit4]   2>        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
   [junit4]   2>        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   [junit4]   2>        at java.lang.reflect.Method.invoke(Method.java:498)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java: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> 1777709 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[DEFA52CDF876677E]) [    x:collection1] 
o.a.s.SolrTestCaseJ4 ###Ending testMaxTime
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=AutoCommitTest 
-Dtests.method=testMaxTime -Dtests.seed=DEFA52CDF876677E -Dtests.slow=true 
-Dtests.locale=en-ZA -Dtests.timezone=America/Fortaleza -Dtests.asserts=true 
-Dtests.file.encoding=ISO-8859-1
   [junit4] ERROR   0.25s J0 | AutoCommitTest.testMaxTime <<<
   [junit4]    > Throwable #1: java.lang.RuntimeException: Exception during 
query
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([DEFA52CDF876677E:440E2F2F66ECFB42]:0)
   [junit4]    >        at 
org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:813)
   [junit4]    >        at 
org.apache.solr.update.AutoCommitTest.testMaxTime(AutoCommitTest.java:270)
   [junit4]    >        at java.lang.Thread.run(Thread.java:745)
   [junit4]    > Caused by: java.lang.RuntimeException: REQUEST FAILED: 
xpath=//result[@numFound=1]
   [junit4]    >        xml response was: <?xml version="1.0" encoding="UTF-8"?>
   [junit4]    > <response>
   [junit4]    > <lst name="responseHeader"><int name="status">0</int><int 
name="QTime">0</int></lst><result name="response" numFound="0" 
start="0"></result>
   [junit4]    > </response>
   [junit4]    >        request 
was:q=id:529&qt=standard&start=0&rows=20&version=2.2
   [junit4]    >        at 
org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:806)
   [junit4]    >        ... 40 more
   [junit4]   2> 1777714 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[DEFA52CDF876677E]) [    x:collection1] 
o.a.s.SolrTestCaseJ4 ###Starting testMaxDocs
   [junit4]   2> 1777718 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[DEFA52CDF876677E]) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@772a41e4[collection1] realtime]
   [junit4]   2> 1777719 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[DEFA52CDF876677E]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{deleteByQuery=*:* (-1546828618142842880)} 0 4
   [junit4]   2> 1777720 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[DEFA52CDF876677E]) [    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> 1777754 WARN  
(TEST-AutoCommitTest.testMaxDocs-seed#[DEFA52CDF876677E]) [    x:collection1] 
o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use 
<mergePolicyFactory> instead.
   [junit4]   2> 1777755 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[DEFA52CDF876677E]) [    x:collection1] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1777775 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[DEFA52CDF876677E]) [    x:collection1] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1777869 WARN  
(TEST-AutoCommitTest.testMaxDocs-seed#[DEFA52CDF876677E]) [    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> 1777872 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[DEFA52CDF876677E]) [    x:collection1] 
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1777884 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[DEFA52CDF876677E]) [    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> 1777884 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[DEFA52CDF876677E]) [    x:collection1] 
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1],
 
dataDir=[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.update.AutoCommitTest_DEFA52CDF876677E-001/init-core-data-001/]
   [junit4]   2> 1777884 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[DEFA52CDF876677E]) [    x:collection1] 
o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX 
Server: com.sun.jmx.mbeanserver.JmxMBeanServer@4d024f13
   [junit4]   2> 1777902 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[DEFA52CDF876677E]) [    x:collection1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1777902 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[DEFA52CDF876677E]) [    x:collection1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1777903 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[DEFA52CDF876677E]) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@28425a4c[collection1] main]
   [junit4]   2> 1777903 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[DEFA52CDF876677E]) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1777903 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[DEFA52CDF876677E]) [    x:collection1] 
o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 1777906 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[DEFA52CDF876677E]) [    x:collection1] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1777907 INFO  
(searcherExecutor-7769-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1777907 INFO  
(searcherExecutor-7769-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1777907 INFO  
(searcherExecutor-7769-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1777907 INFO  
(searcherExecutor-7769-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 1777907 INFO  
(searcherExecutor-7769-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1777908 INFO  
(searcherExecutor-7769-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1777908 INFO  
(searcherExecutor-7769-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1777909 INFO  
(searcherExecutor-7769-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 1777909 INFO  
(searcherExecutor-7769-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 1777910 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[DEFA52CDF876677E]) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: 
minMergeSize=0, mergeFactor=10, maxMergeSize=1918018649, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.1]
   [junit4]   2> 1777910 INFO  
(searcherExecutor-7769-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@28425a4c[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1777910 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[DEFA52CDF876677E]) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 1777910 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[DEFA52CDF876677E]) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@11b68258[collection1] main]
   [junit4]   2> 1777910 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[DEFA52CDF876677E]) [    x:collection1] 
o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@7037e803
   [junit4]   2> 1777911 INFO  
(searcherExecutor-7769-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@11b68258[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1777920 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[DEFA52CDF876677E]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[0 
(1546828618357800960)]} 0 1
   [junit4]   2> 1777920 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[DEFA52CDF876677E]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[1 
(1546828618358849536)]} 0 1
   [junit4]   2> 1777920 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[DEFA52CDF876677E]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[2 
(1546828618358849537)]} 0 1
   [junit4]   2> 1777920 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[DEFA52CDF876677E]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[3 
(1546828618358849538)]} 0 1
   [junit4]   2> 1777921 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[DEFA52CDF876677E]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[4 
(1546828618359898112)]} 0 2
   [junit4]   2> 1777921 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[DEFA52CDF876677E]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[5 
(1546828618359898113)]} 0 2
   [junit4]   2> 1777921 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[DEFA52CDF876677E]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[6 
(1546828618359898114)]} 0 2
   [junit4]   2> 1777921 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[DEFA52CDF876677E]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[7 
(1546828618359898115)]} 0 2
   [junit4]   2> 1777921 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[DEFA52CDF876677E]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[8 
(1546828618359898116)]} 0 2
   [junit4]   2> 1777922 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[DEFA52CDF876677E]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[9 
(1546828618360946688)]} 0 3
   [junit4]   2> 1777922 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[DEFA52CDF876677E]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[10 
(1546828618360946689)]} 0 3
   [junit4]   2> 1777922 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[DEFA52CDF876677E]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[11 
(1546828618360946690)]} 0 3
   [junit4]   2> 1777922 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[DEFA52CDF876677E]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[12 
(1546828618360946691)]} 0 3
   [junit4]   2> 1777922 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[DEFA52CDF876677E]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[13 
(1546828618360946692)]} 0 3
   [junit4]   2> 1777923 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[DEFA52CDF876677E]) [    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> 1777925 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[DEFA52CDF876677E]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[14 
(1546828618361995264)]} 0 6
   [junit4]   2> 1777926 INFO  (commitScheduler-7772-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> 1777930 INFO  (commitScheduler-7772-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@7763ec9f[collection1] main]
   [junit4]   2> 1777930 INFO  (commitScheduler-7772-thread-1) [    
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1777930 INFO  
(searcherExecutor-7769-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@7763ec9f[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(7.0.0):c15)))}
   [junit4]   2> 1778176 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[DEFA52CDF876677E]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[15 
(1546828618626236416)]} 0 257
   [junit4]   2> 1778177 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[DEFA52CDF876677E]) [    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> 1778177 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[DEFA52CDF876677E]) [    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> 1778178 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[DEFA52CDF876677E]) [    x:collection1] 
o.a.s.SolrTestCaseJ4 ###Ending testMaxDocs
   [junit4]   2> 1778178 INFO  
(SUITE-AutoCommitTest-seed#[DEFA52CDF876677E]-worker) [    x:collection1] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> 1778178 INFO  
(SUITE-AutoCommitTest-seed#[DEFA52CDF876677E]-worker) [    x:collection1] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=295813407
   [junit4]   2> 1778189 INFO  
(coreCloseExecutor-7773-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@1636d0a8
   [junit4]   2> 1778189 INFO  
(coreCloseExecutor-7773-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter close.
   [junit4]   2> 1778189 INFO  
(coreCloseExecutor-7773-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@53e029f
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.update.AutoCommitTest_DEFA52CDF876677E-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene62): 
{range_facet_l_dv=PostingsFormat(name=Memory doPackFST= false), 
_version_=PostingsFormat(name=MockRandom), field_t=PostingsFormat(name=Memory 
doPackFST= false), multiDefault=PostingsFormat(name=LuceneVarGapFixedInterval), 
subject=PostingsFormat(name=LuceneVarGapFixedInterval), 
intDefault=PostingsFormat(name=MockRandom), id=PostingsFormat(name=Memory 
doPackFST= false), 
range_facet_i_dv=PostingsFormat(name=LuceneVarGapFixedInterval), text=FSTOrd50, 
range_facet_l=PostingsFormat(name=LuceneVarGapFixedInterval), 
timestamp=PostingsFormat(name=LuceneVarGapFixedInterval)}, 
docValues:{range_facet_l_dv=DocValuesFormat(name=Lucene54), 
range_facet_i_dv=DocValuesFormat(name=Lucene54), 
timestamp=DocValuesFormat(name=Lucene54)}, maxPointsInLeafNode=1754, 
maxMBSortInHeap=6.04932127855546, sim=ClassicSimilarity, locale=en-ZA, 
timezone=America/Fortaleza
   [junit4]   2> NOTE: SunOS 5.11 amd64/Oracle Corporation 1.8.0_102 
(64-bit)/cpus=3,threads=1,free=220071544,total=536870912
   [junit4]   2> NOTE: All tests run in this JVM: [TestSchemaNameResource, 
TestFileDictionaryLookup, DateFieldTest, PolyFieldTest, 
AnalysisAfterCoreReloadTest, TestDocBasedVersionConstraints, 
UnloadDistributedZkTest, TestSurroundQueryParser, SampleTest, 
TestExactStatsCache, TestNumericTerms64, DeleteShardTest, TestDocTermOrds, 
CopyFieldTest, TestNRTOpen, DocExpirationUpdateProcessorFactoryTest, 
TestInfoStreamLogging, IndexBasedSpellCheckerTest, AnalyticsQueryTest, 
RemoteQueryErrorTest, ChaosMonkeyNothingIsSafeTest, TestGraphMLResponseWriter, 
TestBM25SimilarityFactory, ClassificationUpdateProcessorFactoryTest, 
AddSchemaFieldsUpdateProcessorFactoryTest, TestRemoteStreaming, 
TestCloudPseudoReturnFields, LeaderFailureAfterFreshStartTest, TestSort, 
TestReplicationHandler, FullHLLTest, TestNonDefinedSimilarityFactory, 
PeerSyncTest, TestCloudManagedSchema, TestFastLRUCache, TestHashPartitioner, 
TestFieldSortValues, CoreSorterTest, OpenExchangeRatesOrgProviderTest, 
CdcrReplicationHandlerTest, BJQParserTest, BinaryUpdateRequestHandlerTest, 
StressHdfsTest, TestJmxIntegration, TestFunctionQuery, TestJsonFacets, 
TestExclusionRuleCollectionAccess, TestFieldCacheReopen, TestCoreContainer, 
PeerSyncReplicationTest, UniqFieldsUpdateProcessorFactoryTest, 
SolrPluginUtilsTest, TestEmbeddedSolrServerConstructors, 
TestTrackingShardHandlerFactory, TestDynamicFieldCollectionResource, 
DistributedMLTComponentTest, RollingRestartTest, ChangedSchemaMergeTest, 
TestSubQueryTransformerDistrib, TestDistributedSearch, BitVectorTest, 
AsyncMigrateRouteKeyTest, TestQuerySenderNoQuery, BasicAuthIntegrationTest, 
BlockDirectoryTest, InfoHandlerTest, TestPerFieldSimilarity, 
TestNamedUpdateProcessors, RequiredFieldsTest, TestLazyCores, TestLRUCache, 
TestTolerantUpdateProcessorRandomCloud, ConfigSetsAPITest, 
TestSolrConfigHandlerConcurrent, CollectionsAPISolrJTest, 
HdfsBasicDistributedZk2Test, TestSubQueryTransformer, SpatialFilterTest, 
StatelessScriptUpdateProcessorFactoryTest, TestPhraseSuggestions, 
FastVectorHighlighterTest, SchemaVersionSpecificBehaviorTest, 
TestCursorMarkWithoutUniqueKey, ZkControllerTest, TestSortingResponseWriter, 
TestFaceting, HdfsChaosMonkeyNothingIsSafeTest, CurrencyFieldXmlFileTest, 
OverseerStatusTest, TestSolrDynamicMBean, TestNoOpRegenerator, DocValuesTest, 
ZkStateReaderTest, AlternateDirectoryTest, TestSQLHandler, 
CreateCollectionCleanupTest, TestPostingsSolrHighlighter, 
TestCopyFieldCollectionResource, NumericFieldsTest, HdfsDirectoryTest, 
TestDocumentBuilder, TestSerializedLuceneMatchVersion, TestDistribIDF, 
TestLockTree, SolrIndexConfigTest, SOLR749Test, ActionThrottleTest, 
TestWordDelimiterFilterFactory, TestBlobHandler, SyncSliceTest, 
TermsComponentTest, TestLeaderInitiatedRecoveryThread, 
TestPartialUpdateDeduplication, CollectionReloadTest, TestMaxScoreQueryParser, 
TestDynamicLoading, DistributedDebugComponentTest, MultiThreadedOCPTest, 
HdfsThreadLeakTest, TestStressUserVersions, DOMUtilTest, QueryEqualityTest, 
TestSchemaSimilarityResource, TestShardHandlerFactory, 
HdfsCollectionsAPIDistributedZkTest, TestAuthorizationFramework, 
TestLegacyFieldCache, TestRandomDVFaceting, PrimitiveFieldTypeTest, 
TestXIncludeConfig, SolrCoreTest, DocumentBuilderTest, HLLUtilTest, 
DistributedFacetPivotSmallTest, HardAutoCommitTest, TestFieldCacheVsDocValues, 
TestScoreJoinQPScore, TestStressLiveNodes, TestIntervalFaceting, 
TestReqParamsAPI, TestQueryWrapperFilter, RulesTest, BasicDistributedZkTest, 
TestRTGBase, TestCollationField, SmileWriterTest, BadCopyFieldTest, 
HdfsRestartWhileUpdatingTest, SimplePostToolTest, CdcrBootstrapTest, 
SystemInfoHandlerTest, TestRawTransformer, HighlighterMaxOffsetTest, 
LeaderElectionTest, AutoCommitTest]
   [junit4] Completed [331/634 (1!)] on J0 in 9.17s, 3 tests, 1 error <<< 
FAILURES!

[...truncated 534 lines...]
   [junit4] Suite: org.apache.solr.cloud.TestSolrCloudWithDelegationTokens
   [junit4]   2> Creating dataDir: 
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.TestSolrCloudWithDelegationTokens_DEFA52CDF876677E-001/init-core-data-001
   [junit4]   2> 2616951 INFO  
(SUITE-TestSolrCloudWithDelegationTokens-seed#[DEFA52CDF876677E]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via: 
@org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
   [junit4]   2> 2616954 INFO  
(SUITE-TestSolrCloudWithDelegationTokens-seed#[DEFA52CDF876677E]-worker) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 2616954 INFO  (Thread-6762) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 2616954 INFO  (Thread-6762) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 2617054 INFO  
(SUITE-TestSolrCloudWithDelegationTokens-seed#[DEFA52CDF876677E]-worker) [    ] 
o.a.s.c.ZkTestServer start zk server on port:51626
   [junit4]   2> 2617061 INFO  (jetty-launcher-9509-thread-2) [    ] 
o.e.j.s.Server jetty-9.3.8.v20160314
   [junit4]   2> 2617061 INFO  (jetty-launcher-9509-thread-1) [    ] 
o.e.j.s.Server jetty-9.3.8.v20160314
   [junit4]   2> 2617063 INFO  (jetty-launcher-9509-thread-2) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@3682f88a{/solr,null,AVAILABLE}
   [junit4]   2> 2617064 INFO  (jetty-launcher-9509-thread-1) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@66578487{/solr,null,AVAILABLE}
   [junit4]   2> 2617064 INFO  (jetty-launcher-9509-thread-2) [    ] 
o.e.j.s.ServerConnector Started 
ServerConnector@141b20d4{HTTP/1.1,[http/1.1]}{127.0.0.1:58262}
   [junit4]   2> 2617064 INFO  (jetty-launcher-9509-thread-2) [    ] 
o.e.j.s.Server Started @2621850ms
   [junit4]   2> 2617064 INFO  (jetty-launcher-9509-thread-1) [    ] 
o.e.j.s.ServerConnector Started 
ServerConnector@6ee1af5c{HTTP/1.1,[http/1.1]}{127.0.0.1:53026}
   [junit4]   2> 2617064 INFO  (jetty-launcher-9509-thread-2) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=58262}
   [junit4]   2> 2617064 INFO  (jetty-launcher-9509-thread-1) [    ] 
o.e.j.s.Server Started @2621850ms
   [junit4]   2> 2617065 INFO  (jetty-launcher-9509-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=53026}
   [junit4]   2> 2617065 INFO  (jetty-launcher-9509-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
7.0.0
   [junit4]   2> 2617065 INFO  (jetty-launcher-9509-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
7.0.0
   [junit4]   2> 2617065 INFO  (jetty-launcher-9509-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 2617065 INFO  (jetty-launcher-9509-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 2617065 INFO  (jetty-launcher-9509-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 2617065 INFO  (jetty-launcher-9509-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 2617065 INFO  (jetty-launcher-9509-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2016-09-29T17:52:44.356Z
   [junit4]   2> 2617065 INFO  (jetty-launcher-9509-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2016-09-29T17:52:44.356Z
   [junit4]   2> 2617068 INFO  (jetty-launcher-9509-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 2617068 INFO  (jetty-launcher-9509-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 2617077 INFO  (jetty-launcher-9509-thread-2) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:51626/solr
   [junit4]   2> 2617077 INFO  (jetty-launcher-9509-thread-1) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:51626/solr
   [junit4]   2> 2617112 INFO  (jetty-launcher-9509-thread-2) 
[n:127.0.0.1:58262_solr    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:58262_solr
   [junit4]   2> 2617113 INFO  (jetty-launcher-9509-thread-1) 
[n:127.0.0.1:53026_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:53026_solr
   [junit4]   2> 2617114 INFO  (jetty-launcher-9509-thread-2) 
[n:127.0.0.1:58262_solr    ] o.a.s.c.Overseer Overseer 
(id=96676843634425861-127.0.0.1:58262_solr-n_0000000000) starting
   [junit4]   2> 2617116 INFO  
(zkCallback-9520-thread-1-processing-n:127.0.0.1:53026_solr) 
[n:127.0.0.1:53026_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 2617117 INFO  
(zkCallback-9519-thread-1-processing-n:127.0.0.1:58262_solr) 
[n:127.0.0.1:58262_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 2617128 INFO  (jetty-launcher-9509-thread-2) 
[n:127.0.0.1:58262_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:58262_solr
   [junit4]   2> 2617131 INFO  
(zkCallback-9520-thread-1-processing-n:127.0.0.1:53026_solr) 
[n:127.0.0.1:53026_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (2)
   [junit4]   2> 2617131 INFO  
(zkCallback-9519-thread-1-processing-n:127.0.0.1:58262_solr) 
[n:127.0.0.1:58262_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (2)
   [junit4]   2> 2617138 INFO  (jetty-launcher-9509-thread-1) 
[n:127.0.0.1:53026_solr    ] o.a.s.c.CoreContainer Authentication plugin class 
obtained from system property 'authenticationPlugin': 
org.apache.solr.security.HttpParamDelegationTokenPlugin
   [junit4]   2> 2617149 INFO  (jetty-launcher-9509-thread-1) 
[n:127.0.0.1:53026_solr    ] o.a.s.s.KerberosPlugin Params: {token.valid=30, 
delegation-token.token-kind=solr-dt, cookie.domain=127.0.0.1, cookie.path=/, 
zk-dt-secret-manager.znodeWorkingPath=solr/security/zkdtsm, 
token.validity=36000, signer.secret.provider.zookeeper.path=/token, 
type=kerberos, zk-dt-secret-manager.enable=true, kerberos.name.rules=DEFAULT, 
signer.secret.provider=zookeeper}
   [junit4]   2> 2617160 INFO  (jetty-launcher-9509-thread-2) 
[n:127.0.0.1:58262_solr    ] o.a.s.c.CoreContainer Authentication plugin class 
obtained from system property 'authenticationPlugin': 
org.apache.solr.security.HttpParamDelegationTokenPlugin
   [junit4]   2> 2617160 INFO  (jetty-launcher-9509-thread-2) 
[n:127.0.0.1:58262_solr    ] o.a.s.s.KerberosPlugin Params: {token.valid=30, 
delegation-token.token-kind=solr-dt, cookie.domain=127.0.0.1, cookie.path=/, 
zk-dt-secret-manager.znodeWorkingPath=solr/security/zkdtsm, 
token.validity=36000, signer.secret.provider.zookeeper.path=/token, 
type=kerberos, zk-dt-secret-manager.enable=true, kerberos.name.rules=DEFAULT, 
signer.secret.provider=zookeeper}
   [junit4]   2> 2617252 INFO  (jetty-launcher-9509-thread-2) 
[n:127.0.0.1:58262_solr    ] o.a.c.f.i.CuratorFrameworkImpl Starting
   [junit4]   2> 2617252 INFO  (jetty-launcher-9509-thread-1) 
[n:127.0.0.1:53026_solr    ] o.a.c.f.i.CuratorFrameworkImpl Starting
   [junit4]   2> 2617279 INFO  (jetty-launcher-9509-thread-2-EventThread) 
[n:127.0.0.1:58262_solr    ] o.a.c.f.s.ConnectionStateManager State change: 
CONNECTED
   [junit4]   2> 2617279 INFO  (jetty-launcher-9509-thread-1-EventThread) 
[n:127.0.0.1:53026_solr    ] o.a.c.f.s.ConnectionStateManager State change: 
CONNECTED
   [junit4]   2> 2617422 INFO  (jetty-launcher-9509-thread-2) 
[n:127.0.0.1:58262_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.TestSolrCloudWithDelegationTokens_DEFA52CDF876677E-001/tempDir-001/node2/.
   [junit4]   2> 2617426 INFO  (jetty-launcher-9509-thread-1) 
[n:127.0.0.1:53026_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.TestSolrCloudWithDelegationTokens_DEFA52CDF876677E-001/tempDir-001/node1/.
   [junit4]   2> 2617463 INFO  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenVerify-seed#[DEFA52CDF876677E])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testDelegationTokenVerify
   [junit4]   2> 2617610 INFO  (qtp1170757192-45420) [n:127.0.0.1:58262_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params 
action=LIST&delegation=GgADYmFyA2JhcgCKAVd3E7zligFXmyBA5QEEFKztvILW8IgjTsQQyWnl3_NWHKcQB3NvbHItZHQA&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 2617611 INFO  (qtp1170757192-45420) [n:127.0.0.1:58262_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={action=LIST&delegation=GgADYmFyA2JhcgCKAVd3E7zligFXmyBA5QEEFKztvILW8IgjTsQQyWnl3_NWHKcQB3NvbHItZHQA&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2617629 WARN  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenVerify-seed#[DEFA52CDF876677E])
 [    ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: 
hadoop.auth=; Path=/; Domain=127.0.0.1; Expires= , 01-1 -1970 00:00:00 GMT; 
HttpOnly". Invalid 'expires' attribute: , 01-1 -1970 00:00:00 GMT
   [junit4]   2> 2617633 INFO  (qtp1031983139-45425) [n:127.0.0.1:53026_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params 
action=LIST&delegation=GgADYmFyA2JhcgCKAVd3E7zligFXmyBA5QEEFKztvILW8IgjTsQQyWnl3_NWHKcQB3NvbHItZHQA&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 2617633 INFO  (qtp1031983139-45425) [n:127.0.0.1:53026_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={action=LIST&delegation=GgADYmFyA2JhcgCKAVd3E7zligFXmyBA5QEEFKztvILW8IgjTsQQyWnl3_NWHKcQB3NvbHItZHQA&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2617637 WARN  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenVerify-seed#[DEFA52CDF876677E])
 [    ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: 
hadoop.auth=; Path=/; Domain=127.0.0.1; Expires= , 01-1 -1970 00:00:00 GMT; 
HttpOnly". Invalid 'expires' attribute: , 01-1 -1970 00:00:00 GMT
   [junit4]   2> 2617637 INFO  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenVerify-seed#[DEFA52CDF876677E])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testDelegationTokenVerify
   [junit4]   2> 2617680 INFO  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[DEFA52CDF876677E])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testDelegationTokenRenew
   [junit4]   2> 2617728 INFO  (qtp1170757192-45422) [n:127.0.0.1:58262_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params 
action=LIST&delegation=GgADYmFyA2JhcgCKAVd3E72sigFXmyBBrAIEFCnsi9lPK9FSQlqHxuhS2SX3z-9PB3NvbHItZHQA&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 2617728 INFO  (qtp1170757192-45422) [n:127.0.0.1:58262_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={action=LIST&delegation=GgADYmFyA2JhcgCKAVd3E72sigFXmyBBrAIEFCnsi9lPK9FSQlqHxuhS2SX3z-9PB3NvbHItZHQA&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2617730 WARN  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[DEFA52CDF876677E])
 [    ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: 
hadoop.auth=; Path=/; Domain=127.0.0.1; Expires= , 01-1 -1970 00:00:00 GMT; 
HttpOnly". Invalid 'expires' attribute: , 01-1 -1970 00:00:00 GMT
   [junit4]   2> 2617733 INFO  (qtp1031983139-45425) [n:127.0.0.1:53026_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params 
action=LIST&delegation=GgADYmFyA2JhcgCKAVd3E72sigFXmyBBrAIEFCnsi9lPK9FSQlqHxuhS2SX3z-9PB3NvbHItZHQA&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 2617733 INFO  (qtp1031983139-45425) [n:127.0.0.1:53026_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={action=LIST&delegation=GgADYmFyA2JhcgCKAVd3E72sigFXmyBBrAIEFCnsi9lPK9FSQlqHxuhS2SX3z-9PB3NvbHItZHQA&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2617736 WARN  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[DEFA52CDF876677E])
 [    ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: 
hadoop.auth=; Path=/; Domain=127.0.0.1; Expires= , 01-1 -1970 00:00:00 GMT; 
HttpOnly". Invalid 'expires' attribute: , 01-1 -1970 00:00:00 GMT
   [junit4]   2> 2617770 INFO  (qtp1170757192-45421) [n:127.0.0.1:58262_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params 
action=LIST&delegation=GgADYmFyA2JhcgCKAVd3E73kigFXmyBB5AMEFMMaIzQqVTAdWbk_rlZ9AnWJlG8CB3NvbHItZHQA&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 2617770 INFO  (qtp1170757192-45421) [n:127.0.0.1:58262_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={action=LIST&delegation=GgADYmFyA2JhcgCKAVd3E73kigFXmyBB5AMEFMMaIzQqVTAdWbk_rlZ9AnWJlG8CB3NvbHItZHQA&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2617774 WARN  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[DEFA52CDF876677E])
 [    ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: 
hadoop.auth=; Path=/; Domain=127.0.0.1; Expires= , 01-1 -1970 00:00:00 GMT; 
HttpOnly". Invalid 'expires' attribute: , 01-1 -1970 00:00:00 GMT
   [junit4]   2> 2617776 INFO  (qtp1031983139-45428) [n:127.0.0.1:53026_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params 
action=LIST&delegation=GgADYmFyA2JhcgCKAVd3E73kigFXmyBB5AMEFMMaIzQqVTAdWbk_rlZ9AnWJlG8CB3NvbHItZHQA&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 2617776 INFO  (qtp1031983139-45428) [n:127.0.0.1:53026_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={action=LIST&delegation=GgADYmFyA2JhcgCKAVd3E73kigFXmyBB5AMEFMMaIzQqVTAdWbk_rlZ9AnWJlG8CB3NvbHItZHQA&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2617780 WARN  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[DEFA52CDF876677E])
 [    ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: 
hadoop.auth=; Path=/; Domain=127.0.0.1; Expires= , 01-1 -1970 00:00:00 GMT; 
HttpOnly". Invalid 'expires' attribute: , 01-1 -1970 00:00:00 GMT
   [junit4]   2> 2617797 INFO  (qtp1170757192-45415) [n:127.0.0.1:58262_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params 
action=LIST&delegation=GgADYmFyA2JhcgCKAVd3E74PigFXmyBCDwQEFCyMJlSCPcYXVKTdr54ipUVz8bCsB3NvbHItZHQA&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 2617798 INFO  (qtp1170757192-45415) [n:127.0.0.1:58262_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={action=LIST&delegation=GgADYmFyA2JhcgCKAVd3E74PigFXmyBCDwQEFCyMJlSCPcYXVKTdr54ipUVz8bCsB3NvbHItZHQA&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2617801 WARN  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[DEFA52CDF876677E])
 [    ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: 
hadoop.auth=; Path=/; Domain=127.0.0.1; Expires= , 01-1 -1970 00:00:00 GMT; 
HttpOnly". Invalid 'expires' attribute: , 01-1 -1970 00:00:00 GMT
   [junit4]   2> 2617805 INFO  (qtp1031983139-45428) [n:127.0.0.1:53026_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params 
action=LIST&delegation=GgADYmFyA2JhcgCKAVd3E74PigFXmyBCDwQEFCyMJlSCPcYXVKTdr54ipUVz8bCsB3NvbHItZHQA&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 2617805 INFO  (qtp1031983139-45428) [n:127.0.0.1:53026_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={action=LIST&delegation=GgADYmFyA2JhcgCKAVd3E74PigFXmyBCDwQEFCyMJlSCPcYXVKTdr54ipUVz8bCsB3NvbHItZHQA&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2617807 WARN  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[DEFA52CDF876677E])
 [    ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: 
hadoop.auth=; Path=/; Domain=127.0.0.1; Expires= , 01-1 -1970 00:00:00 GMT; 
HttpOnly". Invalid 'expires' attribute: , 01-1 -1970 00:00:00 GMT
   [junit4]   2> 2617826 INFO  (qtp1170757192-45422) [n:127.0.0.1:58262_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params 
action=LIST&delegation=GgADYmFyA2JhcgCKAVd3E74sigFXmyBCLAUEFMuBvlbHfX8pt04OBKqSOg1r3MwuB3NvbHItZHQA&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 2617826 INFO  (qtp1170757192-45422) [n:127.0.0.1:58262_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={action=LIST&delegation=GgADYmFyA2JhcgCKAVd3E74sigFXmyBCLAUEFMuBvlbHfX8pt04OBKqSOg1r3MwuB3NvbHItZHQA&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2617829 WARN  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[DEFA52CDF876677E])
 [    ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: 
hadoop.auth=; Path=/; Domain=127.0.0.1; Expires= , 01-1 -1970 00:00:00 GMT; 
HttpOnly". Invalid 'expires' attribute: , 01-1 -1970 00:00:00 GMT
   [junit4]   2> 2617833 INFO  (qtp1031983139-45428) [n:127.0.0.1:53026_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params 
action=LIST&delegation=GgADYmFyA2JhcgCKAVd3E74sigFXmyBCLAUEFMuBvlbHfX8pt04OBKqSOg1r3MwuB3NvbHItZHQA&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 2617833 INFO  (qtp1031983139-45428) [n:127.0.0.1:53026_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={action=LIST&delegation=GgADYmFyA2JhcgCKAVd3E74sigFXmyBCLAUEFMuBvlbHfX8pt04OBKqSOg1r3MwuB3NvbHItZHQA&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2617836 WARN  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[DEFA52CDF876677E])
 [    ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: 
hadoop.auth=; Path=/; Domain=127.0.0.1; Expires= , 01-1 -1970 00:00:00 GMT; 
HttpOnly". Invalid 'expires' attribute: , 01-1 -1970 00:00:00 GMT
   [junit4]   2> 2617836 INFO  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[DEFA52CDF876677E])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testDelegationTokenRenew
   [junit4]   2> 2617865 INFO  
(TEST-TestSolrCloudWithDelegationTokens.testZNodePaths-seed#[DEFA52CDF876677E]) 
[    ] o.a.s.SolrTestCaseJ4 ###Starting testZNodePaths
   [junit4]   2> 2617878 INFO  
(TEST-TestSolrCloudWithDelegationTokens.testZNodePaths-seed#[DEFA52CDF876677E]) 
[    ] o.a.s.SolrTestCaseJ4 ###Ending testZNodePaths
   [junit4]   2> 2617925 INFO  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationOtherOp-seed#[DEFA52CDF876677E])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testDelegationOtherOp
   [junit4]   2> 2617928 INFO  (qtp1170757192-45420) [n:127.0.0.1:58262_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params 
op=someSolrOperation&action=LIST&wt=javabin&version=2 and sendToOCPQueue=true
   [junit4]   2> 2617928 INFO  (qtp1170757192-45420) [n:127.0.0.1:58262_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={op=someSolrOperation&action=LIST&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 2617929 WARN  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationOtherOp-seed#[DEFA52CDF876677E])
 [    ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: 
hadoop.auth="u=bar&p=bar&t=test&e=1475207565219&s=KNCmwmo2NEELCSmIAwIv3pa8FWg=";
 Path=/; Domain=127.0.0.1; Expires= , 30-9 -2016 03:52:45 GMT; HttpOnly". 
Invalid 'expires' attribute: , 30-9 -2016 03:52:45 GMT
   [junit4]   2> 2617930 INFO  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationOtherOp-seed#[DEFA52CDF876677E])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testDelegationOtherOp
   [junit4]   2> 2617966 INFO  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenewFail-seed#[DEFA52CDF876677E])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testDelegationTokenRenewFail
   [junit4]   2> 2617988 WARN  (qtp1170757192-45418) [    ] 
o.a.h.s.a.s.AuthenticationFilter Authentication exception: 
org.apache.hadoop.security.AccessControlException: foo tries to renew a token 
with renewer bar
   [junit4]   2> 2617989 WARN  (qtp1170757192-45418) [    ] 
o.a.s.s.KerberosPlugin Could not find 
org.apache.solr.security.kerberosplugin.requestcontinues
   [junit4]   2> 2617989 WARN  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenewFail-seed#[DEFA52CDF876677E])
 [    ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: 
hadoop.auth=; Path=/; Domain=127.0.0.1; Expires= , 01-1 -1970 00:00:00 GMT; 
HttpOnly". Invalid 'expires' attribute: , 01-1 -1970 00:00:00 GMT
   [junit4]   2> 2617990 WARN  (qtp1031983139-45431) [    ] 
o.a.h.s.a.s.AuthenticationFilter Authentication exception: 
org.apache.hadoop.security.AccessControlException: foo tries to renew a token 
with renewer bar
   [junit4]   2> 2617991 WARN  (qtp1031983139-45431) [    ] 
o.a.s.s.KerberosPlugin Could not find 
org.apache.solr.security.kerberosplugin.requestcontinues
   [junit4]   2> 2617991 WARN  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenewFail-seed#[DEFA52CDF876677E])
 [    ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: 
hadoop.auth=; Path=/; Domain=127.0.0.1; Expires= , 01-1 -1970 00:00:00 GMT; 
HttpOnly". Invalid 'expires' attribute: , 01-1 -1970 00:00:00 GMT
   [junit4]   2> 2618001 WARN  (qtp1170757192-45422) [n:127.0.0.1:58262_solr    
] o.a.h.s.a.s.AuthenticationFilter Authentication exception: 
org.apache.hadoop.security.AccessControlException: notRenewUser tries to renew 
a token with renewer renewUser
   [junit4]   2> 2618001 WARN  (qtp1170757192-45422) [n:127.0.0.1:58262_solr    
] o.a.s.s.KerberosPlugin Could not find 
org.apache.solr.security.kerberosplugin.requestcontinues
   [junit4]   2> 2618002 WARN  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenewFail-seed#[DEFA52CDF876677E])
 [    ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: 
hadoop.auth=; Path=/; Domain=127.0.0.1; Expires= , 01-1 -1970 00:00:00 GMT; 
HttpOnly". Invalid 'expires' attribute: , 01-1 -1970 00:00:00 GMT
   [junit4]   2> 2618002 WARN  (qtp1031983139-45428) [n:127.0.0.1:53026_solr    
] o.a.h.s.a.s.AuthenticationFilter Authentication exception: 
org.apache.hadoop.security.AccessControlExc

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

zkCallback-9519-thread-3-processing-n:127.0.0.1:58262_solr) 
[n:127.0.0.1:58262_solr    ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, 
but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
   [junit4]   2> 2619728 WARN  
(zkCallback-9520-thread-1-processing-n:127.0.0.1:53026_solr) 
[n:127.0.0.1:53026_solr    ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, 
but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
   [junit4]   2> 2619729 ERROR 
(Thread[Thread-6779,5,TGRP-TestSolrCloudWithDelegationTokens]) 
[n:127.0.0.1:53026_solr    ] o.a.h.s.t.d.AbstractDelegationTokenSecretManager 
ExpiredTokenRemover received java.lang.InterruptedException: sleep interrupted
   [junit4]   2> 2619729 ERROR 
(Thread[Thread-6781,5,TGRP-TestSolrCloudWithDelegationTokens]) 
[n:127.0.0.1:58262_solr    ] o.a.h.s.t.d.AbstractDelegationTokenSecretManager 
ExpiredTokenRemover received java.lang.InterruptedException: sleep interrupted
   [junit4]   2> 2619741 INFO  (jetty-launcher-9509-thread-1) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@3682f88a{/solr,null,UNAVAILABLE}
   [junit4]   2> 2619747 INFO  (jetty-launcher-9509-thread-2) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@66578487{/solr,null,UNAVAILABLE}
   [junit4]   2> 2619750 INFO  
(SUITE-TestSolrCloudWithDelegationTokens-seed#[DEFA52CDF876677E]-worker) [    ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1:51626 51626
   [junit4]   2> 2619976 INFO  (Thread-6762) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:51626 51626
   [junit4]   2> 2619978 WARN  (Thread-6762) [    ] o.a.s.c.ZkTestServer Watch 
limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2>        2       /solr/aliases.json
   [junit4]   2>        2       /solr/security.json
   [junit4]   2>        2       /solr/clusterprops.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2>        4       /solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMKeyIdRoot
   [junit4]   2>        2       
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_7
   [junit4]   2>        2       
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_6
   [junit4]   2>        2       
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_9
   [junit4]   2>        2       
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_8
   [junit4]   2>        2       
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMMasterKeyRoot/DK_1
   [junit4]   2>        2       
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_1
   [junit4]   2>        2       
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMMasterKeyRoot/DK_3
   [junit4]   2>        2       
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_3
   [junit4]   2>        2       
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMMasterKeyRoot/DK_2
   [junit4]   2>        2       
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_2
   [junit4]   2>        2       /solr/clusterstate.json
   [junit4]   2>        2       
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_5
   [junit4]   2>        2       
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMMasterKeyRoot/DK_4
   [junit4]   2>        2       
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_4
   [junit4]   2>        2       
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_12
   [junit4]   2>        2       
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMSeqNumRoot
   [junit4]   2>        2       
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_11
   [junit4]   2>        2       
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_10
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2>        3       /solr/overseer/queue
   [junit4]   2>        2       /solr/live_nodes
   [junit4]   2>        2       /solr/collections
   [junit4]   2>        2       
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMMasterKeyRoot
   [junit4]   2>        2       /solr/overseer/queue-work
   [junit4]   2>        2       
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot
   [junit4]   2> 
   [junit4]   2> 2619979 INFO  
(SUITE-TestSolrCloudWithDelegationTokens-seed#[DEFA52CDF876677E]-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/J0/temp/solr.cloud.TestSolrCloudWithDelegationTokens_DEFA52CDF876677E-001
   [junit4]   2> Sep 29, 2016 5:52:47 PM 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 1 leaked 
thread(s).
   [junit4]   2> NOTE: test params are: codec=Lucene62, sim=ClassicSimilarity, 
locale=zh-HK, timezone=HST
   [junit4]   2> NOTE: SunOS 5.11 amd64/Oracle Corporation 1.8.0_102 
(64-bit)/cpus=3,threads=1,free=188755376,total=536870912
   [junit4]   2> NOTE: All tests run in this JVM: [TestSchemaNameResource, 
TestFileDictionaryLookup, DateFieldTest, PolyFieldTest, 
AnalysisAfterCoreReloadTest, TestDocBasedVersionConstraints, 
UnloadDistributedZkTest, TestSurroundQueryParser, SampleTest, 
TestExactStatsCache, TestNumericTerms64, DeleteShardTest, TestDocTermOrds, 
CopyFieldTest, TestNRTOpen, DocExpirationUpdateProcessorFactoryTest, 
TestInfoStreamLogging, IndexBasedSpellCheckerTest, AnalyticsQueryTest, 
RemoteQueryErrorTest, ChaosMonkeyNothingIsSafeTest, TestGraphMLResponseWriter, 
TestBM25SimilarityFactory, ClassificationUpdateProcessorFactoryTest, 
AddSchemaFieldsUpdateProcessorFactoryTest, TestRemoteStreaming, 
TestCloudPseudoReturnFields, LeaderFailureAfterFreshStartTest, TestSort, 
TestReplicationHandler, FullHLLTest, TestNonDefinedSimilarityFactory, 
PeerSyncTest, TestCloudManagedSchema, TestFastLRUCache, TestHashPartitioner, 
TestFieldSortValues, CoreSorterTest, OpenExchangeRatesOrgProviderTest, 
CdcrReplicationHandlerTest, BJQParserTest, BinaryUpdateRequestHandlerTest, 
StressHdfsTest, TestJmxIntegration, TestFunctionQuery, TestJsonFacets, 
TestExclusionRuleCollectionAccess, TestFieldCacheReopen, TestCoreContainer, 
PeerSyncReplicationTest, UniqFieldsUpdateProcessorFactoryTest, 
SolrPluginUtilsTest, TestEmbeddedSolrServerConstructors, 
TestTrackingShardHandlerFactory, TestDynamicFieldCollectionResource, 
DistributedMLTComponentTest, RollingRestartTest, ChangedSchemaMergeTest, 
TestSubQueryTransformerDistrib, TestDistributedSearch, BitVectorTest, 
AsyncMigrateRouteKeyTest, TestQuerySenderNoQuery, BasicAuthIntegrationTest, 
BlockDirectoryTest, InfoHandlerTest, TestPerFieldSimilarity, 
TestNamedUpdateProcessors, RequiredFieldsTest, TestLazyCores, TestLRUCache, 
TestTolerantUpdateProcessorRandomCloud, ConfigSetsAPITest, 
TestSolrConfigHandlerConcurrent, CollectionsAPISolrJTest, 
HdfsBasicDistributedZk2Test, TestSubQueryTransformer, SpatialFilterTest, 
StatelessScriptUpdateProcessorFactoryTest, TestPhraseSuggestions, 
FastVectorHighlighterTest, SchemaVersionSpecificBehaviorTest, 
TestCursorMarkWithoutUniqueKey, ZkControllerTest, TestSortingResponseWriter, 
TestFaceting, HdfsChaosMonkeyNothingIsSafeTest, CurrencyFieldXmlFileTest, 
OverseerStatusTest, TestSolrDynamicMBean, TestNoOpRegenerator, DocValuesTest, 
ZkStateReaderTest, AlternateDirectoryTest, TestSQLHandler, 
CreateCollectionCleanupTest, TestPostingsSolrHighlighter, 
TestCopyFieldCollectionResource, NumericFieldsTest, HdfsDirectoryTest, 
TestDocumentBuilder, TestSerializedLuceneMatchVersion, TestDistribIDF, 
TestLockTree, SolrIndexConfigTest, SOLR749Test, ActionThrottleTest, 
TestWordDelimiterFilterFactory, TestBlobHandler, SyncSliceTest, 
TermsComponentTest, TestLeaderInitiatedRecoveryThread, 
TestPartialUpdateDeduplication, CollectionReloadTest, TestMaxScoreQueryParser, 
TestDynamicLoading, DistributedDebugComponentTest, MultiThreadedOCPTest, 
HdfsThreadLeakTest, TestStressUserVersions, DOMUtilTest, QueryEqualityTest, 
TestSchemaSimilarityResource, TestShardHandlerFactory, 
HdfsCollectionsAPIDistributedZkTest, TestAuthorizationFramework, 
TestLegacyFieldCache, TestRandomDVFaceting, PrimitiveFieldTypeTest, 
TestXIncludeConfig, SolrCoreTest, DocumentBuilderTest, HLLUtilTest, 
DistributedFacetPivotSmallTest, HardAutoCommitTest, TestFieldCacheVsDocValues, 
TestScoreJoinQPScore, TestStressLiveNodes, TestIntervalFaceting, 
TestReqParamsAPI, TestQueryWrapperFilter, RulesTest, BasicDistributedZkTest, 
TestRTGBase, TestCollationField, SmileWriterTest, BadCopyFieldTest, 
HdfsRestartWhileUpdatingTest, SimplePostToolTest, CdcrBootstrapTest, 
SystemInfoHandlerTest, TestRawTransformer, HighlighterMaxOffsetTest, 
LeaderElectionTest, AutoCommitTest, DistributedSpellCheckComponentTest, 
TestStressReorder, TestRangeQuery, SpellCheckComponentTest, TestGroupingSearch, 
QueryElevationComponentTest, TestFiltering, TestBadConfig, HighlighterTest, 
DistributedQueryElevationComponentTest, TestExtendedDismaxParser, 
SpellCheckCollatorTest, SuggesterFSTTest, CoreAdminHandlerTest, SuggesterTest, 
TestCSVLoader, SolrCoreCheckLockOnStartupTest, TestUpdate, 
TestAtomicUpdateErrorCases, DocValuesMultiTest, TestSolrDeletionPolicy1, 
XsltUpdateRequestHandlerTest, DebugComponentTest, DisMaxRequestHandlerTest, 
StandardRequestHandlerTest, TestReversedWildcardFilterFactory, 
DocumentAnalysisRequestHandlerTest, XmlUpdateRequestHandlerTest, 
TestValueSourceCache, PathHierarchyTokenizerFactoryTest, 
FieldAnalysisRequestHandlerTest, IndexSchemaRuntimeFieldTest, 
RegexBoostProcessorTest, TestCSVResponseWriter, TestAnalyzedSuggestions, 
PingRequestHandlerTest, TestLFUCache, TestHighlightDedupGrouping, 
TestTolerantSearch, AliasIntegrationTest, CleanupOldIndexTest, 
CollectionsAPIAsyncDistributedZkTest, DeleteInactiveReplicaTest, 
DeleteLastCustomShardedReplicaTest, DeleteReplicaTest, DistributedQueueTest, 
DistributedVersionInfoTest, LeaderInitiatedRecoveryOnShardRestartTest, 
MigrateRouteKeyTest, OutOfBoxZkACLAndCredentialsProvidersTest, 
OverriddenZkACLAndCredentialsProvidersTest, 
OverseerCollectionConfigSetProcessorTest, OverseerModifyCollectionTest, 
OverseerTaskQueueTest, ReplicationFactorTest, RestartWhileUpdatingTest, 
SSLMigrationTest, SaslZkACLProviderTest, ShardSplitTest, TestRebalanceLeaders, 
TestRequestStatusCollectionAPI, TestSolrCloudWithDelegationTokens]
   [junit4] Completed [496/634 (2!)] on J0 in 3.80s, 8 tests, 1 failure <<< 
FAILURES!

[...truncated 60711 lines...]

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

Reply via email to