lucene-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Policeman Jenkins Server <jenk...@thetaphi.de>
Subject [JENKINS] Lucene-Solr-7.x-Solaris (64bit/jdk1.8.0) - Build # 57 - Unstable!
Date Thu, 20 Jul 2017 18:44:33 GMT
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Solaris/57/
Java: 64bit/jdk1.8.0 -XX:+UseCompressedOops -XX:+UseConcMarkSweepGC

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

Error Message:
Exception during query

Stack Trace:
java.lang.RuntimeException: Exception during query
	at __randomizedtesting.SeedInfo.seed([A6C3DE6D385B1AF1:1C11B115BB75F4E4]:0)
	at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:878)
	at org.apache.solr.update.AutoCommitTest.testCommitWithin(AutoCommitTest.java:353)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:498)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java: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:368)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
	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:368)
	at java.lang.Thread.run(Thread.java:748)
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=&start=0&rows=20&version=2.2
	at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:871)
	... 40 more




Build Log:
[...truncated 11812 lines...]
   [junit4] Suite: org.apache.solr.update.AutoCommitTest
   [junit4]   2> Creating dataDir: /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest_A6C3DE6D385B1AF1-001/init-core-data-001
   [junit4]   2> 1813319 WARN  (SUITE-AutoCommitTest-seed#[A6C3DE6D385B1AF1]-worker) [    ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=2 numCloses=2
   [junit4]   2> 1813319 INFO  (SUITE-AutoCommitTest-seed#[A6C3DE6D385B1AF1]-worker) [    ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 1813321 INFO  (SUITE-AutoCommitTest-seed#[A6C3DE6D385B1AF1]-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> 1813321 INFO  (SUITE-AutoCommitTest-seed#[A6C3DE6D385B1AF1]-worker) [    ] o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 1813322 INFO  (SUITE-AutoCommitTest-seed#[A6C3DE6D385B1AF1]-worker) [    ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1/lib, /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1813372 INFO  (SUITE-AutoCommitTest-seed#[A6C3DE6D385B1AF1]-worker) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.1.0
   [junit4]   2> 1813414 INFO  (SUITE-AutoCommitTest-seed#[A6C3DE6D385B1AF1]-worker) [    ] o.a.s.s.IndexSchema [null] Schema name=test
   [junit4]   2> 1813613 INFO  (SUITE-AutoCommitTest-seed#[A6C3DE6D385B1AF1]-worker) [    ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1813675 INFO  (SUITE-AutoCommitTest-seed#[A6C3DE6D385B1AF1]-worker) [    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2321a703
   [junit4]   2> 1813679 INFO  (SUITE-AutoCommitTest-seed#[A6C3DE6D385B1AF1]-worker) [    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2321a703
   [junit4]   2> 1813680 INFO  (SUITE-AutoCommitTest-seed#[A6C3DE6D385B1AF1]-worker) [    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2321a703
   [junit4]   2> 1813692 INFO  (coreLoadExecutor-7665-thread-1) [    x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1/lib, /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1813739 INFO  (coreLoadExecutor-7665-thread-1) [    x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.1.0
   [junit4]   2> 1813797 INFO  (coreLoadExecutor-7665-thread-1) [    x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1814023 INFO  (coreLoadExecutor-7665-thread-1) [    x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1814049 INFO  (coreLoadExecutor-7665-thread-1) [    x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1, trusted=true
   [junit4]   2> 1814050 INFO  (coreLoadExecutor-7665-thread-1) [    x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2321a703
   [junit4]   2> 1814050 INFO  (coreLoadExecutor-7665-thread-1) [    x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 1814050 INFO  (coreLoadExecutor-7665-thread-1) [    x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1], dataDir=[/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest_A6C3DE6D385B1AF1-001/init-core-data-001/]
   [junit4]   2> 1814052 INFO  (coreLoadExecutor-7665-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=44, maxMergeAtOnceExplicit=37, maxMergedSegmentMB=41.48046875, floorSegmentMB=0.4541015625, forceMergeDeletesPctAllowed=28.35175544817057, segmentsPerTier=11.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 1814165 INFO  (coreLoadExecutor-7665-thread-1) [    x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1814165 INFO  (coreLoadExecutor-7665-thread-1) [    x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1814167 INFO  (coreLoadExecutor-7665-thread-1) [    x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1814167 INFO  (coreLoadExecutor-7665-thread-1) [    x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1814168 INFO  (coreLoadExecutor-7665-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=33, maxMergeAtOnceExplicit=35, maxMergedSegmentMB=53.669921875, floorSegmentMB=1.1875, forceMergeDeletesPctAllowed=2.2158787862525764, segmentsPerTier=12.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 1814168 INFO  (coreLoadExecutor-7665-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@2c7e7bdb[collection1] main]
   [junit4]   2> 1814175 INFO  (coreLoadExecutor-7665-thread-1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1814235 INFO  (coreLoadExecutor-7665-thread-1) [    x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 1814408 INFO  (coreLoadExecutor-7665-thread-1) [    x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1814408 INFO  (coreLoadExecutor-7665-thread-1) [    x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1573465695519244288
   [junit4]   2> 1814413 INFO  (searcherExecutor-7666-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1814422 INFO  (searcherExecutor-7666-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1814422 INFO  (searcherExecutor-7666-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1814423 INFO  (searcherExecutor-7666-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
   [junit4]   2> 1814437 INFO  (searcherExecutor-7666-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1814444 INFO  (searcherExecutor-7666-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1814452 INFO  (searcherExecutor-7666-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1814457 INFO  (searcherExecutor-7666-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 1814462 INFO  (SUITE-AutoCommitTest-seed#[A6C3DE6D385B1AF1]-worker) [    ] o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 1814462 INFO  (searcherExecutor-7666-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 1814499 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A6C3DE6D385B1AF1]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testMaxTime
   [junit4]   2> 1814499 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A6C3DE6D385B1AF1]) [    ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1814501 INFO  (searcherExecutor-7666-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@2c7e7bdb[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1814501 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A6C3DE6D385B1AF1]) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@655e45a8[collection1] realtime]
   [junit4]   2> 1814501 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A6C3DE6D385B1AF1]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}{deleteByQuery=*:* (-9223372036854775807)} 0 2
   [junit4]   2> 1814501 ERROR (TEST-AutoCommitTest.testMaxTime-seed#[A6C3DE6D385B1AF1]) [    ] o.a.s.c.CorePropertiesLocator Couldn't load core descriptor from /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1/core.properties:java.nio.file.NoSuchFileException: /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1/core.properties
   [junit4]   2> 1814502 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A6C3DE6D385B1AF1]) [    ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1/lib, /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1814596 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A6C3DE6D385B1AF1]) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.1.0
   [junit4]   2> 1814638 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A6C3DE6D385B1AF1]) [    ] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1814978 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A6C3DE6D385B1AF1]) [    ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1814990 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A6C3DE6D385B1AF1]) [    ] o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using configuration from instancedir /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1
   [junit4]   2> 1815033 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2321a703
   [junit4]   2> 1815033 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1], dataDir=[/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest_A6C3DE6D385B1AF1-001/init-core-data-001/]
   [junit4]   2> 1815130 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1815131 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1815132 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@3bee88c1[collection1] main]
   [junit4]   2> 1815132 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1815133 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 1815136 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1815137 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1573465696283656192
   [junit4]   2> 1815146 INFO  (searcherExecutor-7671-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1815146 INFO  (searcherExecutor-7671-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1815146 INFO  (searcherExecutor-7671-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1815146 INFO  (searcherExecutor-7671-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
   [junit4]   2> 1815147 INFO  (searcherExecutor-7671-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1815147 INFO  (searcherExecutor-7671-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1815147 INFO  (searcherExecutor-7671-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1815147 INFO  (searcherExecutor-7671-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 1815148 INFO  (searcherExecutor-7671-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 1815150 INFO  (searcherExecutor-7671-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@3bee88c1[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1815151 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=557569077, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
   [junit4]   2> 1815151 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 1815151 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@19b5224b[collection1] main]
   [junit4]   2> 1815152 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@4e178d00
   [junit4]   2> 1815152 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=1310166272
   [junit4]   2> 1815158 INFO  (searcherExecutor-7671-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@19b5224b[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1815186 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[529 (1573465696333987840)]} 0 2
   [junit4]   2> 1815187 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:529&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
   [junit4]   2> 1816687 INFO  (commitScheduler-7674-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> 1816690 INFO  (commitScheduler-7674-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@227b343b[collection1] main]
   [junit4]   2> 1816690 INFO  (commitScheduler-7674-thread-1) [    x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1816694 INFO  (searcherExecutor-7671-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@227b343b[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.1.0):C1)))}
   [junit4]   2> 1816942 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[530 (1573465698176335872)]} 0 1758
   [junit4]   2> 1816943 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:529&qt=&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0
   [junit4]   2> 1816943 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:530&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
   [junit4]   2> 1816944 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{delete=[529 (-1573465698178433024)]} 0 0
   [junit4]   2> 1816944 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:529&qt=&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0
   [junit4]   2> 1818443 INFO  (commitScheduler-7674-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> 1818444 INFO  (commitScheduler-7674-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@451b07e0[collection1] main]
   [junit4]   2> 1818445 INFO  (commitScheduler-7674-thread-1) [    x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1818446 INFO  (searcherExecutor-7671-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@451b07e0[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(7.1.0):C1)))}
   [junit4]   2> 1818448 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[550 (1573465699754442752)]} 0 3264
   [junit4]   2> 1818448 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:529&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
   [junit4]   2> 1818449 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1573465699756539904)]} 0 3265
   [junit4]   2> 1818449 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1573465699756539905)]} 0 3265
   [junit4]   2> 1818449 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1573465699756539906)]} 0 3265
   [junit4]   2> 1818449 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1573465699756539907)]} 0 3266
   [junit4]   2> 1818450 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1573465699757588480)]} 0 3266
   [junit4]   2> 1818450 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1573465699757588481)]} 0 3266
   [junit4]   2> 1818450 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1573465699757588482)]} 0 3266
   [junit4]   2> 1818450 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1573465699757588483)]} 0 3266
   [junit4]   2> 1818450 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1573465699757588484)]} 0 3266
   [junit4]   2> 1818450 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1573465699757588485)]} 0 3266
   [junit4]   2> 1818451 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:500&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
   [junit4]   2> 1819949 INFO  (commitScheduler-7674-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> 1819952 INFO  (commitScheduler-7674-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@4063baab[collection1] main]
   [junit4]   2> 1819952 INFO  (commitScheduler-7674-thread-1) [    x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1819954 INFO  (searcherExecutor-7671-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@4063baab[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(7.1.0):C1) Uninverting(_2(7.1.0):C11/9:delGen=1)))}
   [junit4]   2> 1819959 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[531 (1573465701338841088)]} 0 4776
   [junit4]   2> 1819959 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:500&qt=&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0
   [junit4]   2> 1819960 INFO  (TEST-AutoCommitTest.testMaxTime-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.SolrTestCaseJ4 ###Ending testMaxTime
   [junit4]   2> 1819967 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.SolrTestCaseJ4 ###Starting testMaxDocs
   [junit4]   2> 1819967 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1819967 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@6f75cab3[collection1] realtime]
   [junit4]   2> 1819968 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}{deleteByQuery=*:* (-9223372036854775807)} 0 0
   [junit4]   2> 1819968 ERROR (TEST-AutoCommitTest.testMaxDocs-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.c.CorePropertiesLocator Couldn't load core descriptor from /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1/core.properties:java.nio.file.NoSuchFileException: /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1/core.properties
   [junit4]   2> 1819969 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1/lib, /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1820015 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.1.0
   [junit4]   2> 1820043 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1820257 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1820318 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using configuration from instancedir /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1
   [junit4]   2> 1820335 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2321a703
   [junit4]   2> 1820335 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1], dataDir=[/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest_A6C3DE6D385B1AF1-001/init-core-data-001/]
   [junit4]   2> 1820391 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1820391 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1820392 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1d547a27[collection1] main]
   [junit4]   2> 1820392 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1820393 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 1820432 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1820432 INFO  (searcherExecutor-7675-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1820433 INFO  (searcherExecutor-7675-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1820433 INFO  (searcherExecutor-7675-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1820433 INFO  (searcherExecutor-7675-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
   [junit4]   2> 1820433 INFO  (searcherExecutor-7675-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1820433 INFO  (searcherExecutor-7675-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1820434 INFO  (searcherExecutor-7675-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1820434 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=14, maxMergeAtOnceExplicit=13, maxMergedSegmentMB=26.37890625, floorSegmentMB=1.310546875, forceMergeDeletesPctAllowed=6.900246566144801, segmentsPerTier=27.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 1820434 INFO  (searcherExecutor-7675-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 1820434 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 1820435 INFO  (searcherExecutor-7675-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 1820437 INFO  (searcherExecutor-7675-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1d547a27[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1820437 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@24b86174[collection1] main]
   [junit4]   2> 1820437 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@4cba4a56
   [junit4]   2> 1820438 INFO  (searcherExecutor-7675-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@24b86174[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1820439 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=1287277142
   [junit4]   2> 1820441 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[0 (1573465701845303296)]} 0 0
   [junit4]   2> 1820441 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[1 (1573465701845303297)]} 0 0
   [junit4]   2> 1820441 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[2 (1573465701845303298)]} 0 0
   [junit4]   2> 1820441 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[3 (1573465701845303299)]} 0 0
   [junit4]   2> 1820441 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[4 (1573465701845303300)]} 0 0
   [junit4]   2> 1820441 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[5 (1573465701845303301)]} 0 1
   [junit4]   2> 1820442 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[6 (1573465701846351872)]} 0 1
   [junit4]   2> 1820442 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[7 (1573465701846351873)]} 0 1
   [junit4]   2> 1820442 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[8 (1573465701846351874)]} 0 1
   [junit4]   2> 1820442 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[9 (1573465701846351875)]} 0 1
   [junit4]   2> 1820442 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[10 (1573465701846351876)]} 0 1
   [junit4]   2> 1820442 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[11 (1573465701846351877)]} 0 1
   [junit4]   2> 1820442 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[12 (1573465701846351878)]} 0 1
   [junit4]   2> 1820442 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[13 (1573465701846351879)]} 0 1
   [junit4]   2> 1820442 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:1&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
   [junit4]   2> 1820443 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[14 (1573465701847400448)]} 0 2
   [junit4]   2> 1820444 INFO  (commitScheduler-7678-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> 1820445 INFO  (commitScheduler-7678-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@227139e0[collection1] main]
   [junit4]   2> 1820446 INFO  (commitScheduler-7678-thread-1) [    x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1820447 INFO  (searcherExecutor-7675-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@227139e0[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(7.1.0):C15)))}
   [junit4]   2> 1820693 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[15 (1573465702109544448)]} 0 252
   [junit4]   2> 1820694 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:14&qt=&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0
   [junit4]   2> 1820694 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:15&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
   [junit4]   2> 1820694 INFO  (TEST-AutoCommitTest.testMaxDocs-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.SolrTestCaseJ4 ###Ending testMaxDocs
   [junit4]   2> 1820703 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.SolrTestCaseJ4 ###Starting testCommitWithin
   [junit4]   2> 1820703 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1820704 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@f0f7384[collection1] realtime]
   [junit4]   2> 1820704 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}{deleteByQuery=*:* (-9223372036854775807)} 0 0
   [junit4]   2> 1820704 ERROR (TEST-AutoCommitTest.testCommitWithin-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.c.CorePropertiesLocator Couldn't load core descriptor from /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1/core.properties:java.nio.file.NoSuchFileException: /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1/core.properties
   [junit4]   2> 1820705 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1/lib, /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1820765 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.1.0
   [junit4]   2> 1820782 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1821078 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1821089 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using configuration from instancedir /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1
   [junit4]   2> 1821110 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2321a703
   [junit4]   2> 1821110 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1], dataDir=[/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest_A6C3DE6D385B1AF1-001/init-core-data-001/]
   [junit4]   2> 1821247 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1821247 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1821248 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@28877509[collection1] main]
   [junit4]   2> 1821248 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1821249 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 1821251 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1821251 INFO  (searcherExecutor-7679-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1821275 INFO  (searcherExecutor-7679-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1821275 INFO  (searcherExecutor-7679-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1821275 INFO  (searcherExecutor-7679-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
   [junit4]   2> 1821275 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=43, maxMergeAtOnceExplicit=39, maxMergedSegmentMB=64.8076171875, floorSegmentMB=0.73828125, forceMergeDeletesPctAllowed=20.61619559062796, segmentsPerTier=49.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 1821275 INFO  (searcherExecutor-7679-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1821275 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 1821276 INFO  (searcherExecutor-7679-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1821277 INFO  (searcherExecutor-7679-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1821277 INFO  (searcherExecutor-7679-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 1821277 INFO  (searcherExecutor-7679-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 1821280 INFO  (searcherExecutor-7679-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@28877509[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1821280 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@517d0f3e[collection1] main]
   [junit4]   2> 1821282 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@7f279506
   [junit4]   2> 1821282 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=2133300486
   [junit4]   2> 1821287 INFO  (searcherExecutor-7679-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@517d0f3e[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1821288 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[529 (1573465702732398592)]} 0 1
   [junit4]   2> 1821288 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:529&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
   [junit4]   2> 1821288 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[530 (1573465702733447168)]} 0 1
   [junit4]   2> 1821288 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:530&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
   [junit4]   2> 1821289 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[529 (-1573465702734495744)]} 0 2
   [junit4]   2> 1821289 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:529&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
   [junit4]   2> 1821289 ERROR (TEST-AutoCommitTest.testCommitWithin-seed#[A6C3DE6D385B1AF1]) [    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=&start=0&rows=20&version=2.2
   [junit4]   2> 1821289 ERROR (TEST-AutoCommitTest.testCommitWithin-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.SolrTestCaseJ4 REQUEST FAILED: q=id:529&qt=&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=&start=0&rows=20&version=2.2
   [junit4]   2> 	at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:871)
   [junit4]   2> 	at org.apache.solr.update.AutoCommitTest.testCommitWithin(AutoCommitTest.java:353)
   [junit4]   2> 	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   [junit4]   2> 	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
   [junit4]   2> 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   [junit4]   2> 	at java.lang.reflect.Method.invoke(Method.java:498)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java: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:368)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
   [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:368)
   [junit4]   2> 	at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> 
   [junit4]   2> 1821290 INFO  (TEST-AutoCommitTest.testCommitWithin-seed#[A6C3DE6D385B1AF1]) [    x:collection1] o.a.s.SolrTestCaseJ4 ###Ending testCommitWithin
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=AutoCommitTest -Dtests.method=testCommitWithin -Dtests.seed=A6C3DE6D385B1AF1 -Dtests.slow=true -Dtests.locale=ga-IE -Dtests.timezone=Kwajalein -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
   [junit4] ERROR   0.59s J1 | AutoCommitTest.testCommitWithin <<<
   [junit4]    > Throwable #1: java.lang.RuntimeException: Exception during query
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([A6C3DE6D385B1AF1:1C11B115BB75F4E4]:0)
   [junit4]    > 	at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:878)
   [junit4]    > 	at org.apache.solr.update.AutoCommitTest.testCommitWithin(AutoCommitTest.java:353)
   [junit4]    > 	at java.lang.Thread.run(Thread.java:748)
   [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=&start=0&rows=20&version=2.2
   [junit4]    > 	at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:871)
   [junit4]    > 	... 40 more
   [junit4]   2> 1821291 INFO  (SUITE-AutoCommitTest-seed#[A6C3DE6D385B1AF1]-worker) [    x:collection1] o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> 1821291 INFO  (SUITE-AutoCommitTest-seed#[A6C3DE6D385B1AF1]-worker) [    x:collection1] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1312495548
   [junit4]   2> 1821291 INFO  (SUITE-AutoCommitTest-seed#[A6C3DE6D385B1AF1]-worker) [    x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
   [junit4]   2> 1821294 INFO  (SUITE-AutoCommitTest-seed#[A6C3DE6D385B1AF1]-worker) [    x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
   [junit4]   2> 1821295 INFO  (SUITE-AutoCommitTest-seed#[A6C3DE6D385B1AF1]-worker) [    x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
   [junit4]   2> 1821295 INFO  (SUITE-AutoCommitTest-seed#[A6C3DE6D385B1AF1]-worker) [    x:collection1] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
   [junit4]   2> 1821295 INFO  (coreCloseExecutor-7683-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@1e18f676
   [junit4]   2> 1821295 INFO  (coreCloseExecutor-7683-thread-1-processing-x:collection1) [    x:collection1] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter close.
   [junit4]   2> 1821295 INFO  (coreCloseExecutor-7683-thread-1-processing-x:collection1) [    x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@4fa987fa commitCommandVersion:0
   [junit4]   2> 1821296 INFO  (coreCloseExecutor-7683-thread-1-processing-x:collection1) [    x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=504952438
   [junit4]   2> NOTE: leaving temporary files on disk at: /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest_A6C3DE6D385B1AF1-001
   [junit4]   2> NOTE: test params are: codec=FastCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=FAST, chunkSize=5, maxDocsPerChunk=1, blockSize=6), termVectorsFormat=CompressingTermVectorsFormat(compressionMode=FAST, chunkSize=5, blockSize=6)), sim=RandomSimilarity(queryNorm=true): {}, locale=ga-IE, timezone=Kwajalein
   [junit4]   2> NOTE: SunOS 5.11 amd64/Oracle Corporation 1.8.0_131 (64-bit)/cpus=3,threads=1,free=234470128,total=375042048
   [junit4]   2> NOTE: All tests run in this JVM: [TestCollectionAPIs, ReplicaListTransformerTest, TestPerFieldSimilarity, TestExactSharedStatsCache, TestCollationField, DistributedFacetPivotLargeTest, TestBadConfig, TestXmlQParser, TestElisionMultitermQuery, TestSolrFieldCacheBean, TestSolrCloudWithSecureImpersonation, TestRandomCollapseQParserPlugin, TestRestManager, SubstringBytesRefFilterTest, TestMultiWordSynonyms, TestFastLRUCache, TestCollationFieldDocValues, TestSchemaNameResource, TestUnifiedSolrHighlighter, TestOverriddenPrefixQueryForCustomFieldType, TestMinMaxOnMultiValuedField, DeleteReplicaTest, TestDistributedGrouping, TestDocSet, TestPartialUpdateDeduplication, TestLRUCache, SchemaVersionSpecificBehaviorTest, TestRemoteStreaming, TestSimpleTrackingShardHandler, TestManagedStopFilterFactory, OverseerModifyCollectionTest, TestScoreJoinQPNoScore, DistributedQueryElevationComponentTest, TestExpandComponent, SolrPluginUtilsTest, DistributedExpandComponentTest, DistributedFacetPivotSmallAdvancedTest, TestStressInPlaceUpdates, TestRawTransformer, TestTolerantUpdateProcessorRandomCloud, TestFieldSortValues, OpenCloseCoreStressTest, TestNumericTerms64, DocExpirationUpdateProcessorFactoryTest, TestConfigReload, SOLR749Test, TestIntervalFaceting, TestSQLHandlerNonCloud, TestAuthenticationFramework, SparseHLLTest, SimpleMLTQParserTest, MergeStrategyTest, TestSolrCloudWithDelegationTokens, TestLeaderInitiatedRecoveryThread, TestUseDocValuesAsStored, CollectionsAPIDistributedZkTest, TestNamedUpdateProcessors, TestRTimerTree, TestConfig, TestSolrQueryParser, SolrMetricReporterTest, TestReloadAndDeleteDocs, TestCloudRecovery, TermVectorComponentDistributedTest, TestManagedResource, RollingRestartTest, TestSchemaSimilarityResource, BlockCacheTest, SignatureUpdateProcessorFactoryTest, TestConfigSetsAPIExclusivity, TestQueryTypes, TestFastWriter, ZkStateReaderTest, TestLegacyFieldReuse, BaseCdcrDistributedZkTest, TestJsonRequest, DeleteStatusTest, SecurityConfHandlerTest, CoreMergeIndexesAdminHandlerTest, TestNumericTokenStream, StatsReloadRaceTest, HdfsRecoverLeaseTest, TestPivotHelperCode, TestCloudPivotFacet, TestDelegationWithHadoopAuth, ConfigureRecoveryStrategyTest, DistributedMLTComponentTest, TestSchemaManager, DocValuesNotIndexedTest, TestDocBasedVersionConstraints, RemoteQueryErrorTest, ClassificationUpdateProcessorFactoryTest, BadComponentTest, HdfsUnloadDistributedZkTest, MigrateRouteKeyTest, DirectSolrSpellCheckerTest, DistribDocExpirationUpdateProcessorTest, SampleTest, ConvertedLegacyTest, TestSimpleTextCodec, DocValuesMissingTest, AtomicUpdateProcessorFactoryTest, CollectionsAPIAsyncDistributedZkTest, CacheHeaderTest, TestJettySolrRunner, TestSolrDeletionPolicy1, TestConfigSets, BufferStoreTest, TestIndexSearcher, TestZkChroot, TestBulkSchemaConcurrent, FileBasedSpellCheckerTest, IndexSchemaRuntimeFieldTest, TestDocumentBuilder, TestInPlaceUpdatesStandalone, BlockJoinFacetDistribTest, TestGraphTermsQParserPlugin, JavabinLoaderTest, SolrCmdDistributorTest, SuggestComponentTest, SolrCoreMetricManagerTest, TestAuthorizationFramework, VersionInfoTest, PolyFieldTest, SolrRequestParserTest, SaslZkACLProviderTest, EchoParamsTest, RulesTest, TriLevelCompositeIdRoutingTest, TestSuggestSpellingConverter, SolrCloudReportersTest, TestQueryUtils, SpellCheckCollatorTest, PeerSyncWithIndexFingerprintCachingTest, UninvertDocValuesMergePolicyTest, LoggingHandlerTest, FacetPivotSmallTest, TestMacroExpander, MBeansHandlerTest, ReplicationFactorTest, TestReloadDeadlock, CursorMarkTest, TestBinaryResponseWriter, FieldMutatingUpdateProcessorTest, TestRuleBasedAuthorizationPlugin, ConcurrentDeleteAndCreateCollectionTest, TestHdfsUpdateLog, TestInitQParser, SolrCoreCheckLockOnStartupTest, SolrGangliaReporterTest, TestTlogReplica, TestExportWriter, BooleanFieldTest, TestLRUStatsCache, TestSystemIdResolver, TestComplexPhraseQParserPlugin, TestRTGBase, TestCoreDiscovery, TestRebalanceLeaders, TestSortByMinMaxFunction, LeaderInitiatedRecoveryOnCommitTest, TestSolrCloudWithHadoopAuthPlugin, TestMergePolicyConfig, TestValueSourceCache, SystemInfoHandlerTest, TestCustomStream, StatelessScriptUpdateProcessorFactoryTest, ZkNodePropsTest, DistributedFacetPivotWhiteBoxTest, TestNumericRangeQuery32, TestAnalyzedSuggestions, FullSolrCloudDistribCmdsTest, ActionThrottleTest, DeleteLastCustomShardedReplicaTest, DocValuesMultiTest, SpellingQueryConverterTest, TestFreeTextSuggestions, LukeRequestHandlerTest, ChaosMonkeySafeLeaderTest, BasicDistributedZk2Test, UnloadDistributedZkTest, OverseerTest, LeaderElectionIntegrationTest, ShardRoutingTest, BasicZkTest, TestReplicationHandler, ClusterStateUpdateTest, TestRandomFaceting, LeaderElectionTest, ZkSolrClientTest, ZkCLITest, ShardRoutingCustomTest, AutoCommitTest]
   [junit4] Completed [336/728 (1!)] on J1 in 8.01s, 3 tests, 1 error <<< FAILURES!

[...truncated 44723 lines...]

Mime
View raw message