Build: https://jenkins.thetaphi.de/job/Lucene-Solr-8.x-Linux/198/
Java: 64bit/jdk1.8.0_172 -XX:+UseCompressedOops -XX:+UseSerialGC
6 tests failed.
FAILED: junit.framework.TestSuite.org.apache.solr.core.TestSolrDeletionPolicy1
Error Message:
1 thread leaked from SUITE scope at
org.apache.solr.core.TestSolrDeletionPolicy1: 1) Thread[id=31,
name=Log4j2-TF-2-AsyncLoggerConfig--2, state=TIMED_WAITING,
group=TGRP-TestSolrDeletionPolicy1] at sun.misc.Unsafe.park(Native
Method) at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
at
com.lmax.disruptor.TimeoutBlockingWaitStrategy.waitFor(TimeoutBlockingWaitStrategy.java:38)
at
com.lmax.disruptor.ProcessingSequenceBarrier.waitFor(ProcessingSequenceBarrier.java:56)
at
com.lmax.disruptor.BatchEventProcessor.run(BatchEventProcessor.java:128)
at java.lang.Thread.run(Thread.java:748)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE
scope at org.apache.solr.core.TestSolrDeletionPolicy1:
1) Thread[id=31, name=Log4j2-TF-2-AsyncLoggerConfig--2, state=TIMED_WAITING,
group=TGRP-TestSolrDeletionPolicy1]
at sun.misc.Unsafe.park(Native Method)
at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
at
com.lmax.disruptor.TimeoutBlockingWaitStrategy.waitFor(TimeoutBlockingWaitStrategy.java:38)
at
com.lmax.disruptor.ProcessingSequenceBarrier.waitFor(ProcessingSequenceBarrier.java:56)
at
com.lmax.disruptor.BatchEventProcessor.run(BatchEventProcessor.java:128)
at java.lang.Thread.run(Thread.java:748)
at __randomizedtesting.SeedInfo.seed([625C7F08970F2375]:0)
FAILED: junit.framework.TestSuite.org.apache.solr.core.TestSolrDeletionPolicy1
Error Message:
There are still zombie threads that couldn't be terminated: 1) Thread[id=31,
name=Log4j2-TF-2-AsyncLoggerConfig--2, state=TIMED_WAITING,
group=TGRP-TestSolrDeletionPolicy1] at sun.misc.Unsafe.park(Native
Method) at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
at
com.lmax.disruptor.TimeoutBlockingWaitStrategy.waitFor(TimeoutBlockingWaitStrategy.java:38)
at
com.lmax.disruptor.ProcessingSequenceBarrier.waitFor(ProcessingSequenceBarrier.java:56)
at
com.lmax.disruptor.BatchEventProcessor.run(BatchEventProcessor.java:128)
at java.lang.Thread.run(Thread.java:748)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie
threads that couldn't be terminated:
1) Thread[id=31, name=Log4j2-TF-2-AsyncLoggerConfig--2, state=TIMED_WAITING,
group=TGRP-TestSolrDeletionPolicy1]
at sun.misc.Unsafe.park(Native Method)
at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
at
com.lmax.disruptor.TimeoutBlockingWaitStrategy.waitFor(TimeoutBlockingWaitStrategy.java:38)
at
com.lmax.disruptor.ProcessingSequenceBarrier.waitFor(ProcessingSequenceBarrier.java:56)
at
com.lmax.disruptor.BatchEventProcessor.run(BatchEventProcessor.java:128)
at java.lang.Thread.run(Thread.java:748)
at __randomizedtesting.SeedInfo.seed([625C7F08970F2375]:0)
FAILED: junit.framework.TestSuite.org.apache.solr.core.TestSolrDeletionPolicy1
Error Message:
1 thread leaked from SUITE scope at
org.apache.solr.core.TestSolrDeletionPolicy1: 1) Thread[id=31,
name=Log4j2-TF-2-AsyncLoggerConfig--2, state=TIMED_WAITING,
group=TGRP-TestSolrDeletionPolicy1] at sun.misc.Unsafe.park(Native
Method) at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
at
com.lmax.disruptor.TimeoutBlockingWaitStrategy.waitFor(TimeoutBlockingWaitStrategy.java:38)
at
com.lmax.disruptor.ProcessingSequenceBarrier.waitFor(ProcessingSequenceBarrier.java:56)
at
com.lmax.disruptor.BatchEventProcessor.run(BatchEventProcessor.java:128)
at java.lang.Thread.run(Thread.java:748)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE
scope at org.apache.solr.core.TestSolrDeletionPolicy1:
1) Thread[id=31, name=Log4j2-TF-2-AsyncLoggerConfig--2, state=TIMED_WAITING,
group=TGRP-TestSolrDeletionPolicy1]
at sun.misc.Unsafe.park(Native Method)
at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
at
com.lmax.disruptor.TimeoutBlockingWaitStrategy.waitFor(TimeoutBlockingWaitStrategy.java:38)
at
com.lmax.disruptor.ProcessingSequenceBarrier.waitFor(ProcessingSequenceBarrier.java:56)
at
com.lmax.disruptor.BatchEventProcessor.run(BatchEventProcessor.java:128)
at java.lang.Thread.run(Thread.java:748)
at __randomizedtesting.SeedInfo.seed([625C7F08970F2375]:0)
FAILED: junit.framework.TestSuite.org.apache.solr.core.TestSolrDeletionPolicy1
Error Message:
There are still zombie threads that couldn't be terminated: 1) Thread[id=31,
name=Log4j2-TF-2-AsyncLoggerConfig--2, state=TIMED_WAITING,
group=TGRP-TestSolrDeletionPolicy1] at sun.misc.Unsafe.park(Native
Method) at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
at
com.lmax.disruptor.TimeoutBlockingWaitStrategy.waitFor(TimeoutBlockingWaitStrategy.java:38)
at
com.lmax.disruptor.ProcessingSequenceBarrier.waitFor(ProcessingSequenceBarrier.java:56)
at
com.lmax.disruptor.BatchEventProcessor.run(BatchEventProcessor.java:128)
at java.lang.Thread.run(Thread.java:748)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie
threads that couldn't be terminated:
1) Thread[id=31, name=Log4j2-TF-2-AsyncLoggerConfig--2, state=TIMED_WAITING,
group=TGRP-TestSolrDeletionPolicy1]
at sun.misc.Unsafe.park(Native Method)
at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
at
com.lmax.disruptor.TimeoutBlockingWaitStrategy.waitFor(TimeoutBlockingWaitStrategy.java:38)
at
com.lmax.disruptor.ProcessingSequenceBarrier.waitFor(ProcessingSequenceBarrier.java:56)
at
com.lmax.disruptor.BatchEventProcessor.run(BatchEventProcessor.java:128)
at java.lang.Thread.run(Thread.java:748)
at __randomizedtesting.SeedInfo.seed([625C7F08970F2375]:0)
FAILED:
junit.framework.TestSuite.org.apache.solr.handler.export.TestExportWriter
Error Message:
1 thread leaked from SUITE scope at
org.apache.solr.handler.export.TestExportWriter: 1) Thread[id=32,
name=Log4j2-TF-2-AsyncLoggerConfig--2, state=TIMED_WAITING,
group=TGRP-TestExportWriter] at sun.misc.Unsafe.park(Native Method)
at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
at
com.lmax.disruptor.TimeoutBlockingWaitStrategy.waitFor(TimeoutBlockingWaitStrategy.java:38)
at
com.lmax.disruptor.ProcessingSequenceBarrier.waitFor(ProcessingSequenceBarrier.java:56)
at
com.lmax.disruptor.BatchEventProcessor.run(BatchEventProcessor.java:128)
at java.lang.Thread.run(Thread.java:748)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE
scope at org.apache.solr.handler.export.TestExportWriter:
1) Thread[id=32, name=Log4j2-TF-2-AsyncLoggerConfig--2, state=TIMED_WAITING,
group=TGRP-TestExportWriter]
at sun.misc.Unsafe.park(Native Method)
at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
at
com.lmax.disruptor.TimeoutBlockingWaitStrategy.waitFor(TimeoutBlockingWaitStrategy.java:38)
at
com.lmax.disruptor.ProcessingSequenceBarrier.waitFor(ProcessingSequenceBarrier.java:56)
at
com.lmax.disruptor.BatchEventProcessor.run(BatchEventProcessor.java:128)
at java.lang.Thread.run(Thread.java:748)
at __randomizedtesting.SeedInfo.seed([625C7F08970F2375]:0)
FAILED:
junit.framework.TestSuite.org.apache.solr.handler.export.TestExportWriter
Error Message:
There are still zombie threads that couldn't be terminated: 1) Thread[id=32,
name=Log4j2-TF-2-AsyncLoggerConfig--2, state=TIMED_WAITING,
group=TGRP-TestExportWriter] at sun.misc.Unsafe.park(Native Method)
at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
at
com.lmax.disruptor.TimeoutBlockingWaitStrategy.waitFor(TimeoutBlockingWaitStrategy.java:38)
at
com.lmax.disruptor.ProcessingSequenceBarrier.waitFor(ProcessingSequenceBarrier.java:56)
at
com.lmax.disruptor.BatchEventProcessor.run(BatchEventProcessor.java:128)
at java.lang.Thread.run(Thread.java:748)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie
threads that couldn't be terminated:
1) Thread[id=32, name=Log4j2-TF-2-AsyncLoggerConfig--2, state=TIMED_WAITING,
group=TGRP-TestExportWriter]
at sun.misc.Unsafe.park(Native Method)
at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
at
com.lmax.disruptor.TimeoutBlockingWaitStrategy.waitFor(TimeoutBlockingWaitStrategy.java:38)
at
com.lmax.disruptor.ProcessingSequenceBarrier.waitFor(ProcessingSequenceBarrier.java:56)
at
com.lmax.disruptor.BatchEventProcessor.run(BatchEventProcessor.java:128)
at java.lang.Thread.run(Thread.java:748)
at __randomizedtesting.SeedInfo.seed([625C7F08970F2375]:0)
Build Log:
[...truncated 12641 lines...]
[junit4] Suite: org.apache.solr.core.TestSolrDeletionPolicy1
[junit4] 2> Creating dataDir:
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestSolrDeletionPolicy1_625C7F08970F2375-001/init-core-data-001
[junit4] 2> 2946 INFO
(SUITE-TestSolrDeletionPolicy1-seed#[625C7F08970F2375]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 3008 INFO
(SUITE-TestSolrDeletionPolicy1-seed#[625C7F08970F2375]-worker) [ ]
o.e.j.u.log Logging initialized @3046ms to org.eclipse.jetty.util.log.Slf4jLog
[junit4] 2> 3018 INFO
(SUITE-TestSolrDeletionPolicy1-seed#[625C7F08970F2375]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via:
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 3273 INFO
(SUITE-TestSolrDeletionPolicy1-seed#[625C7F08970F2375]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 3274 INFO
(SUITE-TestSolrDeletionPolicy1-seed#[625C7F08970F2375]-worker) [ ]
o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 3416 INFO
(SUITE-TestSolrDeletionPolicy1-seed#[625C7F08970F2375]-worker) [ ]
o.a.s.c.SolrResourceLoader Using system property solr.solr.home:
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr
[junit4] 2> 3421 INFO
(SUITE-TestSolrDeletionPolicy1-seed#[625C7F08970F2375]-worker) [ ]
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths:
[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/lib,
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 3682 INFO
(SUITE-TestSolrDeletionPolicy1-seed#[625C7F08970F2375]-worker) [ ]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0
[junit4] 2> 3888 INFO
(SUITE-TestSolrDeletionPolicy1-seed#[625C7F08970F2375]-worker) [ ]
o.a.s.s.IndexSchema [null] Schema name=test
[junit4] 2> 4354 WARN
(SUITE-TestSolrDeletionPolicy1-seed#[625C7F08970F2375]-worker) [ ]
o.a.s.c.SolrResourceLoader Solr loaded a deprecated plugin/analysis class
[solr.WordDelimiterFilterFactory]. Please consult documentation how to replace
it accordingly.
[junit4] 2> 4438 WARN
(SUITE-TestSolrDeletionPolicy1-seed#[625C7F08970F2375]-worker) [ ]
o.a.s.c.SolrResourceLoader Solr loaded a deprecated plugin/analysis class
[solr.GeoHashField]. Please consult documentation how to replace it accordingly.
[junit4] 2> 4444 WARN
(SUITE-TestSolrDeletionPolicy1-seed#[625C7F08970F2375]-worker) [ ]
o.a.s.c.SolrResourceLoader Solr loaded a deprecated plugin/analysis class
[solr.LatLonType]. Please consult documentation how to replace it accordingly.
[junit4] 2> 4456 WARN
(SUITE-TestSolrDeletionPolicy1-seed#[625C7F08970F2375]-worker) [ ]
o.a.s.c.SolrResourceLoader Solr loaded a deprecated plugin/analysis class
[solr.CurrencyField]. Please consult documentation how to replace it
accordingly.
[junit4] 2> 4572 INFO
(SUITE-TestSolrDeletionPolicy1-seed#[625C7F08970F2375]-worker) [ ]
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 5621 INFO
(SUITE-TestSolrDeletionPolicy1-seed#[625C7F08970F2375]-worker) [ ]
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 5641 WARN
(SUITE-TestSolrDeletionPolicy1-seed#[625C7F08970F2375]-worker) [ ]
o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport
since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 5921 WARN
(SUITE-TestSolrDeletionPolicy1-seed#[625C7F08970F2375]-worker) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
SslContextFactory@72d34b27[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 6316 WARN
(SUITE-TestSolrDeletionPolicy1-seed#[625C7F08970F2375]-worker) [ ]
o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport
since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 6348 WARN
(SUITE-TestSolrDeletionPolicy1-seed#[625C7F08970F2375]-worker) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
SslContextFactory@611f894f[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 6798 INFO
(SUITE-TestSolrDeletionPolicy1-seed#[625C7F08970F2375]-worker) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 6801 INFO
(SUITE-TestSolrDeletionPolicy1-seed#[625C7F08970F2375]-worker) [ ]
o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history
in memory.
[junit4] 2> 6990 INFO
(SUITE-TestSolrDeletionPolicy1-seed#[625C7F08970F2375]-worker) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1481e840
[junit4] 2> 6991 INFO
(SUITE-TestSolrDeletionPolicy1-seed#[625C7F08970F2375]-worker) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1481e840
[junit4] 2> 6992 INFO
(SUITE-TestSolrDeletionPolicy1-seed#[625C7F08970F2375]-worker) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1481e840
[junit4] 2> 7074 INFO (coreLoadExecutor-9-thread-1) [ x:collection1]
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths:
[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/lib,
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 7105 INFO (coreLoadExecutor-9-thread-1) [ x:collection1]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0
[junit4] 2> 7172 INFO (coreLoadExecutor-9-thread-1) [ x:collection1]
o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 7353 INFO (coreLoadExecutor-9-thread-1) [ x:collection1]
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 7405 INFO (coreLoadExecutor-9-thread-1) [ x:collection1]
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from
instancedir
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1,
trusted=true
[junit4] 2> 7451 INFO (coreLoadExecutor-9-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@1481e840
[junit4] 2> 7469 INFO (coreLoadExecutor-9-thread-1) [ x:collection1]
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1],
dataDir=[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.core.TestSolrDeletionPolicy1_625C7F08970F2375-001/init-core-data-001/]
[junit4] 2> 7527 INFO (coreLoadExecutor-9-thread-1) [ x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=46, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.43287447674428525]
[junit4] 2> 8747 INFO (coreLoadExecutor-9-thread-1) [ x:collection1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 8747 INFO (coreLoadExecutor-9-thread-1) [ x:collection1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 8750 INFO (coreLoadExecutor-9-thread-1) [ x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=49, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.48127018211727624]
[junit4] 2> 8774 INFO (coreLoadExecutor-9-thread-1) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@6380ec58[collection1] main]
[junit4] 2> 8812 WARN (coreLoadExecutor-9-thread-1) [ x:collection1]
o.a.s.r.ManagedResourceStorage Cannot write to config directory
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/conf;
switching to use InMemory storage instead.
[junit4] 2> 8857 INFO (coreLoadExecutor-9-thread-1) [ x:collection1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 8865 INFO
(SUITE-TestSolrDeletionPolicy1-seed#[625C7F08970F2375]-worker) [ ]
o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 8870 INFO
(searcherExecutor-10-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@6380ec58[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 8887 INFO
(TEST-TestSolrDeletionPolicy1.testCommitAge-seed#[625C7F08970F2375]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testCommitAge
[junit4] 2> 8961 INFO
(TEST-TestSolrDeletionPolicy1.testCommitAge-seed#[625C7F08970F2375]) [ ]
o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 8964 INFO
(TEST-TestSolrDeletionPolicy1.testCommitAge-seed#[625C7F08970F2375]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}{deleteByQuery=*:*}
0 73
[junit4] 2> 9130 INFO
(TEST-TestSolrDeletionPolicy1.testCommitAge-seed#[625C7F08970F2375]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{add=[1]} 0 157
[junit4] 2> 9137 INFO
(TEST-TestSolrDeletionPolicy1.testCommitAge-seed#[625C7F08970F2375]) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 9137 INFO
(TEST-TestSolrDeletionPolicy1.testCommitAge-seed#[625C7F08970F2375]) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@21d73883 commitCommandVersion:0
[junit4] 2> 9380 INFO
(TEST-TestSolrDeletionPolicy1.testCommitAge-seed#[625C7F08970F2375]) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@58705f63[collection1] main]
[junit4] 2> 9382 INFO
(TEST-TestSolrDeletionPolicy1.testCommitAge-seed#[625C7F08970F2375]) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 9390 INFO (searcherExecutor-10-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@58705f63[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.1.0):C1:[diagnostics={os=Linux,
java.vendor=Oracle Corporation, java.version=1.8.0_172,
java.vm.version=25.172-b11, lucene.version=8.1.0, os.arch=amd64,
java.runtime.version=1.8.0_172-b11, source=flush, os.version=4.18.0-15-generic,
timestamp=1550902366214}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
[junit4] 2> 9397 INFO
(TEST-TestSolrDeletionPolicy1.testCommitAge-seed#[625C7F08970F2375]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{commit=} 0 261
[junit4] 2> 9452 INFO
(TEST-TestSolrDeletionPolicy1.testCommitAge-seed#[625C7F08970F2375]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=id:[0+TO+1]&qt=&start=0&rows=20&version=2.2} hits=1 status=0 QTime=53
[junit4] 2> 9476 INFO
(TEST-TestSolrDeletionPolicy1.testCommitAge-seed#[625C7F08970F2375]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{add=[2]} 0 1
[junit4] 2> 9477 INFO
(TEST-TestSolrDeletionPolicy1.testCommitAge-seed#[625C7F08970F2375]) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 9477 INFO
(TEST-TestSolrDeletionPolicy1.testCommitAge-seed#[625C7F08970F2375]) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@21d73883 commitCommandVersion:0
[junit4] 2> 9522 INFO
(TEST-TestSolrDeletionPolicy1.testCommitAge-seed#[625C7F08970F2375]) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@4e0ff5be[collection1] main]
[junit4] 2> 9522 INFO
(TEST-TestSolrDeletionPolicy1.testCommitAge-seed#[625C7F08970F2375]) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 9525 INFO (searcherExecutor-10-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@4e0ff5be[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.1.0):C1:[diagnostics={os=Linux,
java.vendor=Oracle Corporation, java.version=1.8.0_172,
java.vm.version=25.172-b11, lucene.version=8.1.0, os.arch=amd64,
java.runtime.version=1.8.0_172-b11, source=flush, os.version=4.18.0-15-generic,
timestamp=1550902366214}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])
Uninverting(_1(8.1.0):C1:[diagnostics={os=Linux, java.vendor=Oracle
Corporation, java.version=1.8.0_172, java.vm.version=25.172-b11,
lucene.version=8.1.0, os.arch=amd64, java.runtime.version=1.8.0_172-b11,
source=flush, os.version=4.18.0-15-generic,
timestamp=1550902366433}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
[junit4] 2> 9526 INFO
(TEST-TestSolrDeletionPolicy1.testCommitAge-seed#[625C7F08970F2375]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{commit=} 0 49
[junit4] 2> 9528 INFO
(TEST-TestSolrDeletionPolicy1.testCommitAge-seed#[625C7F08970F2375]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=id:[0+TO+2]&qt=&start=0&rows=20&version=2.2} hits=2 status=0 QTime=0
[junit4] 2> 9533 INFO
(TEST-TestSolrDeletionPolicy1.testCommitAge-seed#[625C7F08970F2375]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{add=[3]} 0 1
[junit4] 2> 9534 INFO
(TEST-TestSolrDeletionPolicy1.testCommitAge-seed#[625C7F08970F2375]) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 9535 WARN
(TEST-TestSolrDeletionPolicy1.testCommitAge-seed#[625C7F08970F2375]) [ ]
o.a.s.u.DirectUpdateHandler2 Starting optimize... Reading and rewriting a
potentially large percent of the entire index, reducing to 2147483647 segments
[junit4] 2> 9547 INFO
(TEST-TestSolrDeletionPolicy1.testCommitAge-seed#[625C7F08970F2375]) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@21d73883 commitCommandVersion:0
[junit4] 2> 9554 INFO
(TEST-TestSolrDeletionPolicy1.testCommitAge-seed#[625C7F08970F2375]) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@22bf9714[collection1] main]
[junit4] 2> 9558 INFO
(TEST-TestSolrDeletionPolicy1.testCommitAge-seed#[625C7F08970F2375]) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 9561 INFO (searcherExecutor-10-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@22bf9714[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.1.0):C1:[diagnostics={os=Linux,
java.vendor=Oracle Corporation, java.version=1.8.0_172,
java.vm.version=25.172-b11, lucene.version=8.1.0, os.arch=amd64,
java.runtime.version=1.8.0_172-b11, source=flush, os.version=4.18.0-15-generic,
timestamp=1550902366214}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])
Uninverting(_1(8.1.0):C1:[diagnostics={os=Linux, java.vendor=Oracle
Corporation, java.version=1.8.0_172, java.vm.version=25.172-b11,
lucene.version=8.1.0, os.arch=amd64, java.runtime.version=1.8.0_172-b11,
source=flush, os.version=4.18.0-15-generic,
timestamp=1550902366433}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])
Uninverting(_2(8.1.0):C1:[diagnostics={os=Linux, java.vendor=Oracle
Corporation, java.version=1.8.0_172, java.vm.version=25.172-b11,
lucene.version=8.1.0, os.arch=amd64, java.runtime.version=1.8.0_172-b11,
source=flush, os.version=4.18.0-15-generic,
timestamp=1550902366477}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
[junit4] 2> 9563 INFO
(TEST-TestSolrDeletionPolicy1.testCommitAge-seed#[625C7F08970F2375]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{optimize=} 0 29
[junit4] 2> 9566 INFO
(TEST-TestSolrDeletionPolicy1.testCommitAge-seed#[625C7F08970F2375]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=id:[0+TO+3]&qt=&start=0&rows=20&version=2.2} hits=3 status=0 QTime=0
[junit4] 2> 9573 INFO
(TEST-TestSolrDeletionPolicy1.testCommitAge-seed#[625C7F08970F2375]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{add=[4]} 0 4
[junit4] 2> 9575 INFO
(TEST-TestSolrDeletionPolicy1.testCommitAge-seed#[625C7F08970F2375]) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 9575 WARN
(TEST-TestSolrDeletionPolicy1.testCommitAge-seed#[625C7F08970F2375]) [ ]
o.a.s.u.DirectUpdateHandler2 Starting optimize... Reading and rewriting a
potentially large percent of the entire index, reducing to 2147483647 segments
[junit4] 2> 9591 INFO
(TEST-TestSolrDeletionPolicy1.testCommitAge-seed#[625C7F08970F2375]) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@21d73883 commitCommandVersion:0
[junit4] 2> 9595 INFO
(TEST-TestSolrDeletionPolicy1.testCommitAge-seed#[625C7F08970F2375]) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@937ef30[collection1] main]
[junit4] 2> 9595 INFO
(TEST-TestSolrDeletionPolicy1.testCommitAge-seed#[625C7F08970F2375]) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 9598 INFO (searcherExecutor-10-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@937ef30[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.1.0):C1:[diagnostics={os=Linux,
java.vendor=Oracle Corporation, java.version=1.8.0_172,
java.vm.version=25.172-b11, lucene.version=8.1.0, os.arch=amd64,
java.runtime.version=1.8.0_172-b11, source=flush, os.version=4.18.0-15-generic,
timestamp=1550902366214}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])
Uninverting(_1(8.1.0):C1:[diagnostics={os=Linux, java.vendor=Oracle
Corporation, java.version=1.8.0_172, java.vm.version=25.172-b11,
lucene.version=8.1.0, os.arch=amd64, java.runtime.version=1.8.0_172-b11,
source=flush, os.version=4.18.0-15-generic,
timestamp=1550902366433}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])
Uninverting(_2(8.1.0):C1:[diagnostics={os=Linux, java.vendor=Oracle
Corporation, java.version=1.8.0_172, java.vm.version=25.172-b11,
lucene.version=8.1.0, os.arch=amd64, java.runtime.version=1.8.0_172-b11,
source=flush, os.version=4.18.0-15-generic,
timestamp=1550902366477}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])
Uninverting(_3(8.1.0):C1:[diagnostics={os=Linux, java.vendor=Oracle
Corporation, java.version=1.8.0_172, java.vm.version=25.172-b11,
lucene.version=8.1.0, os.arch=amd64, java.runtime.version=1.8.0_172-b11,
source=flush, os.version=4.18.0-15-generic,
timestamp=1550902366521}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
[junit4] 2> 9600 INFO
(TEST-TestSolrDeletionPolicy1.testCommitAge-seed#[625C7F08970F2375]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{optimize=} 0 25
[junit4] 2> 9603 INFO
(TEST-TestSolrDeletionPolicy1.testCommitAge-seed#[625C7F08970F2375]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=id:[0+TO+4]&qt=&start=0&rows=20&version=2.2} hits=4 status=0 QTime=0
[junit4] 2> 9608 INFO
(TEST-TestSolrDeletionPolicy1.testCommitAge-seed#[625C7F08970F2375]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{add=[5]} 0 1
[junit4] 2> 9609 INFO
(TEST-TestSolrDeletionPolicy1.testCommitAge-seed#[625C7F08970F2375]) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 9609 WARN
(TEST-TestSolrDeletionPolicy1.testCommitAge-seed#[625C7F08970F2375]) [ ]
o.a.s.u.DirectUpdateHandler2 Starting optimize... Reading and rewriting a
potentially large percent of the entire index, reducing to 2147483647 segments
[junit4] 2> 9633 INFO
(TEST-TestSolrDeletionPolicy1.testCommitAge-seed#[625C7F08970F2375]) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@21d73883 commitCommandVersion:0
[junit4] 2> 9638 INFO
(TEST-TestSolrDeletionPolicy1.testCommitAge-seed#[625C7F08970F2375]) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@2953511[collection1] main]
[junit4] 2> 9642 INFO (searcherExecutor-10-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@2953511[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.1.0):C1:[diagnostics={os=Linux,
java.vendor=Oracle Corporation, java.version=1.8.0_172,
java.vm.version=25.172-b11, lucene.version=8.1.0, os.arch=amd64,
java.runtime.version=1.8.0_172-b11, source=flush, os.version=4.18.0-15-generic,
timestamp=1550902366214}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])
Uninverting(_1(8.1.0):C1:[diagnostics={os=Linux, java.vendor=Oracle
Corporation, java.version=1.8.0_172, java.vm.version=25.172-b11,
lucene.version=8.1.0, os.arch=amd64, java.runtime.version=1.8.0_172-b11,
source=flush, os.version=4.18.0-15-generic,
timestamp=1550902366433}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])
Uninverting(_2(8.1.0):C1:[diagnostics={os=Linux, java.vendor=Oracle
Corporation, java.version=1.8.0_172, java.vm.version=25.172-b11,
lucene.version=8.1.0, os.arch=amd64, java.runtime.version=1.8.0_172-b11,
source=flush, os.version=4.18.0-15-generic,
timestamp=1550902366477}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])
Uninverting(_3(8.1.0):C1:[diagnostics={os=Linux, java.vendor=Oracle
Corporation, java.version=1.8.0_172, java.vm.version=25.172-b11,
lucene.version=8.1.0, os.arch=amd64, java.runtime.version=1.8.0_172-b11,
source=flush, os.version=4.18.0-15-generic,
timestamp=1550902366521}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])
Uninverting(_4(8.1.0):C1:[diagnostics={os=Linux, java.vendor=Oracle
Corporation, java.version=1.8.0_172, java.vm.version=25.172-b11,
lucene.version=8.1.0, os.arch=amd64, java.runtime.version=1.8.0_172-b11,
source=flush, os.version=4.18.0-15-generic,
timestamp=1550902366563}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
[junit4] 2> 9642 INFO
(TEST-TestSolrDeletionPolicy1.testCommitAge-seed#[625C7F08970F2375]) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 9642 INFO
(TEST-TestSolrDeletionPolicy1.testCommitAge-seed#[625C7F08970F2375]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{optimize=} 0 33
[junit4] 2> 9644 INFO
(TEST-TestSolrDeletionPolicy1.testCommitAge-seed#[625C7F08970F2375]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=id:[0+TO+5]&qt=&start=0&rows=20&version=2.2} hits=5 status=0 QTime=1
[junit4] 2> 9748 INFO
(TEST-TestSolrDeletionPolicy1.testCommitAge-seed#[625C7F08970F2375]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{add=[6]} 0 1
[junit4] 2> 9750 INFO
(TEST-TestSolrDeletionPolicy1.testCommitAge-seed#[625C7F08970F2375]) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 9750 WARN
(TEST-TestSolrDeletionPolicy1.testCommitAge-seed#[625C7F08970F2375]) [ ]
o.a.s.u.DirectUpdateHandler2 Starting optimize... Reading and rewriting a
potentially large percent of the entire index, reducing to 2147483647 segments
[junit4] 2> 9768 INFO
(TEST-TestSolrDeletionPolicy1.testCommitAge-seed#[625C7F08970F2375]) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@21d73883 commitCommandVersion:0
[junit4] 2> 9785 INFO
(TEST-TestSolrDeletionPolicy1.testCommitAge-seed#[625C7F08970F2375]) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@15c435d8[collection1] main]
[junit4] 2> 9789 INFO (searcherExecutor-10-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@15c435d8[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.1.0):C1:[diagnostics={os=Linux,
java.vendor=Oracle Corporation, java.version=1.8.0_172,
java.vm.version=25.172-b11, lucene.version=8.1.0, os.arch=amd64,
java.runtime.version=1.8.0_172-b11, source=flush, os.version=4.18.0-15-generic,
timestamp=1550902366214}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])
Uninverting(_1(8.1.0):C1:[diagnostics={os=Linux, java.vendor=Oracle
Corporation, java.version=1.8.0_172, java.vm.version=25.172-b11,
lucene.version=8.1.0, os.arch=amd64, java.runtime.version=1.8.0_172-b11,
source=flush, os.version=4.18.0-15-generic,
timestamp=1550902366433}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])
Uninverting(_2(8.1.0):C1:[diagnostics={os=Linux, java.vendor=Oracle
Corporation, java.version=1.8.0_172, java.vm.version=25.172-b11,
lucene.version=8.1.0, os.arch=amd64, java.runtime.version=1.8.0_172-b11,
source=flush, os.version=4.18.0-15-generic,
timestamp=1550902366477}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])
Uninverting(_3(8.1.0):C1:[diagnostics={os=Linux, java.vendor=Oracle
Corporation, java.version=1.8.0_172, java.vm.version=25.172-b11,
lucene.version=8.1.0, os.arch=amd64, java.runtime.version=1.8.0_172-b11,
source=flush, os.version=4.18.0-15-generic,
timestamp=1550902366521}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])
Uninverting(_4(8.1.0):C1:[diagnostics={os=Linux, java.vendor=Oracle
Corporation, java.version=1.8.0_172, java.vm.version=25.172-b11,
lucene.version=8.1.0, os.arch=amd64, java.runtime.version=1.8.0_172-b11,
source=flush, os.version=4.18.0-15-generic,
timestamp=1550902366563}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])
Uninverting(_5(8.1.0):C1:[diagnostics={os=Linux, java.vendor=Oracle
Corporation, java.version=1.8.0_172, java.vm.version=25.172-b11,
lucene.version=8.1.0, os.arch=amd64, java.runtime.version=1.8.0_172-b11,
source=flush, os.version=4.18.0-15-generic,
timestamp=1550902366698}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
[junit4] 2> 9789 INFO
(TEST-TestSolrDeletionPolicy1.testCommitAge-seed#[625C7F08970F2375]) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 9789 INFO
(TEST-TestSolrDeletionPolicy1.testCommitAge-seed#[625C7F08970F2375]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{optimize=} 0 39
[junit4] 2> 9791 INFO
(TEST-TestSolrDeletionPolicy1.testCommitAge-seed#[625C7F08970F2375]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=id:[0+TO+6]&qt=&start=0&rows=20&version=2.2} hits=6 status=0 QTime=1
[junit4] 2> 9799 INFO
(TEST-TestSolrDeletionPolicy1.testCommitAge-seed#[625C7F08970F2375]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending testCommitAge
[junit4] 2> 9817 INFO
(TEST-TestSolrDeletionPolicy1.testNumCommitsConfigured-seed#[625C7F08970F2375])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testNumCommitsConfigured
[junit4] 2> 9818 INFO
(TEST-TestSolrDeletionPolicy1.testNumCommitsConfigured-seed#[625C7F08970F2375])
[ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM
INDEX
[junit4] 2> 9819 INFO
(TEST-TestSolrDeletionPolicy1.testNumCommitsConfigured-seed#[625C7F08970F2375])
[ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}{deleteByQuery=*:*}
0 1
[junit4] 2> 9821 INFO
(TEST-TestSolrDeletionPolicy1.testNumCommitsConfigured-seed#[625C7F08970F2375])
[ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{add=[1]} 0 1
[junit4] 2> 9823 INFO
(TEST-TestSolrDeletionPolicy1.testNumCommitsConfigured-seed#[625C7F08970F2375])
[ ] o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 9823 INFO
(TEST-TestSolrDeletionPolicy1.testNumCommitsConfigured-seed#[625C7F08970F2375])
[ ] o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@21d73883 commitCommandVersion:0
[junit4] 2> 9861 INFO
(TEST-TestSolrDeletionPolicy1.testNumCommitsConfigured-seed#[625C7F08970F2375])
[ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@4ff2708[collection1] main]
[junit4] 2> 9867 INFO (searcherExecutor-10-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@4ff2708[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_6(8.1.0):C1:[diagnostics={os=Linux,
java.vendor=Oracle Corporation, java.version=1.8.0_172,
java.vm.version=25.172-b11, lucene.version=8.1.0, os.arch=amd64,
java.runtime.version=1.8.0_172-b11, source=flush, os.version=4.18.0-15-generic,
timestamp=1550902366774}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
[junit4] 2> 9887 INFO
(TEST-TestSolrDeletionPolicy1.testNumCommitsConfigured-seed#[625C7F08970F2375])
[ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 9887 INFO
(TEST-TestSolrDeletionPolicy1.testNumCommitsConfigured-seed#[625C7F08970F2375])
[ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{commit=} 0 64
[junit4] 2> 9891 INFO
(TEST-TestSolrDeletionPolicy1.testNumCommitsConfigured-seed#[625C7F08970F2375])
[ ] o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=id:[0+TO+1]&qt=&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0
[junit4] 2> 9900 INFO
(TEST-TestSolrDeletionPolicy1.testNumCommitsConfigured-seed#[625C7F08970F2375])
[ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{add=[2]} 0 3
[junit4] 2> 9901 INFO
(TEST-TestSolrDeletionPolicy1.testNumCommitsConfigured-seed#[625C7F08970F2375])
[ ] o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 9902 INFO
(TEST-TestSolrDeletionPolicy1.testNumCommitsConfigured-seed#[625C7F08970F2375])
[ ] o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@21d73883 commitCommandVersion:0
[junit4] 2> 9927 INFO
(TEST-TestSolrDeletionPolicy1.testNumCommitsConfigured-seed#[625C7F08970F2375])
[ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1446fad2[collection1] main]
[junit4] 2> 9932 INFO (searcherExecutor-10-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@1446fad2[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_6(8.1.0):C1:[diagnostics={os=Linux,
java.vendor=Oracle Corporation, java.version=1.8.0_172,
java.vm.version=25.172-b11, lucene.version=8.1.0, os.arch=amd64,
java.runtime.version=1.8.0_172-b11, source=flush, os.version=4.18.0-15-generic,
timestamp=1550902366774}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])
Uninverting(_7(8.1.0):C1:[diagnostics={os=Linux, java.vendor=Oracle
Corporation, java.version=1.8.0_172, java.vm.version=25.172-b11,
lucene.version=8.1.0, os.arch=amd64, java.runtime.version=1.8.0_172-b11,
source=flush, os.version=4.18.0-15-generic,
timestamp=1550902366852}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
[junit4] 2> 9935 INFO
(TEST-TestSolrDeletionPolicy1.testNumCommitsConfigured-seed#[625C7F08970F2375])
[ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 9935 INFO
(TEST-TestSolrDeletionPolicy1.testNumCommitsConfigured-seed#[625C7F08970F2375])
[ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{commit=} 0 33
[junit4] 2> 9938 INFO
(TEST-TestSolrDeletionPolicy1.testNumCommitsConfigured-seed#[625C7F08970F2375])
[ ] o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=id:[0+TO+2]&qt=&start=0&rows=20&version=2.2} hits=2 status=0 QTime=0
[junit4] 2> 9945 INFO
(TEST-TestSolrDeletionPolicy1.testNumCommitsConfigured-seed#[625C7F08970F2375])
[ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{add=[3]} 0 3
[junit4] 2> 9949 INFO
(TEST-TestSolrDeletionPolicy1.testNumCommitsConfigured-seed#[625C7F08970F2375])
[ ] o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 9949 WARN
(TEST-TestSolrDeletionPolicy1.testNumCommitsConfigured-seed#[625C7F08970F2375])
[ ] o.a.s.u.DirectUpdateHandler2 Starting optimize... Reading and rewriting
a potentially large percent of the entire index, reducing to 2147483647 segments
[junit4] 2> 9963 INFO
(TEST-TestSolrDeletionPolicy1.testNumCommitsConfigured-seed#[625C7F08970F2375])
[ ] o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@21d73883 commitCommandVersion:0
[junit4] 2> 9975 INFO
(TEST-TestSolrDeletionPolicy1.testNumCommitsConfigured-seed#[625C7F08970F2375])
[ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@4f398c90[collection1] main]
[junit4] 2> 9979 INFO (searcherExecutor-10-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@4f398c90[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_6(8.1.0):C1:[diagnostics={os=Linux,
java.vendor=Oracle Corporation, java.version=1.8.0_172,
java.vm.version=25.172-b11, lucene.version=8.1.0, os.arch=amd64,
java.runtime.version=1.8.0_172-b11, source=flush, os.version=4.18.0-15-generic,
timestamp=1550902366774}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])
Uninverting(_7(8.1.0):C1:[diagnostics={os=Linux, java.vendor=Oracle
Corporation, java.version=1.8.0_172, java.vm.version=25.172-b11,
lucene.version=8.1.0, os.arch=amd64, java.runtime.version=1.8.0_172-b11,
source=flush, os.version=4.18.0-15-generic,
timestamp=1550902366852}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])
Uninverting(_8(8.1.0):C1:[diagnostics={os=Linux, java.vendor=Oracle
Corporation, java.version=1.8.0_172, java.vm.version=25.172-b11,
lucene.version=8.1.0, os.arch=amd64, java.runtime.version=1.8.0_172-b11,
source=flush, os.version=4.18.0-15-generic,
timestamp=1550902366894}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
[junit4] 2> 9980 INFO
(TEST-TestSolrDeletionPolicy1.testNumCommitsConfigured-seed#[625C7F08970F2375])
[ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 9980 INFO
(TEST-TestSolrDeletionPolicy1.testNumCommitsConfigured-seed#[625C7F08970F2375])
[ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{optimize=} 0 31
[junit4] 2> 9988 INFO
(TEST-TestSolrDeletionPolicy1.testNumCommitsConfigured-seed#[625C7F08970F2375])
[ ] o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=id:[0+TO+3]&qt=&start=0&rows=20&version=2.2} hits=3 status=0 QTime=0
[junit4] 2> 9991 INFO
(TEST-TestSolrDeletionPolicy1.testNumCommitsConfigured-seed#[625C7F08970F2375])
[ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{add=[4]} 0 1
[junit4] 2> 9992 INFO
(TEST-TestSolrDeletionPolicy1.testNumCommitsConfigured-seed#[625C7F08970F2375])
[ ] o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 9992 WARN
(TEST-TestSolrDeletionPolicy1.testNumCommitsConfigured-seed#[625C7F08970F2375])
[ ] o.a.s.u.DirectUpdateHandler2 Starting optimize... Reading and rewriting
a potentially large percent of the entire index, reducing to 2147483647 segments
[junit4] 2> 10016 INFO
(TEST-TestSolrDeletionPolicy1.testNumCommitsConfigured-seed#[625C7F08970F2375])
[ ] o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@21d73883 commitCommandVersion:0
[junit4] 2> 10030 INFO
(TEST-TestSolrDeletionPolicy1.testNumCommitsConfigured-seed#[625C7F08970F2375])
[ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@254aed60[collection1] main]
[junit4] 2> 10039 INFO
(TEST-TestSolrDeletionPolicy1.testNumCommitsConfigured-seed#[625C7F08970F2375])
[ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 10041 INFO (searcherExecutor-10-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@254aed60[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_6(8.1.0):C1:[diagnostics={os=Linux,
java.vendor=Oracle Corporation, java.version=1.8.0_172,
java.vm.version=25.172-b11, lucene.version=8.1.0, os.arch=amd64,
java.runtime.version=1.8.0_172-b11, source=flush, os.version=4.18.0-15-generic,
timestamp=1550902366774}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])
Uninverting(_7(8.1.0):C1:[diagnostics={os=Linux, java.vendor=Oracle
Corporation, java.version=1.8.0_172, java.vm.version=25.172-b11,
lucene.version=8.1.0, os.arch=amd64, java.runtime.version=1.8.0_172-b11,
source=flush, os.version=4.18.0-15-generic,
timestamp=1550902366852}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])
Uninverting(_8(8.1.0):C1:[diagnostics={os=Linux, java.vendor=Oracle
Corporation, java.version=1.8.0_172, java.vm.version=25.172-b11,
lucene.version=8.1.0, os.arch=amd64, java.runtime.version=1.8.0_172-b11,
source=flush, os.version=4.18.0-15-generic,
timestamp=1550902366894}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])
Uninverting(_9(8.1.0):C1:[diagnostics={os=Linux, java.vendor=Oracle
Corporation, java.version=1.8.0_172, java.vm.version=25.172-b11,
lucene.version=8.1.0, os.arch=amd64, java.runtime.version=1.8.0_172-b11,
source=flush, os.version=4.18.0-15-generic,
timestamp=1550902366946}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
[junit4] 2> 10041 INFO
(TEST-TestSolrDeletionPolicy1.testNumCommitsConfigured-seed#[625C7F08970F2375])
[ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{optimize=} 0 49
[junit4] 2> 10043 INFO
(TEST-TestSolrDeletionPolicy1.testNumCommitsConfigured-seed#[625C7F08970F2375])
[ ] o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=id:[0+TO+4]&qt=&start=0&rows=20&version=2.2} hits=4 status=0 QTime=0
[junit4] 2> 10046 INFO
(TEST-TestSolrDeletionPolicy1.testNumCommitsConfigured-seed#[625C7F08970F2375])
[ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{add=[5]} 0 1
[junit4] 2> 10047 INFO
(TEST-TestSolrDeletionPolicy1.testNumCommitsConfigured-seed#[625C7F08970F2375])
[ ] o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 10047 WARN
(TEST-TestSolrDeletionPolicy1.testNumCommitsConfigured-seed#[625C7F08970F2375])
[ ] o.a.s.u.DirectUpdateHandler2 Starting optimize... Reading and rewriting
a potentially large percent of the entire index, reducing to 2147483647 segments
[junit4] 2> 10068 INFO
(TEST-TestSolrDeletionPolicy1.testNumCommitsConfigured-seed#[625C7F08970F2375])
[ ] o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@21d73883 commitCommandVersion:0
[junit4] 2> 10077 INFO
(TEST-TestSolrDeletionPolicy1.testNumCommitsConfigured-seed#[625C7F08970F2375])
[ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@257457c3[collection1] main]
[junit4] 2> 10080 INFO (searcherExecutor-10-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@257457c3[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_6(8.1.0):C1:[diagnostics={os=Linux,
java.vendor=Oracle Corporation, java.version=1.8.0_172,
java.vm.version=25.172-b11, lucene.version=8.1.0, os.arch=amd64,
java.runtime.version=1.8.0_172-b11, source=flush, os.version=4.18.0-15-generic,
timestamp=1550902366774}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])
Uninverting(_7(8.1.0):C1:[diagnostics={os=Linux, java.vendor=Oracle
Corporation, java.version=1.8.0_172, java.vm.version=25.172-b11,
lucene.version=8.1.0, os.arch=amd64, java.runtime.version=1.8.0_172-b11,
source=flush, os.version=4.18.0-15-generic,
timestamp=1550902366852}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])
Uninverting(_8(8.1.0):C1:[diagnostics={os=Linux, java.vendor=Oracle
Corporation, java.version=1.8.0_172, java.vm.version=25.172-b11,
lucene.version=8.1.0, os.arch=amd64, java.runtime.version=1.8.0_172-b11,
source=flush, os.version=4.18.0-15-generic,
timestamp=1550902366894}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])
Uninverting(_9(8.1.0):C1:[diagnostics={os=Linux, java.vendor=Oracle
Corporation, java.version=1.8.0_172, java.vm.version=25.172-b11,
lucene.version=8.1.0, os.arch=amd64, java.runtime.version=1.8.0_172-b11,
source=flush, os.version=4.18.0-15-generic,
timestamp=1550902366946}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])
Uninverting(_a(8.1.0):C1:[diagnostics={os=Linux, java.vendor=Oracle
Corporation, java.version=1.8.0_172, java.vm.version=25.172-b11,
lucene.version=8.1.0, os.arch=amd64, java.runtime.version=1.8.0_172-b11,
source=flush, os.version=4.18.0-15-generic,
timestamp=1550902366998}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
[junit4] 2> 10080 INFO
(TEST-TestSolrDeletionPolicy1.testNumCommitsConfigured-seed#[625C7F08970F2375])
[ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 10081 INFO
(TEST-TestSolrDeletionPolicy1.testNumCommitsConfigured-seed#[625C7F08970F2375])
[ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{optimize=} 0 33
[junit4] 2> 10082 INFO
(TEST-TestSolrDeletionPolicy1.testNumCommitsConfigured-seed#[625C7F08970F2375])
[ ] o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=id:[0+TO+5]&qt=&start=0&rows=20&version=2.2} hits=5 status=0 QTime=1
[junit4] 2> 10085 INFO
(TEST-TestSolrDeletionPolicy1.testNumCommitsConfigured-seed#[625C7F08970F2375])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testNumCommitsConfigured
[junit4] 2> 10092 INFO
(TEST-TestSolrDeletionPolicy1.testKeepOptimizedOnlyCommits-seed#[625C7F08970F2375])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testKeepOptimizedOnlyCommits
[junit4] 2> 10092 INFO
(TEST-TestSolrDeletionPolicy1.testKeepOptimizedOnlyCommits-seed#[625C7F08970F2375])
[ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM
INDEX
[junit4] 2> 10092 INFO
(TEST-TestSolrDeletionPolicy1.testKeepOptimizedOnlyCommits-seed#[625C7F08970F2375])
[ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null
params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}{deleteByQuery=*:*}
0 0
[junit4] 2> 10100 INFO
(TEST-TestSolrDeletionPolicy1.testKeepOptimizedOnlyCommits-seed#[625C7F08970F2375])
[ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[1]} 0 7
[junit4] 2> 10101 INFO
(TEST-TestSolrDeletionPolicy1.testKeepOptimizedOnlyCommits-seed#[625C7F08970F2375])
[ ] o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 10102 INFO
(TEST-TestSolrDeletionPolicy1.testKeepOptimizedOnlyCommits-seed#[625C7F08970F2375])
[ ] o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@21d73883 commitCommandVersion:0
[junit4] 2> 10124 INFO
(TEST-TestSolrDeletionPolicy1.testKeepOptimizedOnlyCommits-seed#[625C7F08970F2375])
[ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@3c1778dc[collection1] main]
[junit4] 2> 10128 INFO (searcherExecutor-10-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@3c1778dc[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_b(8.1.0):C1:[diagnostics={os=Linux,
java.vendor=Oracle Corporation, java.version=1.8.0_172,
java.vm.version=25.172-b11, lucene.version=8.1.0, os.arch=amd64,
java.runtime.version=1.8.0_172-b11, source=flush, os.version=4.18.0-15-generic,
timestamp=1550902367051}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
[junit4] 2> 10136 INFO
(TEST-TestSolrDeletionPolicy1.testKeepOptimizedOnlyCommits-seed#[625C7F08970F2375])
[ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 10136 INFO
(TEST-TestSolrDeletionPolicy1.testKeepOptimizedOnlyCommits-seed#[625C7F08970F2375])
[ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{commit=} 0 34
[junit4] 2> 10139 INFO
(TEST-TestSolrDeletionPolicy1.testKeepOptimizedOnlyCommits-seed#[625C7F08970F2375])
[ ] o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=id:[0+TO+1]&qt=&start=0&rows=20&version=2.2} hits=1 status=0 QTime=1
[junit4] 2> 10144 INFO
(TEST-TestSolrDeletionPolicy1.testKeepOptimizedOnlyCommits-seed#[625C7F08970F2375])
[ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[2]} 0 2
[junit4] 2> 10146 INFO
(TEST-TestSolrDeletionPolicy1.testKeepOptimizedOnlyCommits-seed#[625C7F08970F2375])
[ ] o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 10146 INFO
(TEST-TestSolrDeletionPolicy1.testKeepOptimizedOnlyCommits-seed#[625C7F08970F2375])
[ ] o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@21d73883 commitCommandVersion:0
[junit4] 2> 10159 INFO
(TEST-TestSolrDeletionPolicy1.testKeepOptimizedOnlyCommits-seed#[625C7F08970F2375])
[ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@79efabbe[collection1] main]
[junit4] 2> 10162 INFO (searcherExecutor-10-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@79efabbe[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_b(8.1.0):C1:[diagnostics={os=Linux,
java.vendor=Oracle Corporation, java.version=1.8.0_172,
java.vm.version=25.172-b11, lucene.version=8.1.0, os.arch=amd64,
java.runtime.version=1.8.0_172-b11, source=flush, os.version=4.18.0-15-generic,
timestamp=1550902367051}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])
Uninverting(_c(8.1.0):C1:[diagnostics={os=Linux, java.vendor=Oracle
Corporation, java.version=1.8.0_172, java.vm.version=25.172-b11,
lucene.version=8.1.0, os.arch=amd64, java.runtime.version=1.8.0_172-b11,
source=flush, os.version=4.18.0-15-generic,
timestamp=1550902367085}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
[junit4] 2> 10163 INFO
(TEST-TestSolrDeletionPolicy1.testKeepOptimizedOnlyCommits-seed#[625C7F08970F2375])
[ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 10163 INFO
(TEST-TestSolrDeletionPolicy1.testKeepOptimizedOnlyCommits-seed#[625C7F08970F2375])
[ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{commit=} 0 17
[junit4] 2> 10166 INFO
(TEST-TestSolrDeletionPolicy1.testKeepOptimizedOnlyCommits-seed#[625C7F08970F2375])
[ ] o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=id:[0+TO+2]&qt=&start=0&rows=20&version=2.2} hits=2 status=0 QTime=0
[junit4] 2> 10177 INFO
(TEST-TestSolrDeletionPolicy1.testKeepOptimizedOnlyCommits-seed#[625C7F08970F2375])
[ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[3]} 0 8
[junit4] 2> 10178 INFO
(TEST-TestSolrDeletionPolicy1.testKeepOptimizedOnlyCommits-seed#[625C7F08970F2375])
[ ] o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 10178 WARN
(TEST-TestSolrDeletionPolicy1.testKeepOptimizedOnlyCommits-seed#[625C7F08970F2375])
[ ] o.a.s.u.DirectUpdateHandler2 Starting optimize... Reading and rewriting
a potentially large percent of the entire index, reducing to 2147483647 segments
[junit4] 2> 10193 INFO
(TEST-TestSolrDeletionPolicy1.testKeepOptimizedOnlyCommits-seed#[625C7F08970F2375])
[ ] o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@21d73883 commitCommandVersion:0
[junit4] 2> 10196 INFO
(TEST-TestSolrDeletionPolicy1.testKeepOptimizedOnlyCommits-seed#[625C7F08970F2375])
[ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@16391b9[collection1] main]
[junit4] 2> 10199 INFO (searcherExecutor-10-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@16391b9[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_b(8.1.0):C1:[diagnostics={os=Linux,
java.vendor=Oracle Corporation, java.version=1.8.0_172,
java.vm.version=25.172-b11, lucene.version=8.1.0, os.arch=amd64,
java.runtime.version=1.8.0_172-b11, source=flush, os.version=4.18.0-15-generic,
timestamp=1550902367051}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])
Uninverting(_c(8.1.0):C1:[diagnostics={os=Linux, java.vendor=Oracle
Corporation, java.version=1.8.0_172, java.vm.version=25.172-b11,
lucene.version=8.1.0, os.arch=amd64, java.runtime.version=1.8.0_172-b11,
source=flush, os.version=4.18.0-15-generic,
timestamp=1550902367085}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])
Uninverting(_d(8.1.0):C1:[diagnostics={os=Linux, java.vendor=Oracle
Corporation, java.version=1.8.0_172, java.vm.version=25.172-b11,
lucene.version=8.1.0, os.arch=amd64, java.runtime.version=1.8.0_172-b11,
source=flush, os.version=4.18.0-15-generic,
timestamp=1550902367123}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
[junit4] 2> 10199 INFO
(TEST-TestSolrDeletionPolicy1.testKeepOptimizedOnlyCommits-seed#[625C7F08970F2375])
[ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 10199 INFO
(TEST-TestSolrDeletionPolicy1.testKeepOptimizedOnlyCommits-seed#[625C7F08970F2375])
[ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{optimize=} 0 21
[junit4] 2> 10201 INFO
(TEST-TestSolrDeletionPolicy1.testKeepOptimizedOnlyCommits-seed#[625C7F08970F2375])
[ ] o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=id:[0+TO+3]&qt=&start=0&rows=20&version=2.2} hits=3 status=0 QTime=0
[junit4] 2> 10204 INFO
(TEST-TestSolrDeletionPolicy1.testKeepOptimizedOnlyCommits-seed#[625C7F08970F2375])
[ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[4]} 0 1
[junit4] 2> 10205 INFO
(TEST-TestSolrDeletionPolicy1.testKeepOptimizedOnlyCommits-seed#[625C7F08970F2375])
[ ] o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 10205 WARN
(TEST-TestSolrDeletionPolicy1.testKeepOptimizedOnlyCommits-seed#[625C7F08970F2375])
[ ] o.a.s.u.DirectUpdateHandler2 Starting optimize... Reading and rewriting
a potentially large percent of the entire index, reducing to 2147483647 segments
[junit4] 2> 10216 INFO
(TEST-TestSolrDeletionPolicy1.testKeepOptimizedOnlyCommits-seed#[625C7F08970F2375])
[ ] o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@21d73883 commitCommandVersion:0
[junit4] 2> 10221 INFO
(TEST-TestSolrDeletionPolicy1.testKeepOptimizedOnlyCommits-seed#[625C7F08970F2375])
[ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@13f13130[collection1] main]
[junit4] 2> 10224 INFO (searcherExecutor-10-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@13f13130[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_b(8.1.0):C1:[diagnostics={os=Linux,
java.vendor=Oracle Corporation, java.version=1.8.0_172,
java.vm.version=25.172-b11, lucene.version=8.1.0, os.arch=amd64,
java.runtime.version=1.8.0_172-b11, source=flush, os.version=4.18.0-15-generic,
timestamp=1550902367051}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])
Uninverting(_c(8.1.0):C1:[diagnostics={os=Linux, java.vendor=Oracle
Corporation, java.version=1.8.0_172, java.vm.version=25.172-b11,
lucene.version=8.1.0, os.arch=amd64, java.runtime.version=1.8.0_172-b11,
source=flush, os.version=4.18.0-15-generic,
timestamp=1550902367085}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])
Uninverting(_d(8.1.0):C1:[diagnostics={os=Linux, java.vendor=Oracle
Corporation, java.version=1.8.0_172, java.vm.version=25.172-b11,
lucene.version=8.1.0, os.arch=amd64, java.runtime.version=1.8.0_172-b11,
source=flush, os.version=4.18.0-15-generic,
timestamp=1550902367123}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])
Uninverting(_e(8.1.0):C1:[diagnostics={os=Linux, java.vendor=Oracle
Corporation, java.version=1.8.0_172, java.vm.version=25.172-b11,
lucene.version=8.1.0, os.arch=amd64, java.runtime.version=1.8.0_172-b11,
source=flush, os.version=4.18.0-15-generic,
timestamp=1550902367146}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
[junit4] 2> 10226 INFO
(TEST-TestSolrDeletionPolicy1.testKeepOptimizedOnlyCommits-seed#[625C7F08970F2375])
[ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 10226 INFO
(TEST-TestSolrDeletionPolicy1.testKeepOptimizedOnlyCommits-seed#[625C7F08970F2375])
[ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{optimize=} 0 21
[junit4] 2> 10230 INFO
(TEST-TestSolrDeletionPolicy1.testKeepOptimizedOnlyCommits-seed#[625C7F08970F2375])
[ ] o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=id:[0+TO+4]&qt=&start=0&rows=20&version=2.2} hits=4 status=0 QTime=1
[junit4] 2> 10238 INFO
(TEST-TestSolrDeletionPolicy1.testKeepOptimizedOnlyCommits-seed#[625C7F08970F2375])
[ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{add=[5]} 0 2
[junit4] 2> 10239 INFO
(TEST-TestSolrDeletionPolicy1.testKeepOptimizedOnlyCommits-seed#[625C7F08970F2375])
[ ] o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 10239 WARN
(TEST-TestSolrDeletionPolicy1.testKeepOptimizedOnlyCommits-seed#[625C7F08970F2375])
[ ] o.a.s.u.DirectUpdateHandler2 Starting optimize... Reading and rewriting
a potentially large percent of the entire index, reducing to 2147483647 segments
[junit4] 2> 10250 INFO
(TEST-TestSolrDeletionPolicy1.testKeepOptimizedOnlyCommits-seed#[625C7F08970F2375])
[ ] o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@21d73883 commitCommandVersion:0
[junit4] 2> 10256 INFO
(TEST-TestSolrDeletionPolicy1.testKeepOptimizedOnlyCommits-seed#[625C7F08970F2375])
[ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@19158e60[collection1] main]
[junit4] 2> 10257 INFO
(TEST-TestSolrDeletionPolicy1.testKeepOptimizedOnlyCommits-seed#[625C7F08970F2375])
[ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 10260 INFO (searcherExecutor-10-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@19158e60[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_b(8.1.0):C1:[diagnostics={os=Linux,
java.vendor=Oracle Corporation, java.version=1.8.0_172,
java.vm.version=25.172-b11, lucene.version=8.1.0, os.arch=amd64,
java.runtime.version=1.8.0_172-b11, source=flush, os.version=4.18.0-15-generic,
timestamp=1550902367051}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])
Uninverting(_c(8.1.0):C1:[diagnostics={os=Linux, java.vendor=Oracle
Corporation, java.version=1.8.0_172, java.vm.version=25.172-b11,
lucene.version=8.1.0, os.arch=amd64, java.runtime.version=1.8.0_172-b11,
source=flush, os.version=4.18.0-15-generic,
timestamp=1550902367085}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])
Uninverting(_d(8.1.0):C1:[diagnostics={os=Linux, java.vendor=Oracle
Corporation, java.version=1.8.0_172, java.vm.version=25.172-b11,
lucene.version=8.1.0, os.arch=amd64, java.runtime.version=1.8.0_172-b11,
source=flush, os.version=4.18.0-15-generic,
timestamp=1550902367123}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])
Uninverting(_e(8.1.0):C1:[diagnostics={os=Linux, java.vendor=Oracle
Corporation, java.version=1.8.0_172, java.vm.version=25.172-b11,
lucene.version=8.1.0, os.arch=amd64, java.runtime.version=1.8.0_172-b11,
source=flush, os.version=4.18.0-15-generic,
timestamp=1550902367146}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])
Uninverting(_f(8.1.0):C1:[diagnostics={os=Linux, java.vendor=Oracle
Corporation, java.version=1.8.0_172, java.vm.version=25.172-b11,
lucene.version=8.1.0, os.arch=amd64, java.runtime.version=1.8.0_172-b11,
source=flush, os.version=4.18.0-15-generic,
timestamp=1550902367180}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
[junit4] 2> 10264 INFO
(TEST-TestSolrDeletionPolicy1.testKeepOptimizedOnlyCommits-seed#[625C7F08970F2375])
[ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{optimize=} 0 24
[junit4] 2> 10266 INFO
(TEST-TestSolrDeletionPolicy1.testKeepOptimizedOnlyCommits-seed#[625C7F08970F2375])
[ ] o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=id:[0+TO+5]&qt=&start=0&rows=20&version=2.2} hits=5 status=0 QTime=1
[junit4] 2> 10269 INFO
(TEST-TestSolrDeletionPolicy1.testKeepOptimizedOnlyCommits-seed#[625C7F08970F2375])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testKeepOptimizedOnlyCommits
[junit4] 2> 10269 INFO
(SUITE-TestSolrDeletionPolicy1-seed#[625C7F08970F2375]-worker) [ ]
o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> 10270 INFO
(SUITE-TestSolrDeletionPolicy1-seed#[625C7F08970F2375]-worker) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1058045390
[junit4] 2> 10300 INFO (coreCloseExecutor-14-thread-1) [
x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@4d228e83
[junit4] 2> 10300 INFO (coreCloseExecutor-14-thread-1) [
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection1, tag=4d228e83
[junit4] 2> 10301 INFO (coreCloseExecutor-14-thread-1) [
x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@70cee54e: rootName = null,
domain = solr.core.collection1, service url = null, agent id = null] for
registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@2ae1f105
[junit4] 2> 10404 INFO
(SUITE-TestSolrDeletionPolicy1-seed#[625C7F08970F2375]-worker) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 10404 INFO
(SUITE-TestSolrDeletionPolicy1-seed#[625C7F08970F2375]-worker) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@15aa87c9: rootName = null,
domain = solr.node, service url = null, agent id = null] for registry solr.node
/ com.codahale.metrics.MetricRegistry@7553c86d
[junit4] 2> 10410 INFO
(SUITE-TestSolrDeletionPolicy1-seed#[625C7F08970F2375]-worker) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 10410 INFO
(SUITE-TestSolrDeletionPolicy1-seed#[625C7F08970F2375]-worker) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@69d8fd90: rootName = null,
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm /
com.codahale.metrics.MetricRegistry@97f2442
[junit4] 2> 10410 INFO
(SUITE-TestSolrDeletionPolicy1-seed#[625C7F08970F2375]-worker) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 10411 INFO
(SUITE-TestSolrDeletionPolicy1-seed#[625C7F08970F2375]-worker) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@53d921ac: rootName = null,
domain = solr.jetty, service url = null, agent id = null] for registry
solr.jetty / com.codahale.metrics.MetricRegistry@1df4b3cf
[junit4] 1> Done close
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor@404fb957[Terminated,
pool size = 0, active threads = 0, queued tasks = 0, completed tasks = 2]
[junit4] 1> Done close
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor@595eaee3[Terminated,
pool size = 0, active threads = 0, queued tasks = 0, completed tasks = 2]
[junit4] 2> 10449 INFO
(SUITE-TestSolrDeletionPolicy1-seed#[625C7F08970F2375]-worker) [ ]
o.a.s.SolrTestCaseJ4 -------------------------------------------------------
Done waiting for tracked resources to be released
[junit4] 2> Feb 23, 2019 6:12:47 AM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 1 leaked
thread(s).
[junit4] 2> Feb 23, 2019 6:12:57 AM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> SEVERE: 1 thread leaked from SUITE scope at
org.apache.solr.core.TestSolrDeletionPolicy1:
[junit4] 2> 1) Thread[id=31, name=Log4j2-TF-2-AsyncLoggerConfig--2,
state=TIMED_WAITING, group=TGRP-TestSolrDeletionPolicy1]
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
[junit4] 2> at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
[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.lang.Thread.run(Thread.java:748)
[junit4] 2> Feb 23, 2019 6:12:57 AM
com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
[junit4] 2> INFO: Starting to interrupt leaked threads:
[junit4] 2> 1) Thread[id=31, name=Log4j2-TF-2-AsyncLoggerConfig--2,
state=TIMED_WAITING, group=TGRP-TestSolrDeletionPolicy1]
[junit4] 2> AsyncLogger error handling event seq=0, value='null':
[junit4] 2> java.lang.InterruptedException
[junit4] 2> at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.reportInterruptAfterWait(AbstractQueuedSynchronizer.java:2014)
[junit4] 2> at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2088)
[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.lang.Thread.run(Thread.java:748)
[junit4] 2> AsyncLogger error handling event seq=1, value='null':
[junit4] 2> java.lang.InterruptedException
[junit4] 2> at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.reportInterruptAfterWait(AbstractQueuedSynchronizer.java:2014)
[junit4] 2> at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2088)
[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.lang.Thread.run(Thread.java:748)
[junit4] 2> AsyncLogger error handling event seq=2, value='null':
[junit4] 2> java.lang.InterruptedException
[junit4] 2> at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.reportInterruptAfterWait(AbstractQueuedSynchronizer.java:2014)
[junit4] 2> at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2088)
[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.lang.Thread.run(Thread.java:748)
[junit4] 2> AsyncLogger error handling event seq=3, value='null':
[junit4] 2> java.lang.InterruptedException
[junit4] 2> at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.reportInterruptAfterWait(AbstractQueuedSynchronizer.java:2014)
[junit4] 2> at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2088)
[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.lang.Thread.run(Thread.java:748)
[junit4] 2> AsyncLogger error handling event seq=4, value='null':
[junit4] 2> java.lang.InterruptedException
[junit4] 2> at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.reportInterruptAfterWait(AbstractQueuedSynchronizer.java:2014)
[junit4] 2> at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2088)
[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.lang.Thread.run(Thread.java:748)
[junit4] 2> Feb 23, 2019 6:13:00 AM
com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
[junit4] 2> SEVERE: There are still zombie threads that couldn't be
terminated:
[junit4] 2> 1) Thread[id=31, name=Log4j2-TF-2-AsyncLoggerConfig--2,
state=TIMED_WAITING, group=TGRP-TestSolrDeletionPolicy1]
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
[junit4] 2> at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
[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.lang.Thread.run(Thread.java:748)
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene80):
{multiDefault=PostingsFormat(name=LuceneVarGapDocFreqInterval),
_root_=PostingsFormat(name=LuceneFixedGap),
name=PostingsFormat(name=LuceneVarGapFixedInterval),
id=PostingsFormat(name=LuceneVarGapFixedInterval)},
docValues:{range_facet_l_dv=DocValuesFormat(name=Direct),
intDefault=DocValuesFormat(name=Asserting),
id_i1=DocValuesFormat(name=Asserting),
range_facet_i_dv=DocValuesFormat(name=Lucene80),
intDvoDefault=DocValuesFormat(name=Direct),
range_facet_l=DocValuesFormat(name=Lucene80),
timestamp=DocValuesFormat(name=Lucene80)}, maxPointsInLeafNode=1257,
maxMBSortInHeap=6.376067230628509,
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@1743e852),
locale=uk, timezone=Africa/Juba
[junit4] 2> NOTE: Linux 4.18.0-15-generic amd64/Oracle Corporation
1.8.0_172 (64-bit)/cpus=8,threads=3,free=354329008,total=518979584
[junit4] 2> NOTE: All tests run in this JVM: [TestSolrDeletionPolicy1]
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=TestSolrDeletionPolicy1 -Dtests.seed=625C7F08970F2375
-Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=uk
-Dtests.timezone=Africa/Juba -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
[junit4] ERROR 0.00s J1 | TestSolrDeletionPolicy1 (suite) <<<
[junit4] > Throwable #1:
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE
scope at org.apache.solr.core.TestSolrDeletionPolicy1:
[junit4] > 1) Thread[id=31, name=Log4j2-TF-2-AsyncLoggerConfig--2,
state=TIMED_WAITING, group=TGRP-TestSolrDeletionPolicy1]
[junit4] > at sun.misc.Unsafe.park(Native Method)
[junit4] > at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
[junit4] > at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
[junit4] > at
com.lmax.disruptor.TimeoutBlockingWaitStrategy.waitFor(TimeoutBlockingWaitStrategy.java:38)
[junit4] > at
com.lmax.disruptor.ProcessingSequenceBarrier.waitFor(ProcessingSequenceBarrier.java:56)
[junit4] > at
com.lmax.disruptor.BatchEventProcessor.run(BatchEventProcessor.java:128)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] > at
__randomizedtesting.SeedInfo.seed([625C7F08970F2375]:0)Throwable #2:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie
threads that couldn't be terminated:
[junit4] > 1) Thread[id=31, name=Log4j2-TF-2-AsyncLoggerConfig--2,
state=TIMED_WAITING, group=TGRP-TestSolrDeletionPolicy1]
[junit4] > at sun.misc.Unsafe.park(Native Method)
[junit4] > at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
[junit4] > at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
[junit4] > at
com.lmax.disruptor.TimeoutBlockingWaitStrategy.waitFor(TimeoutBlockingWaitStrategy.java:38)
[junit4] > at
com.lmax.disruptor.ProcessingSequenceBarrier.waitFor(ProcessingSequenceBarrier.java:56)
[junit4] > at
com.lmax.disruptor.BatchEventProcessor.run(BatchEventProcessor.java:128)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] > at
__randomizedtesting.SeedInfo.seed([625C7F08970F2375]:0)
[junit4] Completed [4/844 (1!)] on J1 in 22.21s, 3 tests, 2 errors <<<
FAILURES!
[...truncated 181 lines...]
[junit4] Suite: org.apache.solr.handler.export.TestExportWriter
[junit4] 2> Creating dataDir:
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.export.TestExportWriter_625C7F08970F2375-001/init-core-data-001
[junit4] 2> 2856 INFO
(SUITE-TestExportWriter-seed#[625C7F08970F2375]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 2917 INFO
(SUITE-TestExportWriter-seed#[625C7F08970F2375]-worker) [ ] o.e.j.u.log
Logging initialized @2958ms to org.eclipse.jetty.util.log.Slf4jLog
[junit4] 2> 2927 INFO
(SUITE-TestExportWriter-seed#[625C7F08970F2375]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via:
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 3225 INFO
(SUITE-TestExportWriter-seed#[625C7F08970F2375]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 3226 INFO
(SUITE-TestExportWriter-seed#[625C7F08970F2375]-worker) [ ]
o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 3294 INFO
(SUITE-TestExportWriter-seed#[625C7F08970F2375]-worker) [ ]
o.a.s.c.SolrResourceLoader Using system property solr.solr.home:
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr
[junit4] 2> 3301 INFO
(SUITE-TestExportWriter-seed#[625C7F08970F2375]-worker) [ ]
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths:
[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/lib,
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 3528 INFO
(SUITE-TestExportWriter-seed#[625C7F08970F2375]-worker) [ ]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0
[junit4] 2> 3666 INFO
(SUITE-TestExportWriter-seed#[625C7F08970F2375]-worker) [ ]
o.a.s.s.IndexSchema [null] Schema name=schema-docValuesMulti
[junit4] 2> 3781 INFO
(SUITE-TestExportWriter-seed#[625C7F08970F2375]-worker) [ ]
o.a.s.s.IndexSchema Loaded schema schema-docValuesMulti/1.6 with uniqueid field
id
[junit4] 2> 4198 INFO
(SUITE-TestExportWriter-seed#[625C7F08970F2375]-worker) [ ]
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 4217 WARN
(SUITE-TestExportWriter-seed#[625C7F08970F2375]-worker) [ ]
o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport
since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 4376 WARN
(SUITE-TestExportWriter-seed#[625C7F08970F2375]-worker) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
SslContextFactory@418e8277[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 4599 WARN
(SUITE-TestExportWriter-seed#[625C7F08970F2375]-worker) [ ]
o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport
since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 4601 WARN
(SUITE-TestExportWriter-seed#[625C7F08970F2375]-worker) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
SslContextFactory@5c1c5581[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 4912 INFO
(SUITE-TestExportWriter-seed#[625C7F08970F2375]-worker) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 4916 INFO
(SUITE-TestExportWriter-seed#[625C7F08970F2375]-worker) [ ]
o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history
in memory.
[junit4] 2> 5091 INFO
(SUITE-TestExportWriter-seed#[625C7F08970F2375]-worker) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@63273f0d
[junit4] 2> 5093 INFO
(SUITE-TestExportWriter-seed#[625C7F08970F2375]-worker) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@63273f0d
[junit4] 2> 5093 INFO
(SUITE-TestExportWriter-seed#[625C7F08970F2375]-worker) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@63273f0d
[junit4] 2> 5176 INFO (coreLoadExecutor-9-thread-1) [ x:collection1]
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths:
[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/lib,
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 5224 INFO (coreLoadExecutor-9-thread-1) [ x:collection1]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0
[junit4] 2> 5268 INFO (coreLoadExecutor-9-thread-1) [ x:collection1]
o.a.s.s.IndexSchema [collection1] Schema name=schema-docValuesMulti
[junit4] 2> 5323 INFO (coreLoadExecutor-9-thread-1) [ x:collection1]
o.a.s.s.IndexSchema Loaded schema schema-docValuesMulti/1.6 with uniqueid field
id
[junit4] 2> 5325 INFO (coreLoadExecutor-9-thread-1) [ x:collection1]
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from
instancedir
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1,
trusted=true
[junit4] 2> 5445 INFO (coreLoadExecutor-9-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@63273f0d
[junit4] 2> 5464 INFO (coreLoadExecutor-9-thread-1) [ x:collection1]
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1],
dataDir=[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.export.TestExportWriter_625C7F08970F2375-001/init-core-data-001/]
[junit4] 2> 5581 INFO (coreLoadExecutor-9-thread-1) [ x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=37, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147
[...truncated too long message...]
.disruptor.ProcessingSequenceBarrier.waitFor(ProcessingSequenceBarrier.java:56)
[junit4] 2> at
com.lmax.disruptor.BatchEventProcessor.run(BatchEventProcessor.java:128)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> AsyncLogger error handling event seq=2, value='null':
[junit4] 2> java.lang.InterruptedException
[junit4] 2> at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.reportInterruptAfterWait(AbstractQueuedSynchronizer.java:2014)
[junit4] 2> at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2088)
[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.lang.Thread.run(Thread.java:748)
[junit4] 2> AsyncLogger error handling event seq=3, value='null':
[junit4] 2> java.lang.InterruptedException
[junit4] 2> at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.reportInterruptAfterWait(AbstractQueuedSynchronizer.java:2014)
[junit4] 2> at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2088)
[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.lang.Thread.run(Thread.java:748)
[junit4] 2> AsyncLogger error handling event seq=4, value='null':
[junit4] 2> java.lang.InterruptedException
[junit4] 2> at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.reportInterruptAfterWait(AbstractQueuedSynchronizer.java:2014)
[junit4] 2> at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2088)
[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.lang.Thread.run(Thread.java:748)
[junit4] 2> Feb 23, 2019 6:46:00 AM
com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
[junit4] 2> SEVERE: There are still zombie threads that couldn't be
terminated:
[junit4] 2> 1) Thread[id=31, name=Log4j2-TF-2-AsyncLoggerConfig--2,
state=TIMED_WAITING, group=TGRP-TestSolrDeletionPolicy1]
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
[junit4] 2> at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
[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.lang.Thread.run(Thread.java:748)
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene80):
{multiDefault=PostingsFormat(name=LuceneVarGapDocFreqInterval),
_root_=PostingsFormat(name=LuceneFixedGap),
name=PostingsFormat(name=LuceneVarGapFixedInterval),
id=PostingsFormat(name=LuceneVarGapFixedInterval)},
docValues:{range_facet_l_dv=DocValuesFormat(name=Direct),
intDefault=DocValuesFormat(name=Asserting),
id_i1=DocValuesFormat(name=Asserting),
range_facet_i_dv=DocValuesFormat(name=Lucene80),
intDvoDefault=DocValuesFormat(name=Direct),
range_facet_l=DocValuesFormat(name=Lucene80),
timestamp=DocValuesFormat(name=Lucene80)}, maxPointsInLeafNode=1257,
maxMBSortInHeap=6.376067230628509,
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@1743e852),
locale=de-AT, timezone=America/Glace_Bay
[junit4] 2> NOTE: Linux 4.18.0-15-generic amd64/Oracle Corporation
1.8.0_172 (64-bit)/cpus=8,threads=3,free=354097816,total=518979584
[junit4] 2> NOTE: All tests run in this JVM: [TestSolrDeletionPolicy1]
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=TestSolrDeletionPolicy1 -Dtests.seed=625C7F08970F2375
-Dtests.multiplier=3 -Dtests.slow=true -Dtests.badapples=true
-Dtests.locale=de-AT -Dtests.timezone=America/Glace_Bay -Dtests.asserts=true
-Dtests.file.encoding=US-ASCII
[junit4] ERROR 0.00s J2 | TestSolrDeletionPolicy1 (suite) <<<
[junit4] > Throwable #1:
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE
scope at org.apache.solr.core.TestSolrDeletionPolicy1:
[junit4] > 1) Thread[id=31, name=Log4j2-TF-2-AsyncLoggerConfig--2,
state=TIMED_WAITING, group=TGRP-TestSolrDeletionPolicy1]
[junit4] > at sun.misc.Unsafe.park(Native Method)
[junit4] > at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
[junit4] > at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
[junit4] > at
com.lmax.disruptor.TimeoutBlockingWaitStrategy.waitFor(TimeoutBlockingWaitStrategy.java:38)
[junit4] > at
com.lmax.disruptor.ProcessingSequenceBarrier.waitFor(ProcessingSequenceBarrier.java:56)
[junit4] > at
com.lmax.disruptor.BatchEventProcessor.run(BatchEventProcessor.java:128)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] > at
__randomizedtesting.SeedInfo.seed([625C7F08970F2375]:0)Throwable #2:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie
threads that couldn't be terminated:
[junit4] > 1) Thread[id=31, name=Log4j2-TF-2-AsyncLoggerConfig--2,
state=TIMED_WAITING, group=TGRP-TestSolrDeletionPolicy1]
[junit4] > at sun.misc.Unsafe.park(Native Method)
[junit4] > at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
[junit4] > at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
[junit4] > at
com.lmax.disruptor.TimeoutBlockingWaitStrategy.waitFor(TimeoutBlockingWaitStrategy.java:38)
[junit4] > at
com.lmax.disruptor.ProcessingSequenceBarrier.waitFor(ProcessingSequenceBarrier.java:56)
[junit4] > at
com.lmax.disruptor.BatchEventProcessor.run(BatchEventProcessor.java:128)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] > at
__randomizedtesting.SeedInfo.seed([625C7F08970F2375]:0)
[junit4] Completed [9/10 (1!)] on J2 in 20.43s, 3 tests, 2 errors <<<
FAILURES!
[junit4]
[junit4] Suite: org.apache.solr.core.TestSolrDeletionPolicy1
[junit4] Completed [10/10 (1!)] on J2 in 0.01s, 3 tests, 3 skipped
[junit4]
[junit4]
[junit4] Tests with failures [seed: 625C7F08970F2375]:
[junit4] - org.apache.solr.core.TestSolrDeletionPolicy1 (suite)
[junit4]
[junit4]
[junit4] JVM J0: 0.64 .. 18.61 = 17.97s
[junit4] JVM J1: 0.41 .. 18.69 = 18.28s
[junit4] JVM J2: 0.65 .. 21.98 = 21.33s
[junit4] Execution time total: 21 seconds
[junit4] Tests summary: 10 suites, 60 tests, 2 suite-level errors, 3 ignored
BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/common-build.xml:1572: The
following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/common-build.xml:1099:
There were test failures: 10 suites, 60 tests, 2 suite-level errors, 3 ignored
[seed: 625C7F08970F2375]
Total time: 23 seconds
[repro] Setting last failure code to 256
[repro] Failures:
[repro] 0/5 failed: org.apache.solr.handler.export.TestExportWriter
[repro] 1/5 failed: org.apache.solr.core.TestSolrDeletionPolicy1
[repro] Exiting with code 256
+ mv lucene/build lucene/build.repro
+ mv solr/build solr/build.repro
+ mv lucene/build.orig lucene/build
+ mv solr/build.orig solr/build
Archiving artifacts
Setting
ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
[WARNINGS] Parsing warnings in console log with parser Java Compiler (javac)
Setting
ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
No credentials specified
Setting
ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
<Git Blamer> Using GitBlamer to create author and commit information for all
warnings.
<Git Blamer> GIT_COMMIT=4aa0645ea6216f556ffd8c3ad6fcb276a0cc796d,
workspace=/home/jenkins/workspace/Lucene-Solr-8.x-Linux
[WARNINGS] Computing warning deltas based on reference build #197
Recording test results
Setting
ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Build step 'Publish JUnit test result report' changed build result to UNSTABLE
Email was triggered for: Unstable (Test Failures)
Sending email for trigger: Unstable (Test Failures)
Setting
ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting
ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting
ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting
ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting
ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting
ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
