Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-master/1281/
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([31601BA5F83E12A1:8BB274DD7B10FCB4]:0)
at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:896)
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:745)
Caused by: java.lang.RuntimeException: REQUEST FAILED:
xpath=//result[@numFound=1]
xml response was: <?xml version="1.0" encoding="UTF-8"?>
<response>
<lst name="responseHeader"><int name="status">0</int><int
name="QTime">0</int></lst><result name="response" numFound="0"
start="0"></result>
</response>
request was:q=id:529&qt=standard&start=0&rows=20&version=2.2
at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:889)
... 40 more
Build Log:
[...truncated 12739 lines...]
[junit4] Suite: org.apache.solr.update.AutoCommitTest
[junit4] 2> Creating dataDir:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.update.AutoCommitTest_31601BA5F83E12A1-001/init-core-data-001
[junit4] 2> 4037578 INFO
(SUITE-AutoCommitTest-seed#[31601BA5F83E12A1]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields
[junit4] 2> 4037580 INFO
(SUITE-AutoCommitTest-seed#[31601BA5F83E12A1]-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> 4037580 INFO
(SUITE-AutoCommitTest-seed#[31601BA5F83E12A1]-worker) [ ]
o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 4037581 INFO
(SUITE-AutoCommitTest-seed#[31601BA5F83E12A1]-worker) [ ]
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths:
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/lib,
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 4037630 ERROR (Finalizer) [ ] o.a.s.c.CoreContainer
CoreContainer was not close prior to finalize(), indicates a bug -- POSSIBLE
RESOURCE LEAK!!! instance=2105382249
[junit4] 2> 4037631 WARN
(SUITE-AutoCommitTest-seed#[31601BA5F83E12A1]-worker) [ ] o.a.s.c.Config
Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory>
instead.
[junit4] 2> 4037633 INFO
(SUITE-AutoCommitTest-seed#[31601BA5F83E12A1]-worker) [ ] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 7.0.0
[junit4] 2> 4037669 INFO
(SUITE-AutoCommitTest-seed#[31601BA5F83E12A1]-worker) [ ]
o.a.s.s.IndexSchema [null] Schema name=test
[junit4] 2> 4037938 WARN
(SUITE-AutoCommitTest-seed#[31601BA5F83E12A1]-worker) [ ]
o.a.s.s.IndexSchema [null] default search field in schema is text. WARNING:
Deprecated, please use 'df' on request instead.
[junit4] 2> 4037940 INFO
(SUITE-AutoCommitTest-seed#[31601BA5F83E12A1]-worker) [ ]
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 4038025 INFO
(SUITE-AutoCommitTest-seed#[31601BA5F83E12A1]-worker) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@759752c7
[junit4] 2> 4038030 INFO
(SUITE-AutoCommitTest-seed#[31601BA5F83E12A1]-worker) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@759752c7
[junit4] 2> 4038030 INFO
(SUITE-AutoCommitTest-seed#[31601BA5F83E12A1]-worker) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@759752c7
[junit4] 2> 4038049 INFO (coreLoadExecutor-5231-thread-1) [
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader,
from paths:
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/lib,
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 4038107 WARN (coreLoadExecutor-5231-thread-1) [
x:collection1] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is
deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 4038109 INFO (coreLoadExecutor-5231-thread-1) [
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 4038138 INFO (coreLoadExecutor-5231-thread-1) [
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 4038351 WARN (coreLoadExecutor-5231-thread-1) [
x:collection1] o.a.s.s.IndexSchema [collection1] default search field in schema
is text. WARNING: Deprecated, please use 'df' on request instead.
[junit4] 2> 4038380 INFO (coreLoadExecutor-5231-thread-1) [
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 4038387 INFO (coreLoadExecutor-5231-thread-1) [
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using
configuration from instancedir
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1,
trusted=true
[junit4] 2> 4038387 INFO (coreLoadExecutor-5231-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@759752c7
[junit4] 2> 4038387 INFO (coreLoadExecutor-5231-thread-1) [
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 4038387 INFO (coreLoadExecutor-5231-thread-1) [
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1],
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.update.AutoCommitTest_31601BA5F83E12A1-001/init-core-data-001/]
[junit4] 2> 4038399 INFO (coreLoadExecutor-5231-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy:
minMergeSize=0, mergeFactor=10, maxMergeSize=1330821008,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.1]
[junit4] 2> 4038474 INFO (coreLoadExecutor-5231-thread-1) [
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 4038474 INFO (coreLoadExecutor-5231-thread-1) [
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10
numVersionBuckets=65536
[junit4] 2> 4038475 INFO (coreLoadExecutor-5231-thread-1) [
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 4038475 INFO (coreLoadExecutor-5231-thread-1) [
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 4038476 INFO (coreLoadExecutor-5231-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=25, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=0.9326171875, noCFSRatio=0.0]
[junit4] 2> 4038476 INFO (coreLoadExecutor-5231-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@33d03d90[collection1] main]
[junit4] 2> 4038477 INFO (coreLoadExecutor-5231-thread-1) [
x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 4038487 INFO (coreLoadExecutor-5231-thread-1) [
x:collection1] o.a.s.s.DirectSolrSpellChecker init:
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 4038516 INFO (coreLoadExecutor-5231-thread-1) [
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 4038516 INFO
(searcherExecutor-5232-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 4038516 INFO
(searcherExecutor-5232-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 4038516 INFO
(searcherExecutor-5232-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 4038516 INFO
(searcherExecutor-5232-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker:
multipleFields
[junit4] 2> 4038517 INFO
(searcherExecutor-5232-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 4038517 INFO
(searcherExecutor-5232-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 4038517 INFO
(searcherExecutor-5232-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 4038517 INFO (coreLoadExecutor-5231-thread-1) [
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent
updates, using new clock 1564624124297347072
[junit4] 2> 4038519 INFO
(searcherExecutor-5232-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 4038520 INFO
(searcherExecutor-5232-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 4038522 INFO
(searcherExecutor-5232-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@33d03d90[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 4038522 INFO
(SUITE-AutoCommitTest-seed#[31601BA5F83E12A1]-worker) [ ]
o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 4038524 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[31601BA5F83E12A1]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testMaxDocs
[junit4] 2> 4038525 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[31601BA5F83E12A1]) [ ]
o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 4038526 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[31601BA5F83E12A1]) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@32d03051[collection1] realtime]
[junit4] 2> 4038527 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[31601BA5F83E12A1]) [ ]
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> 4038527 ERROR
(TEST-AutoCommitTest.testMaxDocs-seed#[31601BA5F83E12A1]) [ ]
o.a.s.c.CorePropertiesLocator Couldn't load core descriptor from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/solrcore.properties:java.nio.file.NoSuchFileException:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/solrcore.properties
[junit4] 2> 4038528 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[31601BA5F83E12A1]) [ ]
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths:
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/lib,
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 4038608 WARN
(TEST-AutoCommitTest.testMaxDocs-seed#[31601BA5F83E12A1]) [ ] o.a.s.c.Config
Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory>
instead.
[junit4] 2> 4038610 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[31601BA5F83E12A1]) [ ]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 4038642 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[31601BA5F83E12A1]) [ ]
o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 4038872 WARN
(TEST-AutoCommitTest.testMaxDocs-seed#[31601BA5F83E12A1]) [ ]
o.a.s.s.IndexSchema [collection1] default search field in schema is text.
WARNING: Deprecated, please use 'df' on request instead.
[junit4] 2> 4038875 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[31601BA5F83E12A1]) [ ]
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 4038898 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[31601BA5F83E12A1]) [ ]
o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using configuration from
instancedir
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1
[junit4] 2> 4038957 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[31601BA5F83E12A1]) [ 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@759752c7
[junit4] 2> 4038957 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1],
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.update.AutoCommitTest_31601BA5F83E12A1-001/init-core-data-001/]
[junit4] 2> 4039097 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 4039097 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 4039099 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@6df13c8f[collection1] main]
[junit4] 2> 4039099 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 4039101 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.s.DirectSolrSpellChecker init:
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 4039105 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 4039105 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1564624124913909760
[junit4] 2> 4039105 INFO
(searcherExecutor-5237-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 4039108 INFO
(searcherExecutor-5237-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 4039108 INFO
(searcherExecutor-5237-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 4039108 INFO
(searcherExecutor-5237-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker:
multipleFields
[junit4] 2> 4039109 INFO
(searcherExecutor-5237-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 4039109 INFO
(searcherExecutor-5237-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 4039109 INFO
(searcherExecutor-5237-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 4039109 INFO
(searcherExecutor-5237-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 4039109 INFO
(searcherExecutor-5237-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 4039112 INFO
(searcherExecutor-5237-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@6df13c8f[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 4039113 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=30, maxMergeAtOnceExplicit=19, maxMergedSegmentMB=99.90234375,
floorSegmentMB=0.375, forceMergeDeletesPctAllowed=22.333029474871363,
segmentsPerTier=11.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 4039113 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 4039113 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@46f6cb74[collection1] main]
[junit4] 2> 4039114 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@716beb55
[junit4] 2> 4039117 INFO
(searcherExecutor-5237-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@46f6cb74[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 4039117 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection1, tag=1902898005
[junit4] 2> 4039128 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[0
(1564624124935929856)]} 0 2
[junit4] 2> 4039129 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[1
(1564624124938027008)]} 0 3
[junit4] 2> 4039129 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[2
(1564624124939075584)]} 0 3
[junit4] 2> 4039154 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[3
(1564624124939075585)]} 0 28
[junit4] 2> 4039160 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[4
(1564624124971581440)]} 0 34
[junit4] 2> 4039188 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[5
(1564624124992552960)]} 0 62
[junit4] 2> 4039188 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[6
(1564624125000941568)]} 0 63
[junit4] 2> 4039189 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[7
(1564624125001990144)]} 0 63
[junit4] 2> 4039189 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[8
(1564624125001990145)]} 0 63
[junit4] 2> 4039189 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[9
(1564624125001990146)]} 0 63
[junit4] 2> 4039189 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[10
(1564624125001990147)]} 0 64
[junit4] 2> 4039190 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[11
(1564624125003038720)]} 0 64
[junit4] 2> 4039190 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[12
(1564624125003038721)]} 0 64
[junit4] 2> 4039190 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[13
(1564624125003038722)]} 0 65
[junit4] 2> 4039191 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[31601BA5F83E12A1]) [ 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> 4039204 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[14
(1564624125006184448)]} 0 78
[junit4] 2> 4039204 INFO (commitScheduler-5240-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> 4039209 INFO (commitScheduler-5240-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@15be8d8b[collection1] main]
[junit4] 2> 4039210 INFO (commitScheduler-5240-thread-1) [
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 4039212 INFO
(searcherExecutor-5237-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@15be8d8b[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):c15)))}
[junit4] 2> 4039455 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[15
(1564624125279862784)]} 0 329
[junit4] 2> 4039455 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=id:14&qt=standard&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0
[junit4] 2> 4039456 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=id:15&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
[junit4] 2> 4039456 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.SolrTestCaseJ4 ###Ending testMaxDocs
[junit4] 2> 4039459 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[31601BA5F83E12A1]) [
x:collection1] o.a.s.SolrTestCaseJ4 ###Starting testCommitWithin
[junit4] 2> 4039460 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[31601BA5F83E12A1]) [
x:collection1] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL
DOCUMENTS FROM INDEX
[junit4] 2> 4039460 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[31601BA5F83E12A1]) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@13a1f975[collection1] realtime]
[junit4] 2> 4039482 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[31601BA5F83E12A1]) [
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 22
[junit4] 2> 4039482 ERROR
(TEST-AutoCommitTest.testCommitWithin-seed#[31601BA5F83E12A1]) [
x:collection1] o.a.s.c.CorePropertiesLocator Couldn't load core descriptor from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/solrcore.properties:java.nio.file.NoSuchFileException:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/solrcore.properties
[junit4] 2> 4039483 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[31601BA5F83E12A1]) [
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader,
from paths:
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/lib,
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 4039532 WARN
(TEST-AutoCommitTest.testCommitWithin-seed#[31601BA5F83E12A1]) [
x:collection1] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is
deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 4039533 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[31601BA5F83E12A1]) [
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 4039557 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[31601BA5F83E12A1]) [
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 4039709 WARN
(TEST-AutoCommitTest.testCommitWithin-seed#[31601BA5F83E12A1]) [
x:collection1] o.a.s.s.IndexSchema [collection1] default search field in schema
is text. WARNING: Deprecated, please use 'df' on request instead.
[junit4] 2> 4039712 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[31601BA5F83E12A1]) [
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 4039718 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[31601BA5F83E12A1]) [
x:collection1] o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using
configuration from instancedir
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1
[junit4] 2> 4039738 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[31601BA5F83E12A1]) [
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@759752c7
[junit4] 2> 4039738 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[31601BA5F83E12A1]) [
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1],
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.update.AutoCommitTest_31601BA5F83E12A1-001/init-core-data-001/]
[junit4] 2> 4040019 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[31601BA5F83E12A1]) [
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 4040019 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[31601BA5F83E12A1]) [
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 4040021 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[31601BA5F83E12A1]) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@66f5275a[collection1] main]
[junit4] 2> 4040022 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[31601BA5F83E12A1]) [
x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 4040022 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[31601BA5F83E12A1]) [
x:collection1] o.a.s.s.DirectSolrSpellChecker init:
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 4040026 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[31601BA5F83E12A1]) [
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 4040028 INFO
(searcherExecutor-5241-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 4040029 INFO
(searcherExecutor-5241-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 4040029 INFO
(searcherExecutor-5241-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 4040029 INFO
(searcherExecutor-5241-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker:
multipleFields
[junit4] 2> 4040029 INFO
(searcherExecutor-5241-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 4040030 INFO
(searcherExecutor-5241-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 4040030 INFO
(searcherExecutor-5241-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 4040030 INFO
(searcherExecutor-5241-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 4040030 INFO
(searcherExecutor-5241-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 4040033 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[31601BA5F83E12A1]) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=19, maxMergeAtOnceExplicit=34, maxMergedSegmentMB=17.01171875,
floorSegmentMB=0.8037109375, forceMergeDeletesPctAllowed=28.2563834767927,
segmentsPerTier=4.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.448952022933381
[junit4] 2> 4040034 INFO
(searcherExecutor-5241-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@66f5275a[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 4040034 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[31601BA5F83E12A1]) [
x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 4040034 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[31601BA5F83E12A1]) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@236c4abb[collection1] main]
[junit4] 2> 4040035 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[31601BA5F83E12A1]) [
x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@1523ae04
[junit4] 2> 4040035 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[31601BA5F83E12A1]) [
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection1, tag=354659844
[junit4] 2> 4040040 INFO
(searcherExecutor-5241-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@236c4abb[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 4040041 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[31601BA5F83E12A1]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[529
(1564624125892231168)]} 0 2
[junit4] 2> 4040041 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[31601BA5F83E12A1]) [
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> 4040042 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[31601BA5F83E12A1]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[530
(1564624125896425472)]} 0 3
[junit4] 2> 4040042 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[31601BA5F83E12A1]) [
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> 4040043 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[31601BA5F83E12A1]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[529
(-1564624125897474048)]} 0 4
[junit4] 2> 4040043 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[31601BA5F83E12A1]) [
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> 4040043 ERROR
(TEST-AutoCommitTest.testCommitWithin-seed#[31601BA5F83E12A1]) [
x:collection1] o.a.s.SolrTestCaseJ4 REQUEST FAILED: xpath=//result[@numFound=1]
[junit4] 2> xml response was: <?xml version="1.0" encoding="UTF-8"?>
[junit4] 2> <response>
[junit4] 2> <lst name="responseHeader"><int name="status">0</int><int
name="QTime">0</int></lst><result name="response" numFound="0"
start="0"></result>
[junit4] 2> </response>
[junit4] 2>
[junit4] 2> request
was:q=id:529&qt=standard&start=0&rows=20&version=2.2
[junit4] 2> 4040056 ERROR
(TEST-AutoCommitTest.testCommitWithin-seed#[31601BA5F83E12A1]) [
x:collection1] o.a.s.SolrTestCaseJ4 REQUEST FAILED:
q=id:529&qt=standard&start=0&rows=20&version=2.2:java.lang.RuntimeException:
REQUEST FAILED: xpath=//result[@numFound=1]
[junit4] 2> xml response was: <?xml version="1.0" encoding="UTF-8"?>
[junit4] 2> <response>
[junit4] 2> <lst name="responseHeader"><int name="status">0</int><int
name="QTime">0</int></lst><result name="response" numFound="0"
start="0"></result>
[junit4] 2> </response>
[junit4] 2>
[junit4] 2> request
was:q=id:529&qt=standard&start=0&rows=20&version=2.2
[junit4] 2> at
org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:889)
[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:745)
[junit4] 2>
[junit4] 2> 4040056 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[31601BA5F83E12A1]) [
x:collection1] o.a.s.SolrTestCaseJ4 ###Ending testCommitWithin
[junit4] 2> NOTE: download the large Jenkins line-docs file by running
'ant get-jenkins-line-docs' in the lucene directory.
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=AutoCommitTest
-Dtests.method=testCommitWithin -Dtests.seed=31601BA5F83E12A1
-Dtests.multiplier=2 -Dtests.nightly=true -Dtests.slow=true
-Dtests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/test-data/enwiki.random.lines.txt
-Dtests.locale=hi -Dtests.timezone=Asia/Tbilisi -Dtests.asserts=true
-Dtests.file.encoding=UTF-8
[junit4] ERROR 0.61s J2 | AutoCommitTest.testCommitWithin <<<
[junit4] > Throwable #1: java.lang.RuntimeException: Exception during
query
[junit4] > at
__randomizedtesting.SeedInfo.seed([31601BA5F83E12A1:8BB274DD7B10FCB4]:0)
[junit4] > at
org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:896)
[junit4] > at
org.apache.solr.update.AutoCommitTest.testCommitWithin(AutoCommitTest.java:353)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] > Caused by: java.lang.RuntimeException: REQUEST FAILED:
xpath=//result[@numFound=1]
[junit4] > xml response was: <?xml version="1.0" encoding="UTF-8"?>
[junit4] > <response>
[junit4] > <lst name="responseHeader"><int name="status">0</int><int
name="QTime">0</int></lst><result name="response" numFound="0"
start="0"></result>
[junit4] > </response>
[junit4] > request
was:q=id:529&qt=standard&start=0&rows=20&version=2.2
[junit4] > at
org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:889)
[junit4] > ... 40 more
[junit4] 2> 4040078 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.SolrTestCaseJ4 ###Starting testMaxTime
[junit4] 2> 4040078 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 4040078 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@58eaa436[collection1] realtime]
[junit4] 2> 4040079 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[31601BA5F83E12A1]) [ 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> 4040079 ERROR
(TEST-AutoCommitTest.testMaxTime-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.c.CorePropertiesLocator Couldn't load core descriptor from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/solrcore.properties:java.nio.file.NoSuchFileException:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/solrcore.properties
[junit4] 2> 4040080 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths:
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/lib,
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 4040133 WARN
(TEST-AutoCommitTest.testMaxTime-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use
<mergePolicyFactory> instead.
[junit4] 2> 4040135 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 4040159 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 4040424 WARN
(TEST-AutoCommitTest.testMaxTime-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.s.IndexSchema [collection1] default search field in schema is text.
WARNING: Deprecated, please use 'df' on request instead.
[junit4] 2> 4040427 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 4040437 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using configuration from
instancedir
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1
[junit4] 2> 4040462 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[31601BA5F83E12A1]) [ 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@759752c7
[junit4] 2> 4040462 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1],
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.update.AutoCommitTest_31601BA5F83E12A1-001/init-core-data-001/]
[junit4] 2> 4040554 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 4040554 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 4040556 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@6fa3ce9e[collection1] main]
[junit4] 2> 4040557 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 4040558 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.s.DirectSolrSpellChecker init:
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 4040566 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 4040569 INFO
(searcherExecutor-5245-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 4040569 INFO
(searcherExecutor-5245-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 4040569 INFO
(searcherExecutor-5245-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 4040569 INFO
(searcherExecutor-5245-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker:
multipleFields
[junit4] 2> 4040569 INFO
(searcherExecutor-5245-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 4040569 INFO
(searcherExecutor-5245-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 4040570 INFO
(searcherExecutor-5245-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 4040570 INFO
(searcherExecutor-5245-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 4040570 INFO
(searcherExecutor-5245-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 4040573 INFO
(searcherExecutor-5245-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@6fa3ce9e[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 4040574 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy:
minMergeSize=0, mergeFactor=10, maxMergeSize=598179592,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.1]
[junit4] 2> 4040574 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 4040575 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@3bb72b6e[collection1] main]
[junit4] 2> 4040575 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@498f085
[junit4] 2> 4040576 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection1, tag=77131909
[junit4] 2> 4040583 INFO
(searcherExecutor-5245-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@3bb72b6e[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 4040586 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[529
(1564624126465802240)]} 0 0
[junit4] 2> 4040586 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[31601BA5F83E12A1]) [ 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> 4042086 INFO (commitScheduler-5248-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> 4042089 INFO (commitScheduler-5248-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@5f2b7f90[collection1] main]
[junit4] 2> 4042090 INFO (commitScheduler-5248-thread-1) [
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 4042091 INFO
(searcherExecutor-5245-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@5f2b7f90[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_3(7.0.0):c1)))}
[junit4] 2> 4042344 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[530
(1564624128302907392)]} 0 1759
[junit4] 2> 4042344 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[31601BA5F83E12A1]) [ 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> 4042345 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[31601BA5F83E12A1]) [ 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> 4042346 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{delete=[529 (-1564624128312344576)]} 0 0
[junit4] 2> 4042346 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[31601BA5F83E12A1]) [ 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> 4043844 INFO (commitScheduler-5248-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> 4043850 INFO (commitScheduler-5248-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@780a62fc[collection1] main]
[junit4] 2> 4043850 INFO (commitScheduler-5248-thread-1) [
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 4043852 INFO
(searcherExecutor-5245-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@780a62fc[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(7.0.0):c1)))}
[junit4] 2> 4044098 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[550
(1564624130148401152)]} 0 3513
[junit4] 2> 4044098 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[31601BA5F83E12A1]) [ 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> 4044099 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1564624130150498304)]} 0 3514
[junit4] 2> 4044099 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1564624130150498305)]} 0 3514
[junit4] 2> 4044099 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1564624130150498306)]} 0 3514
[junit4] 2> 4044100 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1564624130150498307)]} 0 3514
[junit4] 2> 4044100 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1564624130151546880)]} 0 3514
[junit4] 2> 4044100 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1564624130151546881)]} 0 3515
[junit4] 2> 4044108 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1564624130151546882)]} 0 3522
[junit4] 2> 4044108 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1564624130159935488)]} 0 3523
[junit4] 2> 4044108 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1564624130159935489)]} 0 3523
[junit4] 2> 4044109 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1564624130159935490)]} 0 3523
[junit4] 2> 4044109 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[31601BA5F83E12A1]) [ 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> 4045598 INFO (commitScheduler-5248-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> 4045601 INFO (commitScheduler-5248-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@35c144be[collection1] main]
[junit4] 2> 4045602 INFO (commitScheduler-5248-thread-1) [
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 4045603 INFO
(searcherExecutor-5245-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@35c144be[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(7.0.0):c1)
Uninverting(_5(7.0.0):c11/9:delGen=1)))}
[junit4] 2> 4045614 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[531
(1564624131734896640)]} 0 5029
[junit4] 2> 4045614 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[31601BA5F83E12A1]) [ 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> 4045615 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[31601BA5F83E12A1]) [ x:collection1]
o.a.s.SolrTestCaseJ4 ###Ending testMaxTime
[junit4] 2> 4045615 INFO
(SUITE-AutoCommitTest-seed#[31601BA5F83E12A1]-worker) [ x:collection1]
o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> 4045615 INFO
(SUITE-AutoCommitTest-seed#[31601BA5F83E12A1]-worker) [ x:collection1]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=2113695735
[junit4] 2> 4045615 INFO
(SUITE-AutoCommitTest-seed#[31601BA5F83E12A1]-worker) [ x:collection1]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 4045617 INFO
(SUITE-AutoCommitTest-seed#[31601BA5F83E12A1]-worker) [ x:collection1]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 4045624 INFO
(SUITE-AutoCommitTest-seed#[31601BA5F83E12A1]-worker) [ x:collection1]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 4045624 INFO
(SUITE-AutoCommitTest-seed#[31601BA5F83E12A1]-worker) [ x:collection1]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 4045630 INFO
(coreCloseExecutor-5249-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@2ba2b3a0
[junit4] 2> 4045630 INFO
(coreCloseExecutor-5249-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter close.
[junit4] 2> 4045630 INFO
(coreCloseExecutor-5249-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@26e5e60d commitCommandVersion:0
[junit4] 2> 4045652 INFO
(coreCloseExecutor-5249-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection1, tag=732083104
[junit4] 2> NOTE: leaving temporary files on disk at:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.update.AutoCommitTest_31601BA5F83E12A1-001
[junit4] 2> Apr 14, 2017 3:50:49 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=FastCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=FAST,
chunkSize=32355, maxDocsPerChunk=2, blockSize=543),
termVectorsFormat=CompressingTermVectorsFormat(compressionMode=FAST,
chunkSize=32355, blockSize=543)), sim=RandomSimilarity(queryNorm=false): {},
locale=hi, timezone=Asia/Tbilisi
[junit4] 2> NOTE: Linux 3.13.0-85-generic amd64/Oracle Corporation
1.8.0_121 (64-bit)/cpus=4,threads=1,free=251540024,total=513802240
[junit4] 2> NOTE: All tests run in this JVM: [TestDistribDocBasedVersion,
SolrMetricReporterTest, SynonymTokenizerTest, DirectoryFactoryTest,
ClassificationUpdateProcessorFactoryTest, BadIndexSchemaTest,
SpatialRPTFieldTypeTest, BlockDirectoryTest, TestSolrFieldCacheBean,
ResponseHeaderTest, UnloadDistributedZkTest, TestTestInjection,
TestTrackingShardHandlerFactory, ShowFileRequestHandlerTest,
SolrIndexConfigTest, TestRequestStatusCollectionAPI, EchoParamsTest,
TestReqParamsAPI, HdfsLockFactoryTest, HdfsRestartWhileUpdatingTest,
SuggesterTest, TestStressInPlaceUpdates, StatsComponentTest,
TestFreeTextSuggestions, TestSolrQueryResponse,
ParsingFieldUpdateProcessorsTest, FieldMutatingUpdateProcessorTest,
TestCollationField, OutputWriterTest, MigrateRouteKeyTest,
CollectionTooManyReplicasTest, TestSolrQueryParser,
TestTolerantUpdateProcessorRandomCloud, TestCloudPseudoReturnFields, RulesTest,
DataDrivenBlockJoinTest, TestManagedResourceStorage, SimpleFacetsTest,
HdfsTlogReplayBufferedWhileIndexingTest, CdcrReplicationDistributedZkTest,
TestRuleBasedAuthorizationPlugin, TestLeaderInitiatedRecoveryThread,
TestConfigSetsAPIZkFailure, TestSystemCollAutoCreate, TestZkChroot,
RemoteQueryErrorTest, TestFilteredDocIdSet, DeleteShardTest,
TestSolrQueryParserResource, TestDistributedStatsComponentCardinality,
TestAnalyzeInfixSuggestions, StatelessScriptUpdateProcessorFactoryTest,
TestRebalanceLeaders, TestClassicSimilarityFactory, TestFieldCacheReopen,
HttpPartitionTest, TestExtendedDismaxParser, LeaderElectionTest,
TestIndexSearcher, TestAddFieldRealTimeGet, CdcrVersionReplicationTest,
BasicDistributedZk2Test, NoCacheHeaderTest, CurrencyFieldXmlFileTest,
LeaderFailureAfterFreshStartTest, TestMiniSolrCloudCluster,
FieldAnalysisRequestHandlerTest, WrapperMergePolicyFactoryTest,
TestStressReorder, FullSolrCloudDistribCmdsTest, TestSolrConfigHandler,
CachingDirectoryFactoryTest, PrimitiveFieldTypeTest,
TestOnReconnectListenerSupport, HighlighterConfigTest, TestFieldResource,
MergeStrategyTest, RestartWhileUpdatingTest, SolrPluginUtilsTest,
TestDocBasedVersionConstraints, TestBinaryField, TestComponentsName,
TestPhraseSuggestions, TestImplicitCoreProperties,
DeleteLastCustomShardedReplicaTest, ChangedSchemaMergeTest,
HdfsChaosMonkeyNothingIsSafeTest, TestConfigReload, TestClassNameShortening,
MetricsHandlerTest, DistributedVersionInfoTest, ZkStateWriterTest,
DebugComponentTest, TestIndexingPerformance, TestSmileRequest,
TestReloadDeadlock, RecoveryZkTest, TestUnifiedSolrHighlighter, StressHdfsTest,
SaslZkACLProviderTest, DistributedDebugComponentTest, TestConfig,
XmlUpdateRequestHandlerTest, UUIDUpdateProcessorFallbackTest,
HdfsNNFailoverTest, InfixSuggestersTest, TestSQLHandlerNonCloud, TestDocSet,
ClusterStateTest, TestSchemaVersionResource, SolrCloudReportersTest,
OutOfBoxZkACLAndCredentialsProvidersTest, AnalyticsQueryTest,
BasicDistributedZkTest, SyncSliceTest, OpenCloseCoreStressTest,
ClusterStateUpdateTest, ZkSolrClientTest, ZkCLITest, AutoCommitTest]
[junit4] Completed [349/702 (1!)] on J2 in 8.35s, 3 tests, 1 error <<<
FAILURES!
[...truncated 44415 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org
