You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2018/08/12 18:06:17 UTC
[JENKINS] Lucene-Solr-master-Solaris (64bit/jdk1.8.0) - Build #
2015 - Still Unstable!
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Solaris/2015/
Java: 64bit/jdk1.8.0 -XX:-UseCompressedOops -XX:+UseConcMarkSweepGC
1 tests failed.
FAILED: org.apache.solr.update.MaxSizeAutoCommitTest.deleteTest
Error Message:
Tlog size exceeds the max size bound. Tlog path: /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.update.MaxSizeAutoCommitTest_9741EAB7CB275E47-001/init-core-data-001/tlog/tlog.0000000000000000002, tlog size: 1302
Stack Trace:
java.lang.AssertionError: Tlog size exceeds the max size bound. Tlog path: /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.update.MaxSizeAutoCommitTest_9741EAB7CB275E47-001/init-core-data-001/tlog/tlog.0000000000000000002, tlog size: 1302
at __randomizedtesting.SeedInfo.seed([9741EAB7CB275E47:870F0F48B08967B6]: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:382)
at org.apache.solr.update.MaxSizeAutoCommitTest.deleteTest(MaxSizeAutoCommitTest.java:202)
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 12710 lines...]
[junit4] Suite: org.apache.solr.update.MaxSizeAutoCommitTest
[junit4] 2> 755199 INFO (SUITE-MaxSizeAutoCommitTest-seed#[9741EAB7CB275E47]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> Creating dataDir: /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.update.MaxSizeAutoCommitTest_9741EAB7CB275E47-001/init-core-data-001
[junit4] 2> 755200 WARN (SUITE-MaxSizeAutoCommitTest-seed#[9741EAB7CB275E47]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=7 numCloses=7
[junit4] 2> 755200 INFO (SUITE-MaxSizeAutoCommitTest-seed#[9741EAB7CB275E47]-worker) [ ] o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 755201 INFO (SUITE-MaxSizeAutoCommitTest-seed#[9741EAB7CB275E47]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
[junit4] 2> 755202 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[9741EAB7CB275E47]) [ ] o.a.s.SolrTestCaseJ4 ###Starting simpleTest
[junit4] 2> 755493 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[9741EAB7CB275E47]) [ ] o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 755494 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[9741EAB7CB275E47]) [ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/lib, /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 755514 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[9741EAB7CB275E47]) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 755525 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[9741EAB7CB275E47]) [ ] o.a.s.s.IndexSchema [null] Schema name=test
[junit4] 2> 755599 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[9741EAB7CB275E47]) [ ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 756212 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[9741EAB7CB275E47]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 756212 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[9741EAB7CB275E47]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 756228 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[9741EAB7CB275E47]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@39a9765d
[junit4] 2> 756232 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[9741EAB7CB275E47]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@39a9765d
[junit4] 2> 756232 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[9741EAB7CB275E47]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@39a9765d
[junit4] 2> 756233 INFO (coreLoadExecutor-2169-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/lib, /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 756255 INFO (coreLoadExecutor-2169-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 756266 INFO (coreLoadExecutor-2169-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 756342 INFO (coreLoadExecutor-2169-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 756348 INFO (coreLoadExecutor-2169-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1, trusted=true
[junit4] 2> 756348 INFO (coreLoadExecutor-2169-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@39a9765d
[junit4] 2> 756348 INFO (coreLoadExecutor-2169-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 756348 INFO (coreLoadExecutor-2169-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1], dataDir=[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.update.MaxSizeAutoCommitTest_9741EAB7CB275E47-001/init-core-data-001/]
[junit4] 2> 756349 INFO (coreLoadExecutor-2169-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=20, maxMergeAtOnceExplicit=42, maxMergedSegmentMB=68.7373046875, floorSegmentMB=1.3408203125, forceMergeDeletesPctAllowed=28.0500342522912, segmentsPerTier=10.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7598731631290652, deletesPctAllowed=26.521507187497107
[junit4] 2> 756350 WARN (coreLoadExecutor-2169-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> 756386 INFO (coreLoadExecutor-2169-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 756386 INFO (coreLoadExecutor-2169-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 756386 INFO (coreLoadExecutor-2169-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 756386 INFO (coreLoadExecutor-2169-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 756387 INFO (coreLoadExecutor-2169-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=210483054, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
[junit4] 2> 756388 INFO (coreLoadExecutor-2169-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@2a243770[collection1] main]
[junit4] 2> 756388 WARN (coreLoadExecutor-2169-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
[junit4] 2> 756388 INFO (coreLoadExecutor-2169-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 756388 INFO (coreLoadExecutor-2169-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1608612576520830976
[junit4] 2> 756389 INFO (searcherExecutor-2170-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@2a243770[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 756390 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[9741EAB7CB275E47]) [ ] o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 756394 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[0 (1608612576523976704), 1 (1608612576526073856), 2 (1608612576526073857)]} 0 2
[junit4] 2> 756599 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[3 (1608612576742080512), 4 (1608612576742080513), 5 (1608612576742080514)]} 0 0
[junit4] 2> 756800 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[6 (1608612576952844288), 7 (1608612576952844289), 8 (1608612576952844290)]} 0 0
[junit4] 2> 757001 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[9 (1608612577163608064), 10 (1608612577163608065), 11 (1608612577163608066)]} 0 0
[junit4] 2> 757205 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[12 (1608612577376468992), 13 (1608612577376468993), 14 (1608612577376468994)]} 0 0
[junit4] 2> 757415 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[15 (1608612577597718528), 16 (1608612577597718529), 17 (1608612577597718530)]} 0 0
[junit4] 2> 757617 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[18 (1608612577809530880), 19 (1608612577809530881), 20 (1608612577809530882)]} 0 0
[junit4] 2> 757818 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[21 (1608612578019246080), 22 (1608612578020294656), 23 (1608612578020294657)]} 0 0
[junit4] 2> 758026 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[24 (1608612578237349888), 25 (1608612578238398464), 26 (1608612578238398465)]} 0 0
[junit4] 2> 758027 INFO (commitScheduler-2173-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 758027 INFO (commitScheduler-2173-thread-1) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@463cf8d commitCommandVersion:0
[junit4] 2> 758031 INFO (commitScheduler-2173-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@654598ab[collection1] realtime]
[junit4] 2> 758031 INFO (commitScheduler-2173-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 758077 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[27 (1608612578290827264), 28 (1608612578291875840), 29 (1608612578291875841)]} 0 0
[junit4] 2> 758285 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[9741EAB7CB275E47]) [ ] o.a.s.SolrTestCaseJ4 ###Ending simpleTest
[junit4] 2> 758285 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[9741EAB7CB275E47]) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> 758285 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[9741EAB7CB275E47]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=776524030
[junit4] 2> 758285 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[9741EAB7CB275E47]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 758285 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[9741EAB7CB275E47]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@494a73e6: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@e375ecd
[junit4] 2> 758288 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[9741EAB7CB275E47]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 758288 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[9741EAB7CB275E47]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@65c35d07: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@5f12ab71
[junit4] 2> 758290 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[9741EAB7CB275E47]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 758290 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[9741EAB7CB275E47]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@4fa3c4cc: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@18c428c2
[junit4] 2> 758291 INFO (coreCloseExecutor-2175-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@52d2c24d
[junit4] 2> 758291 INFO (coreCloseExecutor-2175-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=52d2c24d
[junit4] 2> 758291 INFO (coreCloseExecutor-2175-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@12c4a24c: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@607e778e
[junit4] 2> 758297 INFO (coreCloseExecutor-2175-thread-1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter close.
[junit4] 2> 758297 INFO (coreCloseExecutor-2175-thread-1) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@463cf8d commitCommandVersion:0
[junit4] 2> 758308 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testRedundantDeletes
[junit4] 2> 758308 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 758308 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/lib, /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 758326 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 758343 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.s.IndexSchema [null] Schema name=test
[junit4] 2> 758415 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 758537 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 758537 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 758549 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@39a9765d
[junit4] 2> 758553 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@39a9765d
[junit4] 2> 758553 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@39a9765d
[junit4] 2> 758555 INFO (coreLoadExecutor-2185-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/lib, /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 758577 INFO (coreLoadExecutor-2185-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 758588 INFO (coreLoadExecutor-2185-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 758667 INFO (coreLoadExecutor-2185-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 758673 INFO (coreLoadExecutor-2185-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1, trusted=true
[junit4] 2> 758673 INFO (coreLoadExecutor-2185-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@39a9765d
[junit4] 2> 758674 INFO (coreLoadExecutor-2185-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 758674 INFO (coreLoadExecutor-2185-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1], dataDir=[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.update.MaxSizeAutoCommitTest_9741EAB7CB275E47-001/init-core-data-001/]
[junit4] 2> 758675 INFO (coreLoadExecutor-2185-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=20, maxMergeAtOnceExplicit=42, maxMergedSegmentMB=68.7373046875, floorSegmentMB=1.3408203125, forceMergeDeletesPctAllowed=28.0500342522912, segmentsPerTier=10.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7598731631290652, deletesPctAllowed=26.521507187497107
[junit4] 2> 758676 WARN (coreLoadExecutor-2185-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> 758715 INFO (coreLoadExecutor-2185-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 758715 INFO (coreLoadExecutor-2185-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 758716 INFO (coreLoadExecutor-2185-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 758716 INFO (coreLoadExecutor-2185-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 758717 INFO (coreLoadExecutor-2185-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=210483054, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
[junit4] 2> 758717 INFO (coreLoadExecutor-2185-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@12a6d8b9[collection1] main]
[junit4] 2> 758717 WARN (coreLoadExecutor-2185-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
[junit4] 2> 758717 INFO (coreLoadExecutor-2185-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 758718 INFO (coreLoadExecutor-2185-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1608612578964013056
[junit4] 2> 758720 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 758723 INFO (searcherExecutor-2186-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@12a6d8b9[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 758726 INFO (commitScheduler-2189-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 758726 INFO (commitScheduler-2189-thread-1) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@1edcce91 commitCommandVersion:0
[junit4] 2> 758736 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[0 (1608612578966110208), 1 (1608612578969255936), 2 (1608612578969255937), 3 (1608612578969255938), 4 (1608612578969255939), 5 (1608612578969255940), 6 (1608612578969255941), 7 (1608612578969255942), 8 (1608612578969255943), 9 (1608612578969255944), ... (150 adds)]} 0 15
[junit4] 2> 758737 INFO (commitScheduler-2189-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@6c78618e[collection1] realtime]
[junit4] 2> 758737 INFO (commitScheduler-2189-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 758737 INFO (commitScheduler-2189-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 758737 INFO (commitScheduler-2189-thread-1) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@1edcce91 commitCommandVersion:0
[junit4] 2> 758739 INFO (commitScheduler-2189-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@21796156[collection1] realtime]
[junit4] 2> 758739 INFO (commitScheduler-2189-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 758842 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579092987904)]} 0 56
[junit4] 2> 758842 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579094036480)]} 0 56
[junit4] 2> 758843 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579095085056)]} 0 56
[junit4] 2> 758843 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579095085057)]} 0 56
[junit4] 2> 758843 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579095085058)]} 0 56
[junit4] 2> 758843 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579095085059)]} 0 56
[junit4] 2> 758843 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579095085060)]} 0 56
[junit4] 2> 758843 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579095085061)]} 0 56
[junit4] 2> 758843 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579095085062)]} 0 56
[junit4] 2> 758843 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579095085063)]} 0 56
[junit4] 2> 758843 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579095085064)]} 0 56
[junit4] 2> 758843 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579095085065)]} 0 56
[junit4] 2> 758843 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579095085066)]} 0 56
[junit4] 2> 758843 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579095085067)]} 0 57
[junit4] 2> 758843 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579095085068)]} 0 57
[junit4] 2> 758843 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579095085069)]} 0 57
[junit4] 2> 758844 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579096133632)]} 0 57
[junit4] 2> 758844 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579096133633)]} 0 57
[junit4] 2> 758844 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579096133634)]} 0 57
[junit4] 2> 758844 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579096133635)]} 0 57
[junit4] 2> 758844 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579096133636)]} 0 57
[junit4] 2> 758844 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579096133637)]} 0 57
[junit4] 2> 758844 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579096133638)]} 0 57
[junit4] 2> 758844 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579096133639)]} 0 57
[junit4] 2> 758844 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579096133640)]} 0 57
[junit4] 2> 758844 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579096133641)]} 0 57
[junit4] 2> 758844 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579096133642)]} 0 57
[junit4] 2> 758844 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579096133643)]} 0 57
[junit4] 2> 758844 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579096133644)]} 0 58
[junit4] 2> 758844 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579096133645)]} 0 58
[junit4] 2> 758844 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579096133646)]} 0 58
[junit4] 2> 758844 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579096133647)]} 0 58
[junit4] 2> 758845 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579096133648)]} 0 58
[junit4] 2> 758845 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579097182208)]} 0 58
[junit4] 2> 758845 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579097182209)]} 0 58
[junit4] 2> 758845 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579097182210)]} 0 58
[junit4] 2> 758845 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579097182211)]} 0 58
[junit4] 2> 758845 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579097182212)]} 0 58
[junit4] 2> 758845 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579097182213)]} 0 58
[junit4] 2> 758845 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579097182214)]} 0 58
[junit4] 2> 758845 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579097182215)]} 0 58
[junit4] 2> 758845 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579097182216)]} 0 58
[junit4] 2> 758845 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579097182217)]} 0 58
[junit4] 2> 758845 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579097182218)]} 0 58
[junit4] 2> 758845 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579097182219)]} 0 58
[junit4] 2> 758845 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579097182220)]} 0 58
[junit4] 2> 758845 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579097182221)]} 0 59
[junit4] 2> 758845 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579097182222)]} 0 59
[junit4] 2> 758845 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579097182223)]} 0 59
[junit4] 2> 758845 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579097182224)]} 0 59
[junit4] 2> 758847 INFO (commitScheduler-2189-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 758847 INFO (commitScheduler-2189-thread-1) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@1edcce91 commitCommandVersion:0
[junit4] 2> 758847 INFO (commitScheduler-2189-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@51b35602[collection1] realtime]
[junit4] 2> 758848 INFO (commitScheduler-2189-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 758896 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579150659584)]} 0 109
[junit4] 2> 758896 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579150659585)]} 0 110
[junit4] 2> 758896 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579150659586)]} 0 110
[junit4] 2> 758896 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579150659587)]} 0 110
[junit4] 2> 758897 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579151708160)]} 0 110
[junit4] 2> 758897 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579151708161)]} 0 110
[junit4] 2> 758897 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579151708162)]} 0 110
[junit4] 2> 758897 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579151708163)]} 0 110
[junit4] 2> 758897 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579151708164)]} 0 110
[junit4] 2> 758897 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579151708165)]} 0 110
[junit4] 2> 758897 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579151708166)]} 0 110
[junit4] 2> 758897 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579151708167)]} 0 110
[junit4] 2> 758897 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579151708168)]} 0 110
[junit4] 2> 758897 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579151708169)]} 0 110
[junit4] 2> 758897 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579151708170)]} 0 110
[junit4] 2> 758897 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579151708171)]} 0 110
[junit4] 2> 758897 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579151708172)]} 0 110
[junit4] 2> 758897 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579151708173)]} 0 110
[junit4] 2> 758897 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579151708174)]} 0 111
[junit4] 2> 758897 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579151708175)]} 0 111
[junit4] 2> 758897 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579151708176)]} 0 111
[junit4] 2> 758898 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579152756736)]} 0 111
[junit4] 2> 758898 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579152756737)]} 0 111
[junit4] 2> 758898 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579152756738)]} 0 111
[junit4] 2> 758898 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579152756739)]} 0 111
[junit4] 2> 758898 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579152756740)]} 0 111
[junit4] 2> 758898 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579152756741)]} 0 111
[junit4] 2> 758898 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579152756742)]} 0 111
[junit4] 2> 758898 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579152756743)]} 0 111
[junit4] 2> 758898 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579152756744)]} 0 111
[junit4] 2> 758898 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579152756745)]} 0 111
[junit4] 2> 758898 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579152756746)]} 0 112
[junit4] 2> 758898 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579152756747)]} 0 112
[junit4] 2> 758899 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579152756748)]} 0 112
[junit4] 2> 758899 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579153805312)]} 0 112
[junit4] 2> 758899 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579153805313)]} 0 112
[junit4] 2> 758899 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579153805314)]} 0 112
[junit4] 2> 758899 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579153805315)]} 0 112
[junit4] 2> 758899 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579153805316)]} 0 112
[junit4] 2> 758899 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579153805317)]} 0 112
[junit4] 2> 758899 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579153805318)]} 0 112
[junit4] 2> 758899 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579153805319)]} 0 112
[junit4] 2> 758899 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579153805320)]} 0 112
[junit4] 2> 758899 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579153805321)]} 0 112
[junit4] 2> 758899 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579153805322)]} 0 113
[junit4] 2> 758899 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579153805323)]} 0 113
[junit4] 2> 758899 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579153805324)]} 0 113
[junit4] 2> 758900 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579154853888)]} 0 113
[junit4] 2> 758900 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579154853889)]} 0 113
[junit4] 2> 758900 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579154853890)]} 0 113
[junit4] 2> 758901 INFO (commitScheduler-2189-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 758901 INFO (commitScheduler-2189-thread-1) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@1edcce91 commitCommandVersion:0
[junit4] 2> 758901 INFO (commitScheduler-2189-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@2032fe0c[collection1] realtime]
[junit4] 2> 758901 INFO (commitScheduler-2189-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 758951 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579207282688)]} 0 164
[junit4] 2> 758951 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579208331264)]} 0 164
[junit4] 2> 758951 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579208331265)]} 0 164
[junit4] 2> 758951 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579208331266)]} 0 164
[junit4] 2> 758951 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579208331267)]} 0 164
[junit4] 2> 758951 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579208331268)]} 0 164
[junit4] 2> 758951 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579208331269)]} 0 164
[junit4] 2> 758951 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579208331270)]} 0 164
[junit4] 2> 758951 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579208331271)]} 0 164
[junit4] 2> 758951 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579208331272)]} 0 164
[junit4] 2> 758951 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579208331273)]} 0 165
[junit4] 2> 758951 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579208331274)]} 0 165
[junit4] 2> 758951 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579208331275)]} 0 165
[junit4] 2> 758951 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579208331276)]} 0 165
[junit4] 2> 758951 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579208331277)]} 0 165
[junit4] 2> 758951 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579208331278)]} 0 165
[junit4] 2> 758952 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579209379840)]} 0 165
[junit4] 2> 758952 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579209379841)]} 0 165
[junit4] 2> 758952 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579209379842)]} 0 165
[junit4] 2> 758952 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579209379843)]} 0 165
[junit4] 2> 758952 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579209379844)]} 0 165
[junit4] 2> 758952 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579209379845)]} 0 165
[junit4] 2> 758952 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579209379846)]} 0 165
[junit4] 2> 758952 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579209379847)]} 0 165
[junit4] 2> 758952 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579209379848)]} 0 165
[junit4] 2> 758952 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579209379849)]} 0 165
[junit4] 2> 758952 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579209379850)]} 0 165
[junit4] 2> 758952 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579209379851)]} 0 165
[junit4] 2> 758952 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579209379852)]} 0 165
[junit4] 2> 758952 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579209379853)]} 0 165
[junit4] 2> 758952 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579209379854)]} 0 166
[junit4] 2> 758952 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579209379855)]} 0 166
[junit4] 2> 758952 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579209379856)]} 0 166
[junit4] 2> 758952 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579209379857)]} 0 166
[junit4] 2> 758952 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579209379858)]} 0 166
[junit4] 2> 758953 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579209379859)]} 0 166
[junit4] 2> 758953 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579210428416)]} 0 166
[junit4] 2> 758953 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579210428417)]} 0 166
[junit4] 2> 758953 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579210428418)]} 0 166
[junit4] 2> 758953 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579210428419)]} 0 166
[junit4] 2> 758953 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579210428420)]} 0 166
[junit4] 2> 758953 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579210428421)]} 0 166
[junit4] 2> 758953 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579210428422)]} 0 166
[junit4] 2> 758953 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579210428423)]} 0 166
[junit4] 2> 758953 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579210428424)]} 0 166
[junit4] 2> 758953 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579210428425)]} 0 166
[junit4] 2> 758953 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579210428426)]} 0 166
[junit4] 2> 758953 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579210428427)]} 0 166
[junit4] 2> 758953 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579210428428)]} 0 167
[junit4] 2> 758953 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579210428429)]} 0 167
[junit4] 2> 758954 INFO (commitScheduler-2189-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 758954 INFO (commitScheduler-2189-thread-1) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@1edcce91 commitCommandVersion:0
[junit4] 2> 758955 INFO (commitScheduler-2189-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@250776c0[collection1] realtime]
[junit4] 2> 758955 INFO (commitScheduler-2189-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 759005 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579262857216)]} 0 218
[junit4] 2> 759005 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579264954368)]} 0 218
[junit4] 2> 759005 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579264954369)]} 0 218
[junit4] 2> 759005 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579264954370)]} 0 218
[junit4] 2> 759005 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579264954371)]} 0 218
[junit4] 2> 759005 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579264954372)]} 0 218
[junit4] 2> 759005 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579264954373)]} 0 218
[junit4] 2> 759005 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579264954374)]} 0 218
[junit4] 2> 759005 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579264954375)]} 0 218
[junit4] 2> 759005 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579264954376)]} 0 219
[junit4] 2> 759005 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579264954377)]} 0 219
[junit4] 2> 759005 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579264954378)]} 0 219
[junit4] 2> 759005 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579264954379)]} 0 219
[junit4] 2> 759005 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579264954380)]} 0 219
[junit4] 2> 759005 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579264954381)]} 0 219
[junit4] 2> 759006 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579266002944)]} 0 219
[junit4] 2> 759006 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579266002945)]} 0 219
[junit4] 2> 759006 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579266002946)]} 0 219
[junit4] 2> 759006 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579266002947)]} 0 219
[junit4] 2> 759006 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579266002948)]} 0 219
[junit4] 2> 759006 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579266002949)]} 0 219
[junit4] 2> 759006 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579266002950)]} 0 219
[junit4] 2> 759006 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579266002951)]} 0 219
[junit4] 2> 759006 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579266002952)]} 0 219
[junit4] 2> 759006 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579266002953)]} 0 219
[junit4] 2> 759006 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579266002954)]} 0 219
[junit4] 2> 759006 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579266002955)]} 0 219
[junit4] 2> 759006 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579266002956)]} 0 219
[junit4] 2> 759006 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579266002957)]} 0 220
[junit4] 2> 759006 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579266002958)]} 0 220
[junit4] 2> 759006 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579266002959)]} 0 220
[junit4] 2> 759006 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579266002960)]} 0 220
[junit4] 2> 759006 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579266002961)]} 0 220
[junit4] 2> 759006 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579266002962)]} 0 220
[junit4] 2> 759007 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579267051520)]} 0 220
[junit4] 2> 759007 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579267051521)]} 0 220
[junit4] 2> 759007 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579267051522)]} 0 220
[junit4] 2> 759007 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579267051523)]} 0 220
[junit4] 2> 759007 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579267051524)]} 0 220
[junit4] 2> 759007 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579267051525)]} 0 220
[junit4] 2> 759007 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579267051526)]} 0 220
[junit4] 2> 759007 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579267051527)]} 0 220
[junit4] 2> 759007 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579267051528)]} 0 220
[junit4] 2> 759007 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579267051529)]} 0 220
[junit4] 2> 759007 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579267051530)]} 0 220
[junit4] 2> 759007 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579267051531)]} 0 220
[junit4] 2> 759007 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579267051532)]} 0 220
[junit4] 2> 759007 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579267051533)]} 0 221
[junit4] 2> 759007 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579267051534)]} 0 221
[junit4] 2> 759007 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579267051535)]} 0 221
[junit4] 2> 759008 INFO (commitScheduler-2189-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 759008 INFO (commitScheduler-2189-thread-1) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@1edcce91 commitCommandVersion:0
[junit4] 2> 759009 INFO (commitScheduler-2189-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@577e636d[collection1] realtime]
[junit4] 2> 759009 INFO (commitScheduler-2189-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 759058 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579320528896)]} 0 271
[junit4] 2> 759058 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579320528897)]} 0 271
[junit4] 2> 759058 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579320528898)]} 0 271
[junit4] 2> 759058 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579320528899)]} 0 272
[junit4] 2> 759058 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579320528900)]} 0 272
[junit4] 2> 759058 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579320528901)]} 0 272
[junit4] 2> 759058 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579320528902)]} 0 272
[junit4] 2> 759058 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579320528903)]} 0 272
[junit4] 2> 759058 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579320528904)]} 0 272
[junit4] 2> 759058 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579320528905)]} 0 272
[junit4] 2> 759059 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579321577472)]} 0 272
[junit4] 2> 759059 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579321577473)]} 0 272
[junit4] 2> 759059 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579321577474)]} 0 272
[junit4] 2> 759059 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579321577475)]} 0 272
[junit4] 2> 759059 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579321577476)]} 0 272
[junit4] 2> 759059 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579321577477)]} 0 272
[junit4] 2> 759059 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579321577478)]} 0 272
[junit4] 2> 759059 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579321577479)]} 0 272
[junit4] 2> 759059 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579321577480)]} 0 272
[junit4] 2> 759059 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579321577481)]} 0 272
[junit4] 2> 759059 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579321577482)]} 0 272
[junit4] 2> 759059 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579321577483)]} 0 272
[junit4] 2> 759059 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579321577484)]} 0 272
[junit4] 2> 759059 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579321577485)]} 0 272
[junit4] 2> 759059 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579321577486)]} 0 273
[junit4] 2> 759059 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579321577487)]} 0 273
[junit4] 2> 759059 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579321577488)]} 0 273
[junit4] 2> 759059 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579321577489)]} 0 273
[junit4] 2> 759059 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579321577490)]} 0 273
[junit4] 2> 759059 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579321577491)]} 0 273
[junit4] 2> 759060 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579321577492)]} 0 273
[junit4] 2> 759060 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579322626048)]} 0 273
[junit4] 2> 759060 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579322626049)]} 0 273
[junit4] 2> 759060 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579322626050)]} 0 273
[junit4] 2> 759060 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579322626051)]} 0 273
[junit4] 2> 759060 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579322626052)]} 0 273
[junit4] 2> 759060 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579322626053)]} 0 273
[junit4] 2> 759060 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579322626054)]} 0 273
[junit4] 2> 759060 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579322626055)]} 0 273
[junit4] 2> 759060 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579322626056)]} 0 273
[junit4] 2> 759060 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579322626057)]} 0 273
[junit4] 2> 759060 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579322626058)]} 0 273
[junit4] 2> 759060 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579322626059)]} 0 273
[junit4] 2> 759060 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579322626060)]} 0 274
[junit4] 2> 759060 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579322626061)]} 0 274
[junit4] 2> 759060 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579322626062)]} 0 274
[junit4] 2> 759060 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579322626063)]} 0 274
[junit4] 2> 759060 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579322626064)]} 0 274
[junit4] 2> 759060 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579322626065)]} 0 274
[junit4] 2> 759060 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579322626066)]} 0 274
[junit4] 2> 759062 INFO (commitScheduler-2189-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 759062 INFO (commitScheduler-2189-thread-1) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@1edcce91 commitCommandVersion:0
[junit4] 2> 759062 INFO (commitScheduler-2189-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@31e3ac46[collection1] realtime]
[junit4] 2> 759062 INFO (commitScheduler-2189-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 759111 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579376103424)]} 0 324
[junit4] 2> 759111 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579376103425)]} 0 324
[junit4] 2> 759111 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579376103426)]} 0 324
[junit4] 2> 759111 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579376103427)]} 0 325
[junit4] 2> 759111 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579376103428)]} 0 325
[junit4] 2> 759111 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579376103429)]} 0 325
[junit4] 2> 759111 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579376103430)]} 0 325
[junit4] 2> 759111 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579376103431)]} 0 325
[junit4] 2> 759111 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579376103432)]} 0 325
[junit4] 2> 759111 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579376103433)]} 0 325
[junit4] 2> 759112 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579377152000)]} 0 325
[junit4] 2> 759112 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579377152001)]} 0 325
[junit4] 2> 759112 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579377152002)]} 0 325
[junit4] 2> 759112 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579377152003)]} 0 325
[junit4] 2> 759112 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579377152004)]} 0 325
[junit4] 2> 759112 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579377152005)]} 0 325
[junit4] 2> 759112 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579377152006)]} 0 325
[junit4] 2> 759112 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579377152007)]} 0 325
[junit4] 2> 759112 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579377152008)]} 0 325
[junit4] 2> 759112 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579377152009)]} 0 325
[junit4] 2> 759112 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579377152010)]} 0 325
[junit4] 2> 759112 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579377152011)]} 0 325
[junit4] 2> 759112 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579377152012)]} 0 325
[junit4] 2> 759112 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579377152013)]} 0 325
[junit4] 2> 759112 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579377152014)]} 0 325
[junit4] 2> 759112 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579377152015)]} 0 325
[junit4] 2> 759112 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579377152016)]} 0 325
[junit4] 2> 759112 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579377152017)]} 0 326
[junit4] 2> 759112 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579377152018)]} 0 326
[junit4] 2> 759112 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579377152019)]} 0 326
[junit4] 2> 759112 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579377152020)]} 0 326
[junit4] 2> 759112 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579377152021)]} 0 326
[junit4] 2> 759112 INFO (TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[9741EAB7CB275E47]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 (-1608612579377152022)]} 0 326
[junit4] 2> 759113 INF
[...truncated too long message...]
E983656130]}
[junit4] Completed [1/5] on J1 in 78.17s, 8 tests
[junit4]
[junit4] Suite: org.apache.solr.update.MaxSizeAutoCommitTest
[junit4] OK 10.2s J0 | MaxSizeAutoCommitTest.simpleTest
[junit4] OK 8.19s J0 | MaxSizeAutoCommitTest.testRedundantDeletes
[junit4] OK 3.82s J0 | MaxSizeAutoCommitTest.deleteTest
[junit4] OK 10.5s J0 | MaxSizeAutoCommitTest.endToEndTest {seed=[9741EAB7CB275E47:8D1785812B957945]}
[junit4] OK 12.1s J0 | MaxSizeAutoCommitTest.endToEndTest {seed=[9741EAB7CB275E47:3941397D1F57B269]}
[junit4] OK 10.2s J0 | MaxSizeAutoCommitTest.endToEndTest {seed=[9741EAB7CB275E47:B7A8AFA14E93FAA2]}
[junit4] OK 10.2s J0 | MaxSizeAutoCommitTest.endToEndTest {seed=[9741EAB7CB275E47:86460444226DA18B]}
[junit4] OK 10.3s J0 | MaxSizeAutoCommitTest.endToEndTest {seed=[9741EAB7CB275E47:CA8781E983656130]}
[junit4] Completed [2/5] on J0 in 78.69s, 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 3.58s J0 | MaxSizeAutoCommitTest.simpleTest
[junit4] OK 6.71s J0 | MaxSizeAutoCommitTest.testRedundantDeletes
[junit4] OK 2.66s J0 | MaxSizeAutoCommitTest.deleteTest
[junit4] OK 10.2s J0 | MaxSizeAutoCommitTest.endToEndTest {seed=[9741EAB7CB275E47:8D1785812B957945]}
[junit4] OK 9.69s J0 | MaxSizeAutoCommitTest.endToEndTest {seed=[9741EAB7CB275E47:3941397D1F57B269]}
[junit4] OK 10.5s J0 | MaxSizeAutoCommitTest.endToEndTest {seed=[9741EAB7CB275E47:B7A8AFA14E93FAA2]}
[junit4] OK 10.1s J0 | MaxSizeAutoCommitTest.endToEndTest {seed=[9741EAB7CB275E47:86460444226DA18B]}
[junit4] OK 10.4s J0 | MaxSizeAutoCommitTest.endToEndTest {seed=[9741EAB7CB275E47:CA8781E983656130]}
[junit4] Completed [3/5] on J0 in 63.92s, 8 tests
[junit4]
[junit4] Suite: org.apache.solr.update.MaxSizeAutoCommitTest
[junit4] OK 3.54s J1 | MaxSizeAutoCommitTest.simpleTest
[junit4] OK 7.22s J1 | MaxSizeAutoCommitTest.testRedundantDeletes
[junit4] OK 2.86s J1 | MaxSizeAutoCommitTest.deleteTest
[junit4] OK 10.7s J1 | MaxSizeAutoCommitTest.endToEndTest {seed=[9741EAB7CB275E47:8D1785812B957945]}
[junit4] OK 10.1s J1 | MaxSizeAutoCommitTest.endToEndTest {seed=[9741EAB7CB275E47:3941397D1F57B269]}
[junit4] OK 10.2s J1 | MaxSizeAutoCommitTest.endToEndTest {seed=[9741EAB7CB275E47:B7A8AFA14E93FAA2]}
[junit4] OK 10.9s J1 | MaxSizeAutoCommitTest.endToEndTest {seed=[9741EAB7CB275E47:86460444226DA18B]}
[junit4] OK 9.82s J1 | MaxSizeAutoCommitTest.endToEndTest {seed=[9741EAB7CB275E47:CA8781E983656130]}
[junit4] Completed [4/5] on J1 in 65.30s, 8 tests
[junit4]
[junit4] Suite: org.apache.solr.update.MaxSizeAutoCommitTest
[junit4] OK 4.26s J0 | MaxSizeAutoCommitTest.simpleTest
[junit4] OK 6.95s J0 | MaxSizeAutoCommitTest.testRedundantDeletes
[junit4] OK 2.47s J0 | MaxSizeAutoCommitTest.deleteTest
[junit4] OK 10.0s J0 | MaxSizeAutoCommitTest.endToEndTest {seed=[9741EAB7CB275E47:8D1785812B957945]}
[junit4] OK 10.4s J0 | MaxSizeAutoCommitTest.endToEndTest {seed=[9741EAB7CB275E47:3941397D1F57B269]}
[junit4] OK 10.4s J0 | MaxSizeAutoCommitTest.endToEndTest {seed=[9741EAB7CB275E47:B7A8AFA14E93FAA2]}
[junit4] OK 10.8s J0 | MaxSizeAutoCommitTest.endToEndTest {seed=[9741EAB7CB275E47:86460444226DA18B]}
[junit4] OK 10.7s J0 | MaxSizeAutoCommitTest.endToEndTest {seed=[9741EAB7CB275E47:CA8781E983656130]}
[junit4] Completed [5/5] on J0 in 65.99s, 8 tests
[junit4]
[junit4] JVM J0: 0.95 .. 210.68 = 209.73s
[junit4] JVM J1: 0.75 .. 145.96 = 145.21s
[junit4] Execution time total: 3 minutes 30 seconds
[junit4] Tests summary: 5 suites, 40 tests
[junit4] Could not remove temporary path: /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0 (java.nio.file.DirectoryNotEmptyException: Remaining files: [/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp])
[junit4] Could not remove temporary path: /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1 (java.nio.file.DirectoryNotEmptyException: Remaining files: [/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp])
[echo] 5 slowest tests:
[junit4:tophints] 136.97s | org.apache.solr.cloud.api.collections.CollectionsAPIDistributedZkTest
[junit4:tophints] 123.76s | org.apache.solr.cloud.TestTlogReplica
[junit4:tophints] 117.73s | org.apache.solr.update.SoftAutoCommitTest
[junit4:tophints] 114.58s | org.apache.solr.cloud.TestWithCollection
[junit4:tophints] 113.51s | org.apache.solr.cloud.ZkFailoverTest
-check-totals:
test-nocompile:
BUILD SUCCESSFUL
Total time: 3 minutes 34 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=/export/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
java.lang.InterruptedException: no matches found within 10000
at hudson.FilePath$ValidateAntFileMask.hasMatch(FilePath.java:2845)
at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:2724)
at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:2705)
at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3084)
Also: hudson.remoting.Channel$CallSiteStackTrace: Remote call to Solaris VBOX
at hudson.remoting.Channel.attachCallSiteStackTrace(Channel.java:1741)
at hudson.remoting.UserRequest$ExceptionResponse.retrieve(UserRequest.java:357)
at hudson.remoting.Channel.call(Channel.java:955)
at hudson.FilePath.act(FilePath.java:1070)
at hudson.FilePath.act(FilePath.java:1059)
at hudson.FilePath.validateAntFileMask(FilePath.java:2703)
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:1840)
at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
at hudson.model.ResourceController.execute(ResourceController.java:97)
at hudson.model.Executor.run(Executor.java:429)
Caused: hudson.FilePath$TunneledInterruptedException
at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3086)
at hudson.remoting.UserRequest.perform(UserRequest.java:212)
at hudson.remoting.UserRequest.perform(UserRequest.java:54)
at hudson.remoting.Request$2.run(Request.java:369)
at hudson.remoting.InterceptingExecutorService$1.call(InterceptingExecutorService.java:72)
at java.util.concurrent.FutureTask.run(FutureTask.java:266)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
Caused: java.lang.InterruptedException: java.lang.InterruptedException: no matches found within 10000
at hudson.FilePath.act(FilePath.java:1072)
at hudson.FilePath.act(FilePath.java:1059)
at hudson.FilePath.validateAntFileMask(FilePath.java:2703)
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:1840)
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=/export/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/export/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
<Git Blamer> Using GitBlamer to create author and commit information for all warnings.
<Git Blamer> GIT_COMMIT=17eb8cd14d27d2680fe7c4b3871f3eb883542d34, workspace=/export/home/jenkins/workspace/Lucene-Solr-master-Solaris
[WARNINGS] Computing warning deltas based on reference build #2014
Recording test results
Setting ANT_1_8_2_HOME=/export/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Build step 'Publish JUnit test result report' changed build result to UNSTABLE
Email was triggered for: Unstable (Test Failures)
Sending email for trigger: Unstable (Test Failures)
Setting ANT_1_8_2_HOME=/export/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/export/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/export/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/export/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
[JENKINS] Lucene-Solr-master-Solaris (64bit/jdk1.8.0) - Build #
2016 - Still Unstable!
Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Solaris/2016/
Java: 64bit/jdk1.8.0 -XX:-UseCompressedOops -XX:+UseParallelGC
4 tests failed.
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.SolrCLIZkUtilsTest
Error Message:
java.util.concurrent.TimeoutException: Could not connect to ZooKeeper 127.0.0.1:57410 within 30000 ms
Stack Trace:
org.apache.solr.common.SolrException: java.util.concurrent.TimeoutException: Could not connect to ZooKeeper 127.0.0.1:57410 within 30000 ms
at __randomizedtesting.SeedInfo.seed([A9F9469DCCB42AA4]:0)
at org.apache.solr.common.cloud.SolrZkClient.<init>(SolrZkClient.java:184)
at org.apache.solr.common.cloud.SolrZkClient.<init>(SolrZkClient.java:121)
at org.apache.solr.common.cloud.SolrZkClient.<init>(SolrZkClient.java:116)
at org.apache.solr.common.cloud.SolrZkClient.<init>(SolrZkClient.java:103)
at org.apache.solr.cloud.MiniSolrCloudCluster.<init>(MiniSolrCloudCluster.java:233)
at org.apache.solr.cloud.SolrCloudTestCase$Builder.build(SolrCloudTestCase.java:200)
at org.apache.solr.cloud.SolrCloudTestCase$Builder.configure(SolrCloudTestCase.java:192)
at org.apache.solr.cloud.SolrCLIZkUtilsTest.setupCluster(SolrCLIZkUtilsTest.java:50)
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$6.evaluate(RandomizedRunner.java:874)
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)
Caused by: java.util.concurrent.TimeoutException: Could not connect to ZooKeeper 127.0.0.1:57410 within 30000 ms
at org.apache.solr.common.cloud.ConnectionManager.waitForConnected(ConnectionManager.java:232)
at org.apache.solr.common.cloud.SolrZkClient.<init>(SolrZkClient.java:176)
... 31 more
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.SolrCLIZkUtilsTest
Error Message:
Stack Trace:
java.lang.NullPointerException
at __randomizedtesting.SeedInfo.seed([A9F9469DCCB42AA4]:0)
at org.apache.solr.cloud.SolrCLIZkUtilsTest.closeConn(SolrCLIZkUtilsTest.java:58)
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$7.evaluate(RandomizedRunner.java:897)
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)
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.SolrCLIZkUtilsTest
Error Message:
4 threads leaked from SUITE scope at org.apache.solr.cloud.SolrCLIZkUtilsTest: 1) Thread[id=31280, name=Thread-5851, state=WAITING, group=TGRP-SolrCLIZkUtilsTest] at java.lang.Object.wait(Native Method) at java.lang.Thread.join(Thread.java:1252) at java.lang.Thread.join(Thread.java:1326) at org.apache.zookeeper.server.NIOServerCnxnFactory.join(NIOServerCnxnFactory.java:313) at org.apache.solr.cloud.ZkTestServer$ZKServerMain.runFromConfig(ZkTestServer.java:313) at org.apache.solr.cloud.ZkTestServer$2.run(ZkTestServer.java:496) 2) Thread[id=31284, name=ProcessThread(sid:0 cport:57410):, state=WAITING, group=TGRP-SolrCLIZkUtilsTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442) at org.apache.zookeeper.server.PrepRequestProcessor.run(PrepRequestProcessor.java:123) 3) Thread[id=31281, name=NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0, state=RUNNABLE, group=TGRP-SolrCLIZkUtilsTest] at sun.nio.ch.DevPollArrayWrapper.poll0(Native Method) at sun.nio.ch.DevPollArrayWrapper.poll(DevPollArrayWrapper.java:223) at sun.nio.ch.DevPollSelectorImpl.doSelect(DevPollSelectorImpl.java:98) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:97) at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:196) at java.lang.Thread.run(Thread.java:748) 4) Thread[id=31282, name=SessionTracker, state=TIMED_WAITING, group=TGRP-SolrCLIZkUtilsTest] at java.lang.Object.wait(Native Method) at org.apache.zookeeper.server.SessionTrackerImpl.run(SessionTrackerImpl.java:147)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 4 threads leaked from SUITE scope at org.apache.solr.cloud.SolrCLIZkUtilsTest:
1) Thread[id=31280, name=Thread-5851, state=WAITING, group=TGRP-SolrCLIZkUtilsTest]
at java.lang.Object.wait(Native Method)
at java.lang.Thread.join(Thread.java:1252)
at java.lang.Thread.join(Thread.java:1326)
at org.apache.zookeeper.server.NIOServerCnxnFactory.join(NIOServerCnxnFactory.java:313)
at org.apache.solr.cloud.ZkTestServer$ZKServerMain.runFromConfig(ZkTestServer.java:313)
at org.apache.solr.cloud.ZkTestServer$2.run(ZkTestServer.java:496)
2) Thread[id=31284, name=ProcessThread(sid:0 cport:57410):, state=WAITING, group=TGRP-SolrCLIZkUtilsTest]
at sun.misc.Unsafe.park(Native Method)
at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
at org.apache.zookeeper.server.PrepRequestProcessor.run(PrepRequestProcessor.java:123)
3) Thread[id=31281, name=NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0, state=RUNNABLE, group=TGRP-SolrCLIZkUtilsTest]
at sun.nio.ch.DevPollArrayWrapper.poll0(Native Method)
at sun.nio.ch.DevPollArrayWrapper.poll(DevPollArrayWrapper.java:223)
at sun.nio.ch.DevPollSelectorImpl.doSelect(DevPollSelectorImpl.java:98)
at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:97)
at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:196)
at java.lang.Thread.run(Thread.java:748)
4) Thread[id=31282, name=SessionTracker, state=TIMED_WAITING, group=TGRP-SolrCLIZkUtilsTest]
at java.lang.Object.wait(Native Method)
at org.apache.zookeeper.server.SessionTrackerImpl.run(SessionTrackerImpl.java:147)
at __randomizedtesting.SeedInfo.seed([A9F9469DCCB42AA4]:0)
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.SolrCLIZkUtilsTest
Error Message:
There are still zombie threads that couldn't be terminated: 1) Thread[id=31281, name=NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0, state=RUNNABLE, group=TGRP-SolrCLIZkUtilsTest] at sun.nio.ch.DevPollArrayWrapper.poll0(Native Method) at sun.nio.ch.DevPollArrayWrapper.poll(DevPollArrayWrapper.java:223) at sun.nio.ch.DevPollSelectorImpl.doSelect(DevPollSelectorImpl.java:98) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:97) at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:196) at java.lang.Thread.run(Thread.java:748)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie threads that couldn't be terminated:
1) Thread[id=31281, name=NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0, state=RUNNABLE, group=TGRP-SolrCLIZkUtilsTest]
at sun.nio.ch.DevPollArrayWrapper.poll0(Native Method)
at sun.nio.ch.DevPollArrayWrapper.poll(DevPollArrayWrapper.java:223)
at sun.nio.ch.DevPollSelectorImpl.doSelect(DevPollSelectorImpl.java:98)
at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:97)
at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:196)
at java.lang.Thread.run(Thread.java:748)
at __randomizedtesting.SeedInfo.seed([A9F9469DCCB42AA4]:0)
Build Log:
[...truncated 13810 lines...]
[junit4] Suite: org.apache.solr.cloud.SolrCLIZkUtilsTest
[junit4] 2> Creating dataDir: /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.SolrCLIZkUtilsTest_A9F9469DCCB42AA4-001/init-core-data-001
[junit4] 2> 2129268 WARN (SUITE-SolrCLIZkUtilsTest-seed#[A9F9469DCCB42AA4]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=10 numCloses=10
[junit4] 2> 2129268 INFO (SUITE-SolrCLIZkUtilsTest-seed#[A9F9469DCCB42AA4]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 2129270 INFO (SUITE-SolrCLIZkUtilsTest-seed#[A9F9469DCCB42AA4]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
[junit4] 2> 2129270 INFO (SUITE-SolrCLIZkUtilsTest-seed#[A9F9469DCCB42AA4]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 2129271 INFO (SUITE-SolrCLIZkUtilsTest-seed#[A9F9469DCCB42AA4]-worker) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 1 servers in /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.SolrCLIZkUtilsTest_A9F9469DCCB42AA4-001/tempDir-001
[junit4] 2> 2129271 INFO (SUITE-SolrCLIZkUtilsTest-seed#[A9F9469DCCB42AA4]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 2129272 INFO (Thread-5851) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 2129272 INFO (Thread-5851) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 2129274 ERROR (Thread-5851) [ ] o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
[junit4] 2> 2129371 INFO (SUITE-SolrCLIZkUtilsTest-seed#[A9F9469DCCB42AA4]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port:57410
[junit4] 2> 2129376 WARN (SUITE-SolrCLIZkUtilsTest-seed#[A9F9469DCCB42AA4]-worker-SendThread(127.0.0.1:57410)) [ ] o.a.z.ClientCnxn Session 0x0 for server 127.0.0.1/127.0.0.1:57410, unexpected error, closing socket connection and attempting reconnect
[junit4] 2> java.io.IOException: Packet len1213486160 is out of range!
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocket.readLength(ClientCnxnSocket.java:113) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:79) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:366) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1144) [zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> 2130682 WARN (SUITE-SolrCLIZkUtilsTest-seed#[A9F9469DCCB42AA4]-worker-SendThread(127.0.0.1:57410)) [ ] o.a.z.ClientCnxn Session 0x0 for server 127.0.0.1/127.0.0.1:57410, unexpected error, closing socket connection and attempting reconnect
[junit4] 2> java.io.IOException: Packet len1213486160 is out of range!
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocket.readLength(ClientCnxnSocket.java:113) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:79) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:366) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1144) [zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> 2131832 WARN (SUITE-SolrCLIZkUtilsTest-seed#[A9F9469DCCB42AA4]-worker-SendThread(127.0.0.1:57410)) [ ] o.a.z.ClientCnxn Session 0x0 for server 127.0.0.1/127.0.0.1:57410, unexpected error, closing socket connection and attempting reconnect
[junit4] 2> java.io.IOException: Packet len1213486160 is out of range!
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocket.readLength(ClientCnxnSocket.java:113) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:79) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:366) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1144) [zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> 2133514 WARN (SUITE-SolrCLIZkUtilsTest-seed#[A9F9469DCCB42AA4]-worker-SendThread(127.0.0.1:57410)) [ ] o.a.z.ClientCnxn Session 0x0 for server 127.0.0.1/127.0.0.1:57410, unexpected error, closing socket connection and attempting reconnect
[junit4] 2> java.io.IOException: Packet len1213486160 is out of range!
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocket.readLength(ClientCnxnSocket.java:113) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:79) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:366) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1144) [zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> 2134767 WARN (SUITE-SolrCLIZkUtilsTest-seed#[A9F9469DCCB42AA4]-worker-SendThread(127.0.0.1:57410)) [ ] o.a.z.ClientCnxn Session 0x0 for server 127.0.0.1/127.0.0.1:57410, unexpected error, closing socket connection and attempting reconnect
[junit4] 2> java.io.IOException: Packet len1213486160 is out of range!
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocket.readLength(ClientCnxnSocket.java:113) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:79) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:366) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1144) [zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> 2136020 WARN (SUITE-SolrCLIZkUtilsTest-seed#[A9F9469DCCB42AA4]-worker-SendThread(127.0.0.1:57410)) [ ] o.a.z.ClientCnxn Session 0x0 for server 127.0.0.1/127.0.0.1:57410, unexpected error, closing socket connection and attempting reconnect
[junit4] 2> java.io.IOException: Packet len1213486160 is out of range!
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocket.readLength(ClientCnxnSocket.java:113) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:79) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:366) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1144) [zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> 2137408 WARN (SUITE-SolrCLIZkUtilsTest-seed#[A9F9469DCCB42AA4]-worker-SendThread(127.0.0.1:57410)) [ ] o.a.z.ClientCnxn Session 0x0 for server 127.0.0.1/127.0.0.1:57410, unexpected error, closing socket connection and attempting reconnect
[junit4] 2> java.io.IOException: Packet len1213486160 is out of range!
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocket.readLength(ClientCnxnSocket.java:113) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:79) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:366) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1144) [zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> 2138939 WARN (SUITE-SolrCLIZkUtilsTest-seed#[A9F9469DCCB42AA4]-worker-SendThread(127.0.0.1:57410)) [ ] o.a.z.ClientCnxn Session 0x0 for server 127.0.0.1/127.0.0.1:57410, unexpected error, closing socket connection and attempting reconnect
[junit4] 2> java.io.IOException: Packet len1213486160 is out of range!
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocket.readLength(ClientCnxnSocket.java:113) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:79) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:366) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1144) [zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> 2140257 WARN (SUITE-SolrCLIZkUtilsTest-seed#[A9F9469DCCB42AA4]-worker-SendThread(127.0.0.1:57410)) [ ] o.a.z.ClientCnxn Session 0x0 for server 127.0.0.1/127.0.0.1:57410, unexpected error, closing socket connection and attempting reconnect
[junit4] 2> java.io.IOException: Packet len1213486160 is out of range!
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocket.readLength(ClientCnxnSocket.java:113) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:79) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:366) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1144) [zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> 2142249 WARN (SUITE-SolrCLIZkUtilsTest-seed#[A9F9469DCCB42AA4]-worker-SendThread(127.0.0.1:57410)) [ ] o.a.z.ClientCnxn Session 0x0 for server 127.0.0.1/127.0.0.1:57410, unexpected error, closing socket connection and attempting reconnect
[junit4] 2> java.io.IOException: Packet len1213486160 is out of range!
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocket.readLength(ClientCnxnSocket.java:113) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:79) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:366) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1144) [zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> 2143778 WARN (SUITE-SolrCLIZkUtilsTest-seed#[A9F9469DCCB42AA4]-worker-SendThread(127.0.0.1:57410)) [ ] o.a.z.ClientCnxn Session 0x0 for server 127.0.0.1/127.0.0.1:57410, unexpected error, closing socket connection and attempting reconnect
[junit4] 2> java.io.IOException: Packet len1213486160 is out of range!
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocket.readLength(ClientCnxnSocket.java:113) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:79) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:366) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1144) [zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> 2145068 WARN (SUITE-SolrCLIZkUtilsTest-seed#[A9F9469DCCB42AA4]-worker-SendThread(127.0.0.1:57410)) [ ] o.a.z.ClientCnxn Session 0x0 for server 127.0.0.1/127.0.0.1:57410, unexpected error, closing socket connection and attempting reconnect
[junit4] 2> java.io.IOException: Packet len1213486160 is out of range!
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocket.readLength(ClientCnxnSocket.java:113) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:79) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:366) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1144) [zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> 2147110 WARN (SUITE-SolrCLIZkUtilsTest-seed#[A9F9469DCCB42AA4]-worker-SendThread(127.0.0.1:57410)) [ ] o.a.z.ClientCnxn Session 0x0 for server 127.0.0.1/127.0.0.1:57410, unexpected error, closing socket connection and attempting reconnect
[junit4] 2> java.io.IOException: Packet len1213486160 is out of range!
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocket.readLength(ClientCnxnSocket.java:113) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:79) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:366) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1144) [zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> 2148790 WARN (SUITE-SolrCLIZkUtilsTest-seed#[A9F9469DCCB42AA4]-worker-SendThread(127.0.0.1:57410)) [ ] o.a.z.ClientCnxn Session 0x0 for server 127.0.0.1/127.0.0.1:57410, unexpected error, closing socket connection and attempting reconnect
[junit4] 2> java.io.IOException: Packet len1213486160 is out of range!
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocket.readLength(ClientCnxnSocket.java:113) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:79) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:366) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1144) [zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> 2150097 WARN (SUITE-SolrCLIZkUtilsTest-seed#[A9F9469DCCB42AA4]-worker-SendThread(127.0.0.1:57410)) [ ] o.a.z.ClientCnxn Session 0x0 for server 127.0.0.1/127.0.0.1:57410, unexpected error, closing socket connection and attempting reconnect
[junit4] 2> java.io.IOException: Packet len1213486160 is out of range!
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocket.readLength(ClientCnxnSocket.java:113) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:79) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:366) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1144) [zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> 2152073 WARN (SUITE-SolrCLIZkUtilsTest-seed#[A9F9469DCCB42AA4]-worker-SendThread(127.0.0.1:57410)) [ ] o.a.z.ClientCnxn Session 0x0 for server 127.0.0.1/127.0.0.1:57410, unexpected error, closing socket connection and attempting reconnect
[junit4] 2> java.io.IOException: Packet len1213486160 is out of range!
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocket.readLength(ClientCnxnSocket.java:113) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:79) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:366) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1144) [zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> 2154098 WARN (SUITE-SolrCLIZkUtilsTest-seed#[A9F9469DCCB42AA4]-worker-SendThread(127.0.0.1:57410)) [ ] o.a.z.ClientCnxn Session 0x0 for server 127.0.0.1/127.0.0.1:57410, unexpected error, closing socket connection and attempting reconnect
[junit4] 2> java.io.IOException: Packet len1213486160 is out of range!
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocket.readLength(ClientCnxnSocket.java:113) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:79) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:366) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1144) [zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> 2155270 WARN (SUITE-SolrCLIZkUtilsTest-seed#[A9F9469DCCB42AA4]-worker-SendThread(127.0.0.1:57410)) [ ] o.a.z.ClientCnxn Session 0x0 for server 127.0.0.1/127.0.0.1:57410, unexpected error, closing socket connection and attempting reconnect
[junit4] 2> java.io.IOException: Packet len1213486160 is out of range!
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocket.readLength(ClientCnxnSocket.java:113) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:79) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:366) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1144) [zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> 2156691 WARN (SUITE-SolrCLIZkUtilsTest-seed#[A9F9469DCCB42AA4]-worker-SendThread(127.0.0.1:57410)) [ ] o.a.z.ClientCnxn Session 0x0 for server 127.0.0.1/127.0.0.1:57410, unexpected error, closing socket connection and attempting reconnect
[junit4] 2> java.io.IOException: Packet len1213486160 is out of range!
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocket.readLength(ClientCnxnSocket.java:113) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:79) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:366) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1144) [zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> 2158122 WARN (SUITE-SolrCLIZkUtilsTest-seed#[A9F9469DCCB42AA4]-worker-SendThread(127.0.0.1:57410)) [ ] o.a.z.ClientCnxn Session 0x0 for server 127.0.0.1/127.0.0.1:57410, unexpected error, closing socket connection and attempting reconnect
[junit4] 2> java.io.IOException: Packet len1213486160 is out of range!
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocket.readLength(ClientCnxnSocket.java:113) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:79) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:366) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1144) [zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> 2159548 INFO (SUITE-SolrCLIZkUtilsTest-seed#[A9F9469DCCB42AA4]-worker) [ ] o.a.s.SolrTestCaseJ4 ------------------------------------------------------- Done waiting for tracked resources to be released
[junit4] 2> Aug 13, 2018 3:50:11 AM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 4 leaked thread(s).
[junit4] 2> Aug 13, 2018 3:51:31 AM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> SEVERE: 4 threads leaked from SUITE scope at org.apache.solr.cloud.SolrCLIZkUtilsTest:
[junit4] 2> 1) Thread[id=31280, name=Thread-5851, state=WAITING, group=TGRP-SolrCLIZkUtilsTest]
[junit4] 2> at java.lang.Object.wait(Native Method)
[junit4] 2> at java.lang.Thread.join(Thread.java:1252)
[junit4] 2> at java.lang.Thread.join(Thread.java:1326)
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.join(NIOServerCnxnFactory.java:313)
[junit4] 2> at org.apache.solr.cloud.ZkTestServer$ZKServerMain.runFromConfig(ZkTestServer.java:313)
[junit4] 2> at org.apache.solr.cloud.ZkTestServer$2.run(ZkTestServer.java:496)
[junit4] 2> 2) Thread[id=31284, name=ProcessThread(sid:0 cport:57410):, state=WAITING, group=TGRP-SolrCLIZkUtilsTest]
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
[junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
[junit4] 2> at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
[junit4] 2> at org.apache.zookeeper.server.PrepRequestProcessor.run(PrepRequestProcessor.java:123)
[junit4] 2> 3) Thread[id=31281, name=NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0, state=RUNNABLE, group=TGRP-SolrCLIZkUtilsTest]
[junit4] 2> at sun.nio.ch.DevPollArrayWrapper.poll0(Native Method)
[junit4] 2> at sun.nio.ch.DevPollArrayWrapper.poll(DevPollArrayWrapper.java:223)
[junit4] 2> at sun.nio.ch.DevPollSelectorImpl.doSelect(DevPollSelectorImpl.java:98)
[junit4] 2> at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
[junit4] 2> at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:97)
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:196)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 4) Thread[id=31282, name=SessionTracker, state=TIMED_WAITING, group=TGRP-SolrCLIZkUtilsTest]
[junit4] 2> at java.lang.Object.wait(Native Method)
[junit4] 2> at org.apache.zookeeper.server.SessionTrackerImpl.run(SessionTrackerImpl.java:147)
[junit4] 2> Aug 13, 2018 3:51:31 AM com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
[junit4] 2> INFO: Starting to interrupt leaked threads:
[junit4] 2> 1) Thread[id=31280, name=Thread-5851, state=WAITING, group=TGRP-SolrCLIZkUtilsTest]
[junit4] 2> 2) Thread[id=31284, name=ProcessThread(sid:0 cport:57410):, state=WAITING, group=TGRP-SolrCLIZkUtilsTest]
[junit4] 2> 3) Thread[id=31281, name=NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0, state=RUNNABLE, group=TGRP-SolrCLIZkUtilsTest]
[junit4] 2> 4) Thread[id=31282, name=SessionTracker, state=TIMED_WAITING, group=TGRP-SolrCLIZkUtilsTest]
[junit4] 2> 2239677 WARN (Thread-5851) [ ] o.a.s.c.ZkTestServer Server interrupted
[junit4] 2> java.lang.InterruptedException: null
[junit4] 2> at java.lang.Object.wait(Native Method) ~[?:1.8.0_172]
[junit4] 2> at java.lang.Thread.join(Thread.java:1252) ~[?:1.8.0_172]
[junit4] 2> at java.lang.Thread.join(Thread.java:1326) ~[?:1.8.0_172]
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.join(NIOServerCnxnFactory.java:313) ~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> at org.apache.solr.cloud.ZkTestServer$ZKServerMain.runFromConfig(ZkTestServer.java:313) [java/:?]
[junit4] 2> at org.apache.solr.cloud.ZkTestServer$2.run(ZkTestServer.java:496) [java/:?]
[junit4] 2> 2239677 ERROR (SessionTracker) [ ] o.a.z.s.ZooKeeperCriticalThread Severe unrecoverable error, from thread : SessionTracker
[junit4] 2> java.lang.InterruptedException: null
[junit4] 2> at java.lang.Object.wait(Native Method) ~[?:1.8.0_172]
[junit4] 2> at org.apache.zookeeper.server.SessionTrackerImpl.run(SessionTrackerImpl.java:147) [zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> 2239677 ERROR (SessionTracker) [ ] o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
[junit4] 2> 2239677 ERROR (ProcessThread(sid:0 cport:57410):) [ ] o.a.z.s.ZooKeeperCriticalThread Severe unrecoverable error, from thread : ProcessThread(sid:0 cport:57410):
[junit4] 2> java.lang.InterruptedException: null
[junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.reportInterruptAfterWait(AbstractQueuedSynchronizer.java:2014) ~[?:1.8.0_172]
[junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2048) ~[?:1.8.0_172]
[junit4] 2> at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442) ~[?:1.8.0_172]
[junit4] 2> at org.apache.zookeeper.server.PrepRequestProcessor.run(PrepRequestProcessor.java:123) [zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> 2239677 ERROR (ProcessThread(sid:0 cport:57410):) [ ] o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
[junit4] 2> Aug 13, 2018 3:51:34 AM com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
[junit4] 2> SEVERE: There are still zombie threads that couldn't be terminated:
[junit4] 2> 1) Thread[id=31281, name=NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0, state=RUNNABLE, group=TGRP-SolrCLIZkUtilsTest]
[junit4] 2> at sun.nio.ch.DevPollArrayWrapper.poll0(Native Method)
[junit4] 2> at sun.nio.ch.DevPollArrayWrapper.poll(DevPollArrayWrapper.java:223)
[junit4] 2> at sun.nio.ch.DevPollSelectorImpl.doSelect(DevPollSelectorImpl.java:98)
[junit4] 2> at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
[junit4] 2> at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:97)
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:196)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {}, docValues:{}, maxPointsInLeafNode=780, maxMBSortInHeap=7.444600233963573, sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@b6e2cf7), locale=es-GT, timezone=America/Nassau
[junit4] 2> NOTE: SunOS 5.11 amd64/Oracle Corporation 1.8.0_172 (64-bit)/cpus=3,threads=3,free=198383552,total=509607936
[junit4] 2> NOTE: All tests run in this JVM: [TestReloadAndDeleteDocs, DocValuesNotIndexedTest, TestScoreJoinQPScore, TestTolerantUpdateProcessorCloud, DeleteReplicaTest, TestSolrQueryResponse, SolrXmlInZkTest, TestCSVLoader, TestRandomFlRTGCloud, FullSolrCloudDistribCmdsTest, CdcrVersionReplicationTest, TriggerSetPropertiesIntegrationTest, TestBlendedInfixSuggestions, TestSimDistributedQueue, SolrJmxReporterTest, StatsReloadRaceTest, MetricsConfigTest, TestQueryUtils, TestDynamicFieldCollectionResource, TestManagedResourceStorage, TestLegacyField, SortSpecParsingTest, TestJavabinTupleStreamParser, ZookeeperStatusHandlerTest, TestLMJelinekMercerSimilarityFactory, ZkStateWriterTest, TestSlowCompositeReaderWrapper, TestSolrCloudWithKerberosAlt, TestWordDelimiterFilterFactory, TestFieldCacheSortRandom, DataDrivenBlockJoinTest, TestExceedMaxTermLength, TestExecutePlanAction, OverseerStatusTest, TestCloudDeleteByQuery, XsltUpdateRequestHandlerTest, AnalyticsQueryTest, TestStandardQParsers, SpellCheckComponentTest, TestSubQueryTransformerDistrib, SearchHandlerTest, AutoAddReplicasPlanActionTest, TestValueSourceCache, MetricsHistoryIntegrationTest, PropertiesRequestHandlerTest, TestAuthorizationFramework, PluginInfoTest, TestStressUserVersions, ShardRoutingCustomTest, TestSchemaNameResource, SearchRateTriggerIntegrationTest, ResponseHeaderTest, SolrGraphiteReporterTest, CloudExitableDirectoryReaderTest, TestSerializedLuceneMatchVersion, ChaosMonkeyNothingIsSafeTest, SuggesterTest, DirectoryFactoryTest, NodeAddedTriggerTest, TestSmileRequest, PeerSyncWithLeaderTest, ClusterStateUpdateTest, TestLuceneMatchVersion, HdfsChaosMonkeyNothingIsSafeTest, TestJsonFacetsStatsParsing, MissingSegmentRecoveryTest, MoveReplicaHDFSTest, HdfsWriteToMultipleCollectionsTest, StatelessScriptUpdateProcessorFactoryTest, SimpleFacetsTest, TestNodeLostTrigger, TestFastOutputStream, TestNumericTerms32, TestXmlQParserPlugin, HdfsNNFailoverTest, TestNoOpRegenerator, TestXIncludeConfig, TestCoreContainer, SuggestComponentContextFilterQueryTest, TestComputePlanAction, TestClusterStateMutator, EmbeddedSolrNoSerializeTest, TestDefaultStatsCache, TestAuthenticationFramework, ZkNodePropsTest, CdcrBootstrapTest, AliasIntegrationTest, CustomHighlightComponentTest, TestStressCloudBlindAtomicUpdates, TestZkChroot, TestLegacyNumericRangeQueryBuilder, SolrCoreCheckLockOnStartupTest, TestSearcherReuse, DistributedDebugComponentTest, TestShortCircuitedRequests, TestAnalyzeInfixSuggestions, SSLMigrationTest, CollectionsAPIAsyncDistributedZkTest, FieldAnalysisRequestHandlerTest, GraphQueryTest, InfoHandlerTest, HighlighterMaxOffsetTest, CollectionStateFormat2Test, DistributedTermsComponentTest, TestUninvertingReader, TestCodecSupport, TestMissingGroups, SynonymTokenizerTest, VMParamsZkACLAndCredentialsProvidersTest, TestRealTimeGet, TestSolrConfigHandlerCloud, IndexSchemaRuntimeFieldTest, TestLuceneIndexBackCompat, PreAnalyzedFieldManagedSchemaCloudTest, TestClusterProperties, TestJsonFacetRefinement, ActionThrottleTest, IgnoreCommitOptimizeUpdateProcessorFactoryTest, TestMergePolicyConfig, TermVectorComponentDistributedTest, TestEmbeddedSolrServerConstructors, ChangedSchemaMergeTest, OutputWriterTest, UtilsToolTest, TaggingAttributeTest, RestoreTriggerStateTest, TestSystemCollAutoCreate, TestFieldSortValues, TestHighFrequencyDictionaryFactory, HdfsBasicDistributedZk2Test, FileUtilsTest, SmileWriterTest, OpenExchangeRatesOrgProviderTest, TestStressLiveNodes, RequestLoggingTest, LIROnShardRestartTest, LeaderFailureAfterFreshStartTest, TestSolr4Spatial2, CoreAdminHandlerTest, DistributedFacetExistsSmallTest, HttpSolrCallGetCoreTest, TestSortByMinMaxFunction, TestNumericRangeQuery64, TestSolrIndexConfig, RangeFacetCloudTest, DeleteStatusTest, RestartWhileUpdatingTest, TestSchemaSimilarityResource, TestFieldCollectionResource, TestDownShardTolerantSearch, LeaderVoteWaitTimeoutTest, ConfigureRecoveryStrategyTest, BlockJoinFacetRandomTest, SolrIndexMetricsTest, ReplicaListTransformerTest, BaseCdcrDistributedZkTest, TestSQLHandler, ParsingFieldUpdateProcessorsTest, TestBulkSchemaConcurrent, TestGroupingSearch, TestReloadDeadlock, TestLocalFSCloudBackupRestore, OverriddenZkACLAndCredentialsProvidersTest, TestCSVResponseWriter, TestLFUCache, TestAtomicUpdateErrorCases, CursorMarkTest, V2StandaloneTest, TestConfigsApi, ResourceLoaderTest, TestPivotHelperCode, TestSurroundQueryParser, SuggesterFSTTest, TestUpdate, TestInPlaceUpdatesDistrib, DocumentBuilderTest, TestPointFields, AsyncCallRequestStatusResponseTest, HdfsAutoAddReplicasIntegrationTest, ProtectedTermFilterFactoryTest, TestSSLRandomization, TestInfoStreamLogging, WrapperMergePolicyFactoryTest, NotRequiredUniqueKeyTest, TestSimpleTextCodec, UpdateLogTest, SimpleCollectionCreateDeleteTest, BlockCacheTest, RecoveryAfterSoftCommitTest, TriLevelCompositeIdRoutingTest, DistributedQueueTest, TestLRUStatsCache, LukeRequestHandlerTest, ConnectionManagerTest, TestRecoveryHdfs, TestDirectoryFactory, TestJmxIntegration, TestBM25SimilarityFactory, TestIBSimilarityFactory, TestNestedDocsSort, TestPushWriter, DisMaxRequestHandlerTest, TestRandomFaceting, TestDFISimilarityFactory, AnalysisAfterCoreReloadTest, BasicFunctionalityTest, ConvertedLegacyTest, CursorPagingTest, DistributedIntervalFacetingTest, EchoParamsTest, MinimalSchemaTest, SolrInfoBeanTest, SolrTestCaseJ4Test, TestCrossCoreJoin, TestCursorMarkWithoutUniqueKey, TestDistributedGrouping, TestDistributedMissingSort, TestDistributedSearch, TestJoin, TestSolrCoreProperties, TestTrie, PathHierarchyTokenizerFactoryTest, TestCharFilters, TestReversedWildcardFilterFactory, TokenizerChainTest, TestEmbeddedSolrServerAdminHandler, TestJettySolrRunner, AddReplicaTest, BasicDistributedZk2Test, BasicDistributedZkTest, ChaosMonkeyNothingIsSafeWithPullReplicasTest, ChaosMonkeySafeLeaderTest, ChaosMonkeySafeLeaderWithPullReplicasTest, CollectionPropsTest, ConcurrentCreateRoutedAliasTest, CreateRoutedAliasTest, DeleteInactiveReplicaTest, DeleteLastCustomShardedReplicaTest, DeleteNodeTest, DistribCursorPagingTest, DistribDocExpirationUpdateProcessorTest, DistribJoinFromCollectionTest, DistributedVersionInfoTest, ForceLeaderTest, HealthCheckHandlerTest, HttpPartitionOnCommitTest, HttpPartitionTest, LIRRollingUpdatesTest, LeaderElectionContextKeyTest, LeaderElectionIntegrationTest, LeaderElectionTest, LegacyCloudClusterPropTest, MoveReplicaHDFSFailoverTest, NodeMutatorTest, OverseerModifyCollectionTest, OverseerTest, RemoteQueryErrorTest, ReplaceNodeNoTargetTest, ReplaceNodeTest, ReplicationFactorTest, SharedFSAutoReplicaFailoverTest, SolrCLIZkUtilsTest]
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=SolrCLIZkUtilsTest -Dtests.seed=A9F9469DCCB42AA4 -Dtests.slow=true -Dtests.locale=es-GT -Dtests.timezone=America/Nassau -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
[junit4] ERROR 0.00s J0 | SolrCLIZkUtilsTest (suite) <<<
[junit4] > Throwable #1: org.apache.solr.common.SolrException: java.util.concurrent.TimeoutException: Could not connect to ZooKeeper 127.0.0.1:57410 within 30000 ms
[junit4] > at __randomizedtesting.SeedInfo.seed([A9F9469DCCB42AA4]:0)
[junit4] > at org.apache.solr.common.cloud.SolrZkClient.<init>(SolrZkClient.java:184)
[junit4] > at org.apache.solr.common.cloud.SolrZkClient.<init>(SolrZkClient.java:121)
[junit4] > at org.apache.solr.common.cloud.SolrZkClient.<init>(SolrZkClient.java:116)
[junit4] > at org.apache.solr.common.cloud.SolrZkClient.<init>(SolrZkClient.java:103)
[junit4] > at org.apache.solr.cloud.MiniSolrCloudCluster.<init>(MiniSolrCloudCluster.java:233)
[junit4] > at org.apache.solr.cloud.SolrCloudTestCase$Builder.build(SolrCloudTestCase.java:200)
[junit4] > at org.apache.solr.cloud.SolrCloudTestCase$Builder.configure(SolrCloudTestCase.java:192)
[junit4] > at org.apache.solr.cloud.SolrCLIZkUtilsTest.setupCluster(SolrCLIZkUtilsTest.java:50)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] > Caused by: java.util.concurrent.TimeoutException: Could not connect to ZooKeeper 127.0.0.1:57410 within 30000 ms
[junit4] > at org.apache.solr.common.cloud.ConnectionManager.waitForConnected(ConnectionManager.java:232)
[junit4] > at org.apache.solr.common.cloud.SolrZkClient.<init>(SolrZkClient.java:176)
[junit4] > ... 31 moreThrowable #2: java.lang.NullPointerException
[junit4] > at __randomizedtesting.SeedInfo.seed([A9F9469DCCB42AA4]:0)
[junit4] > at org.apache.solr.cloud.SolrCLIZkUtilsTest.closeConn(SolrCLIZkUtilsTest.java:58)
[junit4] > at java.lang.Thread.run(Thread.java:748)Throwable #3: com.carrotsearch.randomizedtesting.ThreadLeakError: 4 threads leaked from SUITE scope at org.apache.solr.cloud.SolrCLIZkUtilsTest:
[junit4] > 1) Thread[id=31280, name=Thread-5851, state=WAITING, group=TGRP-SolrCLIZkUtilsTest]
[junit4] > at java.lang.Object.wait(Native Method)
[junit4] > at java.lang.Thread.join(Thread.java:1252)
[junit4] > at java.lang.Thread.join(Thread.java:1326)
[junit4] > at org.apache.zookeeper.server.NIOServerCnxnFactory.join(NIOServerCnxnFactory.java:313)
[junit4] > at org.apache.solr.cloud.ZkTestServer$ZKServerMain.runFromConfig(ZkTestServer.java:313)
[junit4] > at org.apache.solr.cloud.ZkTestServer$2.run(ZkTestServer.java:496)
[junit4] > 2) Thread[id=31284, name=ProcessThread(sid:0 cport:57410):, state=WAITING, group=TGRP-SolrCLIZkUtilsTest]
[junit4] > at sun.misc.Unsafe.park(Native Method)
[junit4] > at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
[junit4] > at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
[junit4] > at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
[junit4] > at org.apache.zookeeper.server.PrepRequestProcessor.run(PrepRequestProcessor.java:123)
[junit4] > 3) Thread[id=31281, name=NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0, state=RUNNABLE, group=TGRP-SolrCLIZkUtilsTest]
[junit4] > at sun.nio.ch.DevPollArrayWrapper.poll0(Native Method)
[junit4] > at sun.nio.ch.DevPollArrayWrapper.poll(DevPollArrayWrapper.java:223)
[junit4] > at sun.nio.ch.DevPollSelectorImpl.doSelect(DevPollSelectorImpl.java:98)
[junit4] > at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
[junit4] > at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:97)
[junit4] > at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:196)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] > 4) Thread[id=31282, name=SessionTracker, state=TIMED_WAITING, group=TGRP-SolrCLIZkUtilsTest]
[junit4] > at java.lang.Object.wait(Native Method)
[junit4] > at org.apache.zookeeper.server.SessionTrackerImpl.run(SessionTrackerImpl.java:147)
[junit4] > at __randomizedtesting.SeedInfo.seed([A9F9469DCCB42AA4]:0)Throwable #4: com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie threads that couldn't be terminated:
[junit4] > 1) Thread[id=31281, name=NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0, state=RUNNABLE, group=TGRP-SolrCLIZkUtilsTest]
[junit4] > at sun.nio.ch.DevPollArrayWrapper.poll0(Native Method)
[junit4] > at sun.nio.ch.DevPollArrayWrapper.poll(DevPollArrayWrapper.java:223)
[junit4] > at sun.nio.ch.DevPollSelectorImpl.doSelect(DevPollSelectorImpl.java:98)
[junit4] > at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
[junit4] > at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:97)
[junit4] > at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:196)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] > at __randomizedtesting.SeedInfo.seed([A9F9469DCCB42AA4]:0)
[junit4] Completed [477/829 (1!)] on J0 in 113.43s, 0 tests, 4 errors <<< FAILURES!
[...truncated 49900 lines...]
[asciidoctor:convert] asciidoctor: ERROR: about-this-guide.adoc: line 1: invalid part, must have at least one section (e.g., chapter, appendix, etc.)
[asciidoctor:convert] asciidoctor: ERROR: solr-glossary.adoc: line 1: invalid part, must have at least one section (e.g., chapter, appendix, etc.)
[java] Processed 2278 links (1830 relative) to 3141 anchors in 247 files
[echo] Validated Links & Anchors via: /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-ref-guide/bare-bones-html/
-documentation-lint:
[jtidy] Checking for broken html (such as invalid tags)...
[delete] Deleting directory /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/jtidy_tmp
[echo] Checking for broken links...
[exec]
[exec] Crawl/parse...
[exec]
[exec] Verify...
[echo] Checking for malformed docs...
jar-checksums:
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/top-level-ivy-settings.xml
resolve:
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/top-level-ivy-settings.xml
common.resolve:
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/top-level-ivy-settings.xml
resolve:
jar-checksums:
[mkdir] Created dir: /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/null1230886085
[copy] Copying 35 files to /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/null1230886085
[delete] Deleting directory /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/null1230886085
resolve-example:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/top-level-ivy-settings.xml
resolve:
resolve-server:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/top-level-ivy-settings.xml
resolve:
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/top-level-ivy-settings.xml
resolve:
jar-checksums:
[mkdir] Created dir: /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/null1922356783
[copy] Copying 238 files to /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/null1922356783
[delete] Deleting directory /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/null1922356783
check-working-copy:
[ivy:cachepath] :: resolving dependencies :: org.eclipse.jgit#org.eclipse.jgit-caller;working
[ivy:cachepath] confs: [default]
[ivy:cachepath] found org.eclipse.jgit#org.eclipse.jgit;4.6.0.201612231935-r in public
[ivy:cachepath] found com.jcraft#jsch;0.1.53 in public
[ivy:cachepath] found com.googlecode.javaewah#JavaEWAH;1.1.6 in public
[ivy:cachepath] found org.apache.httpcomponents#httpclient;4.3.6 in public
[ivy:cachepath] found org.apache.httpcomponents#httpcore;4.3.3 in public
[ivy:cachepath] found commons-logging#commons-logging;1.1.3 in public
[ivy:cachepath] found commons-codec#commons-codec;1.6 in public
[ivy:cachepath] found org.slf4j#slf4j-api;1.7.2 in public
[ivy:cachepath] :: resolution report :: resolve 45ms :: artifacts dl 7ms
---------------------------------------------------------------------
| | modules || artifacts |
| conf | number| search|dwnlded|evicted|| number|dwnlded|
---------------------------------------------------------------------
| default | 8 | 0 | 0 | 0 || 8 | 0 |
---------------------------------------------------------------------
[wc-checker] Initializing working copy...
[wc-checker] SLF4J: Failed to load class "org.slf4j.impl.StaticLoggerBinder".
[wc-checker] SLF4J: Defaulting to no-operation (NOP) logger implementation
[wc-checker] SLF4J: See http://www.slf4j.org/codes.html#StaticLoggerBinder for further details.
[wc-checker] Checking working copy status...
-jenkins-base:
BUILD SUCCESSFUL
Total time: 91 minutes 52 seconds
Setting ANT_1_8_2_HOME=/export/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
[Lucene-Solr-master-Solaris] $ /bin/sh -xe /var/tmp/jenkins5124390941375482474.sh
+ mv lucene/build lucene/build.orig
+ mv solr/build solr/build.orig
+ ANT_HOME=/export/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
+ export ANT_HOME
+ PATH=/export/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/bin:/export/home/jenkins/tools/java/64bit/jdk1.8.0/bin:/usr/bin:/usr/sbin
+ export PATH
+ python3.4 -u dev-tools/scripts/reproduceJenkinsFailures.py --no-git https://jenkins.thetaphi.de/job/Lucene-Solr-master-Solaris/2016/consoleText
[repro] Jenkins log URL: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Solaris/2016/consoleText
[repro] Revision: 17eb8cd14d27d2680fe7c4b3871f3eb883542d34
[repro] Ant options: "-Dargs=-XX:-UseCompressedOops -XX:+UseParallelGC"
[repro] Repro line: ant test -Dtestcase=SolrCLIZkUtilsTest -Dtests.seed=A9F9469DCCB42AA4 -Dtests.slow=true -Dtests.locale=es-GT -Dtests.timezone=America/Nassau -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
[repro] ant clean
Buildfile: /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/build.xml
clean:
clean:
clean:
BUILD SUCCESSFUL
Total time: 0 seconds
[repro] Test suites by module:
[repro] solr/core
[repro] SolrCLIZkUtilsTest
[repro] ant compile-test
Buildfile: /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/build.xml
check-analyzers-icu-uptodate:
jar-analyzers-icu:
-mrjar-classes-uptodate:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: Apache Ivy 2.4.0 - 20141213170938 :: http://ant.apache.org/ivy/ ::
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/top-level-ivy-settings.xml
resolve-groovy:
[ivy:cachepath] :: resolving dependencies :: org.codehaus.groovy#groovy-all-caller;working
[ivy:cachepath] confs: [default]
[ivy:cachepath] found org.codehaus.groovy#groovy-all;2.4.15 in public
[ivy:cachepath] :: resolution report :: resolve 105ms :: artifacts dl 2ms
---------------------------------------------------------------------
| | modules || artifacts |
| conf | number| search|dwnlded|evicted|| number|dwnlded|
---------------------------------------------------------------------
| default | 1 | 0 | 0 | 0 || 1 | 0 |
---------------------------------------------------------------------
check-analyzers-common-uptodate:
jar-analyzers-common:
-mrjar-classes-uptodate:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/top-level-ivy-settings.xml
resolve-groovy:
-check-git-state:
-git-cleanroot:
-copy-git-state:
[copy] Copying 1 file to /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build
git-autoclean:
resolve:
common.init:
compile-lucene-core:
-check-git-state:
-git-cleanroot:
-copy-git-state:
git-autoclean:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/top-level-ivy-settings.xml
resolve:
init:
-clover.disable:
-clover.load:
-clover.classpath:
-clover.setup:
clover:
compile-core:
[mkdir] Created dir: /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/core/classes/java
[javac] Compiling 856 source files to /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/core/classes/java
[javac] Note: Some input files use or override a deprecated API.
[javac] Note: Recompile with -Xlint:deprecation for details.
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/core/classes/java/org/apache/lucene/util/graph/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/core/classes/java/org/apache/lucene/document/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/core/classes/java/org/apache/lucene/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/core/classes/java/org/apache/lucene/util/bkd/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/core/classes/java/org/apache/lucene/codecs/compressing/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/core/classes/java/org/apache/lucene/codecs/lucene60/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/core/classes/java/org/apache/lucene/codecs/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/core/classes/java/org/apache/lucene/util/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/core/classes/java/org/apache/lucene/index/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/core/classes/java/org/apache/lucene/util/fst/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/core/classes/java/org/apache/lucene/analysis/tokenattributes/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/core/classes/java/org/apache/lucene/search/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/core/classes/java/org/apache/lucene/util/packed/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/core/classes/java/org/apache/lucene/util/mutable/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/core/classes/java/org/apache/lucene/codecs/lucene70/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/core/classes/java/org/apache/lucene/codecs/perfield/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/core/classes/java/org/apache/lucene/analysis/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/core/classes/java/org/apache/lucene/analysis/standard/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/core/classes/java/org/apache/lucene/store/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/core/classes/java/org/apache/lucene/codecs/blocktree/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/core/classes/java/org/apache/lucene/search/spans/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/core/classes/java/org/apache/lucene/search/similarities/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/core/classes/java/org/apache/lucene/util/automaton/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/core/classes/java/org/apache/lucene/codecs/lucene50/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/core/classes/java/org/apache/lucene/geo/package-info.class
[copy] Copying 3 files to /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/core/classes/java
init:
-clover.disable:
-clover.load:
-clover.classpath:
-clover.setup:
clover:
compile-core:
[mkdir] Created dir: /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/analysis/common/classes/java
[javac] Compiling 474 source files to /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/analysis/common/classes/java
[javac] Note: Some input files use or override a deprecated API.
[javac] Note: Recompile with -Xlint:deprecation for details.
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/analysis/common/classes/java/org/apache/lucene/analysis/hunspell/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/analysis/common/classes/java/org/apache/lucene/analysis/minhash/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/analysis/common/classes/java/org/apache/lucene/analysis/ga/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/analysis/common/classes/java/org/apache/lucene/analysis/ca/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/analysis/common/classes/java/org/apache/lucene/analysis/custom/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/analysis/common/classes/java/org/apache/lucene/analysis/sr/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/analysis/common/classes/java/org/apache/lucene/collation/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/analysis/common/classes/java/org/apache/lucene/analysis/sv/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/analysis/common/classes/java/org/apache/lucene/analysis/bg/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/analysis/common/classes/java/org/apache/lucene/analysis/payloads/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/analysis/common/classes/java/org/apache/lucene/analysis/ngram/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/analysis/common/classes/java/org/apache/lucene/analysis/core/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/analysis/common/classes/java/org/apache/lucene/analysis/bn/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/analysis/common/classes/java/org/apache/lucene/analysis/fr/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/analysis/common/classes/java/org/tartarus/snowball/ext/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/analysis/common/classes/java/org/apache/lucene/analysis/br/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/analysis/common/classes/java/org/apache/lucene/analysis/miscellaneous/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/analysis/common/classes/java/org/apache/lucene/analysis/sinks/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/analysis/common/classes/java/org/apache/lucene/analysis/cjk/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/analysis/common/classes/java/org/apache/lucene/analysis/synonym/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/analysis/common/classes/java/org/apache/lucene/analysis/wikipedia/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/analysis/common/classes/java/org/apache/lucene/analysis/fa/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/analysis/common/classes/java/org/apache/lucene/analysis/reverse/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/analysis/common/classes/java/org/apache/lucene/analysis/nl/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/analysis/common/classes/java/org/apache/lucene/analysis/ro/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/analysis/common/classes/java/org/apache/lucene/analysis/fi/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/analysis/common/classes/java/org/apache/lucene/analysis/ru/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/analysis/common/classes/java/org/apache/lucene/analysis/no/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/analysis/common/classes/java/org/apache/lucene/analysis/el/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/analysis/common/classes/java/org/apache/lucene/analysis/ckb/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/analysis/common/classes/java/org/tartarus/snowball/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/analysis/common/classes/java/org/apache/lucene/analysis/in/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/analysis/common/classes/java/org/apache/lucene/analysis/util/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/analysis/common/classes/java/org/apache/lucene/analysis/it/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/analysis/common/classes/java/org/apache/lucene/analysis/snowball/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/analysis/common/classes/java/org/apache/lucene/analysis/en/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/analysis/common/classes/java/org/apache/lucene/analysis/es/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/analysis/common/classes/java/org/apache/lucene/analysis/shingle/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/analysis/common/classes/java/org/apache/lucene/analysis/eu/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/analysis/common/classes/java/org/apache/lucene/analysis/ar/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/analysis/common/classes/java/org/apache/lucene/analysis/query/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/analysis/common/classes/java/org/apache/lucene/analysis/id/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/analysis/common/classes/java/org/apache/lucene/analysis/compound/hyphenation/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/analysis/common/classes/java/org/apache/lucene/analysis/charfilter/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/analysis/common/classes/java/org/apache/lucene/analysis/pt/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/analysis/common/classes/java/org/apache/lucene/analysis/lv/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/analysis/common/classes/java/org/apache/lucene/analysis/lt/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/analysis/common/classes/java/org/apache/lucene/analysis/hu/package-info.class
[javac] Creating empty /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/build/
[...truncated too long message...]
solving dependencies :: org.codehaus.groovy#groovy-all-caller;working
[ivy:cachepath] confs: [default]
[ivy:cachepath] found org.codehaus.groovy#groovy-all;2.4.15 in public
[ivy:cachepath] :: resolution report :: resolve 15ms :: 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: /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test
[junit4:pickseed] Seed property 'tests.seed' already defined: A9F9469DCCB42AA4
[mkdir] Created dir: /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/temp
[junit4] <JUnit4> says ¡Hola! Master seed: A9F9469DCCB42AA4
[junit4] Executing 5 suites with 2 JVMs.
[junit4]
[junit4] Started J0 PID(14001@serv1-vm3).
[junit4] Started J1 PID(14000@serv1-vm3).
[junit4] Suite: org.apache.solr.cloud.SolrCLIZkUtilsTest
[junit4] OK 0.24s J1 | SolrCLIZkUtilsTest.testMv
[junit4] OK 0.06s J1 | SolrCLIZkUtilsTest.testUpconfig
[junit4] OK 0.11s J1 | SolrCLIZkUtilsTest.testRm
[junit4] OK 0.15s J1 | SolrCLIZkUtilsTest.testLs
[junit4] OK 0.30s J1 | SolrCLIZkUtilsTest.testCp
[junit4] OK 0.11s J1 | SolrCLIZkUtilsTest.testDownconfig
[junit4] Completed [1/5] on J1 in 6.65s, 6 tests
[junit4]
[junit4] Suite: org.apache.solr.cloud.SolrCLIZkUtilsTest
[junit4] OK 0.30s J0 | SolrCLIZkUtilsTest.testMv
[junit4] OK 0.13s J0 | SolrCLIZkUtilsTest.testUpconfig
[junit4] OK 0.20s J0 | SolrCLIZkUtilsTest.testRm
[junit4] OK 0.22s J0 | SolrCLIZkUtilsTest.testLs
[junit4] OK 0.29s J0 | SolrCLIZkUtilsTest.testCp
[junit4] OK 0.07s J0 | SolrCLIZkUtilsTest.testDownconfig
[junit4] Completed [2/5] on J0 in 7.63s, 6 tests
[junit4]
[junit4] Duplicate suite name used with XML reports: org.apache.solr.cloud.SolrCLIZkUtilsTest. This may confuse tools that process XML reports. Set 'ignoreDuplicateSuites' to true to skip this message.
[junit4] Suite: org.apache.solr.cloud.SolrCLIZkUtilsTest
[junit4] OK 0.10s J1 | SolrCLIZkUtilsTest.testMv
[junit4] OK 0.04s J1 | SolrCLIZkUtilsTest.testUpconfig
[junit4] OK 0.07s J1 | SolrCLIZkUtilsTest.testRm
[junit4] OK 0.09s J1 | SolrCLIZkUtilsTest.testLs
[junit4] OK 0.19s J1 | SolrCLIZkUtilsTest.testCp
[junit4] OK 0.06s J1 | SolrCLIZkUtilsTest.testDownconfig
[junit4] Completed [3/5] on J1 in 1.78s, 6 tests
[junit4]
[junit4] Suite: org.apache.solr.cloud.SolrCLIZkUtilsTest
[junit4] OK 0.10s J0 | SolrCLIZkUtilsTest.testMv
[junit4] OK 0.05s J0 | SolrCLIZkUtilsTest.testUpconfig
[junit4] OK 0.12s J0 | SolrCLIZkUtilsTest.testRm
[junit4] OK 0.11s J0 | SolrCLIZkUtilsTest.testLs
[junit4] OK 0.22s J0 | SolrCLIZkUtilsTest.testCp
[junit4] OK 0.08s J0 | SolrCLIZkUtilsTest.testDownconfig
[junit4] Completed [4/5] on J0 in 2.64s, 6 tests
[junit4]
[junit4] Suite: org.apache.solr.cloud.SolrCLIZkUtilsTest
[junit4] OK 0.09s J1 | SolrCLIZkUtilsTest.testMv
[junit4] OK 0.05s J1 | SolrCLIZkUtilsTest.testUpconfig
[junit4] OK 0.07s J1 | SolrCLIZkUtilsTest.testRm
[junit4] OK 0.11s J1 | SolrCLIZkUtilsTest.testLs
[junit4] OK 0.20s J1 | SolrCLIZkUtilsTest.testCp
[junit4] OK 0.07s J1 | SolrCLIZkUtilsTest.testDownconfig
[junit4] Completed [5/5] on J1 in 2.11s, 6 tests
[junit4]
[junit4] JVM J0: 0.67 .. 11.80 = 11.12s
[junit4] JVM J1: 0.68 .. 12.66 = 11.98s
[junit4] Execution time total: 12 seconds
[junit4] Tests summary: 5 suites, 30 tests
[junit4] Could not remove temporary path: /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0 (java.nio.file.DirectoryNotEmptyException: Remaining files: [/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp])
[junit4] Could not remove temporary path: /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1 (java.nio.file.DirectoryNotEmptyException: Remaining files: [/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp])
[echo] 5 slowest tests:
[junit4:tophints] 1265.58s | org.apache.solr.cloud.MultiThreadedOCPTest
[junit4:tophints] 119.55s | org.apache.solr.cloud.DeleteReplicaTest
[junit4:tophints] 113.38s | org.apache.solr.cloud.TestTlogReplica
[junit4:tophints] 111.68s | org.apache.solr.cloud.ZkFailoverTest
[junit4:tophints] 97.32s | org.apache.solr.cloud.api.collections.CollectionsAPIDistributedZkTest
-check-totals:
test-nocompile:
BUILD SUCCESSFUL
Total time: 15 seconds
[repro] Failures:
[repro] 0/5 failed: org.apache.solr.cloud.SolrCLIZkUtilsTest
[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=/export/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
java.lang.InterruptedException: no matches found within 10000
at hudson.FilePath$ValidateAntFileMask.hasMatch(FilePath.java:2845)
at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:2724)
at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:2705)
at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3084)
Also: hudson.remoting.Channel$CallSiteStackTrace: Remote call to Solaris VBOX
at hudson.remoting.Channel.attachCallSiteStackTrace(Channel.java:1741)
at hudson.remoting.UserRequest$ExceptionResponse.retrieve(UserRequest.java:357)
at hudson.remoting.Channel.call(Channel.java:955)
at hudson.FilePath.act(FilePath.java:1070)
at hudson.FilePath.act(FilePath.java:1059)
at hudson.FilePath.validateAntFileMask(FilePath.java:2703)
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:1840)
at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
at hudson.model.ResourceController.execute(ResourceController.java:97)
at hudson.model.Executor.run(Executor.java:429)
Caused: hudson.FilePath$TunneledInterruptedException
at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3086)
at hudson.remoting.UserRequest.perform(UserRequest.java:212)
at hudson.remoting.UserRequest.perform(UserRequest.java:54)
at hudson.remoting.Request$2.run(Request.java:369)
at hudson.remoting.InterceptingExecutorService$1.call(InterceptingExecutorService.java:72)
at java.util.concurrent.FutureTask.run(FutureTask.java:266)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
Caused: java.lang.InterruptedException: java.lang.InterruptedException: no matches found within 10000
at hudson.FilePath.act(FilePath.java:1072)
at hudson.FilePath.act(FilePath.java:1059)
at hudson.FilePath.validateAntFileMask(FilePath.java:2703)
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:1840)
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=/export/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/export/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
<Git Blamer> Using GitBlamer to create author and commit information for all warnings.
<Git Blamer> GIT_COMMIT=17eb8cd14d27d2680fe7c4b3871f3eb883542d34, workspace=/export/home/jenkins/workspace/Lucene-Solr-master-Solaris
[WARNINGS] Computing warning deltas based on reference build #2015
Recording test results
Setting ANT_1_8_2_HOME=/export/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Build step 'Publish JUnit test result report' changed build result to UNSTABLE
Email was triggered for: Unstable (Test Failures)
Sending email for trigger: Unstable (Test Failures)
Setting ANT_1_8_2_HOME=/export/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/export/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/export/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/export/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2