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: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org