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

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

Error Message:
Exception during query

Stack Trace:
java.lang.RuntimeException: Exception during query
        at 
__randomizedtesting.SeedInfo.seed([6D200348FF807EAD:D4A1D597D36A7A27]:0)
        at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:812)
        at 
org.apache.solr.update.AutoCommitTest.testMaxDocs(AutoCommitTest.java:225)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:811)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:462)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at java.lang.Thread.run(Thread.java:745)
Caused by: java.lang.RuntimeException: REQUEST FAILED: 
xpath=//result[@numFound=1]
        xml response was: <?xml version="1.0" encoding="UTF-8"?>
<response>
<lst name="responseHeader"><int name="status">0</int><int 
name="QTime">0</int></lst><result name="response" numFound="0" 
start="0"></result>
</response>

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




Build Log:
[...truncated 10715 lines...]
   [junit4] Suite: org.apache.solr.update.AutoCommitTest
   [junit4]   2> Creating dataDir: 
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest_6D200348FF807EAD-001/init-core-data-001
   [junit4]   2> 263997 INFO  
(SUITE-AutoCommitTest-seed#[6D200348FF807EAD]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: 
@org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
   [junit4]   2> 263998 INFO  
(SUITE-AutoCommitTest-seed#[6D200348FF807EAD]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 263998 INFO  
(SUITE-AutoCommitTest-seed#[6D200348FF807EAD]-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> 264043 WARN  
(SUITE-AutoCommitTest-seed#[6D200348FF807EAD]-worker) [    ] o.a.s.c.Config 
Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> 
instead.
   [junit4]   2> 264044 INFO  
(SUITE-AutoCommitTest-seed#[6D200348FF807EAD]-worker) [    ] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 264064 INFO  
(SUITE-AutoCommitTest-seed#[6D200348FF807EAD]-worker) [    ] 
o.a.s.s.IndexSchema [null] Schema name=test
   [junit4]   2> 264179 WARN  
(SUITE-AutoCommitTest-seed#[6D200348FF807EAD]-worker) [    ] 
o.a.s.s.IndexSchema [null] default search field in schema is text. WARNING: 
Deprecated, please use 'df' on request instead.
   [junit4]   2> 264180 INFO  
(SUITE-AutoCommitTest-seed#[6D200348FF807EAD]-worker) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 264191 INFO  (coreLoadExecutor-2132-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> 264219 WARN  (coreLoadExecutor-2132-thread-1) [    ] 
o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use 
<mergePolicyFactory> instead.
   [junit4]   2> 264220 INFO  (coreLoadExecutor-2132-thread-1) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 264241 INFO  (coreLoadExecutor-2132-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 264328 WARN  (coreLoadExecutor-2132-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> 264329 INFO  (coreLoadExecutor-2132-thread-1) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 264341 INFO  (coreLoadExecutor-2132-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> 264342 INFO  (coreLoadExecutor-2132-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1],
 
dataDir=[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest_6D200348FF807EAD-001/init-core-data-001/]
   [junit4]   2> 264342 INFO  (coreLoadExecutor-2132-thread-1) [    
x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr 
mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@2591a1fd
   [junit4]   2> 264343 INFO  (coreLoadExecutor-2132-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=48, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.5062366339116954]
   [junit4]   2> 264356 INFO  (coreLoadExecutor-2132-thread-1) [    
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 264356 INFO  (coreLoadExecutor-2132-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 264356 INFO  (coreLoadExecutor-2132-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 264356 INFO  (coreLoadExecutor-2132-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 264357 INFO  (coreLoadExecutor-2132-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=44, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.0]
   [junit4]   2> 264357 INFO  (coreLoadExecutor-2132-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@732fb0dd[collection1] main]
   [junit4]   2> 264357 INFO  (coreLoadExecutor-2132-thread-1) [    
x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 264361 INFO  (coreLoadExecutor-2132-thread-1) [    
x:collection1] o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 264375 INFO  (coreLoadExecutor-2132-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 264375 INFO  
(searcherExecutor-2133-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 264376 INFO  
(searcherExecutor-2133-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 264376 INFO  (coreLoadExecutor-2132-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1549526422326870016
   [junit4]   2> 264376 INFO  
(searcherExecutor-2133-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 264376 INFO  
(searcherExecutor-2133-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 264376 INFO  
(searcherExecutor-2133-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 264377 INFO  
(searcherExecutor-2133-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 264377 INFO  
(searcherExecutor-2133-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 264377 INFO  
(searcherExecutor-2133-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 264378 INFO  
(searcherExecutor-2133-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 264378 INFO  
(searcherExecutor-2133-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@732fb0dd[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 264379 INFO  
(SUITE-AutoCommitTest-seed#[6D200348FF807EAD]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 264384 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6D200348FF807EAD]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testCommitWithin
   [junit4]   2> 264389 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6D200348FF807EAD]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{deleteByQuery=*:* (-1549526422335258624)} 0 5
   [junit4]   2> 264391 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6D200348FF807EAD]) [    ] 
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> 264429 WARN  
(TEST-AutoCommitTest.testCommitWithin-seed#[6D200348FF807EAD]) [    ] 
o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use 
<mergePolicyFactory> instead.
   [junit4]   2> 264431 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6D200348FF807EAD]) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 264456 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6D200348FF807EAD]) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 264540 WARN  
(TEST-AutoCommitTest.testCommitWithin-seed#[6D200348FF807EAD]) [    ] 
o.a.s.s.IndexSchema [collection1] default search field in schema is text. 
WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 264542 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6D200348FF807EAD]) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 264548 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6D200348FF807EAD]) [    ] 
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> 264549 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6D200348FF807EAD]) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1],
 
dataDir=[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest_6D200348FF807EAD-001/init-core-data-001/]
   [junit4]   2> 264549 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6D200348FF807EAD]) [    
x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr 
mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@2591a1fd
   [junit4]   2> 264567 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6D200348FF807EAD]) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 264567 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6D200348FF807EAD]) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 264568 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6D200348FF807EAD]) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@45441088[collection1] main]
   [junit4]   2> 264568 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6D200348FF807EAD]) [    
x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 264569 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6D200348FF807EAD]) [    
x:collection1] o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 264571 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6D200348FF807EAD]) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 264572 INFO  
(searcherExecutor-2138-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 264572 INFO  
(searcherExecutor-2138-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 264572 INFO  
(searcherExecutor-2138-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 264572 INFO  
(searcherExecutor-2138-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 264572 INFO  
(searcherExecutor-2138-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 264573 INFO  
(searcherExecutor-2138-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 264573 INFO  
(searcherExecutor-2138-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 264573 INFO  
(searcherExecutor-2138-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 264573 INFO  
(searcherExecutor-2138-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 264574 INFO  
(searcherExecutor-2138-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@45441088[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 264575 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6D200348FF807EAD]) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=17, maxMergeAtOnceExplicit=11, maxMergedSegmentMB=23.521484375, 
floorSegmentMB=1.2919921875, forceMergeDeletesPctAllowed=22.813222448362133, 
segmentsPerTier=27.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 264576 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6D200348FF807EAD]) [    
x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 264576 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6D200348FF807EAD]) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@130725a2[collection1] main]
   [junit4]   2> 264576 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6D200348FF807EAD]) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@7a5d763d
   [junit4]   2> 264577 INFO  
(searcherExecutor-2138-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@130725a2[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 264587 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6D200348FF807EAD]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[529 
(1549526422546022400)]} 0 1
   [junit4]   2> 264587 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6D200348FF807EAD]) [    
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> 268587 INFO  (commitScheduler-2141-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> 268593 INFO  (commitScheduler-2141-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@3f639c28[collection1] main]
   [junit4]   2> 268593 INFO  (commitScheduler-2141-thread-1) [    
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 268594 INFO  
(searcherExecutor-2138-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@3f639c28[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C1)))}
   [junit4]   2> 268610 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6D200348FF807EAD]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[530 
(1549526426765492224)]} 0 4025
   [junit4]   2> 268610 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6D200348FF807EAD]) [    
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> 268610 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6D200348FF807EAD]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[529 
(-1549526426766540800)]} 0 4026
   [junit4]   2> 268611 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6D200348FF807EAD]) [    
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> 270611 INFO  (commitScheduler-2141-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> 270616 INFO  (commitScheduler-2141-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@71a68f11[collection1] main]
   [junit4]   2> 270616 INFO  (commitScheduler-2141-thread-1) [    
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 270618 INFO  
(searcherExecutor-2138-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@71a68f11[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(7.0.0):C1)))}
   [junit4]   2> 270620 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6D200348FF807EAD]) [    
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> 270620 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6D200348FF807EAD]) [    
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> 270621 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6D200348FF807EAD]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1549526428875227136)]} 0 6037
   [junit4]   2> 270621 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6D200348FF807EAD]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1549526428875227137)]} 0 6038
   [junit4]   2> 270622 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6D200348FF807EAD]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1549526428876275712)]} 0 6038
   [junit4]   2> 270622 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6D200348FF807EAD]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1549526428876275713)]} 0 6038
   [junit4]   2> 270622 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6D200348FF807EAD]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1549526428876275714)]} 0 6038
   [junit4]   2> 270622 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6D200348FF807EAD]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1549526428876275715)]} 0 6038
   [junit4]   2> 270623 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6D200348FF807EAD]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1549526428876275716)]} 0 6039
   [junit4]   2> 270623 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6D200348FF807EAD]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1549526428877324288)]} 0 6039
   [junit4]   2> 270623 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6D200348FF807EAD]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1549526428877324289)]} 0 6039
   [junit4]   2> 270623 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6D200348FF807EAD]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1549526428877324290)]} 0 6039
   [junit4]   2> 270623 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6D200348FF807EAD]) [    
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> 270624 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6D200348FF807EAD]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1549526428877324291)]} 0 6040
   [junit4]   2> 270624 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6D200348FF807EAD]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1549526428878372864)]} 0 6040
   [junit4]   2> 270624 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6D200348FF807EAD]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1549526428878372865)]} 0 6040
   [junit4]   2> 270624 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6D200348FF807EAD]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1549526428878372866)]} 0 6040
   [junit4]   2> 270624 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6D200348FF807EAD]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1549526428878372867)]} 0 6040
   [junit4]   2> 270624 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6D200348FF807EAD]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1549526428878372868)]} 0 6040
   [junit4]   2> 270624 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6D200348FF807EAD]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1549526428878372869)]} 0 6040
   [junit4]   2> 270624 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6D200348FF807EAD]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1549526428878372870)]} 0 6040
   [junit4]   2> 270625 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6D200348FF807EAD]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1549526428879421440)]} 0 6041
   [junit4]   2> 270625 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6D200348FF807EAD]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1549526428879421441)]} 0 6041
   [junit4]   2> 270625 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6D200348FF807EAD]) [    
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> 271625 INFO  (commitScheduler-2141-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> 271628 INFO  (commitScheduler-2141-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@6bd9ce07[collection1] main]
   [junit4]   2> 271629 INFO  (commitScheduler-2141-thread-1) [    
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 271630 INFO  
(searcherExecutor-2138-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@6bd9ce07[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(7.0.0):C10/9:delGen=1)))}
   [junit4]   2> 271638 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6D200348FF807EAD]) [    
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> 271639 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6D200348FF807EAD]) [    
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> 271639 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[6D200348FF807EAD]) [    
x:collection1] o.a.s.SolrTestCaseJ4 ###Ending testCommitWithin
   [junit4]   2> 271643 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.SolrTestCaseJ4 ###Starting testMaxTime
   [junit4]   2> 271644 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@377d7cae[collection1] realtime]
   [junit4]   2> 271644 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{deleteByQuery=*:* (-1549526429946871808)} 0 1
   [junit4]   2> 271645 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6D200348FF807EAD]) [    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> 271674 WARN  
(TEST-AutoCommitTest.testMaxTime-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use 
<mergePolicyFactory> instead.
   [junit4]   2> 271675 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 271697 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 271780 WARN  
(TEST-AutoCommitTest.testMaxTime-seed#[6D200348FF807EAD]) [    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> 271782 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 271789 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6D200348FF807EAD]) [    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> 271790 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1],
 
dataDir=[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest_6D200348FF807EAD-001/init-core-data-001/]
   [junit4]   2> 271790 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX 
Server: com.sun.jmx.mbeanserver.JmxMBeanServer@2591a1fd
   [junit4]   2> 271808 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 271808 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 271808 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@369aa680[collection1] main]
   [junit4]   2> 271809 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 271809 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 271812 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 271815 INFO  
(searcherExecutor-2142-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 271815 INFO  
(searcherExecutor-2142-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 271815 INFO  
(searcherExecutor-2142-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 271815 INFO  
(searcherExecutor-2142-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 271816 INFO  
(searcherExecutor-2142-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 271816 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=35, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=1.0]
   [junit4]   2> 271816 INFO  
(searcherExecutor-2142-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 271817 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 271817 WARN  
(TEST-AutoCommitTest.testMaxTime-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.c.SolrCore [collection1] PERFORMANCE WARNING: Overlapping 
onDeckSearchers=2
   [junit4]   2> 271817 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@592a82bc[collection1] main]
   [junit4]   2> 271817 INFO  
(searcherExecutor-2142-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 271817 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@b771bb5
   [junit4]   2> 271818 INFO  
(searcherExecutor-2142-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 271818 INFO  
(searcherExecutor-2142-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 271819 INFO  
(searcherExecutor-2142-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@369aa680[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 271819 INFO  
(searcherExecutor-2142-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 271819 INFO  
(searcherExecutor-2142-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 271819 INFO  
(searcherExecutor-2142-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 271819 INFO  
(searcherExecutor-2142-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 271820 INFO  
(searcherExecutor-2142-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 271820 INFO  
(searcherExecutor-2142-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 271820 INFO  
(searcherExecutor-2142-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 271821 INFO  
(searcherExecutor-2142-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 271821 INFO  
(searcherExecutor-2142-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 271822 INFO  
(searcherExecutor-2142-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@592a82bc[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 271826 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[529 
(1549526430136664064)]} 0 1
   [junit4]   2> 271826 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6D200348FF807EAD]) [    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> 272826 INFO  (commitScheduler-2145-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> 272832 INFO  (commitScheduler-2145-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@31e28f99[collection1] main]
   [junit4]   2> 272832 INFO  (commitScheduler-2145-thread-1) [    
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 272833 INFO  
(searcherExecutor-2142-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@31e28f99[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_3(7.0.0):C1)))}
   [junit4]   2> 273082 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[530 
(1549526431454724096)]} 0 1257
   [junit4]   2> 273082 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6D200348FF807EAD]) [    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> 273083 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6D200348FF807EAD]) [    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> 273087 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{delete=[529 (-1549526431459966976)]} 0 0
   [junit4]   2> 273087 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6D200348FF807EAD]) [    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> 274090 INFO  (commitScheduler-2145-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> 274094 INFO  (commitScheduler-2145-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@7767634f[collection1] main]
   [junit4]   2> 274094 INFO  (commitScheduler-2145-thread-1) [    
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 274095 INFO  
(searcherExecutor-2142-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@7767634f[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(7.0.0):C1)))}
   [junit4]   2> 274342 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[550 
(1549526432776978432)]} 0 2518
   [junit4]   2> 274343 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6D200348FF807EAD]) [    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> 274343 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1549526432778027008)]} 0 2519
   [junit4]   2> 274343 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1549526432778027009)]} 0 2519
   [junit4]   2> 274344 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1549526432778027010)]} 0 2519
   [junit4]   2> 274344 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1549526432779075584)]} 0 2520
   [junit4]   2> 274344 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1549526432779075585)]} 0 2520
   [junit4]   2> 274344 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1549526432779075586)]} 0 2520
   [junit4]   2> 274344 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1549526432779075587)]} 0 2520
   [junit4]   2> 274344 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1549526432779075588)]} 0 2520
   [junit4]   2> 274345 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1549526432780124160)]} 0 2520
   [junit4]   2> 274345 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1549526432780124161)]} 0 2521
   [junit4]   2> 274345 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6D200348FF807EAD]) [    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> 275344 INFO  (commitScheduler-2145-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> 275347 INFO  (commitScheduler-2145-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@3d52798e[collection1] main]
   [junit4]   2> 275347 INFO  (commitScheduler-2145-thread-1) [    
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 275347 INFO  
(searcherExecutor-2142-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@3d52798e[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(7.0.0):C1)
 Uninverting(_5(7.0.0):C11/9:delGen=1)))}
   [junit4]   2> 275353 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[531 
(1549526433836040192)]} 0 3529
   [junit4]   2> 275353 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6D200348FF807EAD]) [    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> 275353 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.SolrTestCaseJ4 ###Ending testMaxTime
   [junit4]   2> 275357 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.SolrTestCaseJ4 ###Starting testMaxDocs
   [junit4]   2> 275365 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@25e96118[collection1] realtime]
   [junit4]   2> 275365 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{deleteByQuery=*:* (-1549526433841283072)} 0 7
   [junit4]   2> 275366 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6D200348FF807EAD]) [    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> 275396 WARN  
(TEST-AutoCommitTest.testMaxDocs-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use 
<mergePolicyFactory> instead.
   [junit4]   2> 275397 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 275417 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 275501 WARN  
(TEST-AutoCommitTest.testMaxDocs-seed#[6D200348FF807EAD]) [    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> 275503 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 275509 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6D200348FF807EAD]) [    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> 275509 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1],
 
dataDir=[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest_6D200348FF807EAD-001/init-core-data-001/]
   [junit4]   2> 275509 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX 
Server: com.sun.jmx.mbeanserver.JmxMBeanServer@2591a1fd
   [junit4]   2> 275528 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 275528 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 275528 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@add1c69[collection1] main]
   [junit4]   2> 275529 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 275529 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 275532 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 275532 INFO  
(searcherExecutor-2146-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 275533 INFO  
(searcherExecutor-2146-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 275533 INFO  
(searcherExecutor-2146-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 275533 INFO  
(searcherExecutor-2146-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 275533 INFO  
(searcherExecutor-2146-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 275534 INFO  
(searcherExecutor-2146-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 275534 INFO  
(searcherExecutor-2146-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 275534 INFO  
(searcherExecutor-2146-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 275535 INFO  
(searcherExecutor-2146-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 275536 INFO  
(searcherExecutor-2146-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@add1c69[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 275536 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: 
minMergeSize=0, mergeFactor=10, maxMergeSize=914840206, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.1]
   [junit4]   2> 275536 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 275537 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@326a3295[collection1] main]
   [junit4]   2> 275537 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@20969c84
   [junit4]   2> 275546 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[0 
(1549526434038415360)]} 0 0
   [junit4]   2> 275546 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[1 
(1549526434039463936)]} 0 1
   [junit4]   2> 275546 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[2 
(1549526434039463937)]} 0 1
   [junit4]   2> 275546 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[3 
(1549526434039463938)]} 0 1
   [junit4]   2> 275547 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[4 
(1549526434040512512)]} 0 1
   [junit4]   2> 275547 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[5 
(1549526434040512513)]} 0 1
   [junit4]   2> 275547 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[6 
(1549526434040512514)]} 0 2
   [junit4]   2> 275548 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[7 
(1549526434040512515)]} 0 2
   [junit4]   2> 275548 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[8 
(1549526434041561088)]} 0 2
   [junit4]   2> 275548 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[9 
(1549526434041561089)]} 0 2
   [junit4]   2> 275548 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[10 
(1549526434041561090)]} 0 3
   [junit4]   2> 275548 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[11 
(1549526434041561091)]} 0 3
   [junit4]   2> 275548 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[12 
(1549526434041561092)]} 0 3
   [junit4]   2> 275549 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[13 
(1549526434042609664)]} 0 3
   [junit4]   2> 275549 INFO  
