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/06/27 04:46:53 UTC
[JENKINS] Lucene-Solr-7.x-Solaris (64bit/jdk1.8.0) - Build # 690 -
Unstable!
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Solaris/690/
Java: 64bit/jdk1.8.0 -XX:-UseCompressedOops -XX:+UseConcMarkSweepGC
6 tests failed.
FAILED: org.apache.solr.search.TestRecovery.testExistOldBufferLog
Error Message:
Test abandoned because suite timeout was reached.
Stack Trace:
java.lang.Exception: Test abandoned because suite timeout was reached.
at __randomizedtesting.SeedInfo.seed([4527A15DE01C0C98]:0)
FAILED: junit.framework.TestSuite.org.apache.solr.search.TestRecovery
Error Message:
Suite timeout exceeded (>= 7200000 msec).
Stack Trace:
java.lang.Exception: Suite timeout exceeded (>= 7200000 msec).
at __randomizedtesting.SeedInfo.seed([4527A15DE01C0C98]:0)
FAILED: org.apache.solr.search.TestRecovery.testExistOldBufferLog
Error Message:
Stack Trace:
java.lang.AssertionError
at __randomizedtesting.SeedInfo.seed([4527A15DE01C0C98:1B77BC086ED39C11]:0)
at org.junit.Assert.fail(Assert.java:92)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.junit.Assert.assertFalse(Assert.java:68)
at org.junit.Assert.assertFalse(Assert.java:79)
at org.apache.solr.search.TestRecovery.testExistOldBufferLog(TestRecovery.java:1071)
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)
FAILED: org.apache.solr.search.TestRecovery.testLogReplay
Error Message:
mismatch: '1604391959057661952'!='-9223372036854775807' @ versions/[0]
Stack Trace:
java.lang.RuntimeException: mismatch: '1604391959057661952'!='-9223372036854775807' @ versions/[0]
at __randomizedtesting.SeedInfo.seed([4527A15DE01C0C98:DB468B7F7DB71214]:0)
at org.apache.solr.SolrTestCaseJ4.assertJQ(SolrTestCaseJ4.java:1005)
at org.apache.solr.SolrTestCaseJ4.assertJQ(SolrTestCaseJ4.java:952)
at org.apache.solr.search.TestRecovery.testLogReplay(TestRecovery.java:219)
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)
FAILED: org.apache.solr.search.TestRecovery.testLogReplayWithReorderedDBQUpdateWithDifferentChildCount
Error Message:
java.lang.RuntimeException: mismatch: '8'!='3' @ response/numFound
Stack Trace:
java.lang.Exception: java.lang.RuntimeException: mismatch: '8'!='3' @ response/numFound
at __randomizedtesting.SeedInfo.seed([4527A15DE01C0C98:BA1892850C8D5755]:0)
at org.apache.solr.search.TestRecovery.testLogReplayWithReorderedDBQWrapper(TestRecovery.java:530)
at org.apache.solr.search.TestRecovery.testLogReplayWithReorderedDBQUpdateWithDifferentChildCount(TestRecovery.java:460)
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)
Caused by: java.lang.RuntimeException: mismatch: '8'!='3' @ response/numFound
at org.apache.solr.SolrTestCaseJ4.assertJQ(SolrTestCaseJ4.java:1005)
at org.apache.solr.SolrTestCaseJ4.assertJQ(SolrTestCaseJ4.java:952)
at org.apache.solr.search.TestRecovery.lambda$testLogReplayWithReorderedDBQUpdateWithDifferentChildCount$15(TestRecovery.java:479)
at org.apache.solr.search.TestRecovery.testLogReplayWithReorderedDBQWrapper(TestRecovery.java:527)
... 40 more
FAILED: org.apache.solr.search.TestRecovery.testExistOldBufferLog
Error Message:
Stack Trace:
java.lang.AssertionError
at __randomizedtesting.SeedInfo.seed([4527A15DE01C0C98:1B77BC086ED39C11]:0)
at org.junit.Assert.fail(Assert.java:92)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.junit.Assert.assertFalse(Assert.java:68)
at org.junit.Assert.assertFalse(Assert.java:79)
at org.apache.solr.search.TestRecovery.testExistOldBufferLog(TestRecovery.java:1071)
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 13304 lines...]
[junit4] Suite: org.apache.solr.search.TestRecovery
[junit4] 2> Creating dataDir: /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J1/temp/solr.search.TestRecovery_4527A15DE01C0C98-001/init-core-data-001
[junit4] 2> 1202688 INFO (SUITE-TestRecovery-seed#[4527A15DE01C0C98]-worker) [ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1/lib, /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1202722 INFO (SUITE-TestRecovery-seed#[4527A15DE01C0C98]-worker) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.5.0
[junit4] 2> 1202766 INFO (SUITE-TestRecovery-seed#[4527A15DE01C0C98]-worker) [ ] o.a.s.s.IndexSchema [null] Schema name=test
[junit4] 2> 1202875 INFO (SUITE-TestRecovery-seed#[4527A15DE01C0C98]-worker) [ ] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 1204267 INFO (SUITE-TestRecovery-seed#[4527A15DE01C0C98]-worker) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 1204267 INFO (SUITE-TestRecovery-seed#[4527A15DE01C0C98]-worker) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 1204279 INFO (SUITE-TestRecovery-seed#[4527A15DE01C0C98]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@48a034ba
[junit4] 2> 1204285 INFO (SUITE-TestRecovery-seed#[4527A15DE01C0C98]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@48a034ba
[junit4] 2> 1204285 INFO (SUITE-TestRecovery-seed#[4527A15DE01C0C98]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@48a034ba
[junit4] 2> 1204299 INFO (coreLoadExecutor-4090-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1/lib, /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1204332 INFO (coreLoadExecutor-4090-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.5.0
[junit4] 2> 1204380 INFO (coreLoadExecutor-4090-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1204465 INFO (coreLoadExecutor-4090-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 1204471 INFO (coreLoadExecutor-4090-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1, trusted=true
[junit4] 2> 1204471 INFO (coreLoadExecutor-4090-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@48a034ba
[junit4] 2> 1204472 INFO (coreLoadExecutor-4090-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1204472 INFO (coreLoadExecutor-4090-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1], dataDir=[/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J1/temp/solr.search.TestRecovery_4527A15DE01C0C98-001/init-core-data-001/]
[junit4] 2> 1204474 INFO (coreLoadExecutor-4090-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=30, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.580712035237312]
[junit4] 2> 1204539 WARN (coreLoadExecutor-4090-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> 1204605 INFO (coreLoadExecutor-4090-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.CdcrUpdateLog
[junit4] 2> 1204605 INFO (coreLoadExecutor-4090-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1204606 INFO (coreLoadExecutor-4090-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1204606 INFO (coreLoadExecutor-4090-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1204607 INFO (coreLoadExecutor-4090-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=11, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
[junit4] 2> 1204608 INFO (coreLoadExecutor-4090-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@a0489c[collection1] main]
[junit4] 2> 1204608 WARN (coreLoadExecutor-4090-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
[junit4] 2> 1204608 INFO (coreLoadExecutor-4090-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1204608 INFO (coreLoadExecutor-4090-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1604387788644417536
[junit4] 2> 1204609 INFO (searcherExecutor-4091-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@a0489c[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1204631 INFO (TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 1204634 INFO (TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[4527A15DE01C0C98]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@4221c0d0[collection1] realtime]
[junit4] 2> 1204634 INFO (TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}{deleteByQuery=*:* (-9223372036854775807)} 0 3
[junit4] 2> 1204634 INFO (TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1604387788671680512,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1204634 INFO (TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@4d63a719 commitCommandVersion:1604387788671680512
[junit4] 2> 1204646 INFO (TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[4527A15DE01C0C98]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@27d7db62[collection1] main]
[junit4] 2> 1204646 INFO (TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1204647 INFO (searcherExecutor-4091-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@27d7db62[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1204647 INFO (TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 12
[junit4] 2> 1204654 INFO (TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[RDBQ1_1]} 0 3
[junit4] 2> 1204659 INFO (TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[4527A15DE01C0C98]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@463df3b9[collection1] realtime]
[junit4] 2> 1204660 INFO (TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={update.distrib=FROMLEADER&_version_=-2&wt=json&indent=true}{deleteByQuery=id:RDBQ1_2 (-2)} 0 5
[junit4] 2> 1204660 INFO (TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.DirectUpdateHandler2 Reordered DBQs detected. Update=add{_version_=1,id=RDBQ1_2} DBQs=[DBQ{version=2,q=id:RDBQ1_2}]
[junit4] 2> 1204669 INFO (TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[4527A15DE01C0C98]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@e7d5b97[collection1] realtime]
[junit4] 2> 1204669 INFO (TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[RDBQ1_2 (1)]} 0 9
[junit4] 2> 1204670 INFO (TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[RDBQ1_3 (3)]} 0 0
[junit4] 2> 1204670 INFO (TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[4527A15DE01C0C98]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&wt=xml} hits=0 status=0 QTime=0
[junit4] 2> 1204670 INFO (TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[4527A15DE01C0C98]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=206042021
[junit4] 2> 1204670 INFO (TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[4527A15DE01C0C98]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 1204670 INFO (TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[4527A15DE01C0C98]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@4ab47780: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@20735b7
[junit4] 2> 1204676 INFO (TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[4527A15DE01C0C98]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 1204676 INFO (TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[4527A15DE01C0C98]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@696dc741: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@7be60008
[junit4] 2> 1204678 INFO (TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[4527A15DE01C0C98]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 1204678 INFO (TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[4527A15DE01C0C98]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@236dcad7: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@252caaca
[junit4] 2> 1204679 INFO (coreCloseExecutor-4096-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@579d5f73
[junit4] 2> 1204679 INFO (coreCloseExecutor-4096-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=579d5f73
[junit4] 2> 1204679 INFO (coreCloseExecutor-4096-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@5a258ac6: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@34f4fce8
[junit4] 2> 1204698 INFO (TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[4527A15DE01C0C98]) [ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1/lib, /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1204720 INFO (TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[4527A15DE01C0C98]) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.5.0
[junit4] 2> 1204737 INFO (TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[4527A15DE01C0C98]) [ ] o.a.s.s.IndexSchema [null] Schema name=test
[junit4] 2> 1204816 INFO (TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[4527A15DE01C0C98]) [ ] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 1205868 INFO (TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[4527A15DE01C0C98]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 1205868 INFO (TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[4527A15DE01C0C98]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 1205884 INFO (TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[4527A15DE01C0C98]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@48a034ba
[junit4] 2> 1205891 INFO (TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[4527A15DE01C0C98]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@48a034ba
[junit4] 2> 1205891 INFO (TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[4527A15DE01C0C98]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@48a034ba
[junit4] 2> 1205893 INFO (coreLoadExecutor-4106-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1/lib, /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1205919 INFO (coreLoadExecutor-4106-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.5.0
[junit4] 2> 1205937 INFO (coreLoadExecutor-4106-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1206006 INFO (coreLoadExecutor-4106-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 1206013 INFO (coreLoadExecutor-4106-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1, trusted=true
[junit4] 2> 1206013 INFO (coreLoadExecutor-4106-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@48a034ba
[junit4] 2> 1206013 INFO (coreLoadExecutor-4106-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1206013 INFO (coreLoadExecutor-4106-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1], dataDir=[/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J1/temp/solr.search.TestRecovery_4527A15DE01C0C98-001/init-core-data-001/]
[junit4] 2> 1206017 WARN (coreLoadExecutor-4106-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> 1206063 INFO (coreLoadExecutor-4106-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.CdcrUpdateLog
[junit4] 2> 1206063 INFO (coreLoadExecutor-4106-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1206065 INFO (coreLoadExecutor-4106-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1206065 INFO (coreLoadExecutor-4106-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1206066 INFO (coreLoadExecutor-4106-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=30, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.580712035237312]
[junit4] 2> 1206067 INFO (coreLoadExecutor-4106-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@546ec5b6[collection1] main]
[junit4] 2> 1206067 WARN (coreLoadExecutor-4106-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
[junit4] 2> 1206067 INFO (coreLoadExecutor-4106-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1206071 INFO (searcherExecutor-4107-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@546ec5b6[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1206082 WARN (recoveryExecutor-4109-thread-1-processing-x:collection1) [ x:collection1] o.a.s.u.UpdateLog Starting log replay tlog{file=/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J1/temp/solr.search.TestRecovery_4527A15DE01C0C98-001/init-core-data-001/tlog/tlog.0000000000000000001.0 refcount=1} active=false starting pos=0 inSortedOrder=false
[junit4] 2> 1206083 INFO (TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[4527A15DE01C0C98]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&wt=xml} hits=0 status=0 QTime=0
[junit4] 2> 1206598 INFO (recoveryExecutor-4109-thread-1-processing-x:collection1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@6003cf53[collection1] realtime]
[junit4] 2> 1206599 INFO (replayUpdatesExecutor-4100-thread-1-processing-x:collection1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 Reordered DBQs detected. Update=add{flags=a,_version_=1,id=RDBQ1_2} DBQs=[DBQ{version=2,q=id:RDBQ1_2}]
[junit4] 2> 1206605 INFO (replayUpdatesExecutor-4100-thread-1-processing-x:collection1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@593949c[collection1] realtime]
[junit4] 2> 1207100 INFO (recoveryExecutor-4109-thread-1-processing-x:collection1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{flags=2,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1207100 INFO (recoveryExecutor-4109-thread-1-processing-x:collection1) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@64091507 commitCommandVersion:0
[junit4] 2> 1207173 INFO (recoveryExecutor-4109-thread-1-processing-x:collection1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@4aa1e2e2[collection1] main]
[junit4] 2> 1207178 INFO (recoveryExecutor-4109-thread-1-processing-x:collection1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1207179 INFO (searcherExecutor-4107-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@4aa1e2e2[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(7.5.0):c1) Uninverting(_3(7.5.0):c1)))}
[junit4] 2> 1207180 INFO (recoveryExecutor-4109-thread-1-processing-x:collection1) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[RDBQ1_1, RDBQ1_2 (1), RDBQ1_3 (3)],deleteByQuery=id:RDBQ1_2 (-2)} 0 1098
[junit4] 2> 1207180 WARN (recoveryExecutor-4109-thread-1-processing-x:collection1) [ x:collection1] o.a.s.u.UpdateLog Log replay finished. recoveryInfo=RecoveryInfo{adds=3 deletes=0 deleteByQuery=1 errors=0 positionOfStart=0}
[junit4] 2> 1207180 INFO (TEST-TestRecovery.testLogReplayWithReorderedDBQ-seed#[4527A15DE01C0C98]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&wt=xml} hits=2 status=0 QTime=0
[junit4] 2> 1207195 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 1207195 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@47862017[collection1] realtime]
[junit4] 2> 1207196 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}{deleteByQuery=*:* (-9223372036854775807)} 0 0
[junit4] 2> 1207196 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1604387791358132224,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1207196 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@64091507 commitCommandVersion:1604387791358132224
[junit4] 2> 1207218 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@176a64da[collection1] main]
[junit4] 2> 1207218 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1207220 INFO (searcherExecutor-4107-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@176a64da[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1207220 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 24
[junit4] 2> 1207222 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[5403 (1604387791384346624)]} 0 1
[junit4] 2> 1207223 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[509 (1604387791386443776)]} 0 0
[junit4] 2> 1207223 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[3940 (1604387791386443777)]} 0 0
[junit4] 2> 1207223 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[4472 (1604387791386443778)]} 0 0
[junit4] 2> 1207223 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[3021 (1604387791386443779)]} 0 0
[junit4] 2> 1207223 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[2895 (1604387791386443780)]} 0 0
[junit4] 2> 1207223 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[4559 (1604387791386443781)]} 0 0
[junit4] 2> 1207223 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[9883 (1604387791386443782)]} 0 0
[junit4] 2> 1207223 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[7527 (1604387791386443783)]} 0 0
[junit4] 2> 1207224 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[8684 (1604387791386443784)]} 0 0
[junit4] 2> 1207224 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[4520 (1604387791387492352)]} 0 0
[junit4] 2> 1207224 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[8684 (1604387791387492353)]} 0 0
[junit4] 2> 1207224 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[6038 (1604387791387492354)]} 0 0
[junit4] 2> 1207224 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[7296 (1604387791387492355)]} 0 0
[junit4] 2> 1207224 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[5403 (1604387791387492356)]} 0 0
[junit4] 2> 1207225 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[4520 (1604387791387492357)]} 0 0
[junit4] 2> 1207225 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{delete=[4520 (-1604387791388540928)]} 0 0
[junit4] 2> 1207225 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[1770 (1604387791388540929)]} 0 0
[junit4] 2> 1207225 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[5103 (1604387791388540930)]} 0 0
[junit4] 2> 1207225 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[4472 (1604387791388540931)]} 0 0
[junit4] 2> 1207225 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[1552 (1604387791388540932)]} 0 0
[junit4] 2> 1207225 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[8752 (1604387791388540933)]} 0 0
[junit4] 2> 1207226 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[1552 (1604387791389589504)]} 0 0
[junit4] 2> 1207226 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[4559 (1604387791389589505)]} 0 0
[junit4] 2> 1207226 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[6508 (1604387791389589506)]} 0 0
[junit4] 2> 1207226 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[5403 (1604387791389589507)]} 0 0
[junit4] 2> 1207227 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[7296 (1604387791390638080)]} 0 0
[junit4] 2> 1207237 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@7081ebfb[collection1] realtime]
[junit4] 2> 1207238 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@64b5766f[collection1] realtime]
[junit4] 2> 1207238 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{deleteByQuery=val_i_dvo:396 (-1604387791390638081)} 0 11
[junit4] 2> 1207240 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[1307 (1604387791403220992)]} 0 0
[junit4] 2> 1207240 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[2834 (1604387791404269568)]} 0 0
[junit4] 2> 1207240 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[7254 (1604387791404269569)]} 0 0
[junit4] 2> 1207245 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@30feb2f5[collection1] realtime]
[junit4] 2> 1207246 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@5962215d[collection1] realtime]
[junit4] 2> 1207246 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{deleteByQuery=val_i_dvo:14 (-1604387791404269570)} 0 6
[junit4] 2> 1207247 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[1307 (1604387791411609600)]} 0 0
[junit4] 2> 1207247 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[4472 (1604387791411609601)]} 0 0
[junit4] 2> 1207248 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[5075 (1604387791411609602)]} 0 0
[junit4] 2> 1207248 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[5887 (1604387791412658176)]} 0 0
[junit4] 2> 1207248 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{delete=[8752 (-1604387791412658177)]} 0 0
[junit4] 2> 1207248 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[5104 (1604387791412658178)]} 0 0
[junit4] 2> 1207248 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[6332 (1604387791412658179)]} 0 0
[junit4] 2> 1207248 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[9005 (1604387791412658180)]} 0 0
[junit4] 2> 1207258 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@8fd490f[collection1] realtime]
[junit4] 2> 1207272 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@6292c8ce[collection1] realtime]
[junit4] 2> 1207272 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{deleteByQuery=val_i_dvo:739 (-1604387791412658181)} 0 23
[junit4] 2> 1207273 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[9883 (1604387791437824000)]} 0 0
[junit4] 2> 1207273 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[2360 (1604387791438872576)]} 0 0
[junit4] 2> 1207273 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[6508 (1604387791438872577)]} 0 0
[junit4] 2> 1207273 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{delete=[2360 (-1604387791438872578)]} 0 0
[junit4] 2> 1207280 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@234d245f[collection1] realtime]
[junit4] 2> 1207281 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@56bd3aef[collection1] realtime]
[junit4] 2> 1207282 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{deleteByQuery=val_i_dvo:782 (-1604387791438872579)} 0 8
[junit4] 2> 1207282 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[6038 (1604387791448309760)]} 0 0
[junit4] 2> 1207283 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[2895 (1604387791449358336)]} 0 0
[junit4] 2> 1207283 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[6332 (1604387791449358337)]} 0 0
[junit4] 2> 1207283 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[5104 (1604387791449358338)]} 0 0
[junit4] 2> 1207284 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[7171 (1604387791449358339)]} 0 0
[junit4] 2> 1207284 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[2378 (1604387791450406912)]} 0 0
[junit4] 2> 1207284 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[8439 (1604387791450406913)]} 0 0
[junit4] 2> 1207284 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[9936 (1604387791450406914)]} 0 0
[junit4] 2> 1207284 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[9005 (1604387791450406915)]} 0 0
[junit4] 2> 1207284 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[5981 (1604387791450406916)]} 0 0
[junit4] 2> 1207285 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[809 (1604387791450406917)]} 0 0
[junit4] 2> 1207285 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[9079 (1604387791451455488)]} 0 0
[junit4] 2> 1207285 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[5981 (1604387791451455489)]} 0 0
[junit4] 2> 1207285 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[7527 (1604387791451455490)]} 0 0
[junit4] 2> 1207285 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[163 (1604387791451455491)]} 0 0
[junit4] 2> 1207285 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[2378 (1604387791451455492)]} 0 0
[junit4] 2> 1207285 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{delete=[2895 (-1604387791451455493)]} 0 0
[junit4] 2> 1207286 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[1288 (1604387791452504064)]} 0 0
[junit4] 2> 1207286 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[7085 (1604387791452504065)]} 0 0
[junit4] 2> 1207287 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{delete=[9936 (-1604387791452504066)]} 0 1
[junit4] 2> 1207288 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[2593 (1604387791454601216)]} 0 0
[junit4] 2> 1207288 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[5971 (1604387791454601217)]} 0 0
[junit4] 2> 1207300 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@7fd88fbe[collection1] realtime]
[junit4] 2> 1207302 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@3fc2e89d[collection1] realtime]
[junit4] 2> 1207302 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{deleteByQuery=val_i_dvo:918 (-1604387791454601218)} 0 13
[junit4] 2> 1207302 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[5103 (1604387791469281280)]} 0 0
[junit4] 2> 1207303 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[6783 (1604387791469281281)]} 0 0
[junit4] 2> 1207303 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[9 (1604387791470329856)]} 0 0
[junit4] 2> 1207303 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[5103 (1604387791470329857)]} 0 0
[junit4] 2> 1207304 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[7296 (1604387791470329858)]} 0 0
[junit4] 2> 1207304 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{delete=[9883 (-1604387791471378432)]} 0 0
[junit4] 2> 1207304 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[9669 (1604387791471378433)]} 0 0
[junit4] 2> 1207304 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[3213 (1604387791471378434)]} 0 0
[junit4] 2> 1207304 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[1307 (1604387791471378435)]} 0 0
[junit4] 2> 1207304 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[7987 (1604387791471378436)]} 0 0
[junit4] 2> 1207305 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[809 (1604387791472427008)]} 0 0
[junit4] 2> 1207305 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[1527 (1604387791472427009)]} 0 0
[junit4] 2> 1207305 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[6698 (1604387791472427010)]} 0 0
[junit4] 2> 1207305 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{delete=[5075 (-1604387791472427011)]} 0 0
[junit4] 2> 1207305 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[6260 (1604387791472427012)]} 0 0
[junit4] 2> 1207305 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{delete=[2593 (-1604387791472427013)]} 0 0
[junit4] 2> 1207305 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[4575 (1604387791472427014)]} 0 0
[junit4] 2> 1207306 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{delete=[7254 (-1604387791472427015)]} 0 0
[junit4] 2> 1207306 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[5306 (1604387791473475584)]} 0 0
[junit4] 2> 1207306 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[2660 (1604387791473475585)]} 0 0
[junit4] 2> 1207306 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[2660 (1604387791473475586)]} 0 0
[junit4] 2> 1207306 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[3213 (1604387791473475587)]} 0 0
[junit4] 2> 1207307 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[7085 (1604387791474524160)]} 0 0
[junit4] 2> 1207307 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[562 (1604387791474524161)]} 0 0
[junit4] 2> 1207307 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[6783 (1604387791474524162)]} 0 0
[junit4] 2> 1207307 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[3639 (1604387791474524163)]} 0 0
[junit4] 2> 1207307 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[9005 (1604387791474524164)]} 0 0
[junit4] 2> 1207308 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[3213 (1604387791475572736)]} 0 0
[junit4] 2> 1207308 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[4472 (1604387791475572737)]} 0 0
[junit4] 2> 1207308 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[7085 (1604387791475572738)]} 0 0
[junit4] 2> 1207308 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[4915 (1604387791475572739)]} 0 0
[junit4] 2> 1207309 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[3702 (1604387791476621312)]} 0 0
[junit4] 2> 1207309 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[5104 (1604387791476621313)]} 0 0
[junit4] 2> 1207309 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[6093 (1604387791476621314)]} 0 0
[junit4] 2> 1207309 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[6658 (1604387791476621315)]} 0 0
[junit4] 2> 1207309 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[9829 (1604387791476621316)]} 0 0
[junit4] 2> 1207310 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{delete=[5971 (-1604387791477669888)]} 0 0
[junit4] 2> 1207310 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[6038 (1604387791477669889)]} 0 0
[junit4] 2> 1207310 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[4949 (1604387791477669890)]} 0 0
[junit4] 2> 1207310 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[7492 (1604387791477669891)]} 0 0
[junit4] 2> 1207310 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[6260 (1604387791477669892)]} 0 0
[junit4] 2> 1207311 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[2776 (1604387791478718464)]} 0 0
[junit4] 2> 1207311 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[6599 (1604387791478718465)]} 0 0
[junit4] 2> 1207311 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[4575 (1604387791478718466)]} 0 0
[junit4] 2> 1207311 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[7527 (1604387791478718467)]} 0 0
[junit4] 2> 1207311 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[163 (1604387791478718468)]} 0 0
[junit4] 2> 1207312 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[809 (1604387791479767040)]} 0 0
[junit4] 2> 1207312 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[2166 (1604387791479767041)]} 0 0
[junit4] 2> 1207312 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[5306 (1604387791479767042)]} 0 0
[junit4] 2> 1207312 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[6042 (1604387791479767043)]} 0 0
[junit4] 2> 1207312 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[51 (1604387791479767044)]} 0 0
[junit4] 2> 1207312 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[7157 (1604387791479767045)]} 0 0
[junit4] 2> 1207313 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[5251 (1604387791479767046)]} 0 0
[junit4] 2> 1207313 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[4575 (1604387791480815616)]} 0 0
[junit4] 2> 1207313 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[6298 (1604387791480815617)]} 0 0
[junit4] 2> 1207313 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[8106 (1604387791480815618)]} 0 0
[junit4] 2> 1207314 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[4472 (1604387791481864192)]} 0 0
[junit4] 2> 1207314 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[7520 (1604387791481864193)]} 0 0
[junit4] 2> 1207314 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[6093 (1604387791481864194)]} 0 0
[junit4] 2> 1207314 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[6298 (1604387791481864195)]} 0 0
[junit4] 2> 1207314 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[1969 (1604387791481864196)]} 0 0
[junit4] 2> 1207314 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[4102 (1604387791481864197)]} 0 0
[junit4] 2> 1207315 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[4472 (1604387791482912768)]} 0 0
[junit4] 2> 1207315 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[3159 (1604387791482912769)]} 0 0
[junit4] 2> 1207315 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[8439 (1604387791482912770)]} 0 0
[junit4] 2> 1207315 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[2965 (1604387791482912771)]} 0 0
[junit4] 2> 1207315 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[5065 (1604387791482912772)]} 0 0
[junit4] 2> 1207316 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[3699 (1604387791482912773)]} 0 0
[junit4] 2> 1207316 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[119 (1604387791483961344)]} 0 0
[junit4] 2> 1207316 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[2261 (1604387791483961345)]} 0 0
[junit4] 2> 1207329 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@5526bc0f[collection1] realtime]
[junit4] 2> 1207333 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@10441c8[collection1] realtime]
[junit4] 2> 1207333 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{deleteByQuery=val_i_dvo:102 (-1604387791483961346)} 0 17
[junit4] 2> 1207334 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[7336 (1604387791501787136)]} 0 0
[junit4] 2> 1207334 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[1862 (1604387791502835712)]} 0 0
[junit4] 2> 1207334 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[5020 (1604387791502835713)]} 0 0
[junit4] 2> 1207334 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[2181 (1604387791502835714)]} 0 0
[junit4] 2> 1207334 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[5073 (1604387791502835715)]} 0 0
[junit4] 2> 1207335 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[5104 (1604387791503884288)]} 0 0
[junit4] 2> 1207335 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[4746 (1604387791503884289)]} 0 0
[junit4] 2> 1207335 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[602 (1604387791503884290)]} 0 0
[junit4] 2> 1207335 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{delete=[9005 (-1604387791503884291)]} 0 0
[junit4] 2> 1207336 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={versions=true&wt=json&indent=true}{add=[7527 (1604387791504932864)]} 0 0
[junit4] 2> 1207336 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1444948340
[junit4] 2> 1207336 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 1207336 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@7b75fd1: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@1767ff59
[junit4] 2> 1207342 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 1207342 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@48051dda: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@7be60008
[junit4] 2> 1207345 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 1207345 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1be9aa6a: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@252caaca
[junit4] 2> 1207345 INFO (coreCloseExecutor-4112-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@1413e870
[junit4] 2> 1207345 INFO (coreCloseExecutor-4112-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=1413e870
[junit4] 2> 1207345 INFO (coreCloseExecutor-4112-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@47d53230: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@4fba96c4
[junit4] 2> 1207375 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1/lib, /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1207417 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.5.0
[junit4] 2> 1207427 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.s.IndexSchema [null] Schema name=test
[junit4] 2> 1207514 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 1207918 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 1207918 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 1207932 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@48a034ba
[junit4] 2> 1207939 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@48a034ba
[junit4] 2> 1207939 INFO (TEST-TestRecovery.stressLogReplay-seed#[4527A15DE01C0C98]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@48a034ba
[junit4] 2> 1207955 INFO (coreLoadExecutor-4122-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1/lib, /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1207981 INFO (coreLoadExecutor-4122-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.5.0
[junit4] 2> 1208002 INFO (coreLoadExecutor-4122-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1208076 INFO (coreLoadExecutor-4122-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 1208081 INFO (coreLoadExecutor-4122-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1, trusted=true
[junit4] 2> 1208082 INFO (coreLoadExecutor-4122-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@48a034ba
[junit4] 2> 1208082 INFO (coreLoadExecutor-4122-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1208082 INFO (coreLoadExecutor-4122-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1], dataDir=[/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J1/temp/solr.search.TestRecovery_4527A15DE01C0C98-001/init-core-data-001/]
[junit4] 2> 1208084 WARN (coreLoadExecutor-4122-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> 1208140 INFO (coreLoadExecutor-4122-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.CdcrUpdateLog
[junit4] 2> 1208140 INFO (coreLoadExecutor-4122-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[juni
[...truncated too long message...]
mizedRunner.java:984)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
[junit4] 2> at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
[junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4] 2> at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
[junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
[junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
[junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 4) Thread[id=97, name=coreCloseExecutor-111-thread-1, state=RUNNABLE, group=TGRP-TestRecovery]
[junit4] 2> at java.lang.Thread.interrupt0(Native Method)
[junit4] 2> at java.lang.Thread.interrupt(Thread.java:926)
[junit4] 2> at org.apache.solr.common.util.ExecutorUtil.awaitTermination(ExecutorUtil.java:87)
[junit4] 2> at org.apache.solr.common.util.ExecutorUtil.shutdownAndAwaitTermination(ExecutorUtil.java:76)
[junit4] 2> at org.apache.solr.update.UpdateLog.close(UpdateLog.java:1371)
[junit4] 2> at org.apache.solr.update.CdcrUpdateLog.close(CdcrUpdateLog.java:478)
[junit4] 2> at org.apache.solr.update.UpdateLog.close(UpdateLog.java:1344)
[junit4] 2> at org.apache.solr.update.DirectUpdateHandler2.closeWriter(DirectUpdateHandler2.java:837)
[junit4] 2> at org.apache.solr.update.DefaultSolrCoreState.closeIndexWriter(DefaultSolrCoreState.java:105)
[junit4] 2> at org.apache.solr.update.DefaultSolrCoreState.close(DefaultSolrCoreState.java:399)
[junit4] 2> at org.apache.solr.update.SolrCoreState.decrefSolrCoreState(SolrCoreState.java:83)
[junit4] 2> at org.apache.solr.core.SolrCore.close(SolrCore.java:1572)
[junit4] 2> at org.apache.solr.core.SolrCores.lambda$close$0(SolrCores.java:141)
[junit4] 2> at org.apache.solr.core.SolrCores$$Lambda$240/2136207794.call(Unknown Source)
[junit4] 2> at java.util.concurrent.FutureTask.run(FutureTask.java:266)
[junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209)
[junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$$Lambda$124/309447555.run(Unknown Source)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {id=Lucene50(blocksize=128)}, docValues:{_version_=DocValuesFormat(name=Lucene70), val_i_dvo=DocValuesFormat(name=Direct)}, maxPointsInLeafNode=477, maxMBSortInHeap=5.348433849274998, sim=RandomSimilarity(queryNorm=true): {}, locale=sr-CS, timezone=America/Louisville
[junit4] 2> NOTE: SunOS 5.11 amd64/Oracle Corporation 1.8.0_172 (64-bit)/cpus=3,threads=5,free=34702688,total=97320960
[junit4] 2> NOTE: All tests run in this JVM: [TestRecovery]
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestRecovery -Dtests.seed=4527A15DE01C0C98 -Dtests.slow=true -Dtests.badapples=true -Dtests.locale=sr-CS -Dtests.timezone=America/Louisville -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] ERROR 0.00s J0 | TestRecovery (suite) <<<
[junit4] > Throwable #1: java.lang.Exception: Suite timeout exceeded (>= 7200000 msec).
[junit4] > at __randomizedtesting.SeedInfo.seed([4527A15DE01C0C98]:0)
[junit4] Completed [4/5 (2!)] on J0 in 7285.46s, 7 tests, 2 errors <<< FAILURES!
[junit4]
[junit4] Suite: org.apache.solr.search.TestRecovery
[junit4] Completed [5/5 (2!)] on J0 in 0.03s, 20 tests, 20 skipped
[junit4]
[junit4]
[junit4] Tests with failures [seed: 4527A15DE01C0C98]:
[junit4] - org.apache.solr.search.TestRecovery.testExistOldBufferLog
[junit4] - org.apache.solr.search.TestRecovery.testLogReplay
[junit4] - org.apache.solr.search.TestRecovery.testLogReplayWithReorderedDBQUpdateWithDifferentChildCount
[junit4] - org.apache.solr.search.TestRecovery.testExistOldBufferLog
[junit4] - org.apache.solr.search.TestRecovery (suite)
[junit4]
[junit4]
[junit4] JVM J0: 0.73 .. 7287.51 = 7286.79s
[junit4] JVM J1: 0.72 .. 287.59 = 286.87s
[junit4] Execution time total: 2 hours 1 minute 27 seconds
[junit4] Tests summary: 5 suites, 87 tests, 1 suite-level error, 3 errors, 1 failure, 20 ignored
BUILD FAILED
/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/common-build.xml:1568: The following error occurred while executing this line:
/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/common-build.xml:1092: There were test failures: 5 suites, 87 tests, 1 suite-level error, 3 errors, 1 failure, 20 ignored [seed: 4527A15DE01C0C98]
Total time: 121 minutes 29 seconds
[repro] Setting last failure code to 256
[repro] Failures:
[repro] 2/5 failed: org.apache.solr.search.TestRecovery
[repro] Exiting with code 256
+ mv lucene/build lucene/build.repro
+ mv solr/build solr/build.repro
+ mv lucene/build.orig lucene/build
+ mv solr/build.orig solr/build
Archiving artifacts
Setting ANT_1_8_2_HOME=/export/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
[WARNINGS] Parsing warnings in console log with parser Java Compiler (javac)
Setting ANT_1_8_2_HOME=/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=c0853200f20e3dd874e025418f6919fd913c5523, workspace=/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris
[WARNINGS] Computing warning deltas based on reference build #689
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