Build: https://jenkins.thetaphi.de/job/Lucene-Solr-BadApples-8.x-Linux/21/
Java: 64bit/jdk-12-ea+shipilev-fastdebug -XX:-UseCompressedOops -XX:+UseSerialGC
2 tests failed.
FAILED: junit.framework.TestSuite.org.apache.solr.core.TestLazyCores
Error Message:
1 thread leaked from SUITE scope at org.apache.solr.core.TestLazyCores: 1)
Thread[id=376, name=Log4j2-TF-2-AsyncLoggerConfig--2, state=TIMED_WAITING,
group=TGRP-TestLazyCores] at
java.base@12-testing/jdk.internal.misc.Unsafe.park(Native Method) at
java.base@12-testing/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:235)
at
java.base@12-testing/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2123)
at
app//com.lmax.disruptor.TimeoutBlockingWaitStrategy.waitFor(TimeoutBlockingWaitStrategy.java:38)
at
app//com.lmax.disruptor.ProcessingSequenceBarrier.waitFor(ProcessingSequenceBarrier.java:56)
at
app//com.lmax.disruptor.BatchEventProcessor.run(BatchEventProcessor.java:128)
at java.base@12-testing/java.lang.Thread.run(Thread.java:835)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE
scope at org.apache.solr.core.TestLazyCores:
1) Thread[id=376, name=Log4j2-TF-2-AsyncLoggerConfig--2,
state=TIMED_WAITING, group=TGRP-TestLazyCores]
at java.base@12-testing/jdk.internal.misc.Unsafe.park(Native Method)
at
java.base@12-testing/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:235)
at
java.base@12-testing/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2123)
at
app//com.lmax.disruptor.TimeoutBlockingWaitStrategy.waitFor(TimeoutBlockingWaitStrategy.java:38)
at
app//com.lmax.disruptor.ProcessingSequenceBarrier.waitFor(ProcessingSequenceBarrier.java:56)
at
app//com.lmax.disruptor.BatchEventProcessor.run(BatchEventProcessor.java:128)
at java.base@12-testing/java.lang.Thread.run(Thread.java:835)
at __randomizedtesting.SeedInfo.seed([459F38DC97B1C6D0]:0)
FAILED: junit.framework.TestSuite.org.apache.solr.core.TestLazyCores
Error Message:
There are still zombie threads that couldn't be terminated: 1)
Thread[id=376, name=Log4j2-TF-2-AsyncLoggerConfig--2, state=TIMED_WAITING,
group=TGRP-TestLazyCores] at
java.base@12-testing/jdk.internal.misc.Unsafe.park(Native Method) at
java.base@12-testing/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:235)
at
java.base@12-testing/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2123)
at
app//com.lmax.disruptor.TimeoutBlockingWaitStrategy.waitFor(TimeoutBlockingWaitStrategy.java:38)
at
app//com.lmax.disruptor.ProcessingSequenceBarrier.waitFor(ProcessingSequenceBarrier.java:56)
at
app//com.lmax.disruptor.BatchEventProcessor.run(BatchEventProcessor.java:128)
at java.base@12-testing/java.lang.Thread.run(Thread.java:835)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie
threads that couldn't be terminated:
1) Thread[id=376, name=Log4j2-TF-2-AsyncLoggerConfig--2,
state=TIMED_WAITING, group=TGRP-TestLazyCores]
at java.base@12-testing/jdk.internal.misc.Unsafe.park(Native Method)
at
java.base@12-testing/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:235)
at
java.base@12-testing/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2123)
at
app//com.lmax.disruptor.TimeoutBlockingWaitStrategy.waitFor(TimeoutBlockingWaitStrategy.java:38)
at
app//com.lmax.disruptor.ProcessingSequenceBarrier.waitFor(ProcessingSequenceBarrier.java:56)
at
app//com.lmax.disruptor.BatchEventProcessor.run(BatchEventProcessor.java:128)
at java.base@12-testing/java.lang.Thread.run(Thread.java:835)
at __randomizedtesting.SeedInfo.seed([459F38DC97B1C6D0]:0)
Build Log:
[...truncated 12746 lines...]
[junit4] Suite: org.apache.solr.core.TestLazyCores
[junit4] 2> 6997 INFO
(SUITE-TestLazyCores-seed#[459F38DC97B1C6D0]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> Creating dataDir:
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_459F38DC97B1C6D0-001/init-core-data-001
[junit4] 2> 7362 INFO
(SUITE-TestLazyCores-seed#[459F38DC97B1C6D0]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 7492 INFO
(SUITE-TestLazyCores-seed#[459F38DC97B1C6D0]-worker) [ ] o.e.j.u.log Logging
initialized @7746ms to org.eclipse.jetty.util.log.Slf4jLog
[junit4] 2> 7506 INFO
(SUITE-TestLazyCores-seed#[459F38DC97B1C6D0]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via:
@org.apache.solr.util.RandomizeSSL(reason="", ssl=0.0/0.0, value=0.0/0.0,
clientAuth=0.0/0.0)
[junit4] 2> 7613 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
] o.a.s.SolrTestCaseJ4 ###Starting testBadConfigsGenerateErrors
[junit4] 2> 7869 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find
system property or JNDI)
[junit4] 2> 8218 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
] o.a.s.c.SolrXmlConfig MBean server found:
com.sun.jmx.mbeanserver.JmxMBeanServer@7d3f2cec, but no JMX reporters were
configured - adding default JMX reporter.
[junit4] 2> 9240 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 10489 WARN
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
SslContextFactory@3c7e2b23[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 11062 WARN
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
SslContextFactory@55dc82a3[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 11963 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for
2147483647 transient cores
[junit4] 2> 11972 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics
history in memory.
[junit4] 2> 12325 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry
'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7d3f2cec
[junit4] 2> 12328 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7d3f2cec
[junit4] 2> 12329 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7d3f2cec
[junit4] 2> 12509 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
] o.a.s.c.CorePropertiesLocator Found 6 core definitions underneath
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_459F38DC97B1C6D0-001/tempDir-001
[junit4] 2> 12522 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
] o.a.s.c.CorePropertiesLocator Cores are: [badSchema1, core1, badConfig2,
badConfig1, badSchema2, core2]
[junit4] 2> 12701 INFO (coreLoadExecutor-9-thread-3) [ x:badConfig2]
o.a.s.c.XmlConfigFile Ignoring exception matching \QSAXParseException\E
[junit4] 2> 12766 INFO (coreLoadExecutor-9-thread-3) [ x:badConfig1]
o.a.s.c.XmlConfigFile Ignoring exception matching \QSAXParseException\E
[junit4] 2> 12773 INFO (coreLoadExecutor-9-thread-1) [ x:badSchema1]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0
[junit4] 2> 12781 INFO (coreLoadExecutor-9-thread-2) [ x:core1]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0
[junit4] 2> 12830 INFO (coreLoadExecutor-9-thread-3) [ x:badSchema2]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0
[junit4] 2> 12974 INFO (coreLoadExecutor-9-thread-1) [ x:badSchema1]
o.a.s.c.XmlConfigFile Ignoring exception matching \QSAXParseException\E
[junit4] 2> 12985 INFO (coreLoadExecutor-9-thread-2) [ x:core1]
o.a.s.s.IndexSchema [core1] Schema name=tiny
[junit4] 2> 12997 INFO (coreLoadExecutor-9-thread-3) [ x:badSchema2]
o.a.s.c.XmlConfigFile Ignoring exception matching \QSAXParseException\E
[junit4] 2> 13017 INFO (coreLoadExecutor-9-thread-1) [ x:core2]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0
[junit4] 2> 13060 INFO (coreLoadExecutor-9-thread-1) [ x:core2]
o.a.s.s.IndexSchema [core2] Schema name=tiny
[junit4] 2> 13571 INFO (coreLoadExecutor-9-thread-2) [ x:core1]
o.a.s.s.IndexSchema Loaded schema tiny/1.1 with uniqueid field id
[junit4] 2> 13571 INFO (coreLoadExecutor-9-thread-1) [ x:core2]
o.a.s.s.IndexSchema Loaded schema tiny/1.1 with uniqueid field id
[junit4] 2> 13573 INFO (coreLoadExecutor-9-thread-1) [ x:core2]
o.a.s.c.CoreContainer Creating SolrCore 'core2' using configuration from
instancedir
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_459F38DC97B1C6D0-001/tempDir-001/core2,
trusted=true
[junit4] 2> 13580 INFO (coreLoadExecutor-9-thread-2) [ x:core1]
o.a.s.c.CoreContainer Creating SolrCore 'core1' using configuration from
instancedir
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_459F38DC97B1C6D0-001/tempDir-001/core1,
trusted=true
[junit4] 2> 13715 INFO (coreLoadExecutor-9-thread-1) [ x:core2]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.core2' (registry
'solr.core.core2') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@7d3f2cec
[junit4] 2> 13715 INFO (coreLoadExecutor-9-thread-2) [ x:core1]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.core1' (registry
'solr.core.core1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@7d3f2cec
[junit4] 2> 13763 INFO (coreLoadExecutor-9-thread-2) [ x:core1]
o.a.s.c.SolrCore [[core1] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_459F38DC97B1C6D0-001/tempDir-001/core1],
dataDir=[/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_459F38DC97B1C6D0-001/tempDir-001/core1/data/]
[junit4] 2> 13763 INFO (coreLoadExecutor-9-thread-1) [ x:core2]
o.a.s.c.SolrCore [[core2] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_459F38DC97B1C6D0-001/tempDir-001/core2],
dataDir=[/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_459F38DC97B1C6D0-001/tempDir-001/core2/data/]
[junit4] 2> 13910 INFO (coreLoadExecutor-9-thread-2) [ x:core1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=36, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.6948321609299785]
[junit4] 2> 13910 INFO (coreLoadExecutor-9-thread-1) [ x:core2]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=36, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.6948321609299785]
[junit4] 2> 16479 INFO (coreLoadExecutor-9-thread-2) [ x:core1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 16479 INFO (coreLoadExecutor-9-thread-2) [ x:core1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 16484 INFO (coreLoadExecutor-9-thread-1) [ x:core2]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 16484 INFO (coreLoadExecutor-9-thread-1) [ x:core2]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 16518 INFO (coreLoadExecutor-9-thread-1) [ x:core2]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=33, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.0]
[junit4] 2> 16531 INFO (coreLoadExecutor-9-thread-2) [ x:core1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=33, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.0]
[junit4] 2> 16616 INFO (coreLoadExecutor-9-thread-2) [ x:core1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@57b00948[core1] main]
[junit4] 2> 16616 INFO (coreLoadExecutor-9-thread-1) [ x:core2]
o.a.s.s.SolrIndexSearcher Opening [Searcher@7b15e9c4[core2] main]
[junit4] 2> 16690 INFO (coreLoadExecutor-9-thread-1) [ x:core2]
o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir:
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_459F38DC97B1C6D0-001/tempDir-001/core2/conf
[junit4] 2> 16692 INFO (coreLoadExecutor-9-thread-2) [ x:core1]
o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir:
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_459F38DC97B1C6D0-001/tempDir-001/core1/conf
[junit4] 2> 16833 INFO (coreLoadExecutor-9-thread-2) [ x:core1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 16833 INFO (coreLoadExecutor-9-thread-1) [ x:core2]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 16895 INFO (searcherExecutor-10-thread-1-processing-x:core2)
[ x:core2] o.a.s.c.SolrCore [core2] Registered new searcher
Searcher@7b15e9c4[core2]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 16896 INFO (searcherExecutor-11-thread-1-processing-x:core1)
[ x:core1] o.a.s.c.SolrCore [core1] Registered new searcher
Searcher@57b00948[core1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 17207 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
] o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 17207 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
] o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@48a66cdc commitCommandVersion:0
[junit4] 2> 18070 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
] o.a.s.s.SolrIndexSearcher Opening [Searcher@40066949[core1] main]
[junit4] 2> 18077 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 18101 INFO (searcherExecutor-11-thread-1) [ ]
o.a.s.c.SolrCore [core1] Registered new searcher Searcher@40066949[core1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.1.0):C7:[diagnostics={os=Linux,
java.vendor=Aleksey Shipilev, java.version=12-testing,
java.vm.version=12-testing+0-builds.shipilev.net-openjdk-jdk12-b109-20190215-jdk-1229,
lucene.version=8.1.0, os.arch=amd64,
java.runtime.version=12-testing+0-builds.shipilev.net-openjdk-jdk12-b109-20190215-jdk-1229,
source=flush, os.version=4.18.0-15-generic,
timestamp=1550989654519}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
[junit4] 2> 18336 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
] o.a.s.c.S.Request [core1] webapp=null path=null
params={q={!prefix+f%3Dv_t}hel&wt=xml} hits=2 status=0 QTime=193
[junit4] 2> 18481 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
] o.a.s.c.S.Request [core1] webapp=null path=null
params={q={!raw+f%3Dv_t}hello&wt=xml} hits=2 status=0 QTime=8
[junit4] 2> 18485 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
] o.a.s.c.S.Request [core1] webapp=null path=null
params={q={!raw+f%3Dv_t}Hello&wt=xml} hits=0 status=0 QTime=0
[junit4] 2> 18493 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
] o.a.s.c.S.Request [core1] webapp=null path=null
params={q={!raw+f%3Dv_f}1.5&wt=xml} hits=0 status=0 QTime=6
[junit4] 2> 18571 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badConfig1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0
[junit4] 2> 18627 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badConfig1] o.a.s.s.IndexSchema [badConfig1] Schema name=tiny
[junit4] 2> 18636 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badConfig1] o.a.s.s.IndexSchema Loaded schema tiny/1.1 with uniqueid field id
[junit4] 2> 18636 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badConfig1] o.a.s.c.CoreContainer Creating SolrCore 'badConfig1' using
configuration from instancedir
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_459F38DC97B1C6D0-001/tempDir-001/badConfig1,
trusted=true
[junit4] 2> 18638 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badConfig1] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.core.badConfig1' (registry 'solr.core.badConfig1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@7d3f2cec
[junit4] 2> 18638 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
] o.a.s.c.SolrCore [[badConfig1] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_459F38DC97B1C6D0-001/tempDir-001/badConfig1],
dataDir=[/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_459F38DC97B1C6D0-001/tempDir-001/badConfig1/data/]
[junit4] 2> 18649 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=13, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.3795491291598244]
[junit4] 2> 18832 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 18832 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 18835 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=32, maxMergeAtOnceExplicit=17, maxMergedSegmentMB=48.3369140625,
floorSegmentMB=1.076171875, forceMergeDeletesPctAllowed=28.643062227928866,
segmentsPerTier=50.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.568960672322789, deletesPctAllowed=33.59626430041249
[junit4] 2> 18836 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
] o.a.s.s.SolrIndexSearcher Opening [Searcher@5544cacb[badConfig1] main]
[junit4] 2> 18838 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir:
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_459F38DC97B1C6D0-001/tempDir-001/badConfig1/conf
[junit4] 2> 18839 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 18854 INFO (searcherExecutor-24-thread-1) [ ]
o.a.s.c.SolrCore [badConfig1] Registered new searcher
Searcher@5544cacb[badConfig1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 18866 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badConfig2] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0
[junit4] 2> 18893 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badConfig2] o.a.s.s.IndexSchema [badConfig2] Schema name=tiny
[junit4] 2> 18901 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badConfig2] o.a.s.s.IndexSchema Loaded schema tiny/1.1 with uniqueid field id
[junit4] 2> 18901 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badConfig2] o.a.s.c.CoreContainer Creating SolrCore 'badConfig2' using
configuration from instancedir
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_459F38DC97B1C6D0-001/tempDir-001/badConfig2,
trusted=true
[junit4] 2> 18902 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badConfig2] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.core.badConfig2' (registry 'solr.core.badConfig2') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@7d3f2cec
[junit4] 2> 18903 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badConfig2] o.a.s.c.SolrCore [[badConfig2] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_459F38DC97B1C6D0-001/tempDir-001/badConfig2],
dataDir=[/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_459F38DC97B1C6D0-001/tempDir-001/badConfig2/data/]
[junit4] 2> 18909 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badConfig2] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=15, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.8217815097278498]
[junit4] 2> 19155 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badConfig2] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 19155 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badConfig2] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 19159 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badConfig2] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=37, maxMergeAtOnceExplicit=29, maxMergedSegmentMB=68.5888671875,
floorSegmentMB=1.8251953125, forceMergeDeletesPctAllowed=17.688509539178643,
segmentsPerTier=36.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.7711594652512755, deletesPctAllowed=28.568205972534216
[junit4] 2> 19160 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badConfig2] o.a.s.s.SolrIndexSearcher Opening [Searcher@1ec84d27[badConfig2]
main]
[junit4] 2> 19162 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badConfig2] o.a.s.r.ManagedResourceStorage File-based storage initialized to
use dir:
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_459F38DC97B1C6D0-001/tempDir-001/badConfig2/conf
[junit4] 2> 19163 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badConfig2] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 19173 INFO
(searcherExecutor-28-thread-1-processing-x:badConfig2) [ x:badConfig2]
o.a.s.c.SolrCore [badConfig2] Registered new searcher
Searcher@1ec84d27[badConfig2]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 19196 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badSchema1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0
[junit4] 2> 19219 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badSchema1] o.a.s.s.IndexSchema [badSchema1] Schema name=tiny
[junit4] 2> 19227 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badSchema1] o.a.s.s.IndexSchema Loaded schema tiny/1.1 with uniqueid field id
[junit4] 2> 19227 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badSchema1] o.a.s.c.CoreContainer Creating SolrCore 'badSchema1' using
configuration from instancedir
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_459F38DC97B1C6D0-001/tempDir-001/badSchema1,
trusted=true
[junit4] 2> 19228 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badSchema1] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.core.badSchema1' (registry 'solr.core.badSchema1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@7d3f2cec
[junit4] 2> 19228 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badSchema1] o.a.s.c.SolrCore [[badSchema1] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_459F38DC97B1C6D0-001/tempDir-001/badSchema1],
dataDir=[/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_459F38DC97B1C6D0-001/tempDir-001/badSchema1/data/]
[junit4] 2> 19234 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badSchema1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=49, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.0]
[junit4] 2> 19421 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badSchema1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 19421 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badSchema1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 19424 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badSchema1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=42, maxMergeAtOnceExplicit=49, maxMergedSegmentMB=62.4697265625,
floorSegmentMB=1.6796875, forceMergeDeletesPctAllowed=2.499934415844928,
segmentsPerTier=13.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0,
deletesPctAllowed=33.90662686903708
[junit4] 2> 19435 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badSchema1] o.a.s.s.SolrIndexSearcher Opening [Searcher@65a98da9[badSchema1]
main]
[junit4] 2> 19436 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badSchema1] o.a.s.r.ManagedResourceStorage File-based storage initialized to
use dir:
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_459F38DC97B1C6D0-001/tempDir-001/badSchema1/conf
[junit4] 2> 19440 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badSchema1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 19443 INFO
(searcherExecutor-32-thread-1-processing-x:badSchema1) [ x:badSchema1]
o.a.s.c.SolrCore [badSchema1] Registered new searcher
Searcher@65a98da9[badSchema1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 19511 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badSchema2] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0
[junit4] 2> 19637 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badSchema2] o.a.s.s.IndexSchema [badSchema2] Schema name=tiny
[junit4] 2> 19657 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badSchema2] o.a.s.s.IndexSchema Loaded schema tiny/1.1 with uniqueid field id
[junit4] 2> 19658 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badSchema2] o.a.s.c.CoreContainer Creating SolrCore 'badSchema2' using
configuration from instancedir
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_459F38DC97B1C6D0-001/tempDir-001/badSchema2,
trusted=true
[junit4] 2> 19662 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badSchema2] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.core.badSchema2' (registry 'solr.core.badSchema2') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@7d3f2cec
[junit4] 2> 19662 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badSchema2] o.a.s.c.SolrCore [[badSchema2] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_459F38DC97B1C6D0-001/tempDir-001/badSchema2],
dataDir=[/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_459F38DC97B1C6D0-001/tempDir-001/badSchema2/data/]
[junit4] 2> 19704 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badSchema2] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=29, maxMergeAtOnceExplicit=29, maxMergedSegmentMB=55.9150390625,
floorSegmentMB=0.69921875, forceMergeDeletesPctAllowed=14.773259281007348,
segmentsPerTier=46.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0,
deletesPctAllowed=37.15747881244149
[junit4] 2> 19940 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badSchema2] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 19940 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badSchema2] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 19943 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badSchema2] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=16, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.5935376987315183]
[junit4] 2> 19945 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badSchema2] o.a.s.s.SolrIndexSearcher Opening [Searcher@5523625a[badSchema2]
main]
[junit4] 2> 19946 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badSchema2] o.a.s.r.ManagedResourceStorage File-based storage initialized to
use dir:
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_459F38DC97B1C6D0-001/tempDir-001/badSchema2/conf
[junit4] 2> 19947 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badSchema2] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 19954 INFO
(searcherExecutor-36-thread-1-processing-x:badSchema2) [ x:badSchema2]
o.a.s.c.SolrCore [badSchema2] Registered new searcher
Searcher@5523625a[badSchema2]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 19961 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badConfig2] o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 19961 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badConfig2] o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@48a66cdc commitCommandVersion:0
[junit4] 2> 20208 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badConfig2] o.a.s.s.SolrIndexSearcher Opening [Searcher@9d5f8a8[core1] main]
[junit4] 2> 20211 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badConfig2] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 20224 INFO
(searcherExecutor-11-thread-1-processing-x:badConfig2) [ x:badConfig2]
o.a.s.c.SolrCore [core1] Registered new searcher Searcher@9d5f8a8[core1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(8.1.0):C7:[diagnostics={os=Linux,
java.vendor=Aleksey Shipilev, java.version=12-testing,
java.vm.version=12-testing+0-builds.shipilev.net-openjdk-jdk12-b109-20190215-jdk-1229,
lucene.version=8.1.0, os.arch=amd64,
java.runtime.version=12-testing+0-builds.shipilev.net-openjdk-jdk12-b109-20190215-jdk-1229,
source=flush, os.version=4.18.0-15-generic,
timestamp=1550989656753}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
[junit4] 2> 20263 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badConfig2] o.a.s.c.S.Request [core1] webapp=null path=null
params={q={!prefix+f%3Dv_t}hel&wt=xml} hits=2 status=0 QTime=1
[junit4] 2> 20267 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badConfig2] o.a.s.c.S.Request [core1] webapp=null path=null
params={q={!raw+f%3Dv_t}hello&wt=xml} hits=2 status=0 QTime=0
[junit4] 2> 20269 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badConfig2] o.a.s.c.S.Request [core1] webapp=null path=null
params={q={!raw+f%3Dv_t}Hello&wt=xml} hits=0 status=0 QTime=0
[junit4] 2> 20275 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badConfig2] o.a.s.c.S.Request [core1] webapp=null path=null
params={q={!raw+f%3Dv_f}1.5&wt=xml} hits=0 status=0 QTime=3
[junit4] 2> 20280 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badConfig2] o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 20280 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badConfig2] o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@318c578f commitCommandVersion:0
[junit4] 2> 20607 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badConfig2] o.a.s.s.SolrIndexSearcher Opening [Searcher@1b028e5f[badConfig1]
main]
[junit4] 2> 20608 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badConfig2] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 20614 INFO
(searcherExecutor-24-thread-1-processing-x:badConfig2) [ x:badConfig2]
o.a.s.c.SolrCore [badConfig1] Registered new searcher
Searcher@1b028e5f[badConfig1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.1.0):C7:[diagnostics={os=Linux,
java.vendor=Aleksey Shipilev, java.version=12-testing,
java.vm.version=12-testing+0-builds.shipilev.net-openjdk-jdk12-b109-20190215-jdk-1229,
lucene.version=8.1.0, os.arch=amd64,
java.runtime.version=12-testing+0-builds.shipilev.net-openjdk-jdk12-b109-20190215-jdk-1229,
source=flush, os.version=4.18.0-15-generic,
timestamp=1550989657086}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
[junit4] 2> 20617 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badConfig2] o.a.s.c.S.Request [badConfig1] webapp=null path=null
params={q={!prefix+f%3Dv_t}hel&wt=xml} hits=2 status=0 QTime=1
[junit4] 2> 20620 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badConfig2] o.a.s.c.S.Request [badConfig1] webapp=null path=null
params={q={!raw+f%3Dv_t}hello&wt=xml} hits=2 status=0 QTime=0
[junit4] 2> 20622 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badConfig2] o.a.s.c.S.Request [badConfig1] webapp=null path=null
params={q={!raw+f%3Dv_t}Hello&wt=xml} hits=0 status=0 QTime=0
[junit4] 2> 20632 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badConfig2] o.a.s.c.S.Request [badConfig1] webapp=null path=null
params={q={!raw+f%3Dv_f}1.5&wt=xml} hits=0 status=0 QTime=0
[junit4] 2> 20637 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badConfig2] o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 20637 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badConfig2] o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@5d726189 commitCommandVersion:0
[junit4] 2> 20815 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badConfig2] o.a.s.s.SolrIndexSearcher Opening [Searcher@241341fb[badSchema1]
main]
[junit4] 2> 20816 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badConfig2] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 20825 INFO
(searcherExecutor-32-thread-1-processing-x:badConfig2) [ x:badConfig2]
o.a.s.c.SolrCore [badSchema1] Registered new searcher
Searcher@241341fb[badSchema1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.1.0):C7:[diagnostics={os=Linux,
java.vendor=Aleksey Shipilev, java.version=12-testing,
java.vm.version=12-testing+0-builds.shipilev.net-openjdk-jdk12-b109-20190215-jdk-1229,
lucene.version=8.1.0, os.arch=amd64,
java.runtime.version=12-testing+0-builds.shipilev.net-openjdk-jdk12-b109-20190215-jdk-1229,
source=flush, os.version=4.18.0-15-generic,
timestamp=1550989657434}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
[junit4] 2> 20827 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badConfig2] o.a.s.c.S.Request [badSchema1] webapp=null path=null
params={q={!prefix+f%3Dv_t}hel&wt=xml} hits=2 status=0 QTime=1
[junit4] 2> 20830 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badConfig2] o.a.s.c.S.Request [badSchema1] webapp=null path=null
params={q={!raw+f%3Dv_t}hello&wt=xml} hits=2 status=0 QTime=0
[junit4] 2> 20833 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badConfig2] o.a.s.c.S.Request [badSchema1] webapp=null path=null
params={q={!raw+f%3Dv_t}Hello&wt=xml} hits=0 status=0 QTime=0
[junit4] 2> 20835 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badConfig2] o.a.s.c.S.Request [badSchema1] webapp=null path=null
params={q={!raw+f%3Dv_f}1.5&wt=xml} hits=0 status=0 QTime=0
[junit4] 2> 20836 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badConfig2] o.a.s.c.CoreContainer Shutting down CoreContainer
instance=831940120
[junit4] 2> 20888 INFO
(coreCloseExecutor-46-thread-1-processing-x:badConfig2) [ x:core2]
o.a.s.c.SolrCore [core2] CLOSING SolrCore
org.apache.solr.core.SolrCore@349852bf
[junit4] 2> 20888 INFO
(coreCloseExecutor-46-thread-1-processing-x:badConfig2) [ x:core2]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.core2, tag=349852bf
[junit4] 2> 20888 INFO
(coreCloseExecutor-46-thread-2-processing-x:badConfig2) [ x:core1]
o.a.s.c.SolrCore [core1] CLOSING SolrCore
org.apache.solr.core.SolrCore@5d906d2e
[junit4] 2> 20888 INFO
(coreCloseExecutor-46-thread-3-processing-x:badConfig2) [ x:badSchema1]
o.a.s.c.SolrCore [badSchema1] CLOSING SolrCore
org.apache.solr.core.SolrCore@64555361
[junit4] 2> 20892 INFO
(coreCloseExecutor-46-thread-1-processing-x:badConfig2) [ x:core2]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@39d7f59f: rootName = null,
domain = solr.core.core2, service url = null, agent id = null] for registry
solr.core.core2 / com.codahale.metrics.MetricRegistry@2a997a5f
[junit4] 2> 20923 INFO
(coreCloseExecutor-46-thread-5-processing-x:badConfig2) [ x:badConfig1]
o.a.s.c.SolrCore [badConfig1] CLOSING SolrCore
org.apache.solr.core.SolrCore@73be1663
[junit4] 2> 20923 INFO
(coreCloseExecutor-46-thread-4-processing-x:badConfig2) [ x:badSchema2]
o.a.s.c.SolrCore [badSchema2] CLOSING SolrCore
org.apache.solr.core.SolrCore@741f1e16
[junit4] 2> 20955 INFO
(coreCloseExecutor-46-thread-6-processing-x:badConfig2) [ x:badConfig2]
o.a.s.c.SolrCore [badConfig2] CLOSING SolrCore
org.apache.solr.core.SolrCore@5fdc4e6d
[junit4] 2> 20976 INFO
(coreCloseExecutor-46-thread-2-processing-x:badConfig2) [ x:core1]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.core1, tag=5d906d2e
[junit4] 2> 20977 INFO
(coreCloseExecutor-46-thread-2-processing-x:badConfig2) [ x:core1]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@178fb81: rootName = null,
domain = solr.core.core1, service url = null, agent id = null] for registry
solr.core.core1 / com.codahale.metrics.MetricRegistry@1fc2770c
[junit4] 2> 21055 INFO
(coreCloseExecutor-46-thread-3-processing-x:badConfig2) [ x:badSchema1]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.badSchema1, tag=64555361
[junit4] 2> 21056 INFO
(coreCloseExecutor-46-thread-3-processing-x:badConfig2) [ x:badSchema1]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@7cc78b2c: rootName = null,
domain = solr.core.badSchema1, service url = null, agent id = null] for
registry solr.core.badSchema1 / com.codahale.metrics.MetricRegistry@3c99f5d6
[junit4] 2> 21110 INFO
(coreCloseExecutor-46-thread-5-processing-x:badConfig2) [ x:badConfig1]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.badConfig1, tag=73be1663
[junit4] 2> 21110 INFO
(coreCloseExecutor-46-thread-5-processing-x:badConfig2) [ x:badConfig1]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@701bdbb7: rootName = null,
domain = solr.core.badConfig1, service url = null, agent id = null] for
registry solr.core.badConfig1 / com.codahale.metrics.MetricRegistry@6d2549ae
[junit4] 2> 21220 INFO
(coreCloseExecutor-46-thread-4-processing-x:badConfig2) [ x:badSchema2]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.badSchema2, tag=741f1e16
[junit4] 2> 21220 INFO
(coreCloseExecutor-46-thread-4-processing-x:badConfig2) [ x:badSchema2]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@5579fe9d: rootName = null,
domain = solr.core.badSchema2, service url = null, agent id = null] for
registry solr.core.badSchema2 / com.codahale.metrics.MetricRegistry@40e008f
[junit4] 2> 21286 INFO
(coreCloseExecutor-46-thread-6-processing-x:badConfig2) [ x:badConfig2]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.badConfig2, tag=5fdc4e6d
[junit4] 2> 21286 INFO
(coreCloseExecutor-46-thread-6-processing-x:badConfig2) [ x:badConfig2]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@145845e3: rootName = null,
domain = solr.core.badConfig2, service url = null, agent id = null] for
registry solr.core.badConfig2 / com.codahale.metrics.MetricRegistry@2d54573a
[junit4] 2> 21420 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badConfig2] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.node, tag=null
[junit4] 2> 21424 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badConfig2] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@6087a577: rootName = null,
domain = solr.node, service url = null, agent id = null] for registry solr.node
/ com.codahale.metrics.MetricRegistry@2f2ecb80
[junit4] 2> 21443 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badConfig2] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.jvm, tag=null
[junit4] 2> 21444 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badConfig2] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@2e2fb04f: rootName = null,
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm /
com.codahale.metrics.MetricRegistry@1d373101
[junit4] 2> 21444 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badConfig2] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.jetty, tag=null
[junit4] 2> 21444 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badConfig2] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@5d10c080: rootName = null,
domain = solr.jetty, service url = null, agent id = null] for registry
solr.jetty / com.codahale.metrics.MetricRegistry@29922493
[junit4] 1> Done close
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor@4a165089[Terminated,
pool size = 0, active threads = 0, queued tasks = 0, completed tasks = 1]
[junit4] 1> Done close
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor@6e80e00b[Terminated,
pool size = 0, active threads = 0, queued tasks = 0, completed tasks = 1]
[junit4] 2> 21577 INFO
(TEST-TestLazyCores.testBadConfigsGenerateErrors-seed#[459F38DC97B1C6D0]) [
x:badConfig2] o.a.s.SolrTestCaseJ4 ###Ending testBadConfigsGenerateErrors
[junit4] 2> 21655 INFO
(TEST-TestLazyCores.testCreateSame-seed#[459F38DC97B1C6D0]) [ x:badConfig2]
o.a.s.SolrTestCaseJ4 ###Starting testCreateSame
[junit4] 2> 21797 INFO
(TEST-TestLazyCores.testCreateSame-seed#[459F38DC97B1C6D0]) [ x:badConfig2]
o.a.s.c.SolrXmlConfig Loading container configuration from
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_459F38DC97B1C6D0-001/tempDir-002/solr.xml
[junit4] 2> 21873 INFO
(TEST-TestLazyCores.testCreateSame-seed#[459F38DC97B1C6D0]) [ x:badConfig2]
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay
is ignored
[junit4] 2> 21873 INFO
(TEST-TestLazyCores.testCreateSame-seed#[459F38DC97B1C6D0]) [ x:badConfig2]
o.a.s.c.SolrXmlConfig Configuration parameter
autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 21897 INFO
(TEST-TestLazyCores.testCreateSame-seed#[459F38DC97B1C6D0]) [ x:badConfig2]
o.a.s.c.SolrXmlConfig MBean server found:
com.sun.jmx.mbeanserver.JmxMBeanServer@7d3f2cec, but no JMX reporters were
configured - adding default JMX reporter.
[junit4] 2> 22310 INFO
(TEST-TestLazyCores.testCreateSame-seed#[459F38DC97B1C6D0]) [ x:badConfig2]
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 22334 WARN
(TEST-TestLazyCores.testCreateSame-seed#[459F38DC97B1C6D0]) [ x:badConfig2]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
SslContextFactory@139e4189[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 22386 WARN
(TEST-TestLazyCores.testCreateSame-seed#[459F38DC97B1C6D0]) [ x:badConfig2]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
SslContextFactory@5d3c131c[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 22447 INFO
(TEST-TestLazyCores.testCreateSame-seed#[459F38DC97B1C6D0]) [ x:badConfig2]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4
transient cores
[junit4] 2> 22448 INFO
(TEST-TestLazyCores.testCreateSame-seed#[459F38DC97B1C6D0]) [ x:badConfig2]
o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history
in memory.
[junit4] 2> 22523 INFO
(TEST-TestLazyCores.testCreateSame-seed#[459F38DC97B1C6D0]) [ x:badConfig2]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7d3f2cec
[junit4] 2> 22523 INFO
(TEST-TestLazyCores.testCreateSame-seed#[459F38DC97B1C6D0]) [ x:badConfig2]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7d3f2cec
[junit4] 2> 22524 INFO
(TEST-TestLazyCores.testCreateSame-seed#[459F38DC97B1C6D0]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7d3f2cec
[junit4] 2> 22577 INFO (coreLoadExecutor-56-thread-1) [ x:collection1]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0
[junit4] 2> 22601 INFO (coreLoadExecutor-56-thread-1) [ x:collection1]
o.a.s.s.IndexSchema [collection1] Schema name=tiny
[junit4] 2> 22609 INFO (coreLoadExecutor-56-thread-1) [ x:collection1]
o.a.s.s.IndexSchema Loaded schema tiny/1.1 with uniqueid field id
[junit4] 2> 22609 INFO (coreLoadExecutor-56-thread-1) [ x:collection1]
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from
instancedir
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_459F38DC97B1C6D0-001/tempDir-002/./collection1,
trusted=true
[junit4] 2> 22610 INFO (coreLoadExecutor-56-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@7d3f2cec
[junit4] 2> 22610 INFO (coreLoadExecutor-56-thread-1) [ x:collection1]
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_459F38DC97B1C6D0-001/tempDir-002/collection1],
dataDir=[/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_459F38DC97B1C6D0-001/tempDir-002/./collection1/data/]
[junit4] 2> 22636 INFO (coreLoadExecutor-56-thread-1) [ x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=36, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.6948321609299785]
[junit4] 2> 22637 INFO (coreLoadExecutor-56-thread-2) [ x:collection2]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0
[junit4] 2> 22639 INFO (coreLoadExecutor-56-thread-3) [ x:collection5]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0
[junit4] 2> 22747 INFO (coreLoadExecutor-56-thread-3) [ x:collection5]
o.a.s.s.IndexSchema [collection5] Schema name=tiny
[junit4] 2> 22759 INFO (coreLoadExecutor-56-thread-2) [ x:collection2]
o.a.s.s.IndexSchema [collection2] Schema name=tiny
[junit4] 2> 22761 INFO (coreLoadExecutor-56-thread-3) [ x:collection5]
o.a.s.s.IndexSchema Loaded schema tiny/1.1 with uniqueid field id
[junit4] 2> 22761 INFO (coreLoadExecutor-56-thread-3) [ x:collection5]
o.a.s.c.CoreContainer Creating SolrCore 'collection5' using configuration from
instancedir
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_459F38DC97B1C6D0-001/tempDir-002/./collection5,
trusted=true
[junit4] 2> 22762 INFO (coreLoadExecutor-56-thread-3) [ x:collection5]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection5' (registry
'solr.core.collection5') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@7d3f2cec
[junit4] 2> 22773 INFO (coreLoadExecutor-56-thread-3) [ x:collection5]
o.a.s.c.SolrCore [[collection5] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_459F38DC97B1C6D0-001/tempDir-002/collection5],
dataDir=[/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_459F38DC97B1C6D0-001/tempDir-002/./collection5/data/]
[junit4] 2> 22789 INFO (coreLoadExecutor-56-thread-3) [ x:collection5]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=36, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.6948321609299785]
[junit4] 2> 22795 INFO (coreLoadExecutor-56-thread-2) [ x:collection2]
o.a.s.s.IndexSchema Loaded schema tiny/1.1 with uniqueid field id
[junit4] 2> 22795 INFO (coreLoadExecutor-56-thread-2) [ x:collection2]
o.a.s.c.CoreContainer Creating SolrCore 'collection2' using configuration from
instancedir
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_459F38DC97B1C6D0-001/tempDir-002/./collection2,
trusted=true
[junit4] 2> 22795 INFO (coreLoadExecutor-56-thread-2) [ x:collection2]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection2' (registry
'solr.core.collection2') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@7d3f2cec
[junit4] 2> 22797 INFO (coreLoadExecutor-56-thread-2) [ x:collection2]
o.a.s.c.SolrCore [[collection2] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_459F38DC97B1C6D0-001/tempDir-002/collection2],
dataDir=[/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_459F38DC97B1C6D0-001/tempDir-002/./collection2/data/]
[junit4] 2> 22812 INFO (coreLoadExecutor-56-thread-2) [ x:collection2]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=36, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.6948321609299785]
[junit4] 2> 23265 INFO (coreLoadExecutor-56-thread-1) [ x:collection1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 23265 INFO (coreLoadExecutor-56-thread-1) [ x:collection1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 23284 INFO (coreLoadExecutor-56-thread-3) [ x:collection5]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 23284 INFO (coreLoadExecutor-56-thread-3) [ x:collection5]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 23288 INFO (coreLoadExecutor-56-thread-1) [ x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=33, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.0]
[junit4] 2> 23290 INFO (coreLoadExecutor-56-thread-3) [ x:collection5]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=33, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.0]
[junit4] 2> 23335 INFO (coreLoadExecutor-56-thread-3) [ x:collection5]
o.a.s.s.SolrIndexSearcher Opening [Searcher@1074103[collection5] main]
[junit4] 2> 23335 INFO (coreLoadExecutor-56-thread-3) [ x:collection5]
o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir:
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_459F38DC97B1C6D0-001/tempDir-002/collection5/conf
[junit4] 2> 23336 INFO (coreLoadExecutor-56-thread-3) [ x:collection5]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 23338 INFO
(searcherExecutor-58-thread-1-processing-x:collection5) [ x:collection5]
o.a.s.c.SolrCore [collection5] Registered new searcher
Searcher@1074103[collection5]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 23344 INFO (coreLoadExecutor-56-thread-1) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@4e8e3821[collection1] main]
[junit4] 2> 23360 INFO (coreLoadExecutor-56-thread-1) [ x:collection1]
o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir:
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_459F38DC97B1C6D0-001/tempDir-002/collection1/conf
[junit4] 2> 23361 INFO (coreLoadExecutor-56-thread-1) [ x:collection1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 23363 INFO
(searcherExecutor-57-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@4e8e3821[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 23388 INFO (coreLoadExecutor-56-thread-2) [ x:collection2]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 23388 INFO (coreLoadExecutor-56-thread-2) [ x:collection2]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 23390 INFO (coreLoadExecutor-56-thread-2) [ x:collection2]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=33, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.0]
[junit4] 2> 23397 INFO (coreLoadExecutor-56-thread-2) [ x:collection2]
o.a.s.s.SolrIndexSearcher Opening [Searcher@e3bf7e[collection2] main]
[junit4] 2> 23397 INFO (coreLoadExecutor-56-thread-2) [ x:collection2]
o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir:
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_459F38DC97B1C6D0-001/tempDir-002/collection2/conf
[junit4] 2> 23398 INFO (coreLoadExecutor-56-thread-2) [ x:collection2]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 23422 INFO
(searcherExecutor-59-thread-1-processing-x:collection2) [ x:collection2]
o.a.s.c.SolrCore [collection2] Registered new searcher
Searcher@e3bf7e[collection2]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 23517 INFO
(TEST-TestLazyCores.testCreateSame-seed#[459F38DC97B1C6D0]) [ x:collection4]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0
[junit4] 2> 23540 INFO
(TEST-TestLazyCores.testCreateSame-seed#[459F38DC97B1C6D0]) [ x:collection4]
o.a.s.s.IndexSchema [collection4] Schema name=tiny
[junit4] 2> 23549 INFO
(TEST-TestLazyCores.testCreateSame-seed#[459F38DC97B1C6D0]) [ x:collection4]
o.a.s.s.IndexSchema Loaded schema tiny/1.1 with uniqueid field id
[junit4] 2> 23549 INFO
(TEST-TestLazyCores.testCreateSame-seed#[459F38DC97B1C6D0]) [ x:collection4]
o.a.s.c.CoreContainer Creating SolrCore 'collection4' using configuration from
instancedir
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_459F38DC97B1C6D0-001/tempDir-002/./collection4,
trusted=true
[junit4] 2> 23557 INFO
(TEST-TestLazyCores.testCreateSame-seed#[459F38DC97B1C6D0]) [ x:collection4]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection4' (registry
'solr.core.collection4') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@7d3f2cec
[junit4] 2> 23557 INFO
(TEST-TestLazyCores.testCreateSame-seed#[459F38DC97B1C6D0]) [ x:collection4]
o.a.s.c.SolrCore [[collection4] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_459F38DC97B1C6D0-001/tempDir-002/collection4],
dataDir=[/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_459F38DC97B1C6D0-001/tempDir-002/./collection4/data/]
[junit4] 2> 23567 INFO
(TEST-TestLazyCores.testCreateSame-seed#[459F38DC97B1C6D0]) [ x:collection4]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=10, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=1.0]
[junit4] 2> 23764 INFO
(TEST-TestLazyCores.testCreateSame-seed#[459F38DC97B1C6D0]) [ x:collection4]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 23764 INFO
(TEST-TestLazyCores.testCreateSame-seed#[459F38DC97B1C6D0]) [ x:collection4]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 23766 INFO
(TEST-TestLazyCores.testCreateSame-seed#[459F38DC97B1C6D0]) [ x:collection4]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=31, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=1.0]
[junit4] 2> 23774 INFO
(TEST-TestLazyCores.testCreateSame-seed#[459F38DC97B1C6D0]) [ x:collection4]
o.a.s.s.SolrIndexSearcher Opening [Searcher@2e239f0b[collection4] main]
[junit4] 2> 23775 INFO
(TEST-TestLazyCores.testCreateSame-seed#[459F38DC97B1C6D0]) [ x:collection4]
o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir:
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_459F38DC97B1C6D0-001/tempDir-002/collection4/conf
[junit4] 2> 23776 INFO
(TEST-TestLazyCores.testCreateSame-seed#[459F38DC97B1C6D0]) [ x:collection4]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 23778 INFO
(searcherExecutor-70-thread-1-processing-x:collection4) [ x:collection4]
o.a.s.c.SolrCore [collection4] Registered new searcher
Searcher@2e239f0b[collection4]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 23812 INFO
(TEST-TestLazyCores.testCreateSame-seed#[459F38DC97B1C6D0]) [ x:collection6]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0
[junit4] 2> 23867 INFO
(TEST-TestLazyCores.testCreateSame-seed#[459F38DC97B1C6D0]) [ x:collection6]
o.a.s.s.IndexSchema [collection6] Schema name=tiny
[junit4] 2> 23874 INFO
(TEST-TestLazyCores.testCreateSame-seed#[459F38DC97B1C6D0]) [ x:collection6]
o.a.s.s.IndexSchema Loaded schema tiny/1.1 with uniqueid field id
[junit4] 2> 23874 INFO
(TEST-TestLazyCores.testCreateSame-seed#[459F38DC97B1C6D0]) [ x:collection6]
o.a.s.c.CoreContainer Creating SolrCore 'collection6' using configuration from
instancedir
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_459F38DC97B1C6D0-001/tempDir-002/./collection6,
trusted=true
[junit4] 2> 23877 INFO
(TEST-TestLazyCores.testCreateSame-seed#[459F38DC97B1C6D0]) [ x:collection6]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection6' (registry
'solr.core.collection6') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@7d3f2cec
[junit4] 2> 23892 INFO
(TEST-TestLazyCores.testCreateSame-seed#[459F38DC97B1C6D0]) [ x:collection6]
o.a.s.c.SolrCore [[collection6] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_459F38DC97B1C6D0-001/tempDir-002/collection6],
dataDir=[/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_459F38DC97B1C6D0-001/tempDir-002/./collection6/data/]
[junit4] 2> 23900 INFO
(TEST-TestLazyCores.testCreateSame-seed#[459F38DC97B1C6D0]) [ x:collection6]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=37, maxMergeAtOnceExplicit=20, maxMergedSegmentMB=90.521484375,
floorSegmentMB=0.759765625, forceMergeDeletesPctAllowed=12.816306659687175,
segmentsPerTier=42.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0,
deletesPctAllowed=28.0676755979377
[junit4] 2> 24298 INFO
(TEST-TestLazyCores.testCreateSame-seed#[459F38DC97B1C6D0]) [ x:collection6]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 24298 INFO
(TEST-TestLazyCores.testCreateSame-seed#[459F38DC97B1C6D0]) [ x:collection6]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 24301 INFO
(TEST-TestLazyCores.testCreateSame-seed#[459F38DC97B1C6D0]) [ x:collection6]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=34, maxMergeAtOnceExplicit=14, maxMergedSegmentMB=3.21875,
floorSegmentMB=1.2421875, forceMergeDeletesPctAllowed=7.270568311343444,
segmentsPerTier=35.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.31708610650266733, deletesPctAllowed=49.40329096231183
[junit4] 2> 24302 INFO
(TEST-TestLazyCores.testCreateSame-seed#[459F38DC97B1C6D0]) [ x:collection6]
o.a.s.s.SolrIndexSearcher Opening [Searcher@5d5ceb80[collection6] main]
[junit4] 2> 24303 INFO
(TEST-TestLazyCores.testCreateSame-seed#[459F38DC97B1C6D0]) [ x:collection6]
o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir:
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_459F38DC97B1C6D0-001/tempDir-002/collection6/conf
[junit4] 2> 24304 INFO
(TEST-TestLazyCores.testCreateSame-seed#[459F38DC97B1C6D0]) [ x:collection6]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 24313 INFO
(searcherExecutor-74-thread-1-processing-x:collection6) [ x:collection6]
o.a.s.c.SolrCore [collection6] Registered new searcher
Searcher@5d5ceb80[collection6]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 24322 INFO
(TEST-TestLazyCores.testCreateSame-seed#[459F38DC97B1C6D0]) [ x:collection2]
o.a.s.h.a.CoreAdminOperation core create command
schema=schema.xml&dataDir=t12&name=collection2&action=CREATE&config=solrconfig.xml&wt=xml
[junit4] 2> 24328 WARN
(TEST-TestLazyCores.testCreateSame-seed#[459F38DC97B1C6D0]) [ x:collection2]
o.a.s.c.CoreContainer Creating a core with existing name is not allowed
[junit4] 2> 24328 INFO
(TEST-TestLazyCores.testCreateSame-seed#[459F38DC97B1C6D0]) [ x:collection4]
o.a.s.h.a.CoreAdminOperation core create command
schema=schema.xml&dataDir=t14&name=collection4&action=CREATE&config=solrconfig.xml&wt=xml
[junit4] 2> 24329 WARN
(TEST-TestLazyCores.testCreateSame-seed#[459F38DC97B1C6D0]) [ x:collection4]
o.a.s.c.CoreContainer Creating a core with existing name is not allowed
[junit4] 2> 24329 INFO
(TEST-TestLazyCores.testCreateSame-seed#[459F38DC97B1C6D0]) [ x:collection5]
o.a.s.h.a.CoreAdminOperation core create command
schema=schema.xml&dataDir=t15&name=collection5&action=CREATE&config=solrconfig.xml&wt=xml
[junit4] 2> 24329 WARN
(TEST-TestLazyCores.testCreateSame-seed#[459F38DC97B1C6D0]) [ x:collection5]
o.a.s.c.CoreContainer Creating a core with existing name is not allowed
[junit4] 2> 24329 INFO
(TEST-TestLazyCores.testCreateSame-seed#[459F38DC97B1C6D0]) [ x:collection6]
o.a.s.h.a.CoreAdminOperation core create command
schema=schema.xml&dataDir=t16&name=collection6&action=CREATE&config=solrconfig.xml&wt=xml
[junit4] 2> 24329 WARN
(TEST-TestLazyCores.testCreateSame-seed#[459F38DC97B1C6D0]) [ x:collection6]
o.a.s.c.CoreContainer Creating a core with existing name is not allowed
[junit4] 2> 24330 INFO
(TEST-TestLazyCores.testCreateSame-seed#[459F38DC97B1C6D0]) [ x:collection6]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=257866234
[junit4] 2> 24331 INFO
(coreCloseExecutor-78-thread-1-processing-x:collection6) [ x:collection5]
o.a.s.c.SolrCore [collection5] CLOSING SolrCore
org.apache.solr.core.SolrCore@1a864885
[junit4] 2> 24331 INFO
(coreCloseExecutor-78-thread-1-processing-x:collection6) [ x:collection5]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection5, tag=1a864885
[junit4] 2> 24331 INFO
(coreCloseExecutor-78-thread-1-processing-x:collection6) [ x:collection5]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@6e9179fa: rootName = null,
domain = solr.core.collection5, service url = null, agent id = null] for
registry solr.core.collection5 / com.codahale.metrics.MetricRegistry@772ca600
[junit4] 2> 24356 INFO
(coreCloseExecutor-78-thread-2-processing-x:collection6) [ x:collection1]
o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@533aa054
[junit4] 2> 24364 INFO
(coreCloseExecutor-78-thread-3-processing-x:collection6) [ x:collection4]
o.a.s.c.SolrCore [collection4] CLOSING SolrCore
org.apache.solr.core.SolrCore@12ac3db5
[junit4] 2> 24384 INFO
(coreCloseExecutor-78-thread-4-processing-x:collection6) [ x:collection2]
o.a.s.c.SolrCore [collection2] CLOSING SolrCore
org.apache.solr.core.SolrCore@18012f51
[junit4] 2> 24384 INFO
(coreCloseExecutor-78-thread-5-processing-x:collection6) [ x:collection6]
o.a.s.c.SolrCore [collection6] CLOSING SolrCore
org.apache.solr.core.SolrCore@24f9c4f7
[junit4] 2> 24462 INFO
(coreCloseExecutor-78-thread-2-processing-x:collection6) [ x:collection1]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection1, tag=533aa054
[junit4] 2> 24462 INFO
(coreCloseExecutor-78-thread-2-processing-x:collection6) [ x:collection1]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@27e4e550: rootName = null,
domain = solr.core.collection1, service url = null, agent id = null] for
registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@43f46e59
[junit4] 2> 24522 INFO
(coreCloseExecutor-78-thread-3-processing-x:collection6) [ x:collection4]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection4, tag=12ac3db5
[junit4] 2> 24522 INFO
(coreCloseExecutor-78-thread-3-processing-x:collection6) [ x:collection4]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@41aa1ba8: rootName = null,
domain = solr.core.collection4, service url = null, agent id = null] for
registry solr.core.collection4 / com.codahale.metrics.MetricRegistry@18b38ed6
[junit4] 2> 24572 INFO
(coreCloseExecutor-78-thread-4-processing-x:collection6) [ x:collection2]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection2, tag=18012f51
[junit4] 2> 24572 INFO
(coreCloseExecutor-78-thread-4-processing-x:collection6) [ x:collection2]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@2bafee89: rootName = null,
domain = solr.core.collection2, service url = null, agent id = null] for
registry solr.core.collection2 / com.codahale.metrics.MetricRegistry@308b86c8
[junit4] 2> 24640 INFO
(coreCloseExecutor-78-thread-5-processing-x:collection6) [ x:collection6]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection6, tag=24f9c4f7
[junit4] 2> 24640 INFO
(coreCloseExecutor-78-thread-5-processing-x:collection6) [ x:collection6]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@471d48ea: rootName = null,
domain = solr.core.collection6, service url = null, agent id = null] for
registry solr.core.collection6 / com.codahale.metrics.MetricRegistry@32dca45
[junit4] 2> 24728 INFO
(TEST-TestLazyCores.testCreateSame-seed#[459F38DC97B1C6D0]) [ x:collection6]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 24728 INFO
(TEST-TestLazyCores.testCreateSame-seed#[459F38DC97B1C6D0]) [ x:collection6]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@4745a64: rootName = null,
domain = solr.node, service url = null, agent id = null] for registry solr.node
/ com.codahale.metrics.MetricRegistry@4d9dd237
[junit4] 2> 24758 INFO
(TEST-TestLazyCores.testCreateSame-seed#[459F38DC97B1C6D0]) [ x:collection6]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 24768 INFO
(TEST-TestLazyCores.testCreateSame-seed#[459F38DC97B1C6D0]) [ x:collection6]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@63ec1311: rootName = null,
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm /
com.codahale.metrics.MetricRegistry@1d373101
[junit4] 2> 24768 INFO
(TEST-TestLazyCores.testCreateSame-seed#[459F38DC97B1C6D0]) [ x:collection6]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 24768 INFO
(TEST-TestLazyCores.testCreateSame-seed#[459F38DC97B1C6D0]) [ x:collection6]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@3d016f0d: rootName = null,
domain = solr.jetty, service url = null, agent id = null] for registry
solr.jetty / com.codahale.metrics.MetricRegistry@29922493
[junit4] 1> Done close
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor@4a3ae5dd[Terminated,
pool size = 0, active threads = 0, queued tasks = 0, completed tasks = 1]
[junit4] 1> Done close
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor@7cce0f00[Terminated,
pool size = 0, active threads = 0, queued tasks = 0, completed tasks = 1]
[junit4] 2> 24804 INFO
(TEST-TestLazyCores.testCreateSame-seed#[459F38DC97B1C6D0]) [ x:collection6]
o.a.s.SolrTestCaseJ4 ###Ending testCreateSame
[junit4] 2> 24826 INFO
(TEST-TestLazyCores.testRace-seed#[459F38DC97B1C6D0]) [ x:collection6]
o.a.s.SolrTestCaseJ4 ###Starting testRace
[junit4] 2> 24858 INFO
(TEST-TestLazyCores.testRace-seed#[459F38DC97B1C6D0]) [ x:collection6]
o.a.s.c.SolrXmlConfig Loading container configuration from
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_459F38DC97B1C6D0-001/tempDir-003/solr.xml
[junit4] 2> 24867 INFO
(TEST-TestLazyCores.testRace-seed#[459F38DC97B1C6D0]) [ x:collection6]
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay
is ignored
[junit4] 2> 24868 INFO
(TEST-TestLazyCores.testRace-seed#[459F38DC97B1C6D0]) [ x:collection6]
o.a.s.c.SolrXmlConfig Configuration parameter
autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 24880 INFO
(TEST-TestLazyCores.testRace-seed#[459F38DC97B1C6D0]) [ x:collection6]
o.a.s.c.SolrXmlConfig MBean server found:
com.sun.jmx.mbeanserver.JmxMBeanServer@7d3f2cec, but no JMX reporters were
configured - adding default JMX reporter.
[junit4] 2> 25124 INFO
(TEST-TestLazyCores.testRace-seed#[459F38DC97B1C6D0]) [ x:collection6]
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 25146 WARN
(TEST-TestLazyCores.testRace-seed#[459F38DC97B1C6D0]) [ x:collection6]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
SslContextFactory@3f3d445a[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 25226 WARN
(TEST-TestLazyCores.testRace-seed#[459F38DC97B1C6D0]) [ x:collection6]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
SslContextFactory@4aa2b880[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 25280 INFO
(TEST-TestLazyCores.testRace-seed#[459F38DC97B1C6D0]) [ x:collection6]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4
transient cores
[junit4] 2> 25280 INFO
(TEST-TestLazyCores.testRace-seed#[459F38DC97B1C6D0]) [ x:collection6]
o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history
in memory.
[junit4] 2> 25347 INFO
(TEST-TestLazyCores.testRace-seed#[459F38DC97B1C6D0]) [ x:collection6]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7d3f2cec
[junit4] 2> 25348 INFO
(TEST-TestLazyCores.testRace-seed#[459F38DC97B1C6D0]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7d3f2cec
[junit4] 2> 25350 INFO
(TEST-TestLazyCores.testRace-seed#[459F38DC97B1C6D0]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7d3f2cec
[junit4] 2> 25571 INFO (coreLoadExecutor-88-thread-1) [ x:collection1]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0
[junit4] 2> 25582 INFO (coreLoadExecutor-88-thread-3) [ x:collection5]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0
[junit4] 2> 25628 INFO (coreLoadExecutor-88-thread-2) [ x:collection2]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0
[junit4] 2> 25661 INFO (coreLoadExecutor-88-thread-2) [ x:collection2]
o.a.s.s.IndexSchema [collection2] Schema name=tiny
[junit4] 2> 25667 INFO (coreLoadExecutor-88-thread-2) [ x:collection2]
o.a.s.s.IndexSchema Loaded schema tiny/1.1 with uniqueid field id
[junit4] 2> 25667 INFO (coreLoadExecutor-88-thread-2) [ x:collection2]
o.a.s.c.CoreContainer Creating SolrCore 'collection2' using configuration from
instancedir
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_459F38DC97B1C6D0-001/tempDir-003/./collection2,
trusted=true
[junit4] 2> 25668 INFO (coreLoadExecutor-88-thread-2) [ x:collection2]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection2' (registry
'solr.core.collection2') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@7d3f2cec
[junit4] 2> 25668 INFO (coreLoadExecutor-88-thread-2) [ x:collection2]
o.a.s.c.SolrCore [[collection2] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_459F38DC97B1C6D0-001/tempDir-003/collection2],
dataDir=[/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_459F38DC97B1C6D0-001/tempDir-003/./collection2/data/]
[junit4] 2> 25672 INFO (coreLoadExecutor-88-thread-3) [ x:collection5]
o.a.s.s.IndexSchema [collection5] Schema name=tiny
[junit4] 2> 25673 INFO (coreLoadExecutor-88-thread-2) [ x:collection2]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=36, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.6948321609299785]
[junit4] 2> 25678 INFO (coreLoadExecutor-88-thread-3) [ x:collection5]
o.a.s.s.IndexSchema Loaded schema tiny/1.1 with uniqueid field id
[junit4] 2> 25678 INFO (coreLoadExecutor-88-thread-3) [ x:collection5]
o.a.s.c.CoreContainer Creating SolrCore 'collection5' using configuration from
instancedir
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_459F38DC97B1C6D0-001/tempDir-003/./collection5,
trusted=true
[junit4] 2> 25678 INFO (coreLoadExecutor-88-thread-3) [ x:collection5]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection5' (registry
'solr.core.collection5') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@7d3f2cec
[junit4] 2> 25679 INFO (coreLoadExecutor-88-thread-3) [ x:collection5]
o.a.s.c.SolrCore [[collection5] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_459F38DC97B1C6D0-001/tempDir-003/collection5],
dataDir=[/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_459F38DC97B1C6D0-001/tempDir-003/./collection5/data/]
[junit4] 2> 25705 INFO (coreLoadExecutor-88-thread-1) [ x:collection1]
o.a.s.s.IndexSchema [collection1] Schema name=tiny
[junit4] 2> 25723 INFO (coreLoadExecutor-88-thread-1) [ x:collection1]
o.a.s.s.IndexSchema Loaded schema tiny/1.1 with uniqueid field id
[junit4] 2> 25723 INFO (coreLoadExecutor-88-thread-1) [ x:collection1]
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from
instancedir
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_459F38DC97B1C6D0-001/tempDir-003/./collection1,
trusted=true
[junit4] 2> 25723 INFO (coreLoadExecutor-88-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@7d3f2cec
[junit4] 2> 25724 INFO (coreLoadExecutor-88-thread-1) [ x:collection1]
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_459F38DC97B1C6D0-001/tempDir-003/collection1],
dataDir=[/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_459F38DC97B1C6D0-001/tempDir-003/./collection1/data/]
[junit4] 2> 25758 INFO (coreLoadExecutor-88-thread-3) [ x:collection5]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=36, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.6948321609299785]
[junit4] 2> 25763 INFO (coreLoadExecutor-88-thread-1) [ x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=36, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.6948321609299785]
[junit4] 2> 26044 INFO (coreLoadExecutor-88-thread-2) [ x:collection2]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 26044 INFO (coreLoadExecutor-88-thread-2) [ x:collection2]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 26046 INFO (coreLoadExecutor-88-thread-2) [ x:collection2]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=33, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.0]
[junit4] 2> 26047 INFO (coreLoadExecutor-88-thread-2) [ x:collection2]
o.a.s.s.SolrIndexSearcher Opening [Searcher@3c2e27d4[collection2] main]
[junit4] 2> 26048 INFO (coreLoadExecutor-88-thread-2) [ x:collection2]
o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir:
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_459F38DC97B1C6D0-001/tempDir-003/collection2/conf
[junit4] 2> 26049 INFO (coreLoadExecutor-88-thread-2) [ x:collection2]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 26057 INFO
(searcherExecutor-89-thread-1-processing-x:collection2) [ x:collection2]
o.a.s.c.SolrCore [collection2] Registered new searcher
Searcher@3c2e27d4[collection2]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 26116 INFO (coreLoadExecutor-88-thread-3) [ x:collection5]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 26116 INFO (coreLoadExecutor-88-thread-3) [ x:collection5]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 26119 INFO (coreLoadExecutor-88-thread-3) [ x:collection5]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=33, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.0]
[junit4] 2> 26120 INFO (coreLoadExecutor-88-thread-3) [ x:collection5]
o.a.s.s.SolrIndexSearcher Opening [Searcher@562e3f82[collection5] main]
[junit4] 2> 26124 INFO (coreLoadExecutor-88-thread-3) [ x:collection5]
o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir:
/home/jenkins/workspace/Lucene-Solr-BadApples-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_459F38DC97B1C6D0-001/tempDir-003/collection5/conf
[junit4] 2> 26125 INFO (coreLoadExecutor-88-thread-3) [ x:collection5]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 26127 INFO
(searcherExecutor-90-thread-1-processing-x:collection5) [ x:collection5]
o.a.s.c.SolrCore [collection5] Registered new searcher
Searcher@562e3f82[collection5]
main{ExitableDirectoryReader(UninvertingDirectoryReader())
[...truncated too long message...]
M com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
[junit4] 2> INFO: Starting to interrupt leaked threads:
[junit4] 2> 1) Thread[id=376, name=Log4j2-TF-2-AsyncLoggerConfig--2,
state=TIMED_WAITING, group=TGRP-TestLazyCores]
[junit4] 2> AsyncLogger error handling event seq=0, value='null':
[junit4] 2> java.lang.InterruptedException
[junit4] 2> at
java.base/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.reportInterruptAfterWait(AbstractQueuedSynchronizer.java:2056)
[junit4] 2> at
java.base/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2133)
[junit4] 2> at
com.lmax.disruptor.TimeoutBlockingWaitStrategy.waitFor(TimeoutBlockingWaitStrategy.java:38)
[junit4] 2> at
com.lmax.disruptor.ProcessingSequenceBarrier.waitFor(ProcessingSequenceBarrier.java:56)
[junit4] 2> at
com.lmax.disruptor.BatchEventProcessor.run(BatchEventProcessor.java:128)
[junit4] 2> at java.base/java.lang.Thread.run(Thread.java:835)
[junit4] 2> AsyncLogger error handling event seq=1, value='null':
[junit4] 2> java.lang.InterruptedException
[junit4] 2> at
java.base/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.reportInterruptAfterWait(AbstractQueuedSynchronizer.java:2056)
[junit4] 2> at
java.base/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2133)
[junit4] 2> at
com.lmax.disruptor.TimeoutBlockingWaitStrategy.waitFor(TimeoutBlockingWaitStrategy.java:38)
[junit4] 2> at
com.lmax.disruptor.ProcessingSequenceBarrier.waitFor(ProcessingSequenceBarrier.java:56)
[junit4] 2> at
com.lmax.disruptor.BatchEventProcessor.run(BatchEventProcessor.java:128)
[junit4] 2> at java.base/java.lang.Thread.run(Thread.java:835)
[junit4] 2> AsyncLogger error handling event seq=2, value='null':
[junit4] 2> java.lang.InterruptedException
[junit4] 2> at
java.base/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.reportInterruptAfterWait(AbstractQueuedSynchronizer.java:2056)
[junit4] 2> at
java.base/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2133)
[junit4] 2> at
com.lmax.disruptor.TimeoutBlockingWaitStrategy.waitFor(TimeoutBlockingWaitStrategy.java:38)
[junit4] 2> at
com.lmax.disruptor.ProcessingSequenceBarrier.waitFor(ProcessingSequenceBarrier.java:56)
[junit4] 2> at
com.lmax.disruptor.BatchEventProcessor.run(BatchEventProcessor.java:128)
[junit4] 2> at java.base/java.lang.Thread.run(Thread.java:835)
[junit4] 2> AsyncLogger error handling event seq=3, value='null':
[junit4] 2> java.lang.InterruptedException
[junit4] 2> at
java.base/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.reportInterruptAfterWait(AbstractQueuedSynchronizer.java:2056)
[junit4] 2> at
java.base/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2133)
[junit4] 2> at
com.lmax.disruptor.TimeoutBlockingWaitStrategy.waitFor(TimeoutBlockingWaitStrategy.java:38)
[junit4] 2> at
com.lmax.disruptor.ProcessingSequenceBarrier.waitFor(ProcessingSequenceBarrier.java:56)
[junit4] 2> at
com.lmax.disruptor.BatchEventProcessor.run(BatchEventProcessor.java:128)
[junit4] 2> at java.base/java.lang.Thread.run(Thread.java:835)
[junit4] 2> AsyncLogger error handling event seq=4, value='null':
[junit4] 2> java.lang.InterruptedException
[junit4] 2> at
java.base/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.reportInterruptAfterWait(AbstractQueuedSynchronizer.java:2056)
[junit4] 2> at
java.base/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2133)
[junit4] 2> at
com.lmax.disruptor.TimeoutBlockingWaitStrategy.waitFor(TimeoutBlockingWaitStrategy.java:38)
[junit4] 2> at
com.lmax.disruptor.ProcessingSequenceBarrier.waitFor(ProcessingSequenceBarrier.java:56)
[junit4] 2> at
com.lmax.disruptor.BatchEventProcessor.run(BatchEventProcessor.java:128)
[junit4] 2> at java.base/java.lang.Thread.run(Thread.java:835)
[junit4] 2> Feb 24, 2019 6:28:35 AM
com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
[junit4] 2> SEVERE: There are still zombie threads that couldn't be
terminated:
[junit4] 2> 1) Thread[id=376, name=Log4j2-TF-2-AsyncLoggerConfig--2,
state=TIMED_WAITING, group=TGRP-TestLazyCores]
[junit4] 2> at
java.base@12-testing/jdk.internal.misc.Unsafe.park(Native Method)
[junit4] 2> at
java.base@12-testing/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:235)
[junit4] 2> at
java.base@12-testing/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2123)
[junit4] 2> at
app//com.lmax.disruptor.TimeoutBlockingWaitStrategy.waitFor(TimeoutBlockingWaitStrategy.java:38)
[junit4] 2> at
app//com.lmax.disruptor.ProcessingSequenceBarrier.waitFor(ProcessingSequenceBarrier.java:56)
[junit4] 2> at
app//com.lmax.disruptor.BatchEventProcessor.run(BatchEventProcessor.java:128)
[junit4] 2> at
java.base@12-testing/java.lang.Thread.run(Thread.java:835)
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene80):
{_root_=Lucene50(blocksize=128), v_t=BlockTreeOrds(blocksize=128),
id=BlockTreeOrds(blocksize=128), v_s=FSTOrd50,
v_f=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128)))},
docValues:{}, maxPointsInLeafNode=100, maxMBSortInHeap=5.75135668237395,
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@410e72ba),
locale=lag, timezone=Europe/Gibraltar
[junit4] 2> NOTE: Linux 4.18.0-15-generic amd64/Aleksey Shipilev
12-testing (64-bit)/cpus=8,threads=3,free=424819912,total=518979584
[junit4] 2> NOTE: All tests run in this JVM: [TestLazyCores]
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestLazyCores
-Dtests.seed=459F38DC97B1C6D0 -Dtests.multiplier=3 -Dtests.slow=true
-Dtests.badapples=true -Dtests.locale=lag -Dtests.timezone=Europe/Gibraltar
-Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] ERROR 0.00s J1 | TestLazyCores (suite) <<<
[junit4] > Throwable #1:
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE
scope at org.apache.solr.core.TestLazyCores:
[junit4] > 1) Thread[id=376, name=Log4j2-TF-2-AsyncLoggerConfig--2,
state=TIMED_WAITING, group=TGRP-TestLazyCores]
[junit4] > at
java.base@12-testing/jdk.internal.misc.Unsafe.park(Native Method)
[junit4] > at
java.base@12-testing/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:235)
[junit4] > at
java.base@12-testing/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2123)
[junit4] > at
app//com.lmax.disruptor.TimeoutBlockingWaitStrategy.waitFor(TimeoutBlockingWaitStrategy.java:38)
[junit4] > at
app//com.lmax.disruptor.ProcessingSequenceBarrier.waitFor(ProcessingSequenceBarrier.java:56)
[junit4] > at
app//com.lmax.disruptor.BatchEventProcessor.run(BatchEventProcessor.java:128)
[junit4] > at
java.base@12-testing/java.lang.Thread.run(Thread.java:835)
[junit4] > at
__randomizedtesting.SeedInfo.seed([459F38DC97B1C6D0]:0)Throwable #2:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie
threads that couldn't be terminated:
[junit4] > 1) Thread[id=376, name=Log4j2-TF-2-AsyncLoggerConfig--2,
state=TIMED_WAITING, group=TGRP-TestLazyCores]
[junit4] > at
java.base@12-testing/jdk.internal.misc.Unsafe.park(Native Method)
[junit4] > at
java.base@12-testing/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:235)
[junit4] > at
java.base@12-testing/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2123)
[junit4] > at
app//com.lmax.disruptor.TimeoutBlockingWaitStrategy.waitFor(TimeoutBlockingWaitStrategy.java:38)
[junit4] > at
app//com.lmax.disruptor.ProcessingSequenceBarrier.waitFor(ProcessingSequenceBarrier.java:56)
[junit4] > at
app//com.lmax.disruptor.BatchEventProcessor.run(BatchEventProcessor.java:128)
[junit4] > at
java.base@12-testing/java.lang.Thread.run(Thread.java:835)
[junit4] > at
__randomizedtesting.SeedInfo.seed([459F38DC97B1C6D0]:0)
[junit4] Completed [6/844 (1!)] on J1 in 76.15s, 9 tests, 2 errors <<<
FAILURES!
[...truncated 45203 lines...]
[repro] Jenkins log URL:
https://jenkins.thetaphi.de/job/Lucene-Solr-BadApples-8.x-Linux/21/consoleText
[repro] Revision: 4aa0645ea6216f556ffd8c3ad6fcb276a0cc796d
[repro] Repro line: ant test -Dtestcase=TestLazyCores
-Dtests.seed=459F38DC97B1C6D0 -Dtests.multiplier=3 -Dtests.slow=true
-Dtests.badapples=true -Dtests.locale=lag -Dtests.timezone=Europe/Gibraltar
-Dtests.asserts=true -Dtests.file.encoding=UTF-8
[repro] ant clean
[...truncated 6 lines...]
[repro] Test suites by module:
[repro] solr/core
[repro] TestLazyCores
[repro] ant compile-test
[...truncated 3580 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5
-Dtests.class="*.TestLazyCores" -Dtests.showOutput=onerror
-Dtests.seed=459F38DC97B1C6D0 -Dtests.multiplier=3 -Dtests.slow=true
-Dtests.badapples=true -Dtests.locale=lag -Dtests.timezone=Europe/Gibraltar
-Dtests.asserts=true -Dtests.file.encoding=UTF-8
[...truncated 115 lines...]
[repro] Failures:
[repro] 0/5 failed: org.apache.solr.core.TestLazyCores
[repro] Exiting with code 0
[...truncated 43 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