(searcherExecutor-2146-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@326a3295[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 275550 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6D200348FF807EAD]) [    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=1
   [junit4]   2> 275550 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[14 
(1549526434043658240)]} 0 5
   [junit4]   2> 275551 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[15 
(1549526434043658241)]} 0 5
   [junit4]   2> 275551 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:14&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
   [junit4]   2> 275551 ERROR 
(TEST-AutoCommitTest.testMaxDocs-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.SolrTestCaseJ4 REQUEST FAILED: xpath=//result[@numFound=1]
   [junit4]   2>        xml response was: <?xml version="1.0" encoding="UTF-8"?>
   [junit4]   2> <response>
   [junit4]   2> <lst name="responseHeader"><int name="status">0</int><int 
name="QTime">0</int></lst><result name="response" numFound="0" 
start="0"></result>
   [junit4]   2> </response>
   [junit4]   2> 
   [junit4]   2>        request 
was:q=id:14&qt=standard&start=0&rows=20&version=2.2
   [junit4]   2> 275551 ERROR 
(TEST-AutoCommitTest.testMaxDocs-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.SolrTestCaseJ4 REQUEST FAILED: 
q=id:14&qt=standard&start=0&rows=20&version=2.2:java.lang.RuntimeException: 
REQUEST FAILED: xpath=//result[@numFound=1]
   [junit4]   2>        xml response was: <?xml version="1.0" encoding="UTF-8"?>
   [junit4]   2> <response>
   [junit4]   2> <lst name="responseHeader"><int name="status">0</int><int 
name="QTime">0</int></lst><result name="response" numFound="0" 
start="0"></result>
   [junit4]   2> </response>
   [junit4]   2> 
   [junit4]   2>        request 
was:q=id:14&qt=standard&start=0&rows=20&version=2.2
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:805)
   [junit4]   2>        at 
org.apache.solr.update.AutoCommitTest.testMaxDocs(AutoCommitTest.java:225)
   [junit4]   2>        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native 
Method)
   [junit4]   2>        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
   [junit4]   2>        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   [junit4]   2>        at java.lang.reflect.Method.invoke(Method.java:498)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
   [junit4]   2>        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:811)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:462)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
   [junit4]   2>        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 
   [junit4]   2> 275552 INFO  (commitScheduler-2149-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> 275552 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[6D200348FF807EAD]) [    x:collection1] 
