Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/22120/ Java: 64bit/jdk1.8.0_172 -XX:+UseCompressedOops -XX:+UseG1GC
1 tests failed. FAILED: org.apache.solr.update.MaxSizeAutoCommitTest.deleteTest Error Message: Tlog size exceeds the max size bound. Tlog path: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.MaxSizeAutoCommitTest_DEA0D2D1D506D059-001/init-core-data-001/tlog/tlog.0000000000000000005, tlog size: 1265 Stack Trace: java.lang.AssertionError: Tlog size exceeds the max size bound. Tlog path: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.MaxSizeAutoCommitTest_DEA0D2D1D506D059-001/init-core-data-001/tlog/tlog.0000000000000000005, tlog size: 1265 at __randomizedtesting.SeedInfo.seed([DEA0D2D1D506D059:CEEE372EAEA8E9A8]:0) at org.junit.Assert.fail(Assert.java:93) at org.junit.Assert.assertTrue(Assert.java:43) at org.apache.solr.update.MaxSizeAutoCommitTest.getTlogFileSizes(MaxSizeAutoCommitTest.java:379) at org.apache.solr.update.MaxSizeAutoCommitTest.deleteTest(MaxSizeAutoCommitTest.java:200) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at java.lang.Thread.run(Thread.java:748) Build Log: [...truncated 13720 lines...] [junit4] Suite: org.apache.solr.update.MaxSizeAutoCommitTest [junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.MaxSizeAutoCommitTest_DEA0D2D1D506D059-001/init-core-data-001 [junit4] 2> 976009 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[DEA0D2D1D506D059]) [ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 976028 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[DEA0D2D1D506D059]) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0 [junit4] 2> 976039 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[DEA0D2D1D506D059]) [ ] o.a.s.s.IndexSchema [null] Schema name=test [junit4] 2> 976142 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[DEA0D2D1D506D059]) [ ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 976176 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[DEA0D2D1D506D059]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7adda9cc [junit4] 2> 976241 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[DEA0D2D1D506D059]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7adda9cc [junit4] 2> 976241 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[DEA0D2D1D506D059]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7adda9cc [junit4] 2> 976242 INFO (coreLoadExecutor-4129-thread-1) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 976243 INFO (coreLoadExecutor-4129-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 976260 INFO (coreLoadExecutor-4129-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0 [junit4] 2> 976279 INFO (coreLoadExecutor-4129-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 976402 INFO (coreLoadExecutor-4129-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 976406 INFO (coreLoadExecutor-4129-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1, trusted=true [junit4] 2> 976406 INFO (coreLoadExecutor-4129-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@7adda9cc [junit4] 2> 976406 INFO (coreLoadExecutor-4129-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 976406 INFO (coreLoadExecutor-4129-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.MaxSizeAutoCommitTest_DEA0D2D1D506D059-001/init-core-data-001/] [junit4] 2> 976407 INFO (coreLoadExecutor-4129-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=34, maxMergeAtOnceExplicit=38, maxMergedSegmentMB=99.7978515625, floorSegmentMB=1.720703125, forceMergeDeletesPctAllowed=20.605483666169288, segmentsPerTier=39.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7376639627984479 [junit4] 2> 976409 WARN (coreLoadExecutor-4129-thread-1) [ x:collection1] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,attributes = {initParams=a, name=/dump, class=DumpRequestHandler},args = {defaults={a=A,b=B}}} [junit4] 2> 976432 INFO (coreLoadExecutor-4129-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 976432 INFO (coreLoadExecutor-4129-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 976433 INFO (coreLoadExecutor-4129-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 976433 INFO (coreLoadExecutor-4129-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 976434 INFO (coreLoadExecutor-4129-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=11, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7412644920625249] [junit4] 2> 976434 INFO (coreLoadExecutor-4129-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@2e696f63[collection1] main] [junit4] 2> 976434 WARN (coreLoadExecutor-4129-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead. [junit4] 2> 976435 INFO (coreLoadExecutor-4129-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 976435 INFO (searcherExecutor-4130-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@2e696f63[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 976435 INFO (coreLoadExecutor-4129-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1601687317764898816 [junit4] 2> 976440 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[0 (1601687317768044544), 1 (1601687317770141696), 2 (1601687317770141697)]} 0 2 [junit4] 2> 976641 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[3 (1601687317980905472), 4 (1601687317980905473), 5 (1601687317980905474)]} 0 0 [junit4] 2> 976845 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[6 (1601687318191669248), 7 (1601687318194814976), 8 (1601687318194814977)]} 0 3 [junit4] 2> 977046 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[9 (1601687318405578752), 10 (1601687318405578753), 11 (1601687318405578754)]} 0 0 [junit4] 2> 977249 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[12 (1601687318616342528), 13 (1601687318616342529), 14 (1601687318618439680)]} 0 2 [junit4] 2> 977450 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[15 (1601687318829203456), 16 (1601687318829203457), 17 (1601687318829203458)]} 0 0 [junit4] 2> 977654 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[18 (1601687319039967232), 19 (1601687319039967233), 20 (1601687319039967234)]} 0 2 [junit4] 2> 977855 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[21 (1601687319252828160), 22 (1601687319253876736), 23 (1601687319253876737)]} 0 0 [junit4] 2> 978056 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[24 (1601687319463591936), 25 (1601687319463591937), 26 (1601687319463591938)]} 0 1 [junit4] 2> 978057 INFO (commitScheduler-4133-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 978057 INFO (commitScheduler-4133-thread-1) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@27d6ba58 commitCommandVersion:0 [junit4] 2> 978072 INFO (commitScheduler-4133-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@5c3427cf[collection1] realtime] [junit4] 2> 978076 INFO (commitScheduler-4133-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 978108 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[27 (1601687319518117888), 28 (1601687319518117889), 29 (1601687319519166464)]} 0 0 [junit4] 2> 978308 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[DEA0D2D1D506D059]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1147496979 [junit4] 2> 978308 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[DEA0D2D1D506D059]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 978308 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[DEA0D2D1D506D059]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@66b1ccff: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@2a14519e [junit4] 2> 978314 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[DEA0D2D1D506D059]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null [junit4] 2> 978314 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[DEA0D2D1D506D059]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1497fa69: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@26977910 [junit4] 2> 978317 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[DEA0D2D1D506D059]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null [junit4] 2> 978318 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[DEA0D2D1D506D059]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@33f714fd: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@718eb833 [junit4] 2> 978318 INFO (coreCloseExecutor-4135-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@4660c1cb [junit4] 2> 978318 INFO (coreCloseExecutor-4135-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=4660c1cb [junit4] 2> 978318 INFO (coreCloseExecutor-4135-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@38bd3fab: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@79dde4a4 [junit4] 2> 978326 INFO (coreCloseExecutor-4135-thread-1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter close. [junit4] 2> 978326 INFO (coreCloseExecutor-4135-thread-1) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@27d6ba58 commitCommandVersion:0 [junit4] 2> 978336 INFO (TEST-MaxSizeAutoCommitTest.deleteTest-seed#[DEA0D2D1D506D059]) [ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 978351 INFO (TEST-MaxSizeAutoCommitTest.deleteTest-seed#[DEA0D2D1D506D059]) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0 [junit4] 2> 978361 INFO (TEST-MaxSizeAutoCommitTest.deleteTest-seed#[DEA0D2D1D506D059]) [ ] o.a.s.s.IndexSchema [null] Schema name=test [junit4] 2> 978454 INFO (TEST-MaxSizeAutoCommitTest.deleteTest-seed#[DEA0D2D1D506D059]) [ ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 978486 INFO (TEST-MaxSizeAutoCommitTest.deleteTest-seed#[DEA0D2D1D506D059]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7adda9cc [junit4] 2> 978494 INFO (TEST-MaxSizeAutoCommitTest.deleteTest-seed#[DEA0D2D1D506D059]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7adda9cc [junit4] 2> 978494 INFO (TEST-MaxSizeAutoCommitTest.deleteTest-seed#[DEA0D2D1D506D059]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7adda9cc [junit4] 2> 978495 INFO (coreLoadExecutor-4142-thread-1) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 978495 INFO (coreLoadExecutor-4142-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 978515 INFO (coreLoadExecutor-4142-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0 [junit4] 2> 978525 INFO (coreLoadExecutor-4142-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 978611 INFO (coreLoadExecutor-4142-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 978617 INFO (coreLoadExecutor-4142-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1, trusted=true [junit4] 2> 978617 INFO (coreLoadExecutor-4142-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@7adda9cc [junit4] 2> 978617 INFO (coreLoadExecutor-4142-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 978617 INFO (coreLoadExecutor-4142-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.MaxSizeAutoCommitTest_DEA0D2D1D506D059-001/init-core-data-001/] [junit4] 2> 978619 INFO (coreLoadExecutor-4142-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=34, maxMergeAtOnceExplicit=38, maxMergedSegmentMB=99.7978515625, floorSegmentMB=1.720703125, forceMergeDeletesPctAllowed=20.605483666169288, segmentsPerTier=39.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7376639627984479 [junit4] 2> 978621 WARN (coreLoadExecutor-4142-thread-1) [ x:collection1] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,attributes = {initParams=a, name=/dump, class=DumpRequestHandler},args = {defaults={a=A,b=B}}} [junit4] 2> 978655 INFO (coreLoadExecutor-4142-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 978655 INFO (coreLoadExecutor-4142-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 978656 INFO (coreLoadExecutor-4142-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 978656 INFO (coreLoadExecutor-4142-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 978656 INFO (coreLoadExecutor-4142-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=11, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7412644920625249] [junit4] 2> 978657 INFO (coreLoadExecutor-4142-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@45376433[collection1] main] [junit4] 2> 978657 WARN (coreLoadExecutor-4142-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead. [junit4] 2> 978657 INFO (coreLoadExecutor-4142-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 978658 INFO (searcherExecutor-4143-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@45376433[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 978658 INFO (coreLoadExecutor-4142-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1601687320095883264 [junit4] 2> 978673 INFO (commitScheduler-4146-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 978673 INFO (commitScheduler-4146-thread-1) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@5bb42d95 commitCommandVersion:0 [junit4] 2> 978677 INFO (commitScheduler-4146-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1147cd0a[collection1] realtime] [junit4] 2> 978677 INFO (commitScheduler-4146-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 978677 INFO (commitScheduler-4146-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 978677 INFO (commitScheduler-4146-thread-1) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@5bb42d95 commitCommandVersion:0 [junit4] 2> 978686 INFO (commitScheduler-4146-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@a8e2549[collection1] realtime] [junit4] 2> 978686 INFO (commitScheduler-4146-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 978713 INFO (commitScheduler-4146-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 978713 INFO (commitScheduler-4146-thread-1) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@5bb42d95 commitCommandVersion:0 [junit4] 2> 978716 INFO (commitScheduler-4146-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@6daf0efb[collection1] realtime] [junit4] 2> 978716 INFO (commitScheduler-4146-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 978724 INFO (commitScheduler-4146-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 978724 INFO (commitScheduler-4146-thread-1) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@5bb42d95 commitCommandVersion:0 [junit4] 2> 978726 INFO (commitScheduler-4146-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1d64d831[collection1] realtime] [junit4] 2> 978726 INFO (commitScheduler-4146-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 978789 INFO (commitScheduler-4146-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 978789 INFO (commitScheduler-4146-thread-1) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@5bb42d95 commitCommandVersion:0 [junit4] 2> 978792 INFO (TEST-MaxSizeAutoCommitTest.deleteTest-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[0 (1601687320099028992), 1 (1601687320100077568), 2 (1601687320100077569), 3 (1601687320100077570), 4 (1601687320100077571), 5 (1601687320100077572), 6 (1601687320100077573), 7 (1601687320103223296), 8 (1601687320103223297), 9 (1601687320103223298), ... (150 adds)]} 0 131 [junit4] 2> 978808 INFO (commitScheduler-4146-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@5da3e437[collection1] realtime] [junit4] 2> 978808 INFO (commitScheduler-4146-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 978993 INFO (TEST-MaxSizeAutoCommitTest.deleteTest-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[0 (-1601687320446107648), 1 (-1601687320447156224), 2 (-1601687320447156225), 3 (-1601687320447156226), 4 (-1601687320447156227), 5 (-1601687320447156228), 6 (-1601687320447156229), 7 (-1601687320447156230), 8 (-1601687320447156231), 9 (-1601687320447156232), ... (15 deletes)]} 0 0 [junit4] 2> 979197 INFO (TEST-MaxSizeAutoCommitTest.deleteTest-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[15 (-1601687320660017152), 16 (-1601687320661065728), 17 (-1601687320661065729), 18 (-1601687320661065730), 19 (-1601687320661065731), 20 (-1601687320661065732), 21 (-1601687320661065733), 22 (-1601687320661065734), 23 (-1601687320661065735), 24 (-1601687320661065736), ... (15 deletes)]} 0 0 [junit4] 2> 979398 INFO (TEST-MaxSizeAutoCommitTest.deleteTest-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[30 (-1601687320870780928), 31 (-1601687320870780929), 32 (-1601687320870780930), 33 (-1601687320870780931), 34 (-1601687320870780932), 35 (-1601687320870780933), 36 (-1601687320870780934), 37 (-1601687320870780935), 38 (-1601687320870780936), 39 (-1601687320870780937), ... (15 deletes)]} 0 0 [junit4] 2> 979598 INFO (TEST-MaxSizeAutoCommitTest.deleteTest-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[45 (-1601687321081544704), 46 (-1601687321081544705), 47 (-1601687321081544706), 48 (-1601687321081544707), 49 (-1601687321081544708), 50 (-1601687321081544709), 51 (-1601687321081544710), 52 (-1601687321081544711), 53 (-1601687321081544712), 54 (-1601687321081544713), ... (15 deletes)]} 0 0 [junit4] 2> 979599 INFO (commitScheduler-4146-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 979599 INFO (commitScheduler-4146-thread-1) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@5bb42d95 commitCommandVersion:0 [junit4] 2> 979609 INFO (commitScheduler-4146-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@375912e7[collection1] realtime] [junit4] 2> 979610 INFO (commitScheduler-4146-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 979649 INFO (TEST-MaxSizeAutoCommitTest.deleteTest-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[60 (-1601687321135022080), 61 (-1601687321135022081), 62 (-1601687321135022082), 63 (-1601687321135022083), 64 (-1601687321135022084), 65 (-1601687321135022085), 66 (-1601687321135022086), 67 (-1601687321135022087), 68 (-1601687321135022088), 69 (-1601687321135022089), ... (15 deletes)]} 0 0 [junit4] 2> 979850 INFO (TEST-MaxSizeAutoCommitTest.deleteTest-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[75 (-1601687321345785856), 76 (-1601687321345785857), 77 (-1601687321345785858), 78 (-1601687321345785859), 79 (-1601687321345785860), 80 (-1601687321345785861), 81 (-1601687321345785862), 82 (-1601687321345785863), 83 (-1601687321345785864), 84 (-1601687321345785865), ... (15 deletes)]} 0 0 [junit4] 2> 980050 INFO (TEST-MaxSizeAutoCommitTest.deleteTest-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[90 (-1601687321555501056), 91 (-1601687321555501057), 92 (-1601687321555501058), 93 (-1601687321555501059), 94 (-1601687321555501060), 95 (-1601687321555501061), 96 (-1601687321555501062), 97 (-1601687321555501063), 98 (-1601687321555501064), 99 (-1601687321555501065), ... (15 deletes)]} 0 0 [junit4] 2> 980251 INFO (TEST-MaxSizeAutoCommitTest.deleteTest-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[105 (-1601687321766264832), 106 (-1601687321766264833), 107 (-1601687321766264834), 108 (-1601687321766264835), 109 (-1601687321766264836), 110 (-1601687321766264837), 111 (-1601687321766264838), 112 (-1601687321766264839), 113 (-1601687321766264840), 114 (-1601687321766264841), ... (15 deletes)]} 0 0 [junit4] 2> 980252 INFO (commitScheduler-4146-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 980252 INFO (commitScheduler-4146-thread-1) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@5bb42d95 commitCommandVersion:0 [junit4] 2> 980253 INFO (commitScheduler-4146-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@4278572a[collection1] realtime] [junit4] 2> 980253 INFO (commitScheduler-4146-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 980302 INFO (TEST-MaxSizeAutoCommitTest.deleteTest-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[120 (-1601687321818693632), 121 (-1601687321819742208), 122 (-1601687321819742209), 123 (-1601687321819742210), 124 (-1601687321819742211), 125 (-1601687321819742212), 126 (-1601687321819742213), 127 (-1601687321819742214), 128 (-1601687321819742215), 129 (-1601687321819742216), ... (15 deletes)]} 0 0 [junit4] 2> 980503 INFO (TEST-MaxSizeAutoCommitTest.deleteTest-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[135 (-1601687322029457408), 136 (-1601687322029457409), 137 (-1601687322030505984), 138 (-1601687322030505985), 139 (-1601687322030505986), 140 (-1601687322030505987), 141 (-1601687322030505988), 142 (-1601687322030505989), 143 (-1601687322030505990), 144 (-1601687322030505991), ... (15 deletes)]} 0 0 [junit4] 2> 980703 INFO (TEST-MaxSizeAutoCommitTest.deleteTest-seed#[DEA0D2D1D506D059]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1169283776 [junit4] 2> 980703 INFO (TEST-MaxSizeAutoCommitTest.deleteTest-seed#[DEA0D2D1D506D059]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 980703 INFO (TEST-MaxSizeAutoCommitTest.deleteTest-seed#[DEA0D2D1D506D059]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@38fffd95: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@38e7ce29 [junit4] 2> 980707 INFO (TEST-MaxSizeAutoCommitTest.deleteTest-seed#[DEA0D2D1D506D059]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null [junit4] 2> 980708 INFO (TEST-MaxSizeAutoCommitTest.deleteTest-seed#[DEA0D2D1D506D059]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@7d716d32: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@26977910 [junit4] 2> 980710 INFO (TEST-MaxSizeAutoCommitTest.deleteTest-seed#[DEA0D2D1D506D059]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null [junit4] 2> 980710 INFO (TEST-MaxSizeAutoCommitTest.deleteTest-seed#[DEA0D2D1D506D059]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@22e308c7: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@718eb833 [junit4] 2> 980710 INFO (coreCloseExecutor-4148-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@16b4fd87 [junit4] 2> 980710 INFO (coreCloseExecutor-4148-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=16b4fd87 [junit4] 2> 980710 INFO (coreCloseExecutor-4148-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1e6e3aa0: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@238387f9 [junit4] 2> 980716 INFO (coreCloseExecutor-4148-thread-1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter close. [junit4] 2> 980716 INFO (coreCloseExecutor-4148-thread-1) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@5bb42d95 commitCommandVersion:0 [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=MaxSizeAutoCommitTest -Dtests.method=deleteTest -Dtests.seed=DEA0D2D1D506D059 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=hu -Dtests.timezone=Europe/Jersey -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1 [junit4] FAILURE 2.39s J1 | MaxSizeAutoCommitTest.deleteTest <<< [junit4] > Throwable #1: java.lang.AssertionError: Tlog size exceeds the max size bound. Tlog path: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.MaxSizeAutoCommitTest_DEA0D2D1D506D059-001/init-core-data-001/tlog/tlog.0000000000000000005, tlog size: 1265 [junit4] > at __randomizedtesting.SeedInfo.seed([DEA0D2D1D506D059:CEEE372EAEA8E9A8]:0) [junit4] > at org.apache.solr.update.MaxSizeAutoCommitTest.getTlogFileSizes(MaxSizeAutoCommitTest.java:379) [junit4] > at org.apache.solr.update.MaxSizeAutoCommitTest.deleteTest(MaxSizeAutoCommitTest.java:200) [junit4] > at java.lang.Thread.run(Thread.java:748) [junit4] 2> 980723 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 980740 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0 [junit4] 2> 980750 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.s.IndexSchema [null] Schema name=test [junit4] 2> 980833 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 980870 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7adda9cc [junit4] 2> 980879 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7adda9cc [junit4] 2> 980879 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7adda9cc [junit4] 2> 980880 INFO (coreLoadExecutor-4155-thread-1) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 980880 INFO (coreLoadExecutor-4155-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 980897 INFO (coreLoadExecutor-4155-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0 [junit4] 2> 980904 INFO (coreLoadExecutor-4155-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 980989 INFO (coreLoadExecutor-4155-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 980994 INFO (coreLoadExecutor-4155-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1, trusted=true [junit4] 2> 980994 INFO (coreLoadExecutor-4155-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@7adda9cc [junit4] 2> 980994 INFO (coreLoadExecutor-4155-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 980994 INFO (coreLoadExecutor-4155-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.MaxSizeAutoCommitTest_DEA0D2D1D506D059-001/init-core-data-001/] [junit4] 2> 980995 INFO (coreLoadExecutor-4155-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=34, maxMergeAtOnceExplicit=38, maxMergedSegmentMB=99.7978515625, floorSegmentMB=1.720703125, forceMergeDeletesPctAllowed=20.605483666169288, segmentsPerTier=39.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7376639627984479 [junit4] 2> 980997 WARN (coreLoadExecutor-4155-thread-1) [ x:collection1] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,attributes = {initParams=a, name=/dump, class=DumpRequestHandler},args = {defaults={a=A,b=B}}} [junit4] 2> 981022 INFO (coreLoadExecutor-4155-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 981022 INFO (coreLoadExecutor-4155-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 981023 INFO (coreLoadExecutor-4155-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 981023 INFO (coreLoadExecutor-4155-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 981023 INFO (coreLoadExecutor-4155-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=11, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7412644920625249] [junit4] 2> 981023 INFO (coreLoadExecutor-4155-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@54e4b4da[collection1] main] [junit4] 2> 981024 WARN (coreLoadExecutor-4155-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead. [junit4] 2> 981024 INFO (coreLoadExecutor-4155-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 981024 INFO (searcherExecutor-4156-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@54e4b4da[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 981025 INFO (coreLoadExecutor-4155-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1601687322577862656 [junit4] 2> 981037 INFO (commitScheduler-4159-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 981037 INFO (commitScheduler-4159-thread-1) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@2c7f55f7 commitCommandVersion:0 [junit4] 2> 981042 INFO (commitScheduler-4159-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@71765b86[collection1] realtime] [junit4] 2> 981042 INFO (commitScheduler-4159-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 981042 INFO (commitScheduler-4159-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 981042 INFO (commitScheduler-4159-thread-1) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@2c7f55f7 commitCommandVersion:0 [junit4] 2> 981057 INFO (commitScheduler-4159-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@5483ebc4[collection1] realtime] [junit4] 2> 981057 INFO (commitScheduler-4159-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 981057 INFO (commitScheduler-4159-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 981057 INFO (commitScheduler-4159-thread-1) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@2c7f55f7 commitCommandVersion:0 [junit4] 2> 981070 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[0 (1601687322579959808), 1 (1601687322582056960), 2 (1601687322582056961), 3 (1601687322582056962), 4 (1601687322582056963), 5 (1601687322582056964), 6 (1601687322582056965), 7 (1601687322584154112), 8 (1601687322584154113), 9 (1601687322584154114), ... (150 adds)]} 0 43 [junit4] 2> 981090 INFO (commitScheduler-4159-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@3970663f[collection1] realtime] [junit4] 2> 981090 INFO (commitScheduler-4159-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 981472 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323046576128)]} 0 200 [junit4] 2> 981472 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323046576129)]} 0 200 [junit4] 2> 981472 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323046576130)]} 0 200 [junit4] 2> 981472 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323046576131)]} 0 200 [junit4] 2> 981472 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323046576132)]} 0 200 [junit4] 2> 981472 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323046576133)]} 0 200 [junit4] 2> 981472 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323046576134)]} 0 200 [junit4] 2> 981472 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323046576135)]} 0 200 [junit4] 2> 981473 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323047624704)]} 0 201 [junit4] 2> 981473 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323047624705)]} 0 201 [junit4] 2> 981473 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323047624706)]} 0 201 [junit4] 2> 981473 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323047624707)]} 0 201 [junit4] 2> 981473 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323047624708)]} 0 201 [junit4] 2> 981473 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323047624709)]} 0 201 [junit4] 2> 981473 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323047624710)]} 0 201 [junit4] 2> 981473 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323047624711)]} 0 201 [junit4] 2> 981473 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323047624712)]} 0 201 [junit4] 2> 981473 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323047624713)]} 0 201 [junit4] 2> 981473 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323047624714)]} 0 201 [junit4] 2> 981473 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323047624715)]} 0 201 [junit4] 2> 981473 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323047624716)]} 0 201 [junit4] 2> 981473 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323047624717)]} 0 201 [junit4] 2> 981473 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323047624718)]} 0 201 [junit4] 2> 981473 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323047624719)]} 0 201 [junit4] 2> 981473 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323047624720)]} 0 201 [junit4] 2> 981473 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323047624721)]} 0 201 [junit4] 2> 981473 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323047624722)]} 0 201 [junit4] 2> 981473 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323047624723)]} 0 201 [junit4] 2> 981473 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323047624724)]} 0 201 [junit4] 2> 981473 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323047624725)]} 0 201 [junit4] 2> 981473 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323047624726)]} 0 201 [junit4] 2> 981473 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323047624727)]} 0 201 [junit4] 2> 981473 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323047624728)]} 0 201 [junit4] 2> 981473 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323047624729)]} 0 201 [junit4] 2> 981473 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323047624730)]} 0 201 [junit4] 2> 981473 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323047624731)]} 0 201 [junit4] 2> 981474 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323048673280)]} 0 202 [junit4] 2> 981474 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323048673281)]} 0 202 [junit4] 2> 981474 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323048673282)]} 0 202 [junit4] 2> 981474 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323048673283)]} 0 202 [junit4] 2> 981474 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323048673284)]} 0 202 [junit4] 2> 981474 INFO (commitScheduler-4159-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 981474 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323048673285)]} 0 202 [junit4] 2> 981474 INFO (commitScheduler-4159-thread-1) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@2c7f55f7 commitCommandVersion:0 [junit4] 2> 981474 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323048673286)]} 0 202 [junit4] 2> 981474 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323048673287)]} 0 202 [junit4] 2> 981474 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323048673288)]} 0 202 [junit4] 2> 981474 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323048673289)]} 0 202 [junit4] 2> 981474 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323048673290)]} 0 202 [junit4] 2> 981475 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323049721856)]} 0 203 [junit4] 2> 981475 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323049721857)]} 0 203 [junit4] 2> 981475 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323049721858)]} 0 203 [junit4] 2> 981478 INFO (commitScheduler-4159-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@2e5a18af[collection1] realtime] [junit4] 2> 981479 INFO (commitScheduler-4159-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 981675 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323259437056)]} 0 403 [junit4] 2> 981675 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323259437057)]} 0 403 [junit4] 2> 981675 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323259437058)]} 0 403 [junit4] 2> 981675 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323259437059)]} 0 403 [junit4] 2> 981675 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323259437060)]} 0 403 [junit4] 2> 981675 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323259437061)]} 0 403 [junit4] 2> 981675 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323259437062)]} 0 403 [junit4] 2> 981675 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323259437063)]} 0 403 [junit4] 2> 981676 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323259437064)]} 0 404 [junit4] 2> 981676 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323260485632)]} 0 404 [junit4] 2> 981676 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323260485633)]} 0 404 [junit4] 2> 981676 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323260485634)]} 0 404 [junit4] 2> 981676 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323260485635)]} 0 404 [junit4] 2> 981676 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323260485636)]} 0 404 [junit4] 2> 981676 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323260485637)]} 0 404 [junit4] 2> 981676 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323260485638)]} 0 404 [junit4] 2> 981676 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323260485639)]} 0 404 [junit4] 2> 981676 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323260485640)]} 0 404 [junit4] 2> 981676 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323260485641)]} 0 404 [junit4] 2> 981676 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323260485642)]} 0 404 [junit4] 2> 981676 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323260485643)]} 0 404 [junit4] 2> 981676 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323260485644)]} 0 404 [junit4] 2> 981676 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323260485645)]} 0 404 [junit4] 2> 981676 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323260485646)]} 0 404 [junit4] 2> 981676 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323260485647)]} 0 404 [junit4] 2> 981676 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323260485648)]} 0 404 [junit4] 2> 981676 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323260485649)]} 0 404 [junit4] 2> 981676 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323260485650)]} 0 404 [junit4] 2> 981677 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323260485651)]} 0 405 [junit4] 2> 981677 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323261534208)]} 0 405 [junit4] 2> 981677 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323261534209)]} 0 405 [junit4] 2> 981677 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323261534210)]} 0 405 [junit4] 2> 981677 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323261534211)]} 0 405 [junit4] 2> 981677 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323261534212)]} 0 405 [junit4] 2> 981677 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323261534213)]} 0 405 [junit4] 2> 981677 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323261534214)]} 0 405 [junit4] 2> 981677 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323261534215)]} 0 405 [junit4] 2> 981677 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323261534216)]} 0 405 [junit4] 2> 981677 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323261534217)]} 0 405 [junit4] 2> 981677 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323261534218)]} 0 405 [junit4] 2> 981677 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323261534219)]} 0 405 [junit4] 2> 981677 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323261534220)]} 0 405 [junit4] 2> 981677 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323261534221)]} 0 405 [junit4] 2> 981677 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323261534222)]} 0 405 [junit4] 2> 981677 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323261534223)]} 0 405 [junit4] 2> 981677 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323261534224)]} 0 405 [junit4] 2> 981677 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323261534225)]} 0 405 [junit4] 2> 981677 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323261534226)]} 0 405 [junit4] 2> 981677 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323261534227)]} 0 405 [junit4] 2> 981678 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323261534228)]} 0 406 [junit4] 2> 981678 INFO (commitScheduler-4159-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 981678 INFO (commitScheduler-4159-thread-1) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@2c7f55f7 commitCommandVersion:0 [junit4] 2> 981679 INFO (commitScheduler-4159-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@72f8d5f5[collection1] realtime] [junit4] 2> 981679 INFO (commitScheduler-4159-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 981728 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323315011584)]} 0 456 [junit4] 2> 981728 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323315011585)]} 0 456 [junit4] 2> 981728 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323315011586)]} 0 456 [junit4] 2> 981729 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323316060160)]} 0 457 [junit4] 2> 981729 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323316060161)]} 0 457 [junit4] 2> 981729 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323316060162)]} 0 457 [junit4] 2> 981729 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323316060163)]} 0 457 [junit4] 2> 981729 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323316060164)]} 0 457 [junit4] 2> 981729 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323316060165)]} 0 457 [junit4] 2> 981729 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323316060166)]} 0 457 [junit4] 2> 981729 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323316060167)]} 0 457 [junit4] 2> 981729 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323316060168)]} 0 457 [junit4] 2> 981729 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323316060169)]} 0 457 [junit4] 2> 981729 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323316060170)]} 0 457 [junit4] 2> 981729 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323316060171)]} 0 457 [junit4] 2> 981729 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323316060172)]} 0 457 [junit4] 2> 981729 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323316060173)]} 0 457 [junit4] 2> 981729 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323316060174)]} 0 457 [junit4] 2> 981729 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323316060175)]} 0 457 [junit4] 2> 981729 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323316060176)]} 0 457 [junit4] 2> 981729 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323316060177)]} 0 457 [junit4] 2> 981729 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323316060178)]} 0 457 [junit4] 2> 981729 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323316060179)]} 0 457 [junit4] 2> 981729 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323316060180)]} 0 457 [junit4] 2> 981729 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323316060181)]} 0 457 [junit4] 2> 981729 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323316060182)]} 0 457 [junit4] 2> 981729 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323316060183)]} 0 457 [junit4] 2> 981730 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323317108736)]} 0 458 [junit4] 2> 981730 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323317108737)]} 0 458 [junit4] 2> 981730 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323317108738)]} 0 458 [junit4] 2> 981730 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323317108739)]} 0 458 [junit4] 2> 981730 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323317108740)]} 0 458 [junit4] 2> 981730 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323317108741)]} 0 458 [junit4] 2> 981730 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323317108742)]} 0 458 [junit4] 2> 981730 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323317108743)]} 0 458 [junit4] 2> 981730 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323317108744)]} 0 458 [junit4] 2> 981730 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323317108745)]} 0 458 [junit4] 2> 981730 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323317108746)]} 0 458 [junit4] 2> 981730 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323317108747)]} 0 458 [junit4] 2> 981730 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323317108748)]} 0 458 [junit4] 2> 981730 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323317108749)]} 0 458 [junit4] 2> 981730 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323317108750)]} 0 458 [junit4] 2> 981730 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323317108751)]} 0 458 [junit4] 2> 981730 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323317108752)]} 0 458 [junit4] 2> 981730 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323317108753)]} 0 458 [junit4] 2> 981730 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323317108754)]} 0 458 [junit4] 2> 981730 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323317108755)]} 0 458 [junit4] 2> 981730 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323317108756)]} 0 458 [junit4] 2> 981730 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323317108757)]} 0 458 [junit4] 2> 981730 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323317108758)]} 0 458 [junit4] 2> 981731 INFO (commitScheduler-4159-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 981731 INFO (commitScheduler-4159-thread-1) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@2c7f55f7 commitCommandVersion:0 [junit4] 2> 981732 INFO (commitScheduler-4159-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@69cb4774[collection1] realtime] [junit4] 2> 981732 INFO (commitScheduler-4159-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 981781 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323370586112)]} 0 509 [junit4] 2> 981781 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323370586113)]} 0 509 [junit4] 2> 981781 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323370586114)]} 0 509 [junit4] 2> 981781 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323370586115)]} 0 509 [junit4] 2> 981781 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323370586116)]} 0 509 [junit4] 2> 981781 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323370586117)]} 0 509 [junit4] 2> 981781 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323370586118)]} 0 509 [junit4] 2> 981781 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323370586119)]} 0 509 [junit4] 2> 981781 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323370586120)]} 0 509 [junit4] 2> 981781 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323370586121)]} 0 509 [junit4] 2> 981781 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323370586122)]} 0 509 [junit4] 2> 981782 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323371634688)]} 0 510 [junit4] 2> 981782 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323371634689)]} 0 510 [junit4] 2> 981782 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323371634690)]} 0 510 [junit4] 2> 981782 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323371634691)]} 0 510 [junit4] 2> 981782 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323371634692)]} 0 510 [junit4] 2> 981782 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323371634693)]} 0 510 [junit4] 2> 981782 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323371634694)]} 0 510 [junit4] 2> 981782 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323371634695)]} 0 510 [junit4] 2> 981782 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323371634696)]} 0 510 [junit4] 2> 981782 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323371634697)]} 0 510 [junit4] 2> 981782 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323371634698)]} 0 510 [junit4] 2> 981782 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323371634699)]} 0 510 [junit4] 2> 981782 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323371634700)]} 0 510 [junit4] 2> 981782 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323371634701)]} 0 510 [junit4] 2> 981782 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323371634702)]} 0 510 [junit4] 2> 981782 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323371634703)]} 0 510 [junit4] 2> 981782 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323371634704)]} 0 510 [junit4] 2> 981782 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323371634705)]} 0 510 [junit4] 2> 981782 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323371634706)]} 0 510 [junit4] 2> 981782 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323371634707)]} 0 510 [junit4] 2> 981782 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323371634708)]} 0 510 [junit4] 2> 981782 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323371634709)]} 0 510 [junit4] 2> 981782 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323371634710)]} 0 510 [junit4] 2> 981782 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323371634711)]} 0 510 [junit4] 2> 981782 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323371634712)]} 0 510 [junit4] 2> 981782 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323371634713)]} 0 510 [junit4] 2> 981782 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323371634714)]} 0 510 [junit4] 2> 981782 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323371634715)]} 0 510 [junit4] 2> 981782 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323371634716)]} 0 510 [junit4] 2> 981783 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323371634717)]} 0 511 [junit4] 2> 981783 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323372683264)]} 0 511 [junit4] 2> 981783 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323372683265)]} 0 511 [junit4] 2> 981783 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323372683266)]} 0 511 [junit4] 2> 981783 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323372683267)]} 0 511 [junit4] 2> 981783 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323372683268)]} 0 511 [junit4] 2> 981783 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323372683269)]} 0 511 [junit4] 2> 981783 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323372683270)]} 0 511 [junit4] 2> 981783 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323372683271)]} 0 511 [junit4] 2> 981783 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[DEA0D2D1D506D059]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1601687323372683272)]} 0 511 [junit4] 2> 981784 INFO (commitScheduler-4159-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] [...truncated too long message...] esolve 47ms :: artifacts dl 1ms --------------------------------------------------------------------- | | modules || artifacts | | conf | number| search|dwnlded|evicted|| number|dwnlded| --------------------------------------------------------------------- | default | 1 | 0 | 0 | 0 || 1 | 0 | --------------------------------------------------------------------- -init-totals: -test: [mkdir] Created dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test [junit4:pickseed] Seed property 'tests.seed' already defined: DEA0D2D1D506D059 [mkdir] Created dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/temp [junit4] <JUnit4> says hi! Master seed: DEA0D2D1D506D059 [junit4] Executing 5 suites with 3 JVMs. [junit4] [junit4] Started J2 PID(4...@serv1.sd-datasolutions.de). [junit4] Started J0 PID(4...@serv1.sd-datasolutions.de). [junit4] Started J1 PID(4...@serv1.sd-datasolutions.de). [junit4] Suite: org.apache.solr.update.MaxSizeAutoCommitTest [junit4] OK 6.82s J0 | MaxSizeAutoCommitTest.simpleTest [junit4] OK 3.41s J0 | MaxSizeAutoCommitTest.deleteTest [junit4] OK 7.53s J0 | MaxSizeAutoCommitTest.testRedundantDeletes [junit4] OK 11.6s J0 | MaxSizeAutoCommitTest.endToEndTest {seed=[DEA0D2D1D506D059:C4F6BDE735B4F75B]} [junit4] OK 11.2s J0 | MaxSizeAutoCommitTest.endToEndTest {seed=[DEA0D2D1D506D059:70A0011B01763C77]} [junit4] OK 11.8s J0 | MaxSizeAutoCommitTest.endToEndTest {seed=[DEA0D2D1D506D059:FE4997C750B274BC]} [junit4] OK 11.0s J0 | MaxSizeAutoCommitTest.endToEndTest {seed=[DEA0D2D1D506D059:CFA73C223C4C2F95]} [junit4] OK 11.0s J0 | MaxSizeAutoCommitTest.endToEndTest {seed=[DEA0D2D1D506D059:8366B98F9D44EF2E]} [junit4] Completed [1/5] on J0 in 76.25s, 8 tests [junit4] [junit4] Suite: org.apache.solr.update.MaxSizeAutoCommitTest [junit4] OK 6.85s J2 | MaxSizeAutoCommitTest.simpleTest [junit4] OK 3.49s J2 | MaxSizeAutoCommitTest.deleteTest [junit4] OK 7.64s J2 | MaxSizeAutoCommitTest.testRedundantDeletes [junit4] OK 11.8s J2 | MaxSizeAutoCommitTest.endToEndTest {seed=[DEA0D2D1D506D059:C4F6BDE735B4F75B]} [junit4] OK 11.2s J2 | MaxSizeAutoCommitTest.endToEndTest {seed=[DEA0D2D1D506D059:70A0011B01763C77]} [junit4] OK 12.1s J2 | MaxSizeAutoCommitTest.endToEndTest {seed=[DEA0D2D1D506D059:FE4997C750B274BC]} [junit4] OK 10.8s J2 | MaxSizeAutoCommitTest.endToEndTest {seed=[DEA0D2D1D506D059:CFA73C223C4C2F95]} [junit4] OK 10.8s J2 | MaxSizeAutoCommitTest.endToEndTest {seed=[DEA0D2D1D506D059:8366B98F9D44EF2E]} [junit4] Completed [2/5] on J2 in 76.48s, 8 tests [junit4] [junit4] Duplicate suite name used with XML reports: org.apache.solr.update.MaxSizeAutoCommitTest. This may confuse tools that process XML reports. Set 'ignoreDuplicateSuites' to true to skip this message. [junit4] Suite: org.apache.solr.update.MaxSizeAutoCommitTest [junit4] OK 6.77s J1 | MaxSizeAutoCommitTest.simpleTest [junit4] OK 3.71s J1 | MaxSizeAutoCommitTest.deleteTest [junit4] OK 7.64s J1 | MaxSizeAutoCommitTest.testRedundantDeletes [junit4] OK 11.6s J1 | MaxSizeAutoCommitTest.endToEndTest {seed=[DEA0D2D1D506D059:C4F6BDE735B4F75B]} [junit4] OK 11.1s J1 | MaxSizeAutoCommitTest.endToEndTest {seed=[DEA0D2D1D506D059:70A0011B01763C77]} [junit4] OK 11.9s J1 | MaxSizeAutoCommitTest.endToEndTest {seed=[DEA0D2D1D506D059:FE4997C750B274BC]} [junit4] OK 11.1s J1 | MaxSizeAutoCommitTest.endToEndTest {seed=[DEA0D2D1D506D059:CFA73C223C4C2F95]} [junit4] OK 10.9s J1 | MaxSizeAutoCommitTest.endToEndTest {seed=[DEA0D2D1D506D059:8366B98F9D44EF2E]} [junit4] Completed [3/5] on J1 in 76.82s, 8 tests [junit4] [junit4] Suite: org.apache.solr.update.MaxSizeAutoCommitTest [junit4] OK 2.28s J0 | MaxSizeAutoCommitTest.simpleTest [junit4] OK 2.10s J0 | MaxSizeAutoCommitTest.deleteTest [junit4] OK 6.29s J0 | MaxSizeAutoCommitTest.testRedundantDeletes [junit4] OK 11.0s J0 | MaxSizeAutoCommitTest.endToEndTest {seed=[DEA0D2D1D506D059:C4F6BDE735B4F75B]} [junit4] OK 11.1s J0 | MaxSizeAutoCommitTest.endToEndTest {seed=[DEA0D2D1D506D059:70A0011B01763C77]} [junit4] OK 10.9s J0 | MaxSizeAutoCommitTest.endToEndTest {seed=[DEA0D2D1D506D059:FE4997C750B274BC]} [junit4] OK 10.7s J0 | MaxSizeAutoCommitTest.endToEndTest {seed=[DEA0D2D1D506D059:CFA73C223C4C2F95]} [junit4] OK 10.7s J0 | MaxSizeAutoCommitTest.endToEndTest {seed=[DEA0D2D1D506D059:8366B98F9D44EF2E]} [junit4] Completed [4/5] on J0 in 65.03s, 8 tests [junit4] [junit4] Suite: org.apache.solr.update.MaxSizeAutoCommitTest [junit4] OK 2.26s J2 | MaxSizeAutoCommitTest.simpleTest [junit4] OK 2.18s J2 | MaxSizeAutoCommitTest.deleteTest [junit4] OK 5.91s J2 | MaxSizeAutoCommitTest.testRedundantDeletes [junit4] OK 11.1s J2 | MaxSizeAutoCommitTest.endToEndTest {seed=[DEA0D2D1D506D059:C4F6BDE735B4F75B]} [junit4] OK 11.1s J2 | MaxSizeAutoCommitTest.endToEndTest {seed=[DEA0D2D1D506D059:70A0011B01763C77]} [junit4] OK 10.9s J2 | MaxSizeAutoCommitTest.endToEndTest {seed=[DEA0D2D1D506D059:FE4997C750B274BC]} [junit4] OK 10.6s J2 | MaxSizeAutoCommitTest.endToEndTest {seed=[DEA0D2D1D506D059:CFA73C223C4C2F95]} [junit4] OK 10.7s J2 | MaxSizeAutoCommitTest.endToEndTest {seed=[DEA0D2D1D506D059:8366B98F9D44EF2E]} [junit4] Completed [5/5] on J2 in 64.78s, 8 tests [junit4] [junit4] JVM J0: 0.44 .. 142.88 = 142.45s [junit4] JVM J1: 0.69 .. 78.39 = 77.70s [junit4] JVM J2: 0.44 .. 143.08 = 142.64s [junit4] Execution time total: 2 minutes 23 seconds [junit4] Tests summary: 5 suites, 40 tests [junit4] Could not remove temporary path: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1 (java.nio.file.DirectoryNotEmptyException: Remaining files: [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp]) [junit4] Could not remove temporary path: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2 (java.nio.file.DirectoryNotEmptyException: Remaining files: [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp]) [junit4] Could not remove temporary path: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0 (java.nio.file.DirectoryNotEmptyException: Remaining files: [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp]) [echo] 5 slowest tests: [junit4:tophints] 116.84s | org.apache.solr.update.SoftAutoCommitTest [junit4:tophints] 113.03s | org.apache.solr.cloud.ZkFailoverTest [junit4:tophints] 105.55s | org.apache.solr.cloud.TestTlogReplica [junit4:tophints] 89.85s | org.apache.solr.cloud.TestPullReplicaErrorHandling [junit4:tophints] 82.13s | org.apache.solr.cloud.autoscaling.SearchRateTriggerTest -check-totals: test-nocompile: BUILD SUCCESSFUL Total time: 2 minutes 24 seconds [repro] Failures: [repro] 0/5 failed: org.apache.solr.update.MaxSizeAutoCommitTest [repro] Exiting with code 0 + 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=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 java.lang.InterruptedException: no matches found within 10000 at hudson.FilePath$34.hasMatch(FilePath.java:2678) at hudson.FilePath$34.invoke(FilePath.java:2557) at hudson.FilePath$34.invoke(FilePath.java:2547) at hudson.FilePath.act(FilePath.java:1047) at hudson.FilePath.act(FilePath.java:1025) at hudson.FilePath.validateAntFileMask(FilePath.java:2547) at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:243) at hudson.tasks.BuildStepCompatibilityLayer.perform(BuildStepCompatibilityLayer.java:81) at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20) at hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:744) at hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:690) at hudson.model.Build$BuildExecution.post2(Build.java:186) at hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:635) at hudson.model.Run.execute(Run.java:1819) at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43) at hudson.model.ResourceController.execute(ResourceController.java:97) at hudson.model.Executor.run(Executor.java:429) No artifacts found that match the file pattern "**/*.events,heapdumps/**,**/*_pid*.log". Configuration error? [WARNINGS] Parsing warnings in console log with parser Java Compiler (javac) Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 Setting ANT_1_8_2_HOME=/var/lib/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=4e12546b02ecfc9b142a026dcaca9996234a409d, workspace=/var/lib/jenkins/workspace/Lucene-Solr-master-Linux [WARNINGS] Computing warning deltas based on reference build #22119 Recording test results Setting ANT_1_8_2_HOME=/var/lib/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=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 Setting ANT_1_8_2_HOME=/var/lib/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