Build: https://builds.apache.org/job/Lucene-Solr-Tests-master/1822/
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([814E8478C4B1CDE6:38CF52A7E85BC96C]:0)
at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:896)
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: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: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:889)
... 40 more
Build Log:
[...truncated 12170 lines...]
[junit4] Suite: org.apache.solr.update.AutoCommitTest
[junit4] 2> Creating dataDir:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.update.AutoCommitTest_814E8478C4B1CDE6-001/init-core-data-001
[junit4] 2> 1141495 WARN
(SUITE-AutoCommitTest-seed#[814E8478C4B1CDE6]-worker) [ ]
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=1 numCloses=1
[junit4] 2> 1141495 INFO
(SUITE-AutoCommitTest-seed#[814E8478C4B1CDE6]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields
[junit4] 2> 1141496 INFO
(SUITE-AutoCommitTest-seed#[814E8478C4B1CDE6]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via:
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 1141516 INFO
(SUITE-AutoCommitTest-seed#[814E8478C4B1CDE6]-worker) [ ]
o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 1141516 INFO
(SUITE-AutoCommitTest-seed#[814E8478C4B1CDE6]-worker) [ ]
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths:
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/lib,
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1141567 WARN
(SUITE-AutoCommitTest-seed#[814E8478C4B1CDE6]-worker) [ ] o.a.s.c.Config
Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory>
instead.
[junit4] 2> 1141569 INFO
(SUITE-AutoCommitTest-seed#[814E8478C4B1CDE6]-worker) [ ] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 7.0.0
[junit4] 2> 1141607 INFO
(SUITE-AutoCommitTest-seed#[814E8478C4B1CDE6]-worker) [ ]
o.a.s.s.IndexSchema [null] Schema name=test
[junit4] 2> 1141908 INFO
(SUITE-AutoCommitTest-seed#[814E8478C4B1CDE6]-worker) [ ]
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1141989 INFO
(SUITE-AutoCommitTest-seed#[814E8478C4B1CDE6]-worker) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@f2df7ed
[junit4] 2> 1141998 INFO
(SUITE-AutoCommitTest-seed#[814E8478C4B1CDE6]-worker) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@f2df7ed
[junit4] 2> 1141998 INFO
(SUITE-AutoCommitTest-seed#[814E8478C4B1CDE6]-worker) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@f2df7ed
[junit4] 2> 1142001 INFO (coreLoadExecutor-5261-thread-1) [
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader,
from paths:
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/lib,
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1142117 WARN (coreLoadExecutor-5261-thread-1) [
x:collection1] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is
deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 1142121 INFO (coreLoadExecutor-5261-thread-1) [
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 1142162 INFO (coreLoadExecutor-5261-thread-1) [
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1142407 INFO (coreLoadExecutor-5261-thread-1) [
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1142415 INFO (coreLoadExecutor-5261-thread-1) [
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using
configuration from instancedir
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1,
trusted=true
[junit4] 2> 1142416 INFO (coreLoadExecutor-5261-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@f2df7ed
[junit4] 2> 1142416 INFO (coreLoadExecutor-5261-thread-1) [
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1142416 INFO (coreLoadExecutor-5261-thread-1) [
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1],
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.update.AutoCommitTest_814E8478C4B1CDE6-001/init-core-data-001/]
[junit4] 2> 1142418 INFO (coreLoadExecutor-5261-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=27, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.5463091155843297]
[junit4] 2> 1142550 INFO (coreLoadExecutor-5261-thread-1) [
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 1142550 INFO (coreLoadExecutor-5261-thread-1) [
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10
numVersionBuckets=65536
[junit4] 2> 1142551 INFO (coreLoadExecutor-5261-thread-1) [
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1142551 INFO (coreLoadExecutor-5261-thread-1) [
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1142552 INFO (coreLoadExecutor-5261-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=34, maxMergeAtOnceExplicit=36, maxMergedSegmentMB=64.74609375,
floorSegmentMB=1.0087890625, forceMergeDeletesPctAllowed=27.204963010696147,
segmentsPerTier=31.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.765001125224141
[junit4] 2> 1142552 INFO (coreLoadExecutor-5261-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1490133[collection1]
main]
[junit4] 2> 1142553 INFO (coreLoadExecutor-5261-thread-1) [
x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 1142584 INFO (coreLoadExecutor-5261-thread-1) [
x:collection1] o.a.s.s.DirectSolrSpellChecker init:
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 1142657 INFO (coreLoadExecutor-5261-thread-1) [
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1142657 INFO
(searcherExecutor-5262-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 1142657 INFO (coreLoadExecutor-5261-thread-1) [
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent
updates, using new clock 1566882708064305152
[junit4] 2> 1142658 INFO
(searcherExecutor-5262-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 1142658 INFO
(searcherExecutor-5262-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 1142658 INFO
(searcherExecutor-5262-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker:
multipleFields
[junit4] 2> 1142658 INFO
(searcherExecutor-5262-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 1142658 INFO
(searcherExecutor-5262-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 1142658 INFO
(searcherExecutor-5262-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 1142659 INFO
(searcherExecutor-5262-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 1142659 INFO
(searcherExecutor-5262-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 1142660 INFO
(searcherExecutor-5262-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@1490133[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1142664 INFO
(SUITE-AutoCommitTest-seed#[814E8478C4B1CDE6]-worker) [ ]
o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 1142667 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[814E8478C4B1CDE6]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testMaxTime
[junit4] 2> 1142667 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[814E8478C4B1CDE6]) [ ]
o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 1142667 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[814E8478C4B1CDE6]) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@3eb7539e[collection1] realtime]
[junit4] 2> 1142668 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[814E8478C4B1CDE6]) [ ]
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 1
[junit4] 2> 1142668 ERROR
(TEST-AutoCommitTest.testMaxTime-seed#[814E8478C4B1CDE6]) [ ]
o.a.s.c.CorePropertiesLocator Couldn't load core descriptor from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/core.properties:java.nio.file.NoSuchFileException:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/core.properties
[junit4] 2> 1142670 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[814E8478C4B1CDE6]) [ ]
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths:
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/lib,
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1142714 WARN
(TEST-AutoCommitTest.testMaxTime-seed#[814E8478C4B1CDE6]) [ ] o.a.s.c.Config
Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory>
instead.
[junit4] 2> 1142716 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[814E8478C4B1CDE6]) [ ]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 1142816 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[814E8478C4B1CDE6]) [ ]
o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1143033 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[814E8478C4B1CDE6]) [ ]
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1143051 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[814E8478C4B1CDE6]) [ ]
o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using configuration from
instancedir
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1
[junit4] 2> 1144356 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[814E8478C4B1CDE6]) [ 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@f2df7ed
[junit4] 2> 1144356 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1],
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.update.AutoCommitTest_814E8478C4B1CDE6-001/init-core-data-001/]
[junit4] 2> 1144674 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1144674 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1144676 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@482a826e[collection1] main]
[junit4] 2> 1144677 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 1144686 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.s.DirectSolrSpellChecker init:
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 1144689 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1144689 INFO
(searcherExecutor-5267-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 1144690 INFO
(searcherExecutor-5267-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 1144690 INFO
(searcherExecutor-5267-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 1144690 INFO
(searcherExecutor-5267-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker:
multipleFields
[junit4] 2> 1144690 INFO
(searcherExecutor-5267-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 1144690 INFO
(searcherExecutor-5267-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 1144691 INFO
(searcherExecutor-5267-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 1144691 INFO
(searcherExecutor-5267-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 1144691 INFO
(searcherExecutor-5267-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 1144694 INFO
(searcherExecutor-5267-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@482a826e[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1144694 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1566882710200254464
[junit4] 2> 1144697 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=46, maxMergeAtOnceExplicit=20, maxMergedSegmentMB=26.0419921875,
floorSegmentMB=1.0458984375, forceMergeDeletesPctAllowed=3.327234566324331,
segmentsPerTier=16.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 1144698 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 1144698 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@421e3dc0[collection1] main]
[junit4] 2> 1144701 INFO
(searcherExecutor-5267-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@421e3dc0[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1144701 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@5ece9d54
[junit4] 2> 1144703 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection1, tag=1590598996
[junit4] 2> 1144762 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[529
(1566882710238003200)]} 0 32
[junit4] 2> 1144762 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[814E8478C4B1CDE6]) [ 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> 1146234 INFO (commitScheduler-5270-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> 1146240 INFO (commitScheduler-5270-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@4d13e6f7[collection1] main]
[junit4] 2> 1146240 INFO (commitScheduler-5270-thread-1) [
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1146243 INFO
(searcherExecutor-5267-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@4d13e6f7[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C1)))}
[junit4] 2> 1146307 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[530
(1566882711890558976)]} 0 1577
[junit4] 2> 1146307 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[814E8478C4B1CDE6]) [ 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> 1146308 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[814E8478C4B1CDE6]) [ 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> 1146308 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{delete=[529 (-1566882711892656128)]} 0 0
[junit4] 2> 1146309 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[814E8478C4B1CDE6]) [ 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> 1147807 INFO (commitScheduler-5270-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> 1147810 INFO (commitScheduler-5270-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@13bdc19f[collection1] main]
[junit4] 2> 1147810 INFO (commitScheduler-5270-thread-1) [
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1147812 INFO
(searcherExecutor-5267-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@13bdc19f[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(7.0.0):C1)))}
[junit4] 2> 1148061 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[550
(1566882713729761280)]} 0 3331
[junit4] 2> 1148061 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[814E8478C4B1CDE6]) [ 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> 1148062 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1566882713731858432)]} 0 3332
[junit4] 2> 1148062 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1566882713731858433)]} 0 3333
[junit4] 2> 1148062 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1566882713731858434)]} 0 3333
[junit4] 2> 1148063 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1566882713732907008)]} 0 3333
[junit4] 2> 1148063 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1566882713732907009)]} 0 3334
[junit4] 2> 1148063 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1566882713732907010)]} 0 3334
[junit4] 2> 1148064 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1566882713733955584)]} 0 3334
[junit4] 2> 1148064 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1566882713733955585)]} 0 3334
[junit4] 2> 1148064 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1566882713733955586)]} 0 3334
[junit4] 2> 1148064 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1566882713733955587)]} 0 3335
[junit4] 2> 1148064 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[814E8478C4B1CDE6]) [ 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> 1149561 INFO (commitScheduler-5270-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> 1149566 INFO (commitScheduler-5270-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@2d1eae10[collection1] main]
[junit4] 2> 1149566 INFO (commitScheduler-5270-thread-1) [
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1149568 INFO
(searcherExecutor-5267-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@2d1eae10[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(7.0.0):C1)
Uninverting(_2(7.0.0):C11/9:delGen=1)))}
[junit4] 2> 1149816 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[531
(1566882715570012160)]} 0 5086
[junit4] 2> 1149816 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[814E8478C4B1CDE6]) [ 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> 1149817 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.SolrTestCaseJ4 ###Ending testMaxTime
[junit4] 2> 1149820 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.SolrTestCaseJ4 ###Starting testMaxDocs
[junit4] 2> 1149820 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 1149821 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@31ee4cad[collection1] realtime]
[junit4] 2> 1149821 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[814E8478C4B1CDE6]) [ 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> 1149821 ERROR
(TEST-AutoCommitTest.testMaxDocs-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.c.CorePropertiesLocator Couldn't load core descriptor from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/core.properties:java.nio.file.NoSuchFileException:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/core.properties
[junit4] 2> 1149822 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths:
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/lib,
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1149867 WARN
(TEST-AutoCommitTest.testMaxDocs-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use
<mergePolicyFactory> instead.
[junit4] 2> 1149869 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 1149897 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1150084 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1150095 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using configuration from
instancedir
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1
[junit4] 2> 1150121 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[814E8478C4B1CDE6]) [ 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@f2df7ed
[junit4] 2> 1150121 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1],
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.update.AutoCommitTest_814E8478C4B1CDE6-001/init-core-data-001/]
[junit4] 2> 1150230 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1150230 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1150232 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@36a0f40a[collection1] main]
[junit4] 2> 1150233 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 1150234 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.s.DirectSolrSpellChecker init:
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 1150242 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1150246 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=46, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.8241472598432611]
[junit4] 2> 1150247 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 1150248 INFO
(searcherExecutor-5271-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 1150248 INFO
(searcherExecutor-5271-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 1150248 INFO
(searcherExecutor-5271-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 1150248 INFO
(searcherExecutor-5271-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker:
multipleFields
[junit4] 2> 1150249 INFO
(searcherExecutor-5271-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 1150249 INFO
(searcherExecutor-5271-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 1150249 INFO
(searcherExecutor-5271-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 1150250 INFO
(searcherExecutor-5271-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 1150250 INFO
(searcherExecutor-5271-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 1150254 INFO
(searcherExecutor-5271-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@36a0f40a[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1150255 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@47563ff[collection1] main]
[junit4] 2> 1150255 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@6ad6607
[junit4] 2> 1150256 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection1, tag=112027143
[junit4] 2> 1150262 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[0
(1566882716036628480)]} 0 2
[junit4] 2> 1150262 INFO
(searcherExecutor-5271-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@47563ff[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1150262 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[1
(1566882716038725632)]} 0 2
[junit4] 2> 1150263 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[2
(1566882716038725633)]} 0 2
[junit4] 2> 1150263 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[3
(1566882716039774208)]} 0 2
[junit4] 2> 1150263 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[4
(1566882716039774209)]} 0 3
[junit4] 2> 1150264 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[5
(1566882716039774210)]} 0 3
[junit4] 2> 1150264 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[6
(1566882716040822784)]} 0 3
[junit4] 2> 1150264 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[7
(1566882716040822785)]} 0 4
[junit4] 2> 1150264 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[8
(1566882716040822786)]} 0 4
[junit4] 2> 1150264 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[9
(1566882716040822787)]} 0 4
[junit4] 2> 1150265 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[10
(1566882716040822788)]} 0 4
[junit4] 2> 1150265 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[11
(1566882716041871360)]} 0 5
[junit4] 2> 1150265 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[12
(1566882716041871361)]} 0 5
[junit4] 2> 1150266 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[13
(1566882716042919936)]} 0 5
[junit4] 2> 1150266 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=id:1&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
[junit4] 2> 1150268 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[14
(1566882716042919937)]} 0 8
[junit4] 2> 1150268 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[15
(1566882716045017088)]} 0 8
[junit4] 2> 1150268 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[814E8478C4B1CDE6]) [ 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> 1150269 ERROR
(TEST-AutoCommitTest.testMaxDocs-seed#[814E8478C4B1CDE6]) [ 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> 1150269 ERROR
(TEST-AutoCommitTest.testMaxDocs-seed#[814E8478C4B1CDE6]) [ 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:889)
[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: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:745)
[junit4] 2>
[junit4] 2> 1150270 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[814E8478C4B1CDE6]) [ x:collection1]
o.a.s.SolrTestCaseJ4 ###Ending testMaxDocs
[junit4] 2> 1150271 INFO (commitScheduler-5274-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> NOTE: reproduce with: ant test -Dtestcase=AutoCommitTest
-Dtests.method=testMaxDocs -Dtests.seed=814E8478C4B1CDE6 -Dtests.multiplier=2
-Dtests.slow=true -Dtests.locale=fr -Dtests.timezone=Europe/Zagreb
-Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
[junit4] ERROR 0.46s J0 | AutoCommitTest.testMaxDocs <<<
[junit4] > Throwable #1: java.lang.RuntimeException: Exception during
query
[junit4] > at
__randomizedtesting.SeedInfo.seed([814E8478C4B1CDE6:38CF52A7E85BC96C]:0)
[junit4] > at
org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:896)
[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:889)
[junit4] > ... 40 more
[junit4] 2> 1150279 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[814E8478C4B1CDE6]) [
x:collection1] o.a.s.SolrTestCaseJ4 ###Starting testCommitWithin
[junit4] 2> 1150286 INFO (commitScheduler-5274-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@24a59260[collection1] main]
[junit4] 2> 1150286 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[814E8478C4B1CDE6]) [
x:collection1] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL
DOCUMENTS FROM INDEX
[junit4] 2> 1150287 INFO (commitScheduler-5274-thread-1) [
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1150288 INFO
(searcherExecutor-5271-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@24a59260[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(7.0.0):C16)))}
[junit4] 2> 1150288 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[814E8478C4B1CDE6]) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@314f170b[collection1] realtime]
[junit4] 2> 1150288 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[814E8478C4B1CDE6]) [
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 9
[junit4] 2> 1150289 ERROR
(TEST-AutoCommitTest.testCommitWithin-seed#[814E8478C4B1CDE6]) [
x:collection1] o.a.s.c.CorePropertiesLocator Couldn't load core descriptor from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/core.properties:java.nio.file.NoSuchFileException:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/core.properties
[junit4] 2> 1150289 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[814E8478C4B1CDE6]) [
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader,
from paths:
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/lib,
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1150320 WARN
(TEST-AutoCommitTest.testCommitWithin-seed#[814E8478C4B1CDE6]) [
x:collection1] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is
deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 1150323 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[814E8478C4B1CDE6]) [
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 1150353 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[814E8478C4B1CDE6]) [
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1150478 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[814E8478C4B1CDE6]) [
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1150485 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[814E8478C4B1CDE6]) [
x:collection1] o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using
configuration from instancedir
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1
[junit4] 2> 1150506 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[814E8478C4B1CDE6]) [
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@f2df7ed
[junit4] 2> 1150506 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[814E8478C4B1CDE6]) [
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1],
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.update.AutoCommitTest_814E8478C4B1CDE6-001/init-core-data-001/]
[junit4] 2> 1150598 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[814E8478C4B1CDE6]) [
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1150598 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[814E8478C4B1CDE6]) [
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1150600 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[814E8478C4B1CDE6]) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@6f808a9b[collection1] main]
[junit4] 2> 1150601 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[814E8478C4B1CDE6]) [
x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 1150602 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[814E8478C4B1CDE6]) [
x:collection1] o.a.s.s.DirectSolrSpellChecker init:
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 1150606 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[814E8478C4B1CDE6]) [
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1150606 INFO
(searcherExecutor-5275-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 1150606 INFO
(searcherExecutor-5275-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 1150606 INFO
(searcherExecutor-5275-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 1150606 INFO
(searcherExecutor-5275-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker:
multipleFields
[junit4] 2> 1150607 INFO
(searcherExecutor-5275-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 1150607 INFO
(searcherExecutor-5275-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 1150607 INFO
(searcherExecutor-5275-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 1150607 INFO
(searcherExecutor-5275-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 1150607 INFO
(searcherExecutor-5275-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 1150609 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[814E8478C4B1CDE6]) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy:
minMergeSize=0, mergeFactor=10, maxMergeSize=1724266285,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.1]
[junit4] 2> 1150609 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[814E8478C4B1CDE6]) [
x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 1150611 INFO
(searcherExecutor-5275-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@6f808a9b[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1150611 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[814E8478C4B1CDE6]) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@65e3a410[collection1] main]
[junit4] 2> 1150611 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[814E8478C4B1CDE6]) [
x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@1c9f51c7
[junit4] 2> 1150612 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[814E8478C4B1CDE6]) [
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection1, tag=480203207
[junit4] 2> 1150620 INFO
(searcherExecutor-5275-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@65e3a410[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1150642 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[814E8478C4B1CDE6]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[529
(1566882716426698752)]} 0 9
[junit4] 2> 1150642 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[814E8478C4B1CDE6]) [
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> 1154633 INFO (commitScheduler-5278-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> 1154636 INFO (commitScheduler-5278-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@4dfe9a29[collection1] main]
[junit4] 2> 1154638 INFO
(searcherExecutor-5275-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@4dfe9a29[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_5(7.0.0):C1)))}
[junit4] 2> 1154638 INFO (commitScheduler-5278-thread-1) [
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1154650 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[814E8478C4B1CDE6]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[530
(1566882720639877120)]} 0 4018
[junit4] 2> 1154650 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[814E8478C4B1CDE6]) [
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> 1154651 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[814E8478C4B1CDE6]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[529
(-1566882720640925696)]} 0 4019
[junit4] 2> 1154651 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[814E8478C4B1CDE6]) [
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> 1156651 INFO (commitScheduler-5278-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> 1156654 INFO (commitScheduler-5278-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@12fb47a0[collection1] main]
[junit4] 2> 1156656 INFO
(searcherExecutor-5275-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@12fb47a0[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_6(7.0.0):C1)))}
[junit4] 2> 1156656 INFO (commitScheduler-5278-thread-1) [
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1156904 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[814E8478C4B1CDE6]) [
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> 1156904 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[814E8478C4B1CDE6]) [
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> 1156905 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[814E8478C4B1CDE6]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1566882723004416000)]} 0 6273
[junit4] 2> 1156906 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[814E8478C4B1CDE6]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1566882723004416001)]} 0 6273
[junit4] 2> 1156906 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[814E8478C4B1CDE6]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1566882723005464576)]} 0 6273
[junit4] 2> 1156906 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[814E8478C4B1CDE6]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1566882723005464577)]} 0 6274
[junit4] 2> 1156906 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[814E8478C4B1CDE6]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1566882723005464578)]} 0 6274
[junit4] 2> 1156906 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[814E8478C4B1CDE6]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1566882723005464579)]} 0 6274
[junit4] 2> 1156906 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[814E8478C4B1CDE6]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1566882723005464580)]} 0 6274
[junit4] 2> 1156907 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[814E8478C4B1CDE6]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1566882723005464581)]} 0 6274
[junit4] 2> 1156907 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[814E8478C4B1CDE6]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1566882723006513152)]} 0 6274
[junit4] 2> 1156907 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[814E8478C4B1CDE6]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1566882723006513153)]} 0 6275
[junit4] 2> 1156907 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[814E8478C4B1CDE6]) [
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> 1156908 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[814E8478C4B1CDE6]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530
(-1566882723006513154)]} 0 6275
[junit4] 2> 1156908 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[814E8478C4B1CDE6]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530
(-1566882723007561728)]} 0 6275
[junit4] 2> 1156908 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[814E8478C4B1CDE6]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530
(-1566882723007561729)]} 0 6276
[junit4] 2> 1156908 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[814E8478C4B1CDE6]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530
(-1566882723007561730)]} 0 6276
[junit4] 2> 1156908 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[814E8478C4B1CDE6]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530
(-1566882723007561731)]} 0 6276
[junit4] 2> 1156908 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[814E8478C4B1CDE6]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530
(-1566882723007561732)]} 0 6276
[junit4] 2> 1156908 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[814E8478C4B1CDE6]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530
(-1566882723007561733)]} 0 6276
[junit4] 2> 1156908 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[814E8478C4B1CDE6]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530
(-1566882723007561734)]} 0 6276
[junit4] 2> 1156909 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[814E8478C4B1CDE6]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530
(-1566882723008610304)]} 0 6276
[junit4] 2> 1156909 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[814E8478C4B1CDE6]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530
(-1566882723008610305)]} 0 6276
[junit4] 2> 1156909 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[814E8478C4B1CDE6]) [
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> 1157908 INFO (commitScheduler-5278-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> 1157919 INFO (commitScheduler-5278-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@71c4178f[collection1] main]
[junit4] 2> 1157920 INFO (commitScheduler-5278-thread-1) [
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1157922 INFO
(searcherExecutor-5275-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@71c4178f[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_7(7.0.0):C10/9:delGen=1)))}
[junit4] 2> 1158160 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[814E8478C4B1CDE6]) [
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> 1158161 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[814E8478C4B1CDE6]) [
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> 1158161 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[814E8478C4B1CDE6]) [
x:collection1] o.a.s.SolrTestCaseJ4 ###Ending testCommitWithin
[junit4] 2> 1158161 INFO
(SUITE-AutoCommitTest-seed#[814E8478C4B1CDE6]-worker) [ x:collection1]
o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> 1158161 INFO
(SUITE-AutoCommitTest-seed#[814E8478C4B1CDE6]-worker) [ x:collection1]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=909770219
[junit4] 2> 1158161 INFO
(SUITE-AutoCommitTest-seed#[814E8478C4B1CDE6]-worker) [ x:collection1]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 1158163 INFO
(SUITE-AutoCommitTest-seed#[814E8478C4B1CDE6]-worker) [ x:collection1]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 1158164 INFO
(SUITE-AutoCommitTest-seed#[814E8478C4B1CDE6]-worker) [ x:collection1]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 1158164 INFO
(SUITE-AutoCommitTest-seed#[814E8478C4B1CDE6]-worker) [ x:collection1]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 1158164 INFO
(coreCloseExecutor-5279-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@20c2c0c3
[junit4] 2> 1158165 INFO
(coreCloseExecutor-5279-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter close.
[junit4] 2> 1158165 INFO
(coreCloseExecutor-5279-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@2d6e239c commitCommandVersion:0
[junit4] 2> 1158166 INFO
(coreCloseExecutor-5279-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection1, tag=549634243
[junit4] 2> NOTE: leaving temporary files on disk at:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.update.AutoCommitTest_814E8478C4B1CDE6-001
[junit4] 2> May 09, 2017 2:10:11 AM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 1 leaked
thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70):
{field_t=PostingsFormat(name=Direct),
multiDefault=BlockTreeOrds(blocksize=128),
subject=BlockTreeOrds(blocksize=128), id=PostingsFormat(name=Direct),
text=FSTOrd50}, docValues:{range_facet_l_dv=DocValuesFormat(name=Lucene70),
_version_=DocValuesFormat(name=Memory),
intDefault=DocValuesFormat(name=Memory),
range_facet_i_dv=DocValuesFormat(name=Asserting),
intDvoDefault=DocValuesFormat(name=Lucene70),
range_facet_l=DocValuesFormat(name=Asserting),
timestamp=DocValuesFormat(name=Asserting)}, maxPointsInLeafNode=358,
maxMBSortInHeap=6.38747405451528, sim=RandomSimilarity(queryNorm=true): {},
locale=fr, timezone=Europe/Zagreb
[junit4] 2> NOTE: Linux 3.13.0-88-generic amd64/Oracle Corporation
1.8.0_121 (64-bit)/cpus=4,threads=1,free=243145800,total=530579456
[junit4] 2> NOTE: All tests run in this JVM: [TestHashQParserPlugin,
DeleteStatusTest, SolrMetricManagerTest, ConfigSetsAPITest,
CollectionReloadTest, TestFieldResource, OverseerRolesTest,
TestBlendedInfixSuggestions, TestSolr4Spatial, TestFastWriter,
TestCloudPseudoReturnFields, TestScoreJoinQPNoScore, TestJsonFacetRefinement,
HdfsChaosMonkeyNothingIsSafeTest, TestPseudoReturnFields, MultiTermTest,
DistributedFacetPivotSmallAdvancedTest, GraphQueryTest,
XsltUpdateRequestHandlerTest, SignatureUpdateProcessorFactoryTest,
TestCSVLoader, TestDynamicFieldCollectionResource, CursorPagingTest,
PingRequestHandlerTest, TestRandomDVFaceting, TestJoin, SuggestComponentTest,
TestHdfsCloudBackupRestore, TestSolrConfigHandlerConcurrent,
PeerSyncWithIndexFingerprintCachingTest, InfoHandlerTest,
VMParamsZkACLAndCredentialsProvidersTest, SmileWriterTest,
DefaultValueUpdateProcessorTest, URLClassifyProcessorTest,
TestTolerantUpdateProcessorRandomCloud, TestCorePropertiesReload,
UUIDFieldTest, TestLeaderInitiatedRecoveryThread, PeerSyncTest,
TestManagedResource, TestManagedSchemaThreadSafety, SolrCoreTest,
ShufflingReplicaListTransformerTest, TestRebalanceLeaders, ReturnFieldsTest,
TestMaxScoreQueryParser, SortSpecParsingTest, NodeMutatorTest,
TestInPlaceUpdatesStandalone, ConjunctionSolrSpellCheckerTest,
TestReplicationHandlerBackup, TestTestInjection, QueryEqualityTest,
TestLazyCores, LeaderInitiatedRecoveryOnCommitTest, RequiredFieldsTest,
BigEndianAscendingWordSerializerTest, TestRawTransformer, CustomCollectionTest,
LeaderElectionIntegrationTest, PolyFieldTest, TestPayloadScoreQParserPlugin,
AddSchemaFieldsUpdateProcessorFactoryTest, TestOmitPositions,
TestSolrFieldCacheBean, TestOrdValues, TestSolrCloudWithKerberosAlt,
TestExactSharedStatsCache, TestShortCircuitedRequests, TestJettySolrRunner,
SecurityConfHandlerTest, TestSolrCloudSnapshots, ChangedSchemaMergeTest,
TestBulkSchemaAPI, RegexBoostProcessorTest, TestNRTOpen,
SolrGangliaReporterTest, TestApiFramework, HdfsRestartWhileUpdatingTest,
HighlighterMaxOffsetTest, UninvertDocValuesMergePolicyTest,
TestManagedSynonymFilterFactory, TestObjectReleaseTracker,
TestAuthorizationFramework, TestSchemaVersionResource, TestSimpleTextCodec,
TestCoreAdminApis, TestBlobHandler, SparseHLLTest, TestLFUCache,
TestExceedMaxTermLength, TestSmileRequest, LargeFieldTest,
DistributedQueryElevationComponentTest, PathHierarchyTokenizerFactoryTest,
MinimalSchemaTest, MissingSegmentRecoveryTest,
ClassificationUpdateProcessorFactoryTest, TestCollectionAPI, BasicZkTest,
TestAnalyzedSuggestions, CurrencyFieldOpenExchangeTest,
TestSubQueryTransformer, TestLMJelinekMercerSimilarityFactory, TestBadConfig,
TestOnReconnectListenerSupport, EnumFieldTest, DeleteNodeTest,
TestFieldCacheSort, PeerSyncReplicationTest, SearchHandlerTest, TestPathTrie,
TestRangeQuery, TestMacroExpander, BasicDistributedZkTest,
BasicDistributedZk2Test, CollectionsAPIDistributedZkTest, ShardRoutingTest,
TestReplicationHandler, ZkSolrClientTest, AutoCommitTest]
[junit4] Completed [368/709 (1!)] on J0 in 16.98s, 3 tests, 1 error <<<
FAILURES!
[...truncated 44481 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