o.a.s.SolrTestCaseJ4 ###Ending testMaxDocs
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=AutoCommitTest 
-Dtests.method=testMaxDocs -Dtests.seed=6D200348FF807EAD -Dtests.slow=true 
-Dtests.locale=ga -Dtests.timezone=Etc/GMT+12 -Dtests.asserts=true 
-Dtests.file.encoding=ISO-8859-1
   [junit4] ERROR   0.21s J1 | AutoCommitTest.testMaxDocs <<<
   [junit4]    > Throwable #1: java.lang.RuntimeException: Exception during 
query
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([6D200348FF807EAD:D4A1D597D36A7A27]:0)
   [junit4]    >        at 
org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:812)
   [junit4]    >        at 
org.apache.solr.update.AutoCommitTest.testMaxDocs(AutoCommitTest.java:225)
   [junit4]    >        at java.lang.Thread.run(Thread.java:745)
   [junit4]    > Caused by: java.lang.RuntimeException: REQUEST FAILED: 
xpath=//result[@numFound=1]
   [junit4]    >        xml response was: <?xml version="1.0" encoding="UTF-8"?>
   [junit4]    > <response>
   [junit4]    > <lst name="responseHeader"><int name="status">0</int><int 
name="QTime">0</int></lst><result name="response" numFound="0" 
start="0"></result>
   [junit4]    > </response>
   [junit4]    >        request 
