Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-master/1361/
2 tests failed.
FAILED: org.apache.solr.update.AutoCommitTest.testMaxTime
Error Message:
Exception during query
Stack Trace:
java.lang.RuntimeException: Exception during query
at
__randomizedtesting.SeedInfo.seed([2C3C29D4212BA24C:B6C85436BFB13E70]:0)
at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:879)
at
org.apache.solr.update.AutoCommitTest.testMaxTime(AutoCommitTest.java:270)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
Caused by: java.lang.RuntimeException: REQUEST FAILED:
xpath=//result[@numFound=1]
xml response was: <?xml version="1.0" encoding="UTF-8"?>
<response>
<lst name="responseHeader"><int name="status">0</int><int
name="QTime">0</int></lst><result name="response" numFound="0"
start="0"></result>
</response>
request was:q=id:529&qt=&start=0&rows=20&version=2.2
at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:872)
... 40 more
FAILED: org.apache.solr.cloud.SharedFSAutoReplicaFailoverTest.test
Error Message:
expected:<2> but was:<3>
Stack Trace:
java.lang.AssertionError: expected:<2> but was:<3>
at
__randomizedtesting.SeedInfo.seed([2C3C29D4212BA24C:A468160E8FD7CFB4]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.failNotEquals(Assert.java:647)
at org.junit.Assert.assertEquals(Assert.java:128)
at org.junit.Assert.assertEquals(Assert.java:472)
at org.junit.Assert.assertEquals(Assert.java:456)
at
org.apache.solr.cloud.SharedFSAutoReplicaFailoverTest.assertSliceAndReplicaCount(SharedFSAutoReplicaFailoverTest.java:403)
at
org.apache.solr.cloud.SharedFSAutoReplicaFailoverTest.testBasics(SharedFSAutoReplicaFailoverTest.java:248)
at
org.apache.solr.cloud.SharedFSAutoReplicaFailoverTest.test(SharedFSAutoReplicaFailoverTest.java:136)
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
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:985)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:960)
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 12313 lines...]
[junit4] Suite: org.apache.solr.update.AutoCommitTest
[junit4] 2> 2015974 INFO
(SUITE-AutoCommitTest-seed#[2C3C29D4212BA24C]-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-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.update.AutoCommitTest_2C3C29D4212BA24C-001/init-core-data-001
[junit4] 2> 2015974 WARN
(SUITE-AutoCommitTest-seed#[2C3C29D4212BA24C]-worker) [ ]
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=1 numCloses=1
[junit4] 2> 2015974 INFO
(SUITE-AutoCommitTest-seed#[2C3C29D4212BA24C]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false)
w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 2015976 INFO
(SUITE-AutoCommitTest-seed#[2C3C29D4212BA24C]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via:
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 2015976 INFO
(SUITE-AutoCommitTest-seed#[2C3C29D4212BA24C]-worker) [ ]
o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 2015976 INFO
(SUITE-AutoCommitTest-seed#[2C3C29D4212BA24C]-worker) [ ]
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths:
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/lib,
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 2016011 INFO
(SUITE-AutoCommitTest-seed#[2C3C29D4212BA24C]-worker) [ ] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 8.0.0
[junit4] 2> 2016036 INFO
(SUITE-AutoCommitTest-seed#[2C3C29D4212BA24C]-worker) [ ]
o.a.s.s.IndexSchema [null] Schema name=test
[junit4] 2> 2016138 INFO
(SUITE-AutoCommitTest-seed#[2C3C29D4212BA24C]-worker) [ ]
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 2016168 INFO
(SUITE-AutoCommitTest-seed#[2C3C29D4212BA24C]-worker) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7f1cb5fd
[junit4] 2> 2016171 INFO
(SUITE-AutoCommitTest-seed#[2C3C29D4212BA24C]-worker) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7f1cb5fd
[junit4] 2> 2016172 INFO
(SUITE-AutoCommitTest-seed#[2C3C29D4212BA24C]-worker) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7f1cb5fd
[junit4] 2> 2016173 INFO (coreLoadExecutor-5569-thread-1) [
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader,
from paths:
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/lib,
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 2016197 INFO (coreLoadExecutor-5569-thread-1) [
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 2016216 INFO (coreLoadExecutor-5569-thread-1) [
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 2016313 INFO (coreLoadExecutor-5569-thread-1) [
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 2016320 INFO (coreLoadExecutor-5569-thread-1) [
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using
configuration from instancedir
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1,
trusted=true
[junit4] 2> 2016320 INFO (coreLoadExecutor-5569-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@7f1cb5fd
[junit4] 2> 2016320 INFO (coreLoadExecutor-5569-thread-1) [
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 2016320 INFO (coreLoadExecutor-5569-thread-1) [
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1],
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.update.AutoCommitTest_2C3C29D4212BA24C-001/init-core-data-001/]
[junit4] 2> 2016322 INFO (coreLoadExecutor-5569-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=19, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=1.0]
[junit4] 2> 2016369 INFO (coreLoadExecutor-5569-thread-1) [
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 2016369 INFO (coreLoadExecutor-5569-thread-1) [
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10
numVersionBuckets=65536
[junit4] 2> 2016370 INFO (coreLoadExecutor-5569-thread-1) [
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2016370 INFO (coreLoadExecutor-5569-thread-1) [
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2016370 INFO (coreLoadExecutor-5569-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=43, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.297980149086326]
[junit4] 2> 2016371 INFO (coreLoadExecutor-5569-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@68d3f17f[collection1] main]
[junit4] 2> 2016371 INFO (coreLoadExecutor-5569-thread-1) [
x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 2016378 INFO (coreLoadExecutor-5569-thread-1) [
x:collection1] o.a.s.s.DirectSolrSpellChecker init:
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 2016408 INFO (coreLoadExecutor-5569-thread-1) [
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 2016408 INFO
(searcherExecutor-5570-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 2016408 INFO
(searcherExecutor-5570-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 2016408 INFO
(searcherExecutor-5570-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 2016408 INFO
(searcherExecutor-5570-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker:
multipleFields
[junit4] 2> 2016408 INFO
(searcherExecutor-5570-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 2016408 INFO
(searcherExecutor-5570-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 2016409 INFO
(searcherExecutor-5570-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 2016409 INFO
(searcherExecutor-5570-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 2016409 INFO
(searcherExecutor-5570-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 2016410 INFO
(searcherExecutor-5570-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@68d3f17f[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2016411 INFO (coreLoadExecutor-5569-thread-1) [
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent
updates, using new clock 1573787915777998848
[junit4] 2> 2016414 INFO
(SUITE-AutoCommitTest-seed#[2C3C29D4212BA24C]-worker) [ ]
o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 2016416 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[2C3C29D4212BA24C]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testMaxDocs
[junit4] 2> 2016416 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[2C3C29D4212BA24C]) [ ]
o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 2016417 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[2C3C29D4212BA24C]) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@5028435a[collection1] realtime]
[junit4] 2> 2016417 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[2C3C29D4212BA24C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}{deleteByQuery=*:*
(-9223372036854775807)} 0 1
[junit4] 2> 2016418 ERROR
(TEST-AutoCommitTest.testMaxDocs-seed#[2C3C29D4212BA24C]) [ ]
o.a.s.c.CorePropertiesLocator Couldn't load core descriptor from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/core.properties:java.nio.file.NoSuchFileException:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/core.properties
[junit4] 2> 2016418 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[2C3C29D4212BA24C]) [ ]
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths:
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/lib,
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 2016442 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[2C3C29D4212BA24C]) [ ]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 2016463 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[2C3C29D4212BA24C]) [ ]
o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 2016562 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[2C3C29D4212BA24C]) [ ]
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 2016569 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[2C3C29D4212BA24C]) [ ]
o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using configuration from
instancedir
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1
[junit4] 2> 2016584 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[2C3C29D4212BA24C]) [ 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@7f1cb5fd
[junit4] 2> 2016584 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[2C3C29D4212BA24C]) [ x:collection1]
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1],
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.update.AutoCommitTest_2C3C29D4212BA24C-001/init-core-data-001/]
[junit4] 2> 2016627 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[2C3C29D4212BA24C]) [ x:collection1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2016627 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[2C3C29D4212BA24C]) [ x:collection1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2016628 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[2C3C29D4212BA24C]) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@2563652f[collection1] main]
[junit4] 2> 2016628 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[2C3C29D4212BA24C]) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 2016629 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[2C3C29D4212BA24C]) [ x:collection1]
o.a.s.s.DirectSolrSpellChecker init:
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 2016631 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[2C3C29D4212BA24C]) [ x:collection1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 2016631 INFO
(searcherExecutor-5575-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 2016632 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[2C3C29D4212BA24C]) [ x:collection1]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1573787916009734144
[junit4] 2> 2016632 INFO
(searcherExecutor-5575-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 2016632 INFO
(searcherExecutor-5575-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 2016632 INFO
(searcherExecutor-5575-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker:
multipleFields
[junit4] 2> 2016632 INFO
(searcherExecutor-5575-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 2016633 INFO
(searcherExecutor-5575-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 2016633 INFO
(searcherExecutor-5575-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 2016633 INFO
(searcherExecutor-5575-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 2016634 INFO
(searcherExecutor-5575-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 2016635 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[2C3C29D4212BA24C]) [ x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=38, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=1.0]
[junit4] 2> 2016636 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[2C3C29D4212BA24C]) [ x:collection1]
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 2016638 INFO
(searcherExecutor-5575-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@2563652f[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2016638 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[2C3C29D4212BA24C]) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@6bbc8f4d[collection1] main]
[junit4] 2> 2016638 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[2C3C29D4212BA24C]) [ x:collection1]
o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@9a2f148
[junit4] 2> 2016639 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[2C3C29D4212BA24C]) [ x:collection1]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection1, tag=161673544
[junit4] 2> 2016641 INFO
(searcherExecutor-5575-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@6bbc8f4d[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2016646 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[2C3C29D4212BA24C]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[0
(1573787916023365632)]} 0 1
[junit4] 2> 2016646 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[2C3C29D4212BA24C]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[1
(1573787916024414208)]} 0 1
[junit4] 2> 2016646 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[2C3C29D4212BA24C]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[2
(1573787916024414209)]} 0 1
[junit4] 2> 2016646 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[2C3C29D4212BA24C]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[3
(1573787916024414210)]} 0 2
[junit4] 2> 2016647 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[2C3C29D4212BA24C]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[4
(1573787916025462784)]} 0 2
[junit4] 2> 2016647 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[2C3C29D4212BA24C]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[5
(1573787916025462785)]} 0 2
[junit4] 2> 2016647 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[2C3C29D4212BA24C]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[6
(1573787916025462786)]} 0 2
[junit4] 2> 2016647 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[2C3C29D4212BA24C]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[7
(1573787916025462787)]} 0 2
[junit4] 2> 2016647 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[2C3C29D4212BA24C]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[8
(1573787916025462788)]} 0 2
[junit4] 2> 2016647 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[2C3C29D4212BA24C]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[9
(1573787916025462789)]} 0 2
[junit4] 2> 2016647 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[2C3C29D4212BA24C]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[10
(1573787916025462790)]} 0 3
[junit4] 2> 2016648 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[2C3C29D4212BA24C]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[11
(1573787916026511360)]} 0 3
[junit4] 2> 2016648 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[2C3C29D4212BA24C]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[12
(1573787916026511361)]} 0 3
[junit4] 2> 2016648 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[2C3C29D4212BA24C]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[13
(1573787916026511362)]} 0 3
[junit4] 2> 2016648 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[2C3C29D4212BA24C]) [ 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> 2016650 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[2C3C29D4212BA24C]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[14
(1573787916028608512)]} 0 5
[junit4] 2> 2016651 INFO (commitScheduler-5578-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> 2016708 INFO (commitScheduler-5578-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@7c3402c4[collection1] main]
[junit4] 2> 2016710 INFO
(searcherExecutor-5575-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@7c3402c4[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):c15)))}
[junit4] 2> 2016710 INFO (commitScheduler-5578-thread-1) [
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 2016901 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[2C3C29D4212BA24C]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[15
(1573787916290752512)]} 0 256
[junit4] 2> 2016901 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[2C3C29D4212BA24C]) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=id:14&qt=&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0
[junit4] 2> 2016902 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[2C3C29D4212BA24C]) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=id:15&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
[junit4] 2> 2016902 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[2C3C29D4212BA24C]) [ x:collection1]
o.a.s.SolrTestCaseJ4 ###Ending testMaxDocs
[junit4] 2> 2016908 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[2C3C29D4212BA24C]) [ x:collection1]
o.a.s.SolrTestCaseJ4 ###Starting testMaxTime
[junit4] 2> 2016908 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[2C3C29D4212BA24C]) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 2016910 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[2C3C29D4212BA24C]) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@33d24e0d[collection1] realtime]
[junit4] 2> 2016910 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[2C3C29D4212BA24C]) [ 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 2
[junit4] 2> 2016910 ERROR
(TEST-AutoCommitTest.testMaxTime-seed#[2C3C29D4212BA24C]) [ x:collection1]
o.a.s.c.CorePropertiesLocator Couldn't load core descriptor from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/core.properties:java.nio.file.NoSuchFileException:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/core.properties
[junit4] 2> 2016911 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[2C3C29D4212BA24C]) [ x:collection1]
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths:
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/lib,
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 2016962 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[2C3C29D4212BA24C]) [ x:collection1]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 2016980 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[2C3C29D4212BA24C]) [ x:collection1]
o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 2017062 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[2C3C29D4212BA24C]) [ x:collection1]
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 2017069 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[2C3C29D4212BA24C]) [ x:collection1]
o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using configuration from
instancedir
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1
[junit4] 2> 2017079 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[2C3C29D4212BA24C]) [ 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@7f1cb5fd
[junit4] 2> 2017079 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[2C3C29D4212BA24C]) [ x:collection1]
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1],
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.update.AutoCommitTest_2C3C29D4212BA24C-001/init-core-data-001/]
[junit4] 2> 2017121 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[2C3C29D4212BA24C]) [ x:collection1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2017121 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[2C3C29D4212BA24C]) [ x:collection1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2017122 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[2C3C29D4212BA24C]) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@6532f7a5[collection1] main]
[junit4] 2> 2017122 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[2C3C29D4212BA24C]) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 2017123 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[2C3C29D4212BA24C]) [ x:collection1]
o.a.s.s.DirectSolrSpellChecker init:
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 2017125 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[2C3C29D4212BA24C]) [ x:collection1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 2017128 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[2C3C29D4212BA24C]) [ x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=16, maxMergeAtOnceExplicit=37, maxMergedSegmentMB=14.400390625,
floorSegmentMB=2.10546875, forceMergeDeletesPctAllowed=20.251443402924643,
segmentsPerTier=16.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
[junit4] 2> 2017128 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[2C3C29D4212BA24C]) [ x:collection1]
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 2017128 INFO
(searcherExecutor-5579-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 2017128 INFO
(searcherExecutor-5579-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 2017129 INFO
(searcherExecutor-5579-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 2017129 INFO
(searcherExecutor-5579-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker:
multipleFields
[junit4] 2> 2017129 INFO
(searcherExecutor-5579-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 2017129 INFO
(searcherExecutor-5579-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 2017129 INFO
(searcherExecutor-5579-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 2017129 INFO
(searcherExecutor-5579-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 2017129 INFO
(searcherExecutor-5579-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 2017131 INFO
(searcherExecutor-5579-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@6532f7a5[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2017131 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[2C3C29D4212BA24C]) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@4afead73[collection1] main]
[junit4] 2> 2017132 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[2C3C29D4212BA24C]) [ x:collection1]
o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@2be76017
[junit4] 2> 2017132 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[2C3C29D4212BA24C]) [ x:collection1]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection1, tag=736583703
[junit4] 2> 2017135 INFO
(searcherExecutor-5579-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@4afead73[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2017135 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[2C3C29D4212BA24C]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[529
(1573787916536119296)]} 0 1
[junit4] 2> 2017136 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[2C3C29D4212BA24C]) [ 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> 2017136 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[2C3C29D4212BA24C]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[530
(1573787916538216448)]} 0 2
[junit4] 2> 2017136 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[2C3C29D4212BA24C]) [ 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> 2017136 ERROR
(TEST-AutoCommitTest.testMaxTime-seed#[2C3C29D4212BA24C]) [ x:collection1]
o.a.s.SolrTestCaseJ4 REQUEST FAILED: xpath=//result[@numFound=1]
[junit4] 2> xml response was: <?xml version="1.0" encoding="UTF-8"?>
[junit4] 2> <response>
[junit4] 2> <lst name="responseHeader"><int name="status">0</int><int
name="QTime">0</int></lst><result name="response" numFound="0"
start="0"></result>
[junit4] 2> </response>
[junit4] 2>
[junit4] 2> request was:q=id:529&qt=&start=0&rows=20&version=2.2
[junit4] 2> 2017137 ERROR
(TEST-AutoCommitTest.testMaxTime-seed#[2C3C29D4212BA24C]) [ x:collection1]
o.a.s.SolrTestCaseJ4 REQUEST FAILED:
q=id:529&qt=&start=0&rows=20&version=2.2:java.lang.RuntimeException: REQUEST
FAILED: xpath=//result[@numFound=1]
[junit4] 2> xml response was: <?xml version="1.0" encoding="UTF-8"?>
[junit4] 2> <response>
[junit4] 2> <lst name="responseHeader"><int name="status">0</int><int
name="QTime">0</int></lst><result name="response" numFound="0"
start="0"></result>
[junit4] 2> </response>
[junit4] 2>
[junit4] 2> request was:q=id:529&qt=&start=0&rows=20&version=2.2
[junit4] 2> at
org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:872)
[junit4] 2> at
org.apache.solr.update.AutoCommitTest.testMaxTime(AutoCommitTest.java:270)
[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> 2017137 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[2C3C29D4212BA24C]) [ x:collection1]
o.a.s.SolrTestCaseJ4 ###Ending testMaxTime
[junit4] 2> NOTE: download the large Jenkins line-docs file by running
'ant get-jenkins-line-docs' in the lucene directory.
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=AutoCommitTest
-Dtests.method=testMaxTime -Dtests.seed=2C3C29D4212BA24C -Dtests.multiplier=2
-Dtests.nightly=true -Dtests.slow=true
-Dtests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/test-data/enwiki.random.lines.txt
-Dtests.locale=et-EE -Dtests.timezone=Asia/Almaty -Dtests.asserts=true
-Dtests.file.encoding=UTF-8
[junit4] ERROR 0.24s J2 | AutoCommitTest.testMaxTime <<<
[junit4] > Throwable #1: java.lang.RuntimeException: Exception during
query
[junit4] > at
__randomizedtesting.SeedInfo.seed([2C3C29D4212BA24C:B6C85436BFB13E70]:0)
[junit4] > at
org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:879)
[junit4] > at
org.apache.solr.update.AutoCommitTest.testMaxTime(AutoCommitTest.java:270)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] > Caused by: java.lang.RuntimeException: REQUEST FAILED:
xpath=//result[@numFound=1]
[junit4] > xml response was: <?xml version="1.0" encoding="UTF-8"?>
[junit4] > <response>
[junit4] > <lst name="responseHeader"><int name="status">0</int><int
name="QTime">0</int></lst><result name="response" numFound="0"
start="0"></result>
[junit4] > </response>
[junit4] > request was:q=id:529&qt=&start=0&rows=20&version=2.2
[junit4] > at
org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:872)
[junit4] > ... 40 more
[junit4] 2> 2017152 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[2C3C29D4212BA24C]) [
x:collection1] o.a.s.SolrTestCaseJ4 ###Starting testCommitWithin
[junit4] 2> 2017152 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[2C3C29D4212BA24C]) [
x:collection1] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL
DOCUMENTS FROM INDEX
[junit4] 2> 2017152 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[2C3C29D4212BA24C]) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@3fc61cfc[collection1] realtime]
[junit4] 2> 2017152 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[2C3C29D4212BA24C]) [
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> 2017152 ERROR
(TEST-AutoCommitTest.testCommitWithin-seed#[2C3C29D4212BA24C]) [
x:collection1] o.a.s.c.CorePropertiesLocator Couldn't load core descriptor from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/core.properties:java.nio.file.NoSuchFileException:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/core.properties
[junit4] 2> 2017153 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[2C3C29D4212BA24C]) [
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader,
from paths:
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/lib,
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 2017193 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[2C3C29D4212BA24C]) [
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 2017212 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[2C3C29D4212BA24C]) [
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 2017317 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[2C3C29D4212BA24C]) [
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 2017324 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[2C3C29D4212BA24C]) [
x:collection1] o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using
configuration from instancedir
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1
[junit4] 2> 2017338 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[2C3C29D4212BA24C]) [
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@7f1cb5fd
[junit4] 2> 2017338 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[2C3C29D4212BA24C]) [
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1],
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.update.AutoCommitTest_2C3C29D4212BA24C-001/init-core-data-001/]
[junit4] 2> 2017397 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[2C3C29D4212BA24C]) [
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2017397 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[2C3C29D4212BA24C]) [
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2017399 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[2C3C29D4212BA24C]) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@575f8cec[collection1] main]
[junit4] 2> 2017399 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[2C3C29D4212BA24C]) [
x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 2017400 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[2C3C29D4212BA24C]) [
x:collection1] o.a.s.s.DirectSolrSpellChecker init:
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 2017402 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[2C3C29D4212BA24C]) [
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 2017405 INFO
(searcherExecutor-5583-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 2017405 INFO
(searcherExecutor-5583-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 2017405 INFO
(searcherExecutor-5583-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 2017405 INFO
(searcherExecutor-5583-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker:
multipleFields
[junit4] 2> 2017405 INFO
(searcherExecutor-5583-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 2017405 INFO
(searcherExecutor-5583-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 2017406 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[2C3C29D4212BA24C]) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy:
minMergeSize=0, mergeFactor=10, maxMergeSize=1032781089,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.1]
[junit4] 2> 2017406 INFO
(searcherExecutor-5583-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 2017406 INFO
(searcherExecutor-5583-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 2017406 INFO
(searcherExecutor-5583-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 2017408 INFO
(searcherExecutor-5583-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@575f8cec[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2017408 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[2C3C29D4212BA24C]) [
x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 2017408 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[2C3C29D4212BA24C]) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@51996347[collection1] main]
[junit4] 2> 2017409 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[2C3C29D4212BA24C]) [
x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@7e95b77b
[junit4] 2> 2017411 INFO
(searcherExecutor-5583-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@51996347[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2017411 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[2C3C29D4212BA24C]) [
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection1, tag=2123741051
[junit4] 2> 2017420 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[2C3C29D4212BA24C]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[529
(1573787916831817728)]} 0 4
[junit4] 2> 2017420 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[2C3C29D4212BA24C]) [
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> 2021416 INFO (commitScheduler-5586-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> 2021470 INFO (commitScheduler-5586-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@2c22fdde[collection1] main]
[junit4] 2> 2021470 INFO (commitScheduler-5586-thread-1) [
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 2021472 INFO
(searcherExecutor-5583-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@2c22fdde[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_3(8.0.0):c1)))}
[junit4] 2> 2021673 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[2C3C29D4212BA24C]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[530
(1573787921294557184)]} 0 4257
[junit4] 2> 2021673 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[2C3C29D4212BA24C]) [
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> 2021674 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[2C3C29D4212BA24C]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[529
(-1573787921295605760)]} 0 4258
[junit4] 2> 2021674 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[2C3C29D4212BA24C]) [
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> 2023674 INFO (commitScheduler-5586-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> 2023680 INFO (commitScheduler-5586-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@3d6dbb0a[collection1] main]
[junit4] 2> 2023680 INFO (commitScheduler-5586-thread-1) [
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 2023681 INFO
(searcherExecutor-5583-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@3d6dbb0a[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(8.0.0):c1)))}
[junit4] 2> 2023925 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[2C3C29D4212BA24C]) [
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> 2023925 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[2C3C29D4212BA24C]) [
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> 2023926 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[2C3C29D4212BA24C]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1573787923658047488)]} 0 6510
[junit4] 2> 2023926 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[2C3C29D4212BA24C]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1573787923658047489)]} 0 6510
[junit4] 2> 2023927 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[2C3C29D4212BA24C]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1573787923659096064)]} 0 6511
[junit4] 2> 2023927 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[2C3C29D4212BA24C]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1573787923659096065)]} 0 6511
[junit4] 2> 2023927 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[2C3C29D4212BA24C]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1573787923659096066)]} 0 6511
[junit4] 2> 2023927 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[2C3C29D4212BA24C]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1573787923659096067)]} 0 6511
[junit4] 2> 2023927 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[2C3C29D4212BA24C]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1573787923659096068)]} 0 6511
[junit4] 2> 2023927 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[2C3C29D4212BA24C]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1573787923659096069)]} 0 6511
[junit4] 2> 2023927 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[2C3C29D4212BA24C]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1573787923659096070)]} 0 6511
[junit4] 2> 2023927 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[2C3C29D4212BA24C]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1573787923659096071)]} 0 6511
[junit4] 2> 2023927 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[2C3C29D4212BA24C]) [
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> 2023928 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[2C3C29D4212BA24C]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530
(-1573787923660144640)]} 0 6512
[junit4] 2> 2023928 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[2C3C29D4212BA24C]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530
(-1573787923660144641)]} 0 6512
[junit4] 2> 2023928 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[2C3C29D4212BA24C]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530
(-1573787923660144642)]} 0 6512
[junit4] 2> 2023928 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[2C3C29D4212BA24C]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530
(-1573787923660144643)]} 0 6512
[junit4] 2> 2023928 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[2C3C29D4212BA24C]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530
(-1573787923660144644)]} 0 6512
[junit4] 2> 2023928 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[2C3C29D4212BA24C]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530
(-1573787923660144645)]} 0 6512
[junit4] 2> 2023928 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[2C3C29D4212BA24C]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530
(-1573787923660144646)]} 0 6512
[junit4] 2> 2023928 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[2C3C29D4212BA24C]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530
(-1573787923660144647)]} 0 6512
[junit4] 2> 2023930 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[2C3C29D4212BA24C]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530
(-1573787923662241792)]} 0 6514
[junit4] 2> 2023930 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[2C3C29D4212BA24C]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530
(-1573787923662241793)]} 0 6514
[junit4] 2> 2023930 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[2C3C29D4212BA24C]) [
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> 2024928 INFO (commitScheduler-5586-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> 2024932 INFO (commitScheduler-5586-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@6554bf[collection1]
main]
[junit4] 2> 2024932 INFO (commitScheduler-5586-thread-1) [
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 2024935 INFO
(searcherExecutor-5583-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@6554bf[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_5(8.0.0):c10/9:delGen=1)))}
[junit4] 2> 2025181 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[2C3C29D4212BA24C]) [
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> 2025182 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[2C3C29D4212BA24C]) [
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> 2025182 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[2C3C29D4212BA24C]) [
x:collection1] o.a.s.SolrTestCaseJ4 ###Ending testCommitWithin
[junit4] 2> 2025182 INFO
(SUITE-AutoCommitTest-seed#[2C3C29D4212BA24C]-worker) [ x:collection1]
o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> 2025182 INFO
(SUITE-AutoCommitTest-seed#[2C3C29D4212BA24C]-worker) [ x:collection1]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1287937912
[junit4] 2> 2025183 INFO
(SUITE-AutoCommitTest-seed#[2C3C29D4212BA24C]-worker) [ x:collection1]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 2025184 INFO
(SUITE-AutoCommitTest-seed#[2C3C29D4212BA24C]-worker) [ x:collection1]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 2025186 INFO
(SUITE-AutoCommitTest-seed#[2C3C29D4212BA24C]-worker) [ x:collection1]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 2025186 INFO
(SUITE-AutoCommitTest-seed#[2C3C29D4212BA24C]-worker) [ x:collection1]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 2025187 INFO
(coreCloseExecutor-5587-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@510bd554
[junit4] 2> 2025187 INFO
(coreCloseExecutor-5587-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter close.
[junit4] 2> 2025187 INFO
(coreCloseExecutor-5587-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@67f67d80 commitCommandVersion:0
[junit4] 2> 2025188 INFO
(coreCloseExecutor-5587-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection1, tag=1359730004
[junit4] 2> NOTE: leaving temporary files on disk at:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.update.AutoCommitTest_2C3C29D4212BA24C-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70):
{range_facet_l_dv=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
field_t=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
multiDefault=BlockTreeOrds(blocksize=128),
subject=BlockTreeOrds(blocksize=128), intDefault=Lucene50(blocksize=128),
id_i1=Lucene50(blocksize=128),
id=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
range_facet_i_dv=BlockTreeOrds(blocksize=128),
text=PostingsFormat(name=LuceneVarGapDocFreqInterval),
range_facet_l=BlockTreeOrds(blocksize=128),
timestamp=BlockTreeOrds(blocksize=128)},
docValues:{range_facet_l_dv=DocValuesFormat(name=Asserting),
_version_=DocValuesFormat(name=Memory),
range_facet_i_dv=DocValuesFormat(name=Lucene70),
intDvoDefault=DocValuesFormat(name=Asserting),
timestamp=DocValuesFormat(name=Lucene70)}, maxPointsInLeafNode=2008,
maxMBSortInHeap=7.036702183003561, sim=RandomSimilarity(queryNorm=false): {},
locale=et-EE, timezone=Asia/Almaty
[junit4] 2> NOTE: Linux 3.13.0-88-generic amd64/Oracle Corporation
1.8.0_131 (64-bit)/cpus=4,threads=1,free=133181520,total=517996544
[junit4] 2> NOTE: All tests run in this JVM: [ExitableDirectoryReaderTest,
StatsReloadRaceTest, SolrMetricReporterTest, TestSuggestSpellingConverter,
ClusterStateTest, SolrCoreCheckLockOnStartupTest, SolrInfoBeanTest,
TestNestedDocsSort, TestCollationFieldDocValues, SpellPossibilityIteratorTest,
CursorMarkTest, TestUtils, TestRawTransformer, TestConfigsApi, TestRecovery,
HdfsBasicDistributedZk2Test, TestQuerySenderListener,
FastVectorHighlighterTest, TestMinMaxOnMultiValuedField, SearchHandlerTest,
SimplePostToolTest, TestSchemaNameResource, CleanupOldIndexTest,
ConfigureRecoveryStrategyTest, HdfsSyncSliceTest,
TestLegacyNumericRangeQueryBuilder, TestTolerantUpdateProcessorRandomCloud,
TestFieldCacheReopen, RollingRestartTest, TestSSLRandomization, RecoveryZkTest,
ReplicaListTransformerTest, TestXmlQParserPlugin, TestCollectionAPI,
DeleteReplicaTest, TestSolrConfigHandler, ImplicitSnitchTest,
HdfsChaosMonkeySafeLeaderTest, ResponseHeaderTest, DeleteInactiveReplicaTest,
TestAnalyzedSuggestions, TestRandomCollapseQParserPlugin, TestBlobHandler,
TestCustomSort, TestSizeLimitedDistributedMap, TestGroupingSearch,
TestGraphTermsQParserPlugin, TestQueryUtils, TermsComponentTest,
DataDrivenBlockJoinTest, PKIAuthenticationIntegrationTest,
TestRandomFlRTGCloud, DateMathParserTest, TestIndexSearcher,
ResponseLogComponentTest, TestDeleteCollectionOnDownNodes, MetricsConfigTest,
TestConfigSetsAPIExclusivity, BlockDirectoryTest, HdfsUnloadDistributedZkTest,
TestSurroundQueryParser, PolyFieldTest, NumericFieldsTest,
TestSolrCLIRunExample, DistributedExpandComponentTest,
OverriddenZkACLAndCredentialsProvidersTest, TestFieldCacheVsDocValues,
TestLegacyFieldReuse, TestFastWriter, UnloadDistributedZkTest, TestLockTree,
BadIndexSchemaTest, SignatureUpdateProcessorFactoryTest,
PropertiesRequestHandlerTest, TestCollapseQParserPlugin, MetricUtilsTest,
DocumentBuilderTest, TestManagedSchemaAPI, TestUseDocValuesAsStored2,
TestTrackingShardHandlerFactory, TestFieldResource, CdcrReplicationHandlerTest,
URLClassifyProcessorTest, TestZkChroot, TestSubQueryTransformer,
TestManagedStopFilterFactory, PreAnalyzedFieldTest, TestTrie,
TestStressUserVersions, BasicDistributedZk2Test,
TestRuleBasedAuthorizationPlugin, TestLeaderElectionZkExpiry,
SolrTestCaseJ4Test, StatsComponentTest, TolerantUpdateProcessorTest,
SuggesterFSTTest, TestImpersonationWithHadoopAuth, SimpleFacetsTest, TestSort,
SortByFunctionTest, TestExportWriter, TestPayloadCheckQParserPlugin,
TestCloudPseudoReturnFields, CopyFieldTest, V2StandaloneTest,
HdfsLockFactoryTest, MinimalSchemaTest, TestLRUStatsCache, TestLFUCache,
SolrGraphiteReporterTest, BJQParserTest, NotRequiredUniqueKeyTest,
WrapperMergePolicyFactoryTest, ReturnFieldsTest, FullSolrCloudDistribCmdsTest,
LeaderElectionTest, ZkSolrClientTest, AutoCommitTest]
[junit4] Completed [330/727 (1!)] on J2 in 9.23s, 3 tests, 1 error <<<
FAILURES!
[...truncated 630 lines...]
[junit4] Suite: org.apache.solr.cloud.SharedFSAutoReplicaFailoverTest
[junit4] 2> 2783716 INFO
(SUITE-SharedFSAutoReplicaFailoverTest-seed#[2C3C29D4212BA24C]-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-NightlyTests-master/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.SharedFSAutoReplicaFailoverTest_2C3C29D4212BA24C-001/init-core-data-001
[junit4] 2> 2783716 WARN
(SUITE-SharedFSAutoReplicaFailoverTest-seed#[2C3C29D4212BA24C]-worker) [ ]
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=17 numCloses=17
[junit4] 2> 2783717 INFO
(SUITE-SharedFSAutoReplicaFailoverTest-seed#[2C3C29D4212BA24C]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 2783718 INFO
(SUITE-SharedFSAutoReplicaFailoverTest-seed#[2C3C29D4212BA24C]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via:
@org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl=None)
[junit4] 2> 2783718 INFO
(SUITE-SharedFSAutoReplicaFailoverTest-seed#[2C3C29D4212BA24C]-worker) [ ]
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /
[junit4] 1> Formatting using clusterid: testClusterID
[junit4] 2> 2783778 WARN
(SUITE-SharedFSAutoReplicaFailoverTest-seed#[2C3C29D4212BA24C]-worker) [ ]
o.a.h.m.i.MetricsConfig Cannot locate configuration: tried
hadoop-metrics2-namenode.properties,hadoop-metrics2.properties
[junit4] 2> 2783807 WARN
(SUITE-SharedFSAutoReplicaFailoverTest-seed#[2C3C29D4212BA24C]-worker) [ ]
o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
[junit4] 2> 2783810 INFO
(SUITE-SharedFSAutoReplicaFailoverTest-seed#[2C3C29D4212BA24C]-worker) [ ]
o.m.log jetty-6.1.26
[junit4] 2> 2783845 INFO
(SUITE-SharedFSAutoReplicaFailoverTest-seed#[2C3C29D4212BA24C]-worker) [ ]
o.m.log Extract
jar:file:/x1/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.7.2-tests.jar!/webapps/hdfs
to ./temp/Jetty_localhost_36479_hdfs____6pvxbx/webapp
[junit4] 2> 2784241 INFO
(SUITE-SharedFSAutoReplicaFailoverTest-seed#[2C3C29D4212BA24C]-worker) [ ]
o.m.log Started
HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:36479
[junit4] 2> 2784403 WARN
(SUITE-SharedFSAutoReplicaFailoverTest-seed#[2C3C29D4212BA24C]-worker) [ ]
o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
[junit4] 2> 2784404 INFO
(SUITE-SharedFSAutoReplicaFailoverTest-seed#[2C3C29D4212BA24C]-worker) [ ]
o.m.log jetty-6.1.26
[junit4] 2> 2784432 INFO
(SUITE-SharedFSAutoReplicaFailoverTest-seed#[2C3C29D4212BA24C]-worker) [ ]
o.m.log Extract
jar:file:/x1/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.7.2-tests.jar!/webapps/datanode
to ./temp/Jetty_localhost_37324_datanode____.togxjc/webapp
[junit4] 2> 2784886 INFO
(SUITE-SharedFSAutoReplicaFailoverTest-seed#[2C3C29D4212BA24C]-worker) [ ]
o.m.log Started
HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:37324
[junit4] 2> 2785069 WARN
(SUITE-SharedFSAutoReplicaFailoverTest-seed#[2C3C29D4212BA24C]-worker) [ ]
o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
[junit4] 2> 2785070 INFO
(SUITE-SharedFSAutoReplicaFailoverTest-seed#[2C3C29D4212BA24C]-worker) [ ]
o.m.log jetty-6.1.26
[junit4] 2> 2785094 INFO
(SUITE-SharedFSAutoReplicaFailoverTest-seed#[2C3C29D4212BA24C]-worker) [ ]
o.m.log Extract
jar:file:/x1/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.7.2-tests.jar!/webapps/datanode
to ./temp/Jetty_localhost_40397_datanode____.la28lg/webapp
[junit4] 2> 2785256 INFO (IPC Server handler 5 on 48360) [ ]
BlockStateChange BLOCK* processReport: from storage
DS-47313cc7-9f53-49e2-9620-4d6b4b288c74 node
DatanodeRegistration(127.0.0.1:45915,
datanodeUuid=01e0fd26-1b7a-4d5e-b913-607156304e12, infoPort=54809,
infoSecurePort=0, ipcPort=44386,
storageInfo=lv=-56;cid=testClusterID;nsid=1193686392;c=0), blocks: 0,
hasStaleStorage: true, processing time: 1 msecs
[junit4] 2> 2785257 INFO (IPC Server handler 5 on 48360) [ ]
BlockStateChange BLOCK* processReport: from storage
DS-ca27ec8f-f073-4ca6-8cae-5c2272cd12b0 node
DatanodeRegistration(127.0.0.1:45915,
datanodeUuid=01e0fd26-1b7a-4d5e-b913-607156304e12, infoPort=54809,
infoSecurePort=0, ipcPort=44386,
storageInfo=lv=-56;cid=testClusterID;nsid=1193686392;c=0), blocks: 0,
hasStaleStorage: false, processing time: 0 msecs
[junit4] 2> 2785528 INFO
(SUITE-SharedFSAutoReplicaFailoverTest-seed#[2C3C29D4212BA24C]-worker) [ ]
o.m.log Started
HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:40397
[junit4] 2> 2785695 INFO (IPC Server handler 7 on 48360) [ ]
BlockStateChange BLOCK* processReport: from storage
DS-1d635e1f-aa26-4d42-9a61-52d26e34be5b node
DatanodeRegistration(127.0.0.1:50978,
datanodeUuid=8a113caf-0cc4-413d-bc2a-da2854c123b5, infoPort=54726,
infoSecurePort=0, ipcPort=56844,
storageInfo=lv=-56;cid=testClusterID;nsid=1193686392;c=0), blocks: 0,
hasStaleStorage: true, processing time: 2 msecs
[junit4] 2> 2785695 INFO (IPC Server handler 7 on 48360) [ ]
BlockStateChange BLOCK* processReport: from storage
DS-80ee90d8-772d-429c-b2a5-2da14ade305b node
DatanodeRegistration(127.0.0.1:50978,
datanodeUuid=8a113caf-0cc4-413d-bc2a-da2854c123b5, infoPort=54726,
infoSecurePort=0, ipcPort=56844,
storageInfo=lv=-56;cid=testClusterID;nsid=1193686392;c=0), blocks: 0,
hasStaleStorage: false, processing time: 0 msecs
[junit4] 2> 2785899 INFO
(TEST-SharedFSAutoReplicaFailoverTest.test-seed#[2C3C29D4212BA24C]) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 2785900 INFO (Thread-86077) [ ] o.a.s.c.ZkTestServer
client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 2785900 INFO (Thread-86077) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 2785908 ERROR (Thread-86077) [ ] 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> 2786000 INFO
(TEST-SharedFSAutoReplicaFailoverTest.test-seed#[2C3C29D4212BA24C]) [ ]
o.a.s.c.ZkTestServer start zk server on port:37961
[junit4] 2> 2786027 INFO
(TEST-SharedFSAutoReplicaFailoverTest.test-seed#[2C3C29D4212BA24C]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
to /configs/conf1/solrconfig.xml
[junit4] 2> 2786028 INFO
(TEST-SharedFSAutoReplicaFailoverTest.test-seed#[2C3C29D4212BA24C]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/schema15.xml
to /configs/conf1/schema.xml
[junit4] 2> 2786029 INFO
(TEST-SharedFSAutoReplicaFailoverTest.test-seed#[2C3C29D4212BA24C]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 2786030 INFO
(TEST-SharedFSAutoReplicaFailoverTest.test-seed#[2C3C29D4212BA24C]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
to /configs/conf1/stopwords.txt
[junit4] 2> 2786032 INFO
(TEST-SharedFSAutoReplicaFailoverTest.test-seed#[2C3C29D4212BA24C]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/protwords.txt
to /configs/conf1/protwords.txt
[junit4] 2> 2786034 INFO
(TEST-SharedFSAutoReplicaFailoverTest.test-seed#[2C3C29D4212BA24C]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/currency.xml
to /configs/conf1/currency.xml
[junit4] 2> 2786038 INFO
(TEST-SharedFSAutoReplicaFailoverTest.test-seed#[2C3C29D4212BA24C]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
to /configs/conf1/enumsConfig.xml
[junit4] 2> 2786039 INFO
(TEST-SharedFSAutoReplicaFailoverTest.test-seed#[2C3C29D4212BA24C]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
to /configs/conf1/open-exchange-rates.json
[junit4] 2> 2786040 INFO
(TEST-SharedFSAutoReplicaFailoverTest.test-seed#[2C3C29D4212BA24C]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 2786042 INFO
(TEST-SharedFSAutoReplicaFailoverTest.test-seed#[2C3C29D4212BA24C]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
to /configs/conf1/old_synonyms.txt
[junit4] 2> 2786044 INFO
(TEST-SharedFSAutoReplicaFailoverTest.test-seed#[2C3C29D4212BA24C]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
to /configs/conf1/synonyms.txt
[junit4] 2> 2786046 INFO
(TEST-SharedFSAutoReplicaFailoverTest.test-seed#[2C3C29D4212BA24C]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase Will use NRT replicas unless explicitly
asked otherwise
[junit4] 2> 2786159 INFO
(TEST-SharedFSAutoReplicaFailoverTest.test-seed#[2C3C29D4212BA24C]) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 2786161 INFO
(TEST-SharedFSAutoReplicaFailoverTest.test-seed#[2C3C29D4212BA24C]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@6db50e59{/,null,AVAILABLE}
[junit4] 2> 2786161 INFO
(TEST-SharedFSAutoReplicaFailoverTest.test-seed#[2C3C29D4212BA24C]) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@2f9ccb7a{HTTP/1.1,[http/1.1]}{127.0.0.1:57783}
[junit4] 2> 2786161 INFO
(TEST-SharedFSAutoReplicaFailoverTest.test-seed#[2C3C29D4212BA24C]) [ ]
o.e.j.s.Server Started @2788409ms
[junit4] 2> 2786161 INFO
(TEST-SharedFSAutoReplicaFailoverTest.test-seed#[2C3C29D4212BA24C]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {replicaType=NRT, hostContext=/,
hostPort=57783,
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.SharedFSAutoReplicaFailoverTest_2C3C29D4212BA24C-001/control-001/cores}
[junit4] 2> 2786161 ERROR
(TEST-SharedFSAutoReplicaFailoverTest.test-seed#[2C3C29D4212BA24C]) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2786161 INFO
(TEST-SharedFSAutoReplicaFailoverTest.test-seed#[2C3C29D4212BA24C]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
8.0.0
[junit4] 2> 2786161 INFO
(TEST-SharedFSAutoReplicaFailoverTest.test-seed#[2C3C29D4212BA24C]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2786161 INFO
(TEST-SharedFSAutoReplicaFailoverTest.test-seed#[2C3C29D4212BA24C]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null, Default config
dir: null
[junit4] 2> 2786161 INFO
(TEST-SharedFSAutoReplicaFailoverTest.test-seed#[2C3C29D4212BA24C]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-07-24T07:38:04.771Z
[junit4] 2> 2786176 INFO
(TEST-SharedFSAutoReplicaFailoverTest.test-seed#[2C3C29D4212BA24C]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 2786177 INFO
(TEST-SharedFSAutoReplicaFailoverTest.test-seed#[2C3C29D4212BA24C]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.SharedFSAutoReplicaFailoverTest_2C3C29D4212BA24C-001/control-001/solr.xml
[junit4] 2> 2786183 INFO
(TEST-SharedFSAutoReplicaFailoverTest.test-seed#[2C3C29D4212BA24C]) [ ]
o.a.s.c.SolrXmlConfig MBean server found:
com.sun.jmx.mbeanserver.JmxMBeanServer@1ce723f9, but no JMX reporters were
configured - adding default JMX reporter.
[junit4] 2> 2786189 INFO
(TEST-SharedFSAutoReplicaFailoverTest.test-seed#[2C3C29D4212BA24C]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:37961/solr
[junit4] 2> 2786362 INFO
(TEST-SharedFSAutoReplicaFailoverTest.test-seed#[2C3C29D4212BA24C])
[n:127.0.0.1:57783_ ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 2786364 INFO
(TEST-SharedFSAutoReplicaFailoverTest.test-seed#[2C3C29D4212BA24C])
[n:127.0.0.1:57783_ ] o.a.s.c.OverseerElectionContext I am going to be the
leader 127.0.0.1:57783_
[junit4] 2> 2786366 INFO
(TEST-SharedFSAutoReplicaFailoverTest.test-seed#[2C3C29D4212BA24C])
[n:127.0.0.1:57783_ ] o.a.s.c.Overseer Overseer
(id=98361795183247364-127.0.0.1:57783_-n_0000000000) starting
[junit4] 2> 2786383 INFO
(TEST-SharedFSAutoReplicaFailoverTest.test-seed#[2C3C29D4212BA24C])
[n:127.0.0.1:57783_ ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:57783_
[junit4] 2> 2786384 INFO
(zkCallback-2488-thread-1-processing-n:127.0.0.1:57783_) [n:127.0.0.1:57783_
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 2786436 INFO
(TEST-SharedFSAutoReplicaFailoverTest.test-seed#[2C3C29D4212BA24C])
[n:127.0.0.1:57783_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1ce723f9
[junit4] 2> 2786442 INFO
(TEST-SharedFSAutoReplicaFailoverTest.test-seed#[2C3C29D4212BA24C])
[n:127.0.0.1:57783_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1ce723f9
[junit4] 2> 2786442 INFO
(TEST-SharedFSAutoReplicaFailoverTest.test-seed#[2C3C29D4212BA24C])
[n:127.0.0.1:57783_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1ce723f9
[junit4] 2> 2786443 INFO
(TEST-SharedFSAutoReplicaFailoverTest.test-seed#[2C3C29D4212BA24C])
[n:127.0.0.1:57783_ ] o.a.s.c.CorePropertiesLocator Found 0 core definitions
underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.SharedFSAutoReplicaFailoverTest_2C3C29D4212BA24C-001/control-001/cores
[junit4] 2> 2786465 INFO
(TEST-SharedFSAutoReplicaFailoverTest.test-seed#[2C3C29D4212BA24C]) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 2786467 INFO
(TEST-SharedFSAutoReplicaFailoverTest.test-seed#[2C3C29D4212BA24C]) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:37961/solr ready
[junit4] 2> 2786471 INFO (qtp1556134548-100132) [n:127.0.0.1:57783_ ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
replicationFactor=1&collection.configName=conf1&name=control_collection&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=127.0.0.1:57783_&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 2786474 INFO
(OverseerThreadFactory-7313-thread-1-processing-n:127.0.0.1:57783_)
[n:127.0.0.1:57783_ ] o.a.s.c.CreateCollectionCmd Create collection
control_collection
[junit4] 2> 2786580 INFO (qtp1556134548-100134) [n:127.0.0.1:57783_ ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&collection.configName=conf1&newCollection=true&name=control_collection_shard1_replica_n1&action=CREATE&numShards=1&collection=control_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 2786581 INFO (qtp1556134548-100134) [n:127.0.0.1:57783_ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4
transient cores
[junit4] 2> 2786689 INFO
(zkCallback-2488-thread-1-processing-n:127.0.0.1:57783_) [n:127.0.0.1:57783_
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/control_collection/state.json] for collection
[control_collection] has occurred - updating... (live nodes size: [1])
[junit4] 2> 2787621 INFO (qtp1556134548-100134) [n:127.0.0.1:57783_
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 2787647 INFO (qtp1556134548-100134) [n:127.0.0.1:57783_
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.s.IndexSchema [control_collection_shard1_replica_n1] Schema name=test
[junit4] 2> 2787764 INFO (qtp1556134548-100134) [n:127.0.0.1:57783_
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 2787791 INFO (qtp1556134548-100134) [n:127.0.0.1:57783_
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.c.CoreContainer Creating SolrCore 'control_collection_shard1_replica_n1'
using configuration from collection control_collection, trusted=true
[junit4] 2> 2787792 INFO (qtp1556134548-100134) [n:127.0.0.1:57783_
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.core.control_collection.shard1.replica_n1' (registry
'solr.core.control_collection.shard1.replica_n1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1ce723f9
[junit4] 2> 2787792 INFO (qtp1556134548-100134) [n:127.0.0.1:57783_
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.c.HdfsDirectoryFa
[...truncated too long message...]
at
org.apache.hadoop.metrics2.impl.MetricsSourceAdapter.getMetrics(MetricsSourceAdapter.java:194)
[junit4] 2> at
org.apache.hadoop.metrics2.impl.MetricsSourceAdapter.updateJmxCache(MetricsSourceAdapter.java:172)
[junit4] 2> at
org.apache.hadoop.metrics2.impl.MetricsSourceAdapter.getMBeanInfo(MetricsSourceAdapter.java:151)
[junit4] 2> at
com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.getClassName(DefaultMBeanServerInterceptor.java:1804)
[junit4] 2> at
com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.safeGetClassName(DefaultMBeanServerInterceptor.java:1595)
[junit4] 2> at
com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.checkMBeanPermission(DefaultMBeanServerInterceptor.java:1813)
[junit4] 2> at
com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.exclusiveUnregisterMBean(DefaultMBeanServerInterceptor.java:430)
[junit4] 2> at
com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.unregisterMBean(DefaultMBeanServerInterceptor.java:415)
[junit4] 2> at
com.sun.jmx.mbeanserver.JmxMBeanServer.unregisterMBean(JmxMBeanServer.java:546)
[junit4] 2> at
org.apache.hadoop.metrics2.util.MBeans.unregister(MBeans.java:81)
[junit4] 2> at
org.apache.hadoop.metrics2.impl.MetricsSourceAdapter.stopMBeans(MetricsSourceAdapter.java:226)
[junit4] 2> at
org.apache.hadoop.metrics2.impl.MetricsSourceAdapter.stop(MetricsSourceAdapter.java:211)
[junit4] 2> at
org.apache.hadoop.metrics2.impl.MetricsSystemImpl.stopSources(MetricsSystemImpl.java:463)
[junit4] 2> at
org.apache.hadoop.metrics2.impl.MetricsSystemImpl.stop(MetricsSystemImpl.java:213)
[junit4] 2> at
org.apache.hadoop.metrics2.impl.MetricsSystemImpl.shutdown(MetricsSystemImpl.java:594)
[junit4] 2> at
org.apache.hadoop.metrics2.lib.DefaultMetricsSystem.shutdownInstance(DefaultMetricsSystem.java:72)
[junit4] 2> at
org.apache.hadoop.metrics2.lib.DefaultMetricsSystem.shutdown(DefaultMetricsSystem.java:68)
[junit4] 2> at
org.apache.hadoop.hdfs.server.namenode.metrics.NameNodeMetrics.shutdown(NameNodeMetrics.java:171)
[junit4] 2> at
org.apache.hadoop.hdfs.server.namenode.NameNode.stop(NameNode.java:872)
[junit4] 2> at
org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:1726)
[junit4] 2> at
org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:1705)
[junit4] 2> at
org.apache.solr.cloud.hdfs.HdfsTestUtil.teardownClass(HdfsTestUtil.java:204)
[junit4] 2> at
org.apache.solr.cloud.SharedFSAutoReplicaFailoverTest.hdfsFailoverAfterClass(SharedFSAutoReplicaFailoverTest.java:97)
[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$7.evaluate(RandomizedRunner.java:870)
[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> Caused by: java.lang.NullPointerException
[junit4] 2> at
org.apache.hadoop.hdfs.server.blockmanagement.BlocksMap.size(BlocksMap.java:203)
[junit4] 2> at
org.apache.hadoop.hdfs.server.blockmanagement.BlockManager.getTotalBlocks(BlockManager.java:3370)
[junit4] 2> at
org.apache.hadoop.hdfs.server.namenode.FSNamesystem.getBlocksTotal(FSNamesystem.java:5729)
[junit4] 2> ... 54 more
[junit4] 2> NOTE: leaving temporary files on disk at:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.SharedFSAutoReplicaFailoverTest_2C3C29D4212BA24C-001
[junit4] 2> Jul 24, 2017 7:39:23 AM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 34 leaked
thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70),
sim=RandomSimilarity(queryNorm=false): {},
locale=ja-JP-u-ca-japanese-x-lvariant-JP, timezone=Indian/Maldives
[junit4] 2> NOTE: Linux 3.13.0-88-generic amd64/Oracle Corporation
1.8.0_131 (64-bit)/cpus=4,threads=2,free=234973488,total=521666560
[junit4] 2> NOTE: All tests run in this JVM: [CoreSorterTest,
TestConfigReload, TestAuthorizationFramework, CdcrBootstrapTest,
HdfsDirectoryFactoryTest, EchoParamsTest, TestTestInjection,
TestJsonFacetRefinement, ManagedSchemaRoundRobinCloudTest,
QueryElevationComponentTest, BasicAuthIntegrationTest, TestBinaryField,
TestFastOutputStream, SolrJmxReporterTest, TestReplicationHandler,
TestHashQParserPlugin, AutoScalingHandlerTest, TestConfigOverlay,
DistributedQueryComponentCustomSortTest, TestSolrQueryParser, UpdateParamsTest,
MBeansHandlerTest, ParsingFieldUpdateProcessorsTest, TestMacros, BasicZkTest,
HdfsRecoveryZkTest, SortSpecParsingTest, TestStressCloudBlindAtomicUpdates,
WordBreakSolrSpellCheckerTest, ReplicationFactorTest,
TestRandomRequestDistribution, OverseerStatusTest, CoreAdminCreateDiscoverTest,
TestSolr4Spatial, TestCloudJSONFacetJoinDomain, CollectionTooManyReplicasTest,
TestDynamicLoading, ZkStateReaderTest, HdfsBasicDistributedZkTest,
TestExactSharedStatsCache, CloudExitableDirectoryReaderTest,
ConjunctionSolrSpellCheckerTest, TestFieldSortValues, TestQuerySenderNoQuery,
TestOmitPositions, TestRequestForwarding, TestDistributedSearch, UUIDFieldTest,
TestExtendedDismaxParser, DebugComponentTest, BufferStoreTest,
TestIBSimilarityFactory, TestMiniSolrCloudClusterSSL,
FieldMutatingUpdateProcessorTest, AnalyticsMergeStrategyTest, InfoHandlerTest,
TestCollectionsAPIViaSolrCloudCluster, CheckHdfsIndexTest, TestCloudRecovery,
SpellCheckCollatorTest, HdfsThreadLeakTest, TestSmileRequest,
TestSchemaResource, TestFieldTypeCollectionResource, SolrPluginUtilsTest,
ShufflingReplicaListTransformerTest, TestHttpShardHandlerFactory,
TestReqParamsAPI, MigrateRouteKeyTest, SuggesterWFSTTest, JavabinLoaderTest,
TemplateUpdateProcessorTest, TlogReplayBufferedWhileIndexingTest,
TestHdfsCloudBackupRestore, TestPHPSerializedResponseWriter,
TestIndexingPerformance, RequestLoggingTest, TestManagedSchemaThreadSafety,
HLLUtilTest, TestFieldCacheWithThreads, OpenExchangeRatesOrgProviderTest,
SynonymTokenizerTest, DistributedFacetPivotSmallAdvancedTest, TestWriterPerf,
AssignTest, ClassificationUpdateProcessorFactoryTest, TestTlogReplica,
SolrShardReporterTest, TestCSVResponseWriter, TestSerializedLuceneMatchVersion,
TestJoin, TestReloadDeadlock, ConnectionReuseTest,
TestLMDirichletSimilarityFactory, TestDistribDocBasedVersion, OutputWriterTest,
SecurityConfHandlerTest, AddSchemaFieldsUpdateProcessorFactoryTest,
TestSha256AuthenticationProvider, TestSolrFieldCacheBean,
TestLegacyNumericUtils, SolrCoreMetricManagerTest, TestComponentsName,
TestAuthenticationFramework, TestPushWriter, BinaryUpdateRequestHandlerTest,
SpellingQueryConverterTest, CursorPagingTest, TestDFISimilarityFactory,
LargeFieldTest, DateRangeFieldTest, TestStressLucene, TestDynamicFieldResource,
DistributedSpellCheckComponentTest, TestHalfAndHalfDocValues,
TestSystemIdResolver, DateFieldTest, DOMUtilTest, RAMDirectoryFactoryTest,
TestDocumentBuilder, ZkNodePropsTest, SystemInfoHandlerTest, CircularListTest,
DistributedIntervalFacetingTest, BaseCdcrDistributedZkTest,
CdcrRequestHandlerTest, CollectionReloadTest, CollectionStateFormat2Test,
CollectionsAPISolrJTest, DistribCursorPagingTest, ForceLeaderTest,
LeaderInitiatedRecoveryOnShardRestartTest, MissingSegmentRecoveryTest,
MoveReplicaHDFSUlogDirTest, NodeMutatorTest,
OverseerCollectionConfigSetProcessorTest, OverseerModifyCollectionTest,
OverseerRolesTest, PeerSyncReplicationTest, RecoveryAfterSoftCommitTest,
ReplaceNodeTest, SharedFSAutoReplicaFailoverTest]
[junit4] Completed [536/727 (2!)] on J0 in 90.95s, 1 test, 1 failure <<<
FAILURES!
[...truncated 43879 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
