Build: https://builds.apache.org/job/Lucene-Solr-Tests-master/2077/
2 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([BFA8E443221F04E3:629329C0EF50069]:0)
at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:886)
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:748)
Caused by: java.lang.RuntimeException: REQUEST FAILED:
xpath=//result[@numFound=1]
xml response was: <?xml version="1.0" encoding="UTF-8"?>
<response>
<lst name="responseHeader"><int name="status">0</int><int
name="QTime">0</int></lst><result name="response" numFound="0"
start="0"></result>
</response>
request was:q=id:14&qt=&start=0&rows=20&version=2.2
at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:879)
... 40 more
FAILED: org.apache.solr.cloud.LeaderElectionContextKeyTest.test
Error Message:
Stack Trace:
java.lang.AssertionError
at
__randomizedtesting.SeedInfo.seed([BFA8E443221F04E3:37FCDB998CE3691B]:0)
at org.junit.Assert.fail(Assert.java:92)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.junit.Assert.assertTrue(Assert.java:54)
at
org.apache.solr.cloud.LeaderElectionContextKeyTest.test(LeaderElectionContextKeyTest.java:88)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
Build Log:
[...truncated 10872 lines...]
[junit4] Suite: org.apache.solr.update.AutoCommitTest
[junit4] 2> 272733 INFO
(SUITE-AutoCommitTest-seed#[BFA8E443221F04E3]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> Creating dataDir:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.update.AutoCommitTest_BFA8E443221F04E3-001/init-core-data-001
[junit4] 2> 272733 WARN
(SUITE-AutoCommitTest-seed#[BFA8E443221F04E3]-worker) [ ]
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=1 numCloses=1
[junit4] 2> 272734 INFO
(SUITE-AutoCommitTest-seed#[BFA8E443221F04E3]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 272735 INFO
(SUITE-AutoCommitTest-seed#[BFA8E443221F04E3]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via:
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 272735 INFO
(SUITE-AutoCommitTest-seed#[BFA8E443221F04E3]-worker) [ ]
o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 272736 INFO
(SUITE-AutoCommitTest-seed#[BFA8E443221F04E3]-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> 272756 INFO
(SUITE-AutoCommitTest-seed#[BFA8E443221F04E3]-worker) [ ] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 8.0.0
[junit4] 2> 272776 INFO
(SUITE-AutoCommitTest-seed#[BFA8E443221F04E3]-worker) [ ]
o.a.s.s.IndexSchema [null] Schema name=test
[junit4] 2> 272853 INFO
(SUITE-AutoCommitTest-seed#[BFA8E443221F04E3]-worker) [ ]
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 272880 INFO
(SUITE-AutoCommitTest-seed#[BFA8E443221F04E3]-worker) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@390b1ba
[junit4] 2> 272883 INFO
(SUITE-AutoCommitTest-seed#[BFA8E443221F04E3]-worker) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@390b1ba
[junit4] 2> 272883 INFO
(SUITE-AutoCommitTest-seed#[BFA8E443221F04E3]-worker) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@390b1ba
[junit4] 2> 272885 INFO (coreLoadExecutor-971-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> 272906 INFO (coreLoadExecutor-971-thread-1) [
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 272925 INFO (coreLoadExecutor-971-thread-1) [
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 273010 INFO (coreLoadExecutor-971-thread-1) [
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 273016 INFO (coreLoadExecutor-971-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> 273017 INFO (coreLoadExecutor-971-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@390b1ba
[junit4] 2> 273017 INFO (coreLoadExecutor-971-thread-1) [
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 273017 INFO (coreLoadExecutor-971-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/J2/temp/solr.update.AutoCommitTest_BFA8E443221F04E3-001/init-core-data-001/]
[junit4] 2> 273019 INFO (coreLoadExecutor-971-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=28, maxMergeAtOnceExplicit=22, maxMergedSegmentMB=4.5126953125,
floorSegmentMB=2.015625, forceMergeDeletesPctAllowed=1.0318340449930996,
segmentsPerTier=45.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
[junit4] 2> 273054 INFO (coreLoadExecutor-971-thread-1) [
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 273054 INFO (coreLoadExecutor-971-thread-1) [
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10
numVersionBuckets=65536
[junit4] 2> 273055 INFO (coreLoadExecutor-971-thread-1) [
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 273055 INFO (coreLoadExecutor-971-thread-1) [
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 273056 INFO (coreLoadExecutor-971-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=29, maxMergeAtOnceExplicit=10, maxMergedSegmentMB=47.9326171875,
floorSegmentMB=0.9296875, forceMergeDeletesPctAllowed=11.929491968960672,
segmentsPerTier=41.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.1758270118505342
[junit4] 2> 273056 INFO (coreLoadExecutor-971-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@67ab59d3[collection1] main]
[junit4] 2> 273056 INFO (coreLoadExecutor-971-thread-1) [
x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 273061 INFO (coreLoadExecutor-971-thread-1) [
x:collection1] o.a.s.s.DirectSolrSpellChecker init:
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 273098 INFO (coreLoadExecutor-971-thread-1) [
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 273098 INFO (coreLoadExecutor-971-thread-1) [
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent
updates, using new clock 1575633752315396096
[junit4] 2> 273101 INFO
(SUITE-AutoCommitTest-seed#[BFA8E443221F04E3]-worker) [ ]
o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 273102 INFO
(searcherExecutor-972-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 273103 INFO
(searcherExecutor-972-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 273103 INFO
(searcherExecutor-972-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 273103 INFO
(searcherExecutor-972-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker:
multipleFields
[junit4] 2> 273104 INFO
(searcherExecutor-972-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 273104 INFO
(searcherExecutor-972-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 273104 INFO
(searcherExecutor-972-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 273104 INFO
(searcherExecutor-972-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 273104 INFO
(searcherExecutor-972-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 273107 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[BFA8E443221F04E3]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testCommitWithin
[junit4] 2> 273107 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[BFA8E443221F04E3]) [ ]
o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 273110 INFO
(searcherExecutor-972-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@67ab59d3[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 273115 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[BFA8E443221F04E3]) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@4b5b31fd[collection1] realtime]
[junit4] 2> 273115 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[BFA8E443221F04E3]) [ ]
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 8
[junit4] 2> 273116 ERROR
(TEST-AutoCommitTest.testCommitWithin-seed#[BFA8E443221F04E3]) [ ]
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> 273116 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[BFA8E443221F04E3]) [ ]
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> 273139 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[BFA8E443221F04E3]) [ ]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 273156 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[BFA8E443221F04E3]) [ ]
o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 273240 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[BFA8E443221F04E3]) [ ]
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 273246 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[BFA8E443221F04E3]) [ ]
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> 273259 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[BFA8E443221F04E3]) [
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@390b1ba
[junit4] 2> 273259 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[BFA8E443221F04E3]) [
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/J2/temp/solr.update.AutoCommitTest_BFA8E443221F04E3-001/init-core-data-001/]
[junit4] 2> 273297 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[BFA8E443221F04E3]) [
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 273297 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[BFA8E443221F04E3]) [
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 273298 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[BFA8E443221F04E3]) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@7da86e25[collection1] main]
[junit4] 2> 273299 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[BFA8E443221F04E3]) [
x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 273299 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[BFA8E443221F04E3]) [
x:collection1] o.a.s.s.DirectSolrSpellChecker init:
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 273301 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[BFA8E443221F04E3]) [
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 273302 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[BFA8E443221F04E3]) [
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent
updates, using new clock 1575633752529305600
[junit4] 2> 273303 INFO
(searcherExecutor-977-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 273308 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[BFA8E443221F04E3]) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=34, maxMergeAtOnceExplicit=21, maxMergedSegmentMB=97.0849609375,
floorSegmentMB=1.9443359375, forceMergeDeletesPctAllowed=23.908908312355496,
segmentsPerTier=21.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.569701908358492
[junit4] 2> 273308 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[BFA8E443221F04E3]) [
x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 273310 INFO
(searcherExecutor-977-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 273310 INFO
(searcherExecutor-977-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 273310 INFO
(searcherExecutor-977-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker:
multipleFields
[junit4] 2> 273311 INFO
(searcherExecutor-977-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 273311 INFO
(searcherExecutor-977-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 273311 INFO
(searcherExecutor-977-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 273311 INFO
(searcherExecutor-977-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 273311 INFO
(searcherExecutor-977-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 273313 INFO
(searcherExecutor-977-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@7da86e25[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 273313 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[BFA8E443221F04E3]) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@59625868[collection1] main]
[junit4] 2> 273313 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[BFA8E443221F04E3]) [
x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@1793b249
[junit4] 2> 273314 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[BFA8E443221F04E3]) [
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection1, tag=395555401
[junit4] 2> 273318 INFO
(searcherExecutor-977-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@59625868[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 273327 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[BFA8E443221F04E3]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[529
(1575633752547131392)]} 0 8
[junit4] 2> 273327 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[BFA8E443221F04E3]) [
x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=id:529&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
[junit4] 2> 277327 INFO (commitScheduler-980-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> 277331 INFO (commitScheduler-980-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@4ec845a[collection1]
main]
[junit4] 2> 277332 INFO (commitScheduler-980-thread-1) [
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 277333 INFO
(searcherExecutor-977-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@4ec845a[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):C1)))}
[junit4] 2> 277582 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[BFA8E443221F04E3]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[530
(1575633757016162304)]} 0 4263
[junit4] 2> 277582 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[BFA8E443221F04E3]) [
x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=id:530&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
[junit4] 2> 277583 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[BFA8E443221F04E3]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[529
(-1575633757018259456)]} 0 4264
[junit4] 2> 277583 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[BFA8E443221F04E3]) [
x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=id:529&qt=&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0
[junit4] 2> 279583 INFO (commitScheduler-980-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> 279586 INFO (commitScheduler-980-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@28b19cd0[collection1] main]
[junit4] 2> 279586 INFO (commitScheduler-980-thread-1) [
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 279588 INFO
(searcherExecutor-977-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@28b19cd0[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(8.0.0):C1)))}
[junit4] 2> 279835 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[BFA8E443221F04E3]) [
x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=id:529&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
[junit4] 2> 279835 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[BFA8E443221F04E3]) [
x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=id:530&qt=&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0
[junit4] 2> 279836 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[BFA8E443221F04E3]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1575633759379652608)]} 0 6517
[junit4] 2> 279836 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[BFA8E443221F04E3]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1575633759380701184)]} 0 6517
[junit4] 2> 279836 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[BFA8E443221F04E3]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1575633759380701185)]} 0 6518
[junit4] 2> 279836 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[BFA8E443221F04E3]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1575633759380701186)]} 0 6518
[junit4] 2> 279837 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[BFA8E443221F04E3]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1575633759381749760)]} 0 6518
[junit4] 2> 279837 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[BFA8E443221F04E3]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1575633759381749761)]} 0 6518
[junit4] 2> 279837 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[BFA8E443221F04E3]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1575633759381749762)]} 0 6518
[junit4] 2> 279837 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[BFA8E443221F04E3]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1575633759381749763)]} 0 6518
[junit4] 2> 279837 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[BFA8E443221F04E3]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1575633759381749764)]} 0 6518
[junit4] 2> 279837 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[BFA8E443221F04E3]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1575633759381749765)]} 0 6518
[junit4] 2> 279837 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[BFA8E443221F04E3]) [
x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=id:500&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
[junit4] 2> 279838 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[BFA8E443221F04E3]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530
(-1575633759382798336)]} 0 6519
[junit4] 2> 279838 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[BFA8E443221F04E3]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530
(-1575633759382798337)]} 0 6519
[junit4] 2> 279838 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[BFA8E443221F04E3]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530
(-1575633759382798338)]} 0 6519
[junit4] 2> 279838 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[BFA8E443221F04E3]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530
(-1575633759382798339)]} 0 6519
[junit4] 2> 279838 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[BFA8E443221F04E3]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530
(-1575633759382798340)]} 0 6519
[junit4] 2> 279838 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[BFA8E443221F04E3]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530
(-1575633759382798341)]} 0 6519
[junit4] 2> 279838 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[BFA8E443221F04E3]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530
(-1575633759382798342)]} 0 6520
[junit4] 2> 279838 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[BFA8E443221F04E3]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530
(-1575633759382798343)]} 0 6520
[junit4] 2> 279838 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[BFA8E443221F04E3]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530
(-1575633759382798344)]} 0 6520
[junit4] 2> 279863 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[BFA8E443221F04E3]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530
(-1575633759382798345)]} 0 6544
[junit4] 2> 279863 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[BFA8E443221F04E3]) [
x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=id:530&qt=&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0
[junit4] 2> 280838 INFO (commitScheduler-980-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> 280840 INFO (commitScheduler-980-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@2ed45349[collection1] main]
[junit4] 2> 280841 INFO (commitScheduler-980-thread-1) [
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 280842 INFO
(searcherExecutor-977-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@2ed45349[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(8.0.0):C10/9:delGen=1)))}
[junit4] 2> 280864 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[BFA8E443221F04E3]) [
x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=id:500&qt=&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0
[junit4] 2> 280865 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[BFA8E443221F04E3]) [
x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=id:530&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
[junit4] 2> 280865 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[BFA8E443221F04E3]) [
x:collection1] o.a.s.SolrTestCaseJ4 ###Ending testCommitWithin
[junit4] 2> 280866 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.SolrTestCaseJ4 ###Starting testMaxDocs
[junit4] 2> 280867 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 280867 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@7f8890c4[collection1] realtime]
[junit4] 2> 280867 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[BFA8E443221F04E3]) [ 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> 280867 ERROR
(TEST-AutoCommitTest.testMaxDocs-seed#[BFA8E443221F04E3]) [ 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> 280868 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[BFA8E443221F04E3]) [ 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> 280889 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 280907 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 280986 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 280992 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[BFA8E443221F04E3]) [ 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> 281003 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[BFA8E443221F04E3]) [ 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@390b1ba
[junit4] 2> 281003 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[BFA8E443221F04E3]) [ 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/J2/temp/solr.update.AutoCommitTest_BFA8E443221F04E3-001/init-core-data-001/]
[junit4] 2> 281040 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 281040 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 281041 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@1b8eb76b[collection1] main]
[junit4] 2> 281042 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 281042 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.s.DirectSolrSpellChecker init:
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 281044 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 281045 INFO
(searcherExecutor-981-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 281047 INFO
(searcherExecutor-981-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 281047 INFO
(searcherExecutor-981-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 281047 INFO
(searcherExecutor-981-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker:
multipleFields
[junit4] 2> 281048 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=47, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=1.0]
[junit4] 2> 281048 INFO
(searcherExecutor-981-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 281048 INFO
(searcherExecutor-981-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 281048 INFO
(searcherExecutor-981-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 281049 INFO
(searcherExecutor-981-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 281049 INFO
(searcherExecutor-981-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 281050 INFO
(searcherExecutor-981-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@1b8eb76b[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 281050 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 281051 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@51933d7b[collection1] main]
[junit4] 2> 281051 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@35c9a886
[junit4] 2> 281051 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection1, tag=902408326
[junit4] 2> 281054 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[0
(1575633760656818176)]} 0 0
[junit4] 2> 281054 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[1
(1575633760657866752)]} 0 1
[junit4] 2> 281054 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[2
(1575633760657866753)]} 0 1
[junit4] 2> 281054 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[3
(1575633760657866754)]} 0 1
[junit4] 2> 281055 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[4
(1575633760657866755)]} 0 1
[junit4] 2> 281055 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[5
(1575633760658915328)]} 0 1
[junit4] 2> 281055 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[6
(1575633760658915329)]} 0 1
[junit4] 2> 281055 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[7
(1575633760658915330)]} 0 1
[junit4] 2> 281055 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[8
(1575633760658915331)]} 0 2
[junit4] 2> 281055 INFO
(searcherExecutor-981-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@51933d7b[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 281055 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[9
(1575633760658915332)]} 0 2
[junit4] 2> 281055 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[10
(1575633760658915333)]} 0 2
[junit4] 2> 281056 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[11
(1575633760658915334)]} 0 2
[junit4] 2> 281056 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[12
(1575633760659963904)]} 0 2
[junit4] 2> 281056 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[13
(1575633760659963905)]} 0 2
[junit4] 2> 281056 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=id:1&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
[junit4] 2> 281056 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[14
(1575633760659963906)]} 0 3
[junit4] 2> 281057 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[15
(1575633760659963907)]} 0 3
[junit4] 2> 281057 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=id:14&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
[junit4] 2> 281057 ERROR
(TEST-AutoCommitTest.testMaxDocs-seed#[BFA8E443221F04E3]) [ 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=&start=0&rows=20&version=2.2
[junit4] 2> 281057 ERROR
(TEST-AutoCommitTest.testMaxDocs-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.SolrTestCaseJ4 REQUEST FAILED:
q=id:14&qt=&start=0&rows=20&version=2.2:java.lang.RuntimeException: REQUEST
FAILED: xpath=//result[@numFound=1]
[junit4] 2> xml response was: <?xml version="1.0" encoding="UTF-8"?>
[junit4] 2> <response>
[junit4] 2> <lst name="responseHeader"><int name="status">0</int><int
name="QTime">0</int></lst><result name="response" numFound="0"
start="0"></result>
[junit4] 2> </response>
[junit4] 2>
[junit4] 2> request was:q=id:14&qt=&start=0&rows=20&version=2.2
[junit4] 2> at
org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:879)
[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:748)
[junit4] 2>
[junit4] 2> 281058 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.SolrTestCaseJ4 ###Ending testMaxDocs
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=AutoCommitTest
-Dtests.method=testMaxDocs -Dtests.seed=BFA8E443221F04E3 -Dtests.multiplier=2
-Dtests.slow=true -Dtests.locale=ar-QA -Dtests.timezone=Europe/Stockholm
-Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] ERROR 0.19s J2 | AutoCommitTest.testMaxDocs <<<
[junit4] > Throwable #1: java.lang.RuntimeException: Exception during
query
[junit4] > at
__randomizedtesting.SeedInfo.seed([BFA8E443221F04E3:629329C0EF50069]:0)
[junit4] > at
org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:886)
[junit4] > at
org.apache.solr.update.AutoCommitTest.testMaxDocs(AutoCommitTest.java:225)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] > Caused by: java.lang.RuntimeException: REQUEST FAILED:
xpath=//result[@numFound=1]
[junit4] > xml response was: <?xml version="1.0" encoding="UTF-8"?>
[junit4] > <response>
[junit4] > <lst name="responseHeader"><int name="status">0</int><int
name="QTime">0</int></lst><result name="response" numFound="0"
start="0"></result>
[junit4] > </response>
[junit4] > request was:q=id:14&qt=&start=0&rows=20&version=2.2
[junit4] > at
org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:879)
[junit4] > ... 40 more
[junit4] 2> 281060 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.SolrTestCaseJ4 ###Starting testMaxTime
[junit4] 2> 281060 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 281061 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@5b7c662f[collection1] realtime]
[junit4] 2> 281061 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[BFA8E443221F04E3]) [ 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> 281061 ERROR
(TEST-AutoCommitTest.testMaxTime-seed#[BFA8E443221F04E3]) [ 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> 281061 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[BFA8E443221F04E3]) [ 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> 281071 INFO (commitScheduler-984-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> 281071 INFO (commitScheduler-984-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@498749ba[collection1] main]
[junit4] 2> 281071 INFO (commitScheduler-984-thread-1) [
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 281072 INFO
(searcherExecutor-981-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@498749ba[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 281083 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 281111 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 281183 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 281188 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[BFA8E443221F04E3]) [ 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> 281209 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[BFA8E443221F04E3]) [ 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@390b1ba
[junit4] 2> 281209 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[BFA8E443221F04E3]) [ 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/J2/temp/solr.update.AutoCommitTest_BFA8E443221F04E3-001/init-core-data-001/]
[junit4] 2> 281247 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 281247 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 281248 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@26b6838f[collection1] main]
[junit4] 2> 281248 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 281249 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.s.DirectSolrSpellChecker init:
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 281251 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 281253 INFO
(searcherExecutor-985-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 281253 INFO
(searcherExecutor-985-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 281253 INFO
(searcherExecutor-985-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 281253 INFO
(searcherExecutor-985-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker:
multipleFields
[junit4] 2> 281254 INFO
(searcherExecutor-985-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 281254 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=15, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.6053558705333106]
[junit4] 2> 281254 INFO
(searcherExecutor-985-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 281254 INFO
(searcherExecutor-985-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 281254 INFO
(searcherExecutor-985-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 281255 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 281255 INFO
(searcherExecutor-985-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 281256 INFO
(searcherExecutor-985-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@26b6838f[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 281256 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@181b020d[collection1] main]
[junit4] 2> 281257 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@257994a3
[junit4] 2> 281258 INFO
(searcherExecutor-985-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@181b020d[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 281259 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection1, tag=628724899
[junit4] 2> 281263 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[529
(1575633760877019136)]} 0 0
[junit4] 2> 281264 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=id:529&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
[junit4] 2> 282763 INFO (commitScheduler-988-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> 282767 INFO (commitScheduler-988-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@57575d28[collection1] main]
[junit4] 2> 282767 INFO (commitScheduler-988-thread-1) [
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 282768 INFO
(searcherExecutor-985-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@57575d28[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(8.0.0):C1)))}
[junit4] 2> 283015 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[530
(1575633762714124288)]} 0 1752
[junit4] 2> 283016 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=id:529&qt=&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0
[junit4] 2> 283016 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=id:530&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
[junit4] 2> 283017 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{delete=[529 (-1575633762716221440)]} 0 0
[junit4] 2> 283017 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=id:529&qt=&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0
[junit4] 2> 284516 INFO (commitScheduler-988-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> 284518 INFO (commitScheduler-988-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@22137a8d[collection1] main]
[junit4] 2> 284518 INFO (commitScheduler-988-thread-1) [
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 284519 INFO
(searcherExecutor-985-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@22137a8d[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_5(8.0.0):C1)))}
[junit4] 2> 284520 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[550
(1575633764291182592)]} 0 3257
[junit4] 2> 284520 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=id:529&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
[junit4] 2> 284520 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1575633764292231168)]} 0 3257
[junit4] 2> 284521 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1575633764292231169)]} 0 3257
[junit4] 2> 284521 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1575633764293279744)]} 0 3257
[junit4] 2> 284521 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1575633764293279745)]} 0 3258
[junit4] 2> 284521 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1575633764293279746)]} 0 3258
[junit4] 2> 284521 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1575633764293279747)]} 0 3258
[junit4] 2> 284521 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1575633764293279748)]} 0 3258
[junit4] 2> 284521 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1575633764293279749)]} 0 3258
[junit4] 2> 284521 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1575633764293279750)]} 0 3258
[junit4] 2> 284521 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1575633764293279751)]} 0 3258
[junit4] 2> 284521 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=id:500&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
[junit4] 2> 286020 INFO (commitScheduler-988-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> 286022 INFO (commitScheduler-988-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@7b51c5b4[collection1] main]
[junit4] 2> 286023 INFO (commitScheduler-988-thread-1) [
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 286024 INFO
(searcherExecutor-985-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@7b51c5b4[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_5(8.0.0):C1)
Uninverting(_6(8.0.0):C11/9:delGen=1)))}
[junit4] 2> 286274 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[531
(1575633766130384896)]} 0 5011
[junit4] 2> 286274 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=id:500&qt=&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0
[junit4] 2> 286275 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[BFA8E443221F04E3]) [ x:collection1]
o.a.s.SolrTestCaseJ4 ###Ending testMaxTime
[junit4] 2> 286275 INFO
(SUITE-AutoCommitTest-seed#[BFA8E443221F04E3]-worker) [ x:collection1]
o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> 286275 INFO
(SUITE-AutoCommitTest-seed#[BFA8E443221F04E3]-worker) [ x:collection1]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=81867338
[junit4] 2> 286275 INFO
(SUITE-AutoCommitTest-seed#[BFA8E443221F04E3]-worker) [ x:collection1]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 286276 INFO
(SUITE-AutoCommitTest-seed#[BFA8E443221F04E3]-worker) [ x:collection1]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 286277 INFO
(SUITE-AutoCommitTest-seed#[BFA8E443221F04E3]-worker) [ x:collection1]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 286277 INFO
(SUITE-AutoCommitTest-seed#[BFA8E443221F04E3]-worker) [ x:collection1]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 286277 INFO
(coreCloseExecutor-989-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@6488eced
[junit4] 2> 286277 INFO
(coreCloseExecutor-989-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter close.
[junit4] 2> 286277 INFO
(coreCloseExecutor-989-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@521648e0 commitCommandVersion:0
[junit4] 2> 286281 INFO
(coreCloseExecutor-989-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection1, tag=1686695149
[junit4] 2> NOTE: leaving temporary files on disk at:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.update.AutoCommitTest_BFA8E443221F04E3-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70):
{field_t=PostingsFormat(name=MockRandom),
multiDefault=PostingsFormat(name=Asserting),
subject=PostingsFormat(name=Asserting), id=PostingsFormat(name=MockRandom),
text=Lucene50(blocksize=128)},
docValues:{range_facet_l_dv=DocValuesFormat(name=Lucene70),
_version_=DocValuesFormat(name=Direct),
intDefault=DocValuesFormat(name=Direct), id_i1=DocValuesFormat(name=Direct),
range_facet_i_dv=DocValuesFormat(name=Lucene70),
intDvoDefault=DocValuesFormat(name=Lucene70),
range_facet_l=DocValuesFormat(name=Lucene70),
timestamp=DocValuesFormat(name=Lucene70)}, maxPointsInLeafNode=289,
maxMBSortInHeap=5.375424643944881, sim=RandomSimilarity(queryNorm=true): {},
locale=ar-QA, timezone=Europe/Stockholm
[junit4] 2> NOTE: Linux 3.13.0-88-generic amd64/Oracle Corporation
1.8.0_144 (64-bit)/cpus=4,threads=1,free=282728440,total=484442112
[junit4] 2> NOTE: All tests run in this JVM: [TestRecovery,
MetricsConfigTest, HdfsSyncSliceTest, HdfsRecoverLeaseTest, QueryEqualityTest,
TestSolrCoreSnapshots, HardAutoCommitTest, CoreMergeIndexesAdminHandlerTest,
TestCloudJSONFacetJoinDomain, TestCodecSupport, TestJsonFacets,
NumericFieldsTest, TestSolrDeletionPolicy2, BufferStoreTest, TestPointFields,
DeleteNodeTest, TestRawTransformer, SuggestComponentContextFilterQueryTest,
ImplicitSnitchTest, TestDistributedMissingSort, OverseerStatusTest,
PreAnalyzedFieldTest, TestSSLRandomization, TestNumericTerms64,
DirectUpdateHandlerOptimizeTest, UniqFieldsUpdateProcessorFactoryTest,
UUIDUpdateProcessorFallbackTest, ExplicitHLLTest, AnalysisErrorHandlingTest,
TestLFUCache, AutoCommitTest]
[junit4] Completed [58/729 (1!)] on J2 in 13.56s, 3 tests, 1 error <<<
FAILURES!
[...truncated 1539 lines...]
[junit4] Suite: org.apache.solr.cloud.LeaderElectionContextKeyTest
[junit4] 2> 1980698 INFO
(SUITE-LeaderElectionContextKeyTest-seed#[BFA8E443221F04E3]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> Creating dataDir:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderElectionContextKeyTest_BFA8E443221F04E3-001/init-core-data-001
[junit4] 2> 1980698 INFO
(SUITE-LeaderElectionContextKeyTest-seed#[BFA8E443221F04E3]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 1980700 INFO
(SUITE-LeaderElectionContextKeyTest-seed#[BFA8E443221F04E3]-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> 1980700 INFO
(SUITE-LeaderElectionContextKeyTest-seed#[BFA8E443221F04E3]-worker) [ ]
o.a.s.c.MiniSolrCloudCluster Starting cluster of 1 servers in
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderElectionContextKeyTest_BFA8E443221F04E3-001/tempDir-001
[junit4] 2> 1980701 INFO
(SUITE-LeaderElectionContextKeyTest-seed#[BFA8E443221F04E3]-worker) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1980701 INFO (Thread-2558) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1980701 INFO (Thread-2558) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 1980703 ERROR (Thread-2558) [ ] o.a.z.s.ZooKeeperServer
ZKShutdownHandler is not registered, so ZooKeeper server won't take any action
on ERROR or SHUTDOWN server state changes
[junit4] 2> 1980801 INFO
(SUITE-LeaderElectionContextKeyTest-seed#[BFA8E443221F04E3]-worker) [ ]
o.a.s.c.ZkTestServer start zk server on port:52959
[junit4] 2> 1980809 INFO (jetty-launcher-1387-thread-1) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 1980812 INFO (jetty-launcher-1387-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@447a1e29{/solr,null,AVAILABLE}
[junit4] 2> 1980813 INFO (jetty-launcher-1387-thread-1) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@589e3eb9{SSL,[ssl,
http/1.1]}{127.0.0.1:53852}
[junit4] 2> 1980813 INFO (jetty-launcher-1387-thread-1) [ ]
o.e.j.s.Server Started @1984302ms
[junit4] 2> 1980813 INFO (jetty-launcher-1387-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=53852}
[junit4] 2> 1980813 ERROR (jetty-launcher-1387-thread-1) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 1980813 INFO (jetty-launcher-1387-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
8.0.0
[junit4] 2> 1980813 INFO (jetty-launcher-1387-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1980813 INFO (jetty-launcher-1387-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null, Default config
dir: null
[junit4] 2> 1980813 INFO (jetty-launcher-1387-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-08-13T16:52:29.400Z
[junit4] 2> 1980815 INFO (jetty-launcher-1387-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1980821 INFO (jetty-launcher-1387-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:52959/solr
[junit4] 2> 1980878 INFO (jetty-launcher-1387-thread-1)
[n:127.0.0.1:53852_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1980879 INFO (jetty-launcher-1387-thread-1)
[n:127.0.0.1:53852_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:53852_solr
[junit4] 2> 1980879 INFO (jetty-launcher-1387-thread-1)
[n:127.0.0.1:53852_solr ] o.a.s.c.Overseer Overseer
(id=98477221431803907-127.0.0.1:53852_solr-n_0000000000) starting
[junit4] 2> 1980888 INFO (jetty-launcher-1387-thread-1)
[n:127.0.0.1:53852_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:53852_solr
[junit4] 2> 1980896 INFO
(zkCallback-1394-thread-1-processing-n:127.0.0.1:53852_solr)
[n:127.0.0.1:53852_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 1980937 INFO (jetty-launcher-1387-thread-1)
[n:127.0.0.1:53852_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_53852.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@4cddc459
[junit4] 2> 1980939 INFO (jetty-launcher-1387-thread-1)
[n:127.0.0.1:53852_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_53852.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@4cddc459
[junit4] 2> 1980940 INFO (jetty-launcher-1387-thread-1)
[n:127.0.0.1:53852_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_53852.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@4cddc459
[junit4] 2> 1980940 INFO (jetty-launcher-1387-thread-1)
[n:127.0.0.1:53852_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderElectionContextKeyTest_BFA8E443221F04E3-001/tempDir-001/node1/.
[junit4] 2> 1980959 INFO
(SUITE-LeaderElectionContextKeyTest-seed#[BFA8E443221F04E3]-worker) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1980960 INFO
(SUITE-LeaderElectionContextKeyTest-seed#[BFA8E443221F04E3]-worker) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:52959/solr ready
[junit4] 2> 1980986 INFO (qtp1491953338-13463) [n:127.0.0.1:53852_solr
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
replicationFactor=1&collection.configName=config&maxShardsPerNode=1000&name=testCollection1&nrtReplicas=1&action=CREATE&numShards=2&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 1980988 INFO
(OverseerThreadFactory-4648-thread-1-processing-n:127.0.0.1:53852_solr)
[n:127.0.0.1:53852_solr ] o.a.s.c.CreateCollectionCmd Create collection
testCollection1
[junit4] 2> 1981096 INFO
(OverseerStateUpdate-98477221431803907-127.0.0.1:53852_solr-n_0000000000)
[n:127.0.0.1:53852_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"testCollection1",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"testCollection1_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:53852/solr";,
[junit4] 2> "type":"NRT"}
[junit4] 2> 1981098 INFO
(OverseerStateUpdate-98477221431803907-127.0.0.1:53852_solr-n_0000000000)
[n:127.0.0.1:53852_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"testCollection1",
[junit4] 2> "shard":"shard2",
[junit4] 2> "core":"testCollection1_shard2_replica_n2",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:53852/solr";,
[junit4] 2> "type":"NRT"}
[junit4] 2> 1981308 INFO (qtp1491953338-13462) [n:127.0.0.1:53852_solr
] o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node3&collection.configName=config&newCollection=true&name=testCollection1_shard1_replica_n1&action=CREATE&numShards=2&collection=testCollection1&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1981308 INFO (qtp1491953338-13462) [n:127.0.0.1:53852_solr
] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for
2147483647 transient cores
[junit4] 2> 1981311 INFO (qtp1491953338-13457) [n:127.0.0.1:53852_solr
] o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node4&collection.configName=config&newCollection=true&name=testCollection1_shard2_replica_n2&action=CREATE&numShards=2&collection=testCollection1&shard=shard2&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1981424 INFO
(zkCallback-1394-thread-2-processing-n:127.0.0.1:53852_solr)
[n:127.0.0.1:53852_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/testCollection1/state.json] for collection [testCollection1]
has occurred - updating... (live nodes size: [1])
[junit4] 2> 1981424 INFO
(zkCallback-1394-thread-1-processing-n:127.0.0.1:53852_solr)
[n:127.0.0.1:53852_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/testCollection1/state.json] for collection [testCollection1]
has occurred - updating... (live nodes size: [1])
[junit4] 2> 1982340 INFO (qtp1491953338-13457) [n:127.0.0.1:53852_solr
c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n2]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 1982343 INFO (qtp1491953338-13462) [n:127.0.0.1:53852_solr
c:testCollection1 s:shard1 r:core_node3 x:testCollection1_shard1_replica_n1]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 1982347 INFO (qtp1491953338-13457) [n:127.0.0.1:53852_solr
c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n2]
o.a.s.s.IndexSchema [testCollection1_shard2_replica_n2] Schema name=minimal
[junit4] 2> 1982349 INFO (qtp1491953338-13457) [n:127.0.0.1:53852_solr
c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n2]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 1982349 INFO (qtp1491953338-13457) [n:127.0.0.1:53852_solr
c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n2]
o.a.s.c.CoreContainer Creating SolrCore 'testCollection1_shard2_replica_n2'
using configuration from collection testCollection1, trusted=true
[junit4] 2> 1982351 INFO (qtp1491953338-13457) [n:127.0.0.1:53852_solr
c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n2]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_53852.solr.core.testCollection1.shard2.replica_n2' (registry
'solr.core.testCollection1.shard2.replica_n2') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@4cddc459
[junit4] 2> 1982351 INFO (qtp1491953338-13457) [n:127.0.0.1:53852_solr
c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n2]
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1982351 INFO (qtp1491953338-13457) [n:127.0.0.1:53852_solr
c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n2]
o.a.s.c.SolrCore [[testCollection1_shard2_replica_n2] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderElectionContextKeyTest_BFA8E443221F04E3-001/tempDir-001/node1/testCollection1_shard2_replica_n2],
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderElectionContextKeyTest_BFA8E443221F04E3-001/tempDir-001/node1/./testCollection1_shard2_replica_n2/data/]
[junit4] 2> 1982352 INFO (qtp1491953338-13462) [n:127.0.0.1:53852_solr
c:testCollection1 s:shard1 r:core_node3 x:testCollection1_shard1_replica_n1]
o.a.s.s.IndexSchema [testCollection1_shard1_replica_n1] Schema name=minimal
[junit4] 2> 1982354 INFO (qtp1491953338-13462) [n:127.0.0.1:53852_solr
c:testCollection1 s:shard1 r:core_node3 x:testCollection1_shard1_replica_n1]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 1982354 INFO (qtp1491953338-13462) [n:127.0.0.1:53852_solr
c:testCollection1 s:shard1 r:core_node3 x:testCollection1_shard1_replica_n1]
o.a.s.c.CoreContainer Creating SolrCore 'testCollection1_shard1_replica_n1'
using configuration from collection testCollection1, trusted=true
[junit4] 2> 1982355 INFO (qtp1491953338-13462) [n:127.0.0.1:53852_solr
c:testCollection1 s:shard1 r:core_node3 x:testCollection1_shard1_replica_n1]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_53852.solr.core.testCollection1.shard1.replica_n1' (registry
'solr.core.testCollection1.shard1.replica_n1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@4cddc459
[junit4] 2> 1982355 INFO (qtp1491953338-13462) [n:127.0.0.1:53852_solr
c:testCollection1 s:shard1 r:core_node3 x:testCollection1_shard1_replica_n1]
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1982355 INFO (qtp1491953338-13462) [n:127.0.0.1:53852_solr
c:testCollection1 s:shard1 r:core_node3 x:testCollection1_shard1_replica_n1]
o.a.s.c.SolrCore [[testCollection1_shard1_replica_n1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderElectionContextKeyTest_BFA8E443221F04E3-001/tempDir-001/node1/testCollection1_shard1_replica_n1],
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderElectionContextKeyTest_BFA8E443221F04E3-001/tempDir-001/node1/./testCollection1_shard1_replica_n1/data/]
[junit4] 2> 1982390 INFO (qtp1491953338-13457) [n:127.0.0.1:53852_solr
c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n2]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 1982390 INFO (qtp1491953338-13457) [n:127.0.0.1:53852_solr
c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n2]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1982391 INFO (qtp1491953338-13457) [n:127.0.0.1:53852_solr
c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n2]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1982391 INFO (qtp1491953338-13457) [n:127.0.0.1:53852_solr
c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n2]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1982393 INFO (qtp1491953338-13457) [n:127.0.0.1:53852_solr
c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n2]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@da98bd7[testCollection1_shard2_replica_n2] main]
[junit4] 2> 1982394 INFO (qtp1491953338-13457) [n:127.0.0.1:53852_solr
c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n2]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/config
[junit4] 2> 1982394 INFO (qtp1491953338-13457) [n:127.0.0.1:53852_solr
c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n2]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/config
[junit4] 2> 1982394 INFO (qtp1491953338-13457) [n:127.0.0.1:53852_solr
c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n2]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1982399 INFO
(searcherExecutor-4651-thread-1-processing-n:127.0.0.1:53852_solr
x:testCollection1_shard2_replica_n2 s:shard2 c:testCollection1 r:core_node4)
[n:127.0.0.1:53852_solr c:testCollection1 s:shard2 r:core_node4
x:testCollection1_shard2_replica_n2] o.a.s.c.SolrCore
[testCollection1_shard2_replica_n2] Registered new searcher
Searcher@da98bd7[testCollection1_shard2_replica_n2]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1982399 INFO (qtp1491953338-13457) [n:127.0.0.1:53852_solr
c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n2]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1575635544688295936
[junit4] 2> 1982402 INFO (qtp1491953338-13462) [n:127.0.0.1:53852_solr
c:testCollection1 s:shard1 r:core_node3 x:testCollection1_shard1_replica_n1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 1982402 INFO (qtp1491953338-13462) [n:127.0.0.1:53852_solr
c:testCollection1 s:shard1 r:core_node3 x:testCollection1_shard1_replica_n1]
o.a.s.u.UpdateL
[...truncated too long message...]
plier=2 -Dtests.slow=true -Dtests.locale=hr -Dtests.timezone=Pacific/Fiji
-Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] FAILURE 0.02s J0 | LeaderElectionContextKeyTest.test <<<
[junit4] > Throwable #1: java.lang.AssertionError
[junit4] > at
__randomizedtesting.SeedInfo.seed([BFA8E443221F04E3:37FCDB998CE3691B]:0)
[junit4] > at
org.apache.solr.cloud.LeaderElectionContextKeyTest.test(LeaderElectionContextKeyTest.java:88)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 1986293 INFO (jetty-closer-1388-thread-1) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@589e3eb9{SSL,[ssl,
http/1.1]}{127.0.0.1:0}
[junit4] 2> 1986293 INFO (jetty-closer-1388-thread-1) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1557513936
[junit4] 2> 1986293 INFO (jetty-closer-1388-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 1986295 INFO (jetty-closer-1388-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 1986296 INFO (jetty-closer-1388-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 1986297 INFO (jetty-closer-1388-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster,
tag=null
[junit4] 2> 1986297 INFO (coreCloseExecutor-4671-thread-1)
[n:127.0.0.1:53852_solr c:testCollection1 s:shard1 r:core_node3
x:testCollection1_shard1_replica_n1] o.a.s.c.SolrCore
[testCollection1_shard1_replica_n1] CLOSING SolrCore
org.apache.solr.core.SolrCore@7a9882be
[junit4] 2> 1986302 INFO (coreCloseExecutor-4671-thread-3)
[n:127.0.0.1:53852_solr c:testCollection2 s:shard1 r:core_node2
x:testCollection2_shard1_replica_n1] o.a.s.c.SolrCore
[testCollection2_shard1_replica_n1] CLOSING SolrCore
org.apache.solr.core.SolrCore@7cc62cdd
[junit4] 2> 1986303 INFO (coreCloseExecutor-4671-thread-1)
[n:127.0.0.1:53852_solr c:testCollection1 s:shard1 r:core_node3
x:testCollection1_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric
reporters for registry=solr.core.testCollection1.shard1.replica_n1,
tag=2056815294
[junit4] 2> 1986303 INFO (coreCloseExecutor-4671-thread-2)
[n:127.0.0.1:53852_solr c:testCollection2 s:shard2 r:core_node4
x:testCollection2_shard2_replica_n3] o.a.s.c.SolrCore
[testCollection2_shard2_replica_n3] CLOSING SolrCore
org.apache.solr.core.SolrCore@1a767cb8
[junit4] 2> 1986309 INFO (coreCloseExecutor-4671-thread-1)
[n:127.0.0.1:53852_solr c:testCollection1 s:shard1 r:core_node3
x:testCollection1_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric
reporters for registry=solr.collection.testCollection1.shard1.leader,
tag=2056815294
[junit4] 2> 1986310 INFO (coreCloseExecutor-4671-thread-3)
[n:127.0.0.1:53852_solr c:testCollection2 s:shard1 r:core_node2
x:testCollection2_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric
reporters for registry=solr.core.testCollection2.shard1.replica_n1,
tag=2093362397
[junit4] 2> 1986313 INFO (coreCloseExecutor-4671-thread-3)
[n:127.0.0.1:53852_solr c:testCollection2 s:shard1 r:core_node2
x:testCollection2_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric
reporters for registry=solr.collection.testCollection2.shard1.leader,
tag=2093362397
[junit4] 2> 1986313 INFO (coreCloseExecutor-4671-thread-2)
[n:127.0.0.1:53852_solr c:testCollection2 s:shard2 r:core_node4
x:testCollection2_shard2_replica_n3] o.a.s.m.SolrMetricManager Closing metric
reporters for registry=solr.core.testCollection2.shard2.replica_n3,
tag=443972792
[junit4] 2> 1986317 INFO (coreCloseExecutor-4671-thread-2)
[n:127.0.0.1:53852_solr c:testCollection2 s:shard2 r:core_node4
x:testCollection2_shard2_replica_n3] o.a.s.m.SolrMetricManager Closing metric
reporters for registry=solr.collection.testCollection2.shard2.leader,
tag=443972792
[junit4] 2> 1986317 INFO (jetty-closer-1388-thread-1) [ ]
o.a.s.c.Overseer Overseer
(id=98477221431803907-127.0.0.1:53852_solr-n_0000000000) closing
[junit4] 2> 1986318 INFO
(OverseerStateUpdate-98477221431803907-127.0.0.1:53852_solr-n_0000000000)
[n:127.0.0.1:53852_solr ] o.a.s.c.Overseer Overseer Loop exiting :
127.0.0.1:53852_solr
[junit4] 2> 1986320 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x15ddc82d9e90003, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 1986320 WARN
(zkCallback-1394-thread-2-processing-n:127.0.0.1:53852_solr)
[n:127.0.0.1:53852_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered,
but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 1986321 INFO (jetty-closer-1388-thread-1) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@447a1e29{/solr,null,UNAVAILABLE}
[junit4] 2> 1986324 ERROR
(SUITE-LeaderElectionContextKeyTest-seed#[BFA8E443221F04E3]-worker) [ ]
o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper
server won't take any action on ERROR or SHUTDOWN server state changes
[junit4] 2> 1986324 INFO
(SUITE-LeaderElectionContextKeyTest-seed#[BFA8E443221F04E3]-worker) [ ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1:52959 52959
[junit4] 2> 1986408 INFO (Thread-2558) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:52959 52959
[junit4] 2> 1986408 WARN (Thread-2558) [ ] o.a.s.c.ZkTestServer Watch
limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 2 /solr/aliases.json
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 5 /solr/collections/testCollection2/state.json
[junit4] 2> 5 /solr/collections/testCollection1/state.json
[junit4] 2> 2 /solr/clusterstate.json
[junit4] 2> 2 /solr/clusterprops.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 2 /solr/live_nodes
[junit4] 2> 2 /solr/collections
[junit4] 2>
[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.cloud.LeaderElectionContextKeyTest_BFA8E443221F04E3-001
[junit4] 2> Aug 13, 2017 4:52:34 PM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 2 leaked
thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {},
docValues:{}, maxPointsInLeafNode=1886, maxMBSortInHeap=5.4708623332826845,
sim=RandomSimilarity(queryNorm=true): {}, locale=hr, timezone=Pacific/Fiji
[junit4] 2> NOTE: Linux 3.13.0-88-generic amd64/Oracle Corporation
1.8.0_144 (64-bit)/cpus=4,threads=1,free=193390992,total=528482304
[junit4] 2> NOTE: All tests run in this JVM: [PeerSyncTest,
RuleEngineTest, SolrJmxReporterTest, TestGraphTermsQParserPlugin,
TestRandomDVFaceting, TestRemoteStreaming, TestTlogReplica,
TestCopyFieldCollectionResource, HdfsWriteToMultipleCollectionsTest,
SolrIndexConfigTest, OutOfBoxZkACLAndCredentialsProvidersTest,
DistribCursorPagingTest, FieldMutatingUpdateProcessorTest,
DocExpirationUpdateProcessorFactoryTest, BJQParserTest,
TlogReplayBufferedWhileIndexingTest, AssignBackwardCompatibilityTest,
TestCrossCoreJoin, TestPullReplica, TestEmbeddedSolrServerConstructors,
TestHdfsCloudBackupRestore, TestRandomRequestDistribution,
TestLegacyFieldCache, DeleteReplicaTest, SolrCloudExampleTest,
TestWordDelimiterFilterFactory, JavabinLoaderTest, CdcrUpdateLogTest,
TestJsonRequest, BasicZkTest, BaseCdcrDistributedZkTest, UpdateParamsTest,
UpdateLogTest, UtilsToolTest, TestDocumentBuilder, TestSolrDeletionPolicy1,
TestOmitPositions, TestShardHandlerFactory, ChaosMonkeyNothingIsSafeTest,
OutputWriterTest, InfoHandlerTest, RestartWhileUpdatingTest,
BinaryUpdateRequestHandlerTest, MissingSegmentRecoveryTest,
AtomicUpdateProcessorFactoryTest, TestImpersonationWithHadoopAuth,
PreAnalyzedUpdateProcessorTest, SyncSliceTest, SparseHLLTest,
SpellCheckCollatorWithCollapseTest, TestPhraseSuggestions,
CoreAdminCreateDiscoverTest, MBeansHandlerTest, RemoteQueryErrorTest,
TestCloudDeleteByQuery, TestConfigSetsAPIZkFailure,
TestLMDirichletSimilarityFactory, DocumentAnalysisRequestHandlerTest,
TestConfig, TestFieldCache, SecurityConfHandlerTest,
TestHighlightDedupGrouping, ZkStateReaderTest, ConnectionReuseTest,
TestStressUserVersions, SuggestComponentTest, TestCustomSort, TestStressLucene,
TestDistribIDF, DistributedFacetPivotSmallAdvancedTest, TestWriterPerf,
TestDynamicLoading, TestReplicationHandler, TestBadConfig,
CdcrReplicationHandlerTest, TestSubQueryTransformerCrossCore,
LeaderElectionIntegrationTest, TestRandomCollapseQParserPlugin,
TestGeoJSONResponseWriter, TestLeaderInitiatedRecoveryThread, TestApiFramework,
RAMDirectoryFactoryTest, TestDocSet, SuggesterWFSTTest, TestNestedDocsSort,
TestSimpleQParserPlugin, BasicDistributedZkTest,
TestPHPSerializedResponseWriter, TestSolrCloudWithDelegationTokens,
HdfsDirectoryTest, TestClassicSimilarityFactory, DocValuesMissingTest,
RankQueryTest, FullHLLTest, TestRandomFaceting, TestFieldTypeResource,
SolrShardReporterTest, TestSegmentSorting, PKIAuthenticationIntegrationTest,
TestConfigReload, TestSolr4Spatial, CoreSorterTest,
OpenExchangeRatesOrgProviderTest, LeaderElectionContextKeyTest]
[junit4] Completed [529/729 (2!)] on J0 in 5.98s, 1 test, 1 failure <<<
FAILURES!
[...truncated 43973 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