was:q=id:14&qt=standard&start=0&rows=20&version=2.2
   [junit4]    >        at 
org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:805)
   [junit4]    >        ... 40 more
   [junit4]   2> 275561 INFO  
(SUITE-AutoCommitTest-seed#[6D200348FF807EAD]-worker) [    x:collection1] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> 275561 INFO  
(SUITE-AutoCommitTest-seed#[6D200348FF807EAD]-worker) [    x:collection1] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=677721075
   [junit4]   2> 275562 INFO  
(coreCloseExecutor-2150-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@6dde7bb7
   [junit4]   2> 275562 INFO  
(coreCloseExecutor-2150-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter close.
   [junit4]   2> 275563 INFO  (commitScheduler-2149-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@1fd215c0[collection1] main]
   [junit4]   2> 275564 ERROR (commitScheduler-2149-thread-1) [    
x:collection1] o.a.s.u.CommitTracker auto commit 
error...:org.apache.solr.common.SolrException: Error opening new searcher
   [junit4]   2>        at 
org.apache.solr.core.SolrCore.openNewSearcher(SolrCore.java:1836)
   [junit4]   2>        at 
org.apache.solr.core.SolrCore.getSearcher(SolrCore.java:1947)
   [junit4]   2>        at 
org.apache.solr.update.DirectUpdateHandler2.commit(DirectUpdateHandler2.java:630)
   [junit4]   2>        at 
org.apache.solr.update.CommitTracker.run(CommitTracker.java:217)
   [junit4]   2>        at 
java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
   [junit4]   2>        at 
java.util.concurrent.FutureTask.run(FutureTask.java:266)
   [junit4]   2>        at 
java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180)
   [junit4]   2>        at 
java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293)
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> Caused by: org.apache.solr.common.SolrException: 
openNewSearcher called on closed core
   [junit4]   2>        at 
org.apache.solr.core.SolrCore.openNewSearcher(SolrCore.java:1823)
   [junit4]   2>        ... 10 more
   [junit4]   2> 
   [junit4]   2> 275564 INFO  
(coreCloseExecutor-2150-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@36c15f2c
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest_6D200348FF807EAD-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): 
{range_facet_l_dv=PostingsFormat(name=Memory doPackFST= true), 
_version_=PostingsFormat(name=LuceneFixedGap), 
field_t=PostingsFormat(name=LuceneVarGapFixedInterval), 
multiDefault=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
 
subject=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
 intDefault=PostingsFormat(name=LuceneFixedGap), id=PostingsFormat(name=Memory 
doPackFST= true), range_facet_i_dv=PostingsFormat(name=LuceneFixedGap), 
text=PostingsFormat(name=LuceneVarGapFixedInterval), 
range_facet_l=PostingsFormat(name=LuceneFixedGap), 
timestamp=PostingsFormat(name=LuceneFixedGap)}, 
docValues:{range_facet_l_dv=DocValuesFormat(name=Lucene70), 
range_facet_i_dv=DocValuesFormat(name=Direct), 
timestamp=DocValuesFormat(name=Direct)}, maxPointsInLeafNode=1798, 
maxMBSortInHeap=7.832314210798488, sim=RandomSimilarity(queryNorm=false): {}, 
locale=ga, timezone=Etc/GMT+12
   [junit4]   2> NOTE: SunOS 5.11 amd64/Oracle Corporation 1.8.0_102 
(64-bit)/cpus=3,threads=1,free=60786096,total=156676096
   [junit4]   2> NOTE: All tests run in this JVM: 
[TestSolrConfigHandlerConcurrent, TestRawTransformer, HLLUtilTest, 
TestCloudManagedSchema, ExternalFileFieldSortTest, 
DistributedFacetPivotLongTailTest, TestDistribDocBasedVersion, 
TestStressLiveNodes, TestReversedWildcardFilterFactory, 
AsyncCallRequestStatusResponseTest, TestMacros, StressHdfsTest, 
TestConfigSetProperties, CleanupOldIndexTest, FileBasedSpellCheckerTest, 
TestSolrCloudWithDelegationTokens, LeaderElectionIntegrationTest, 
TestExpandComponent, TestDistributedGrouping, TestSolrDynamicMBean, 
TestCollapseQParserPlugin, AutoCommitTest]
   [junit4] Completed [48/647 (1!)] on J1 in 11.59s, 3 tests, 1 error <<< 
FAILURES!

[...truncated 62322 lines...]

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

Reply via email to