[JENKINS] Lucene » Lucene-Solr-Tests-8.9 - Build # 280 - Unstable!

[Apache Jenkins Server]

Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-Solr-Tests-8.9/280/

1 tests failed.
FAILED:  org.apache.solr.search.TestRecovery.stressLogReplay

Error Message:
mismatch: '49'!='50' @ response/numFound

Stack Trace:
java.lang.RuntimeException: mismatch: '49'!='50' @ response/numFound
        at 
__randomizedtesting.SeedInfo.seed([ECF06E1ACF02CADC:295E8DB31894DD9E]:0)
        at org.apache.solr.SolrTestCaseJ4.assertJQ(SolrTestCaseJ4.java:1109)
        at org.apache.solr.SolrTestCaseJ4.assertJQ(SolrTestCaseJ4.java:1058)
        at 
org.apache.solr.search.TestRecovery.stressLogReplay(TestRecovery.java:172)
        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:1750)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at org.junit.rules.RunRules.evaluate(RunRules.java:20)
        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 org.junit.rules.RunRules.evaluate(RunRules.java:20)
        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:947)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at org.junit.rules.RunRules.evaluate(RunRules.java:20)
        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 org.junit.rules.RunRules.evaluate(RunRules.java:20)
        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 13599 lines...]
   [junit4] Suite: org.apache.solr.search.TestRecovery
   [junit4]   2> 129497 INFO  
(SUITE-TestRecovery-seed#[ECF06E1ACF02CADC]-worker) [     ] o.a.s.SolrTestCase 
Setting 'solr.default.confdir' system property to test-framework derived value 
of 
'/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.9/solr/server/solr/configsets/_default/conf'
   [junit4]   2> 129497 INFO  
(SUITE-TestRecovery-seed#[ECF06E1ACF02CADC]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Created dataDir: 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.9/solr/build/solr-core/test/J3/temp/solr.search.TestRecovery_ECF06E1ACF02CADC-001/data-dir-14-001
   [junit4]   2> 129497 WARN  
(SUITE-TestRecovery-seed#[ECF06E1ACF02CADC]-worker) [     ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=33 numCloses=33
   [junit4]   2> 129497 INFO  
(SUITE-TestRecovery-seed#[ECF06E1ACF02CADC]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 129499 INFO  
(SUITE-TestRecovery-seed#[ECF06E1ACF02CADC]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: 
@org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
   [junit4]   2> 129499 INFO  
(SUITE-TestRecovery-seed#[ECF06E1ACF02CADC]-worker) [     ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 129681 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.SolrTestCaseJ4 ###Starting 
testLogReplayWithReorderedDBQByAsterixAndChildDocs
   [junit4]   2> 129682 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.SolrTestCaseJ4 updateLog impl=solr.CdcrUpdateLog
   [junit4]   2> 129682 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 129692 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.c.SolrResourceLoader Added 2 libs to classloader, from paths: 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.9/solr/core/src/test-files/solr/collection1/lib,
 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.9/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 129715 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.9.1
   [junit4]   2> 129717 WARN  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.c.SolrConfig solrconfig.xml: <jmx> is no longer supported, use 
solr.xml:/metrics/reporter section instead
   [junit4]   2> 129720 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.s.IndexSchema Schema name=test
   [junit4]   2> 129786 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 131032 WARN  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.c.CoreContainer Unable to create 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.9/solr/core/src/test-files/solr/userfiles].
  Features requiring this directory may fail.
   [junit4]   2>           => java.security.AccessControlException: access 
denied ("java.io.FilePermission" 
"/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.9/solr/core/src/test-files/solr/userfiles"
 "write")
   [junit4]   2>        at 
java.security.AccessControlContext.checkPermission(AccessControlContext.java:472)
   [junit4]   2> java.security.AccessControlException: access denied 
("java.io.FilePermission" 
"/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.9/solr/core/src/test-files/solr/userfiles"
 "write")
   [junit4]   2>        at 
java.security.AccessControlContext.checkPermission(AccessControlContext.java:472)
 ~[?:1.8.0_291]
   [junit4]   2>        at 
java.security.AccessController.checkPermission(AccessController.java:886) 
~[?:1.8.0_291]
   [junit4]   2>        at 
java.lang.SecurityManager.checkPermission(SecurityManager.java:549) 
~[?:1.8.0_291]
   [junit4]   2>        at 
java.lang.SecurityManager.checkWrite(SecurityManager.java:979) ~[?:1.8.0_291]
   [junit4]   2>        at sun.nio.fs.UnixPath.checkWrite(UnixPath.java:801) 
~[?:?]
   [junit4]   2>        at 
sun.nio.fs.UnixFileSystemProvider.createDirectory(UnixFileSystemProvider.java:376)
 ~[?:?]
   [junit4]   2>        at java.nio.file.Files.createDirectory(Files.java:674) 
~[?:1.8.0_291]
   [junit4]   2>        at 
java.nio.file.Files.createAndCheckIsDirectory(Files.java:781) ~[?:1.8.0_291]
   [junit4]   2>        at 
java.nio.file.Files.createDirectories(Files.java:727) ~[?:1.8.0_291]
   [junit4]   2>        at 
org.apache.solr.core.CoreContainer.<init>(CoreContainer.java:377) [java/:?]
   [junit4]   2>        at 
org.apache.solr.core.CoreContainer.<init>(CoreContainer.java:342) [java/:?]
   [junit4]   2>        at 
org.apache.solr.util.TestHarness.<init>(TestHarness.java:183) [java/:?]
   [junit4]   2>        at 
org.apache.solr.util.TestHarness.<init>(TestHarness.java:156) [java/:?]
   [junit4]   2>        at 
org.apache.solr.util.TestHarness.<init>(TestHarness.java:162) [java/:?]
   [junit4]   2>        at 
org.apache.solr.util.TestHarness.<init>(TestHarness.java:112) [java/:?]
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.createCore(SolrTestCaseJ4.java:812) [java/:?]
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:802) [java/:?]
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:663) [java/:?]
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:652) [java/:?]
   [junit4]   2>        at 
org.apache.solr.search.TestRecovery.beforeTest(TestRecovery.java:80) [test/:?]
   [junit4]   2>        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native 
Method) ~[?:1.8.0_291]
   [junit4]   2>        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) 
~[?:1.8.0_291]
   [junit4]   2>        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
 ~[?:1.8.0_291]
   [junit4]   2>        at java.lang.reflect.Method.invoke(Method.java:498) 
~[?:1.8.0_291]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:972)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at org.junit.rules.RunRules.evaluate(RunRules.java:20) 
[junit-4.13.1.jar:4.13.1]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
 [java/:?]
   [junit4]   2>        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
 [java/:?]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
 [java/:?]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
 [java/:?]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
 [java/:?]
   [junit4]   2>        at org.junit.rules.RunRules.evaluate(RunRules.java:20) 
[junit-4.13.1.jar:4.13.1]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at org.junit.rules.RunRules.evaluate(RunRules.java:20) 
[junit-4.13.1.jar:4.13.1]
   [junit4]   2>        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
 [java/:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
 [java/:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
 [java/:?]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
 [java/:?]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
 [java/:?]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
 [java/:?]
   [junit4]   2>        at org.junit.rules.RunRules.evaluate(RunRules.java:20) 
[junit-4.13.1.jar:4.13.1]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at java.lang.Thread.run(Thread.java:748) [?:1.8.0_291]
   [junit4]   2> 131033 WARN  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.f.DistribPackageStore Unable to create 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.9/solr/core/src/test-files/solr/filestore]
 directory in SOLR_HOME 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.9/solr/core/src/test-files/solr].
  Features requiring this directory may fail.
   [junit4]   2>           => java.security.AccessControlException: access 
denied ("java.io.FilePermission" 
"/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.9/solr/core/src/test-files/solr/filestore"
 "write")
   [junit4]   2>        at 
java.security.AccessControlContext.checkPermission(AccessControlContext.java:472)
   [junit4]   2> java.security.AccessControlException: access denied 
("java.io.FilePermission" 
"/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.9/solr/core/src/test-files/solr/filestore"
 "write")
   [junit4]   2>        at 
java.security.AccessControlContext.checkPermission(AccessControlContext.java:472)
 ~[?:1.8.0_291]
   [junit4]   2>        at 
java.security.AccessController.checkPermission(AccessController.java:886) 
~[?:1.8.0_291]
   [junit4]   2>        at 
java.lang.SecurityManager.checkPermission(SecurityManager.java:549) 
~[?:1.8.0_291]
   [junit4]   2>        at 
java.lang.SecurityManager.checkWrite(SecurityManager.java:979) ~[?:1.8.0_291]
   [junit4]   2>        at java.io.File.mkdir(File.java:1348) ~[?:1.8.0_291]
   [junit4]   2>        at java.io.File.mkdirs(File.java:1380) ~[?:1.8.0_291]
   [junit4]   2>        at 
org.apache.solr.filestore.DistribPackageStore.ensurePackageStoreDir(DistribPackageStore.java:561)
 [java/:?]
   [junit4]   2>        at 
org.apache.solr.filestore.DistribPackageStore.<init>(DistribPackageStore.java:81)
 [java/:?]
   [junit4]   2>        at 
org.apache.solr.filestore.PackageStoreAPI.<init>(PackageStoreAPI.java:78) 
[java/:?]
   [junit4]   2>        at 
org.apache.solr.core.CoreContainer.load(CoreContainer.java:678) [java/:?]
   [junit4]   2>        at 
org.apache.solr.util.TestHarness.<init>(TestHarness.java:184) [java/:?]
   [junit4]   2>        at 
org.apache.solr.util.TestHarness.<init>(TestHarness.java:156) [java/:?]
   [junit4]   2>        at 
org.apache.solr.util.TestHarness.<init>(TestHarness.java:162) [java/:?]
   [junit4]   2>        at 
org.apache.solr.util.TestHarness.<init>(TestHarness.java:112) [java/:?]
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.createCore(SolrTestCaseJ4.java:812) [java/:?]
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:802) [java/:?]
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:663) [java/:?]
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:652) [java/:?]
   [junit4]   2>        at 
org.apache.solr.search.TestRecovery.beforeTest(TestRecovery.java:80) [test/:?]
   [junit4]   2>        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native 
Method) ~[?:1.8.0_291]
   [junit4]   2>        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) 
~[?:1.8.0_291]
   [junit4]   2>        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
 ~[?:1.8.0_291]
   [junit4]   2>        at java.lang.reflect.Method.invoke(Method.java:498) 
~[?:1.8.0_291]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:972)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at org.junit.rules.RunRules.evaluate(RunRules.java:20) 
[junit-4.13.1.jar:4.13.1]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
 [java/:?]
   [junit4]   2>        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
 [java/:?]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
 [java/:?]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
 [java/:?]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
 [java/:?]
   [junit4]   2>        at org.junit.rules.RunRules.evaluate(RunRules.java:20) 
[junit-4.13.1.jar:4.13.1]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at org.junit.rules.RunRules.evaluate(RunRules.java:20) 
[junit-4.13.1.jar:4.13.1]
   [junit4]   2>        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
 [java/:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
 [java/:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
 [java/:?]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
 [java/:?]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
 [java/:?]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
 [java/:?]
   [junit4]   2>        at org.junit.rules.RunRules.evaluate(RunRules.java:20) 
[junit-4.13.1.jar:4.13.1]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at java.lang.Thread.run(Thread.java:748) [?:1.8.0_291]
   [junit4]   2> 131035 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 131037 WARN  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.e.j.u.s.S.config Trusting all certificates configured for 
Client@10f57a91[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 131037 WARN  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm 
configured for Client@10f57a91[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 131041 WARN  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.e.j.u.s.S.config Trusting all certificates configured for 
Client@4c290ad5[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 131041 WARN  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm 
configured for Client@4c290ad5[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 131042 WARN  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.c.CoreContainer Not all security plugins configured!  
authentication=disabled authorization=disabled.  Solr is only as secure as you 
make it. Consider configuring authentication/authorization before exposing Solr 
to users internal or external.  See https://s.apache.org/solrsecurity for more 
info
   [junit4]   2> 131069 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 
'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@62262f17
   [junit4]   2> 131076 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 
'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@62262f17
   [junit4]   2> 131076 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@62262f17
   [junit4]   2> 131078 INFO  (coreLoadExecutor-1095-thread-1) [     ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 131120 INFO  (coreLoadExecutor-1095-thread-1) [    
x:collection1 ] o.a.s.c.SolrResourceLoader Added 2 libs to classloader, from 
paths: 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.9/solr/core/src/test-files/solr/collection1/lib,
 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.9/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 131305 INFO  (coreLoadExecutor-1095-thread-1) [    
x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.9.1
   [junit4]   2> 131305 WARN  (coreLoadExecutor-1095-thread-1) [    
x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <jmx> is no longer 
supported, use solr.xml:/metrics/reporter section instead
   [junit4]   2> 131448 INFO  (coreLoadExecutor-1095-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema Schema name=test
   [junit4]   2> 131457 INFO  (coreLoadExecutor-1095-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field 
id
   [junit4]   2> 131470 INFO  (coreLoadExecutor-1095-thread-1) [    
x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from instancedir 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.9/solr/core/src/test-files/solr/collection1,
 trusted=true
   [junit4]   2> 131470 INFO  (coreLoadExecutor-1095-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@62262f17
   [junit4]   2> 131471 INFO  (coreLoadExecutor-1095-thread-1) [    
x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.9/solr/core/src/test-files/solr/collection1],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.9/solr/build/solr-core/test/J3/temp/solr.search.TestRecovery_ECF06E1ACF02CADC-001/data-dir-14-001/]
   [junit4]   2> 131477 INFO  (coreLoadExecutor-1095-thread-1) [    
x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=43, maxMergeAtOnceExplicit=42, maxMergedSegmentMB=45.89453125, 
floorSegmentMB=0.5458984375, forceMergeDeletesPctAllowed=5.006947369632168, 
segmentsPerTier=16.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0, 
deletesPctAllowed=24.447760479128064
   [junit4]   2> 131637 WARN  (coreLoadExecutor-1095-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> 131725 INFO  (coreLoadExecutor-1095-thread-1) [    
x:collection1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.CdcrUpdateLog
   [junit4]   2> 131725 INFO  (coreLoadExecutor-1095-thread-1) [    
x:collection1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 131726 INFO  (coreLoadExecutor-1095-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 131726 INFO  (coreLoadExecutor-1095-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 131727 INFO  (coreLoadExecutor-1095-thread-1) [    
x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=14, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=1.0]
   [junit4]   2> 131731 WARN  (coreLoadExecutor-1095-thread-1) [    
x:collection1 ] o.a.s.r.ManagedResourceStorage Cannot write to config directory 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.9/solr/core/src/test-files/solr/collection1/conf
 ; switching to use InMemory storage instead.
   [junit4]   2> 131732 INFO  (coreLoadExecutor-1095-thread-1) [    
x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 131732 INFO  (coreLoadExecutor-1095-thread-1) [    
x:collection1 ] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1706359978106814464
   [junit4]   2> 131735 INFO  
(searcherExecutor-1097-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 131736 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 131737 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.u.DirectUpdateHandler2 [collection1]  REMOVING ALL DOCUMENTS 
FROM INDEX
   [junit4]   2> 131739 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] 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 1
   [junit4]   2> 131755 INFO  
(searcherExecutor-1097-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 131756 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  
webapp=null path=null params={}{commit=} 0 16
   [junit4]   2> 131761 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[RDBQ2_1]} 
0 2
   [junit4]   2> 131762 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[RDBQ2_2 
(3)]} 0 0
   [junit4]   2> 131792 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null 
params={update.distrib=FROMLEADER&_version_=-2&wt=json&indent=true}{deleteByQuery=_root_:RDBQ2_1
 _root_:RDBQ2_2 id:RDBQ2_3 _root_:RDBQ2_4 (-2)} 0 29
   [junit4]   2> 131792 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.u.DirectUpdateHandler2 Reordered DBQs detected.  
Update=add{_version_=1,id=RDBQ2_3} DBQs=[DBQ{version=2,q=_root_:RDBQ2_1 
_root_:RDBQ2_2 id:RDBQ2_3 _root_:RDBQ2_4}]
   [junit4]   2> 131801 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[RDBQ2_3 
(1)]} 0 8
   [junit4]   2> 131802 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[RDBQ2_4 
(4)]} 0 0
   [junit4]   2> 131802 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&wt=xml} hits=0 status=0 QTime=0
   [junit4]   2> 131804 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1470203719
   [junit4]   2> 131804 INFO  (coreCloseExecutor-1103-thread-1) [     ] 
o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@238ebd39
   [junit4]   2> 131804 INFO  (coreCloseExecutor-1103-thread-1) [     ] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1 tag=SolrCore@238ebd39
   [junit4]   2> 131804 INFO  (coreCloseExecutor-1103-thread-1) [     ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@42c1245c: rootName = null, 
domain = solr.core.collection1, service url = null, agent id = null] for 
registry solr.core.collection1/com.codahale.metrics.MetricRegistry@67036ba5
   [junit4]   2> 131818 INFO  (coreCloseExecutor-1103-thread-1) [     ] 
o.a.s.u.TestInjection Inject failure: skipIndexWriterCommitOnClose=true: 
org.apache.solr.update.SolrIndexWriter@159d475b
   [junit4]   2> 131818 WARN  (coreCloseExecutor-1103-thread-1) [     ] 
o.a.s.u.DirectUpdateHandler2 Skipping commit for IndexWriter.close() due to 
TestInjection
   [junit4]   2> 131841 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.node tag=null
   [junit4]   2> 131841 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@304fb688: rootName = null, 
domain = solr.node, service url = null, agent id = null] for registry 
solr.node/com.codahale.metrics.MetricRegistry@34287ab1
   [junit4]   2> 131847 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.jvm tag=null
   [junit4]   2> 131847 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@7b227b14: rootName = null, 
domain = solr.jvm, service url = null, agent id = null] for registry 
solr.jvm/com.codahale.metrics.MetricRegistry@4722053d
   [junit4]   2> 131849 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.jetty tag=null
   [junit4]   2> 131849 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@58950107: rootName = null, 
domain = solr.jetty, service url = null, agent id = null] for registry 
solr.jetty/com.codahale.metrics.MetricRegistry@6f7f124a
   [junit4]   2> 131861 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.c.SolrResourceLoader Added 2 libs to classloader, from paths: 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.9/solr/core/src/test-files/solr/collection1/lib,
 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.9/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 131908 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.9.1
   [junit4]   2> 131908 WARN  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.c.SolrConfig solrconfig.xml: <jmx> is no longer supported, use 
solr.xml:/metrics/reporter section instead
   [junit4]   2> 131911 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.s.IndexSchema Schema name=test
   [junit4]   2> 131914 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 134943 WARN  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.c.CoreContainer Unable to create 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.9/solr/core/src/test-files/solr/userfiles].
  Features requiring this directory may fail.
   [junit4]   2>           => java.security.AccessControlException: access 
denied ("java.io.FilePermission" 
"/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.9/solr/core/src/test-files/solr/userfiles"
 "write")
   [junit4]   2>        at 
java.security.AccessControlContext.checkPermission(AccessControlContext.java:472)
   [junit4]   2> java.security.AccessControlException: access denied 
("java.io.FilePermission" 
"/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.9/solr/core/src/test-files/solr/userfiles"
 "write")
   [junit4]   2>        at 
java.security.AccessControlContext.checkPermission(AccessControlContext.java:472)
 ~[?:1.8.0_291]
   [junit4]   2>        at 
java.security.AccessController.checkPermission(AccessController.java:886) 
~[?:1.8.0_291]
   [junit4]   2>        at 
java.lang.SecurityManager.checkPermission(SecurityManager.java:549) 
~[?:1.8.0_291]
   [junit4]   2>        at 
java.lang.SecurityManager.checkWrite(SecurityManager.java:979) ~[?:1.8.0_291]
   [junit4]   2>        at sun.nio.fs.UnixPath.checkWrite(UnixPath.java:801) 
~[?:?]
   [junit4]   2>        at 
sun.nio.fs.UnixFileSystemProvider.createDirectory(UnixFileSystemProvider.java:376)
 ~[?:?]
   [junit4]   2>        at java.nio.file.Files.createDirectory(Files.java:674) 
~[?:1.8.0_291]
   [junit4]   2>        at 
java.nio.file.Files.createAndCheckIsDirectory(Files.java:781) ~[?:1.8.0_291]
   [junit4]   2>        at 
java.nio.file.Files.createDirectories(Files.java:727) ~[?:1.8.0_291]
   [junit4]   2>        at 
org.apache.solr.core.CoreContainer.<init>(CoreContainer.java:377) [java/:?]
   [junit4]   2>        at 
org.apache.solr.core.CoreContainer.<init>(CoreContainer.java:342) [java/:?]
   [junit4]   2>        at 
org.apache.solr.util.TestHarness.<init>(TestHarness.java:183) [java/:?]
   [junit4]   2>        at 
org.apache.solr.util.TestHarness.<init>(TestHarness.java:156) [java/:?]
   [junit4]   2>        at 
org.apache.solr.util.TestHarness.<init>(TestHarness.java:162) [java/:?]
   [junit4]   2>        at 
org.apache.solr.util.TestHarness.<init>(TestHarness.java:112) [java/:?]
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.createCore(SolrTestCaseJ4.java:812) [java/:?]
   [junit4]   2>        at 
org.apache.solr.search.TestRecovery.testLogReplayWithReorderedDBQWrapper(TestRecovery.java:512)
 [test/:?]
   [junit4]   2>        at 
org.apache.solr.search.TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs(TestRecovery.java:396)
 [test/:?]
   [junit4]   2>        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native 
Method) ~[?:1.8.0_291]
   [junit4]   2>        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) 
~[?:1.8.0_291]
   [junit4]   2>        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
 ~[?:1.8.0_291]
   [junit4]   2>        at java.lang.reflect.Method.invoke(Method.java:498) 
~[?:1.8.0_291]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at org.junit.rules.RunRules.evaluate(RunRules.java:20) 
[junit-4.13.1.jar:4.13.1]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
 [java/:?]
   [junit4]   2>        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
 [java/:?]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
 [java/:?]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
 [java/:?]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
 [java/:?]
   [junit4]   2>        at org.junit.rules.RunRules.evaluate(RunRules.java:20) 
[junit-4.13.1.jar:4.13.1]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at org.junit.rules.RunRules.evaluate(RunRules.java:20) 
[junit-4.13.1.jar:4.13.1]
   [junit4]   2>        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
 [java/:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
 [java/:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
 [java/:?]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
 [java/:?]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
 [java/:?]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
 [java/:?]
   [junit4]   2>        at org.junit.rules.RunRules.evaluate(RunRules.java:20) 
[junit-4.13.1.jar:4.13.1]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at java.lang.Thread.run(Thread.java:748) [?:1.8.0_291]
   [junit4]   2> 134945 WARN  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.f.DistribPackageStore Unable to create 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.9/solr/core/src/test-files/solr/filestore]
 directory in SOLR_HOME 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.9/solr/core/src/test-files/solr].
  Features requiring this directory may fail.
   [junit4]   2>           => java.security.AccessControlException: access 
denied ("java.io.FilePermission" 
"/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.9/solr/core/src/test-files/solr/filestore"
 "write")
   [junit4]   2>        at 
java.security.AccessControlContext.checkPermission(AccessControlContext.java:472)
   [junit4]   2> java.security.AccessControlException: access denied 
("java.io.FilePermission" 
"/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.9/solr/core/src/test-files/solr/filestore"
 "write")
   [junit4]   2>        at 
java.security.AccessControlContext.checkPermission(AccessControlContext.java:472)
 ~[?:1.8.0_291]
   [junit4]   2>        at 
java.security.AccessController.checkPermission(AccessController.java:886) 
~[?:1.8.0_291]
   [junit4]   2>        at 
java.lang.SecurityManager.checkPermission(SecurityManager.java:549) 
~[?:1.8.0_291]
   [junit4]   2>        at 
java.lang.SecurityManager.checkWrite(SecurityManager.java:979) ~[?:1.8.0_291]
   [junit4]   2>        at java.io.File.mkdir(File.java:1348) ~[?:1.8.0_291]
   [junit4]   2>        at java.io.File.mkdirs(File.java:1380) ~[?:1.8.0_291]
   [junit4]   2>        at 
org.apache.solr.filestore.DistribPackageStore.ensurePackageStoreDir(DistribPackageStore.java:561)
 [java/:?]
   [junit4]   2>        at 
org.apache.solr.filestore.DistribPackageStore.<init>(DistribPackageStore.java:81)
 [java/:?]
   [junit4]   2>        at 
org.apache.solr.filestore.PackageStoreAPI.<init>(PackageStoreAPI.java:78) 
[java/:?]
   [junit4]   2>        at 
org.apache.solr.core.CoreContainer.load(CoreContainer.java:678) [java/:?]
   [junit4]   2>        at 
org.apache.solr.util.TestHarness.<init>(TestHarness.java:184) [java/:?]
   [junit4]   2>        at 
org.apache.solr.util.TestHarness.<init>(TestHarness.java:156) [java/:?]
   [junit4]   2>        at 
org.apache.solr.util.TestHarness.<init>(TestHarness.java:162) [java/:?]
   [junit4]   2>        at 
org.apache.solr.util.TestHarness.<init>(TestHarness.java:112) [java/:?]
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.createCore(SolrTestCaseJ4.java:812) [java/:?]
   [junit4]   2>        at 
org.apache.solr.search.TestRecovery.testLogReplayWithReorderedDBQWrapper(TestRecovery.java:512)
 [test/:?]
   [junit4]   2>        at 
org.apache.solr.search.TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs(TestRecovery.java:396)
 [test/:?]
   [junit4]   2>        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native 
Method) ~[?:1.8.0_291]
   [junit4]   2>        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) 
~[?:1.8.0_291]
   [junit4]   2>        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
 ~[?:1.8.0_291]
   [junit4]   2>        at java.lang.reflect.Method.invoke(Method.java:498) 
~[?:1.8.0_291]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at org.junit.rules.RunRules.evaluate(RunRules.java:20) 
[junit-4.13.1.jar:4.13.1]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
 [java/:?]
   [junit4]   2>        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
 [java/:?]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
 [java/:?]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
 [java/:?]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
 [java/:?]
   [junit4]   2>        at org.junit.rules.RunRules.evaluate(RunRules.java:20) 
[junit-4.13.1.jar:4.13.1]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at org.junit.rules.RunRules.evaluate(RunRules.java:20) 
[junit-4.13.1.jar:4.13.1]
   [junit4]   2>        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
 [java/:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
 [java/:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
 [java/:?]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
 [java/:?]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
 [java/:?]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
 [java/:?]
   [junit4]   2>        at org.junit.rules.RunRules.evaluate(RunRules.java:20) 
[junit-4.13.1.jar:4.13.1]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at java.lang.Thread.run(Thread.java:748) [?:1.8.0_291]
   [junit4]   2> 135070 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 135072 WARN  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.e.j.u.s.S.config Trusting all certificates configured for 
Client@65ac2ecc[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 135072 WARN  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm 
configured for Client@65ac2ecc[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 135079 WARN  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.e.j.u.s.S.config Trusting all certificates configured for 
Client@2c9e1113[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 135079 WARN  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm 
configured for Client@2c9e1113[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 135080 WARN  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.c.CoreContainer Not all security plugins configured!  
authentication=disabled authorization=disabled.  Solr is only as secure as you 
make it. Consider configuring authentication/authorization before exposing Solr 
to users internal or external.  See https://s.apache.org/solrsecurity for more 
info
   [junit4]   2> 135119 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 
'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@62262f17
   [junit4]   2> 135126 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 
'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@62262f17
   [junit4]   2> 135127 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@62262f17
   [junit4]   2> 135135 INFO  (coreLoadExecutor-1115-thread-1) [     ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 135145 INFO  (coreLoadExecutor-1115-thread-1) [    
x:collection1 ] o.a.s.c.SolrResourceLoader Added 2 libs to classloader, from 
paths: 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.9/solr/core/src/test-files/solr/collection1/lib,
 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.9/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 135162 INFO  (coreLoadExecutor-1115-thread-1) [    
x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.9.1
   [junit4]   2> 135163 WARN  (coreLoadExecutor-1115-thread-1) [    
x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <jmx> is no longer 
supported, use solr.xml:/metrics/reporter section instead
   [junit4]   2> 135166 INFO  (coreLoadExecutor-1115-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema Schema name=test
   [junit4]   2> 135172 INFO  (coreLoadExecutor-1115-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field 
id
   [junit4]   2> 135182 INFO  (coreLoadExecutor-1115-thread-1) [    
x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from instancedir 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.9/solr/core/src/test-files/solr/collection1,
 trusted=true
   [junit4]   2> 135182 INFO  (coreLoadExecutor-1115-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@62262f17
   [junit4]   2> 135183 INFO  (coreLoadExecutor-1115-thread-1) [    
x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.9/solr/core/src/test-files/solr/collection1],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.9/solr/build/solr-core/test/J3/temp/solr.search.TestRecovery_ECF06E1ACF02CADC-001/data-dir-14-001/]
   [junit4]   2> 135186 WARN  (coreLoadExecutor-1115-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> 135341 INFO  (coreLoadExecutor-1115-thread-1) [    
x:collection1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.CdcrUpdateLog
   [junit4]   2> 135341 INFO  (coreLoadExecutor-1115-thread-1) [    
x:collection1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 135343 INFO  (coreLoadExecutor-1115-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 135343 INFO  (coreLoadExecutor-1115-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 135344 INFO  (coreLoadExecutor-1115-thread-1) [    
x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=43, maxMergeAtOnceExplicit=42, maxMergedSegmentMB=45.89453125, 
floorSegmentMB=0.5458984375, forceMergeDeletesPctAllowed=5.006947369632168, 
segmentsPerTier=16.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0, 
deletesPctAllowed=24.447760479128064
   [junit4]   2> 135347 WARN  (coreLoadExecutor-1115-thread-1) [    
x:collection1 ] o.a.s.r.ManagedResourceStorage Cannot write to config directory 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.9/solr/core/src/test-files/solr/collection1/conf
 ; switching to use InMemory storage instead.
   [junit4]   2> 135348 INFO  (coreLoadExecutor-1115-thread-1) [    
x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 135350 INFO  
(searcherExecutor-1117-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 135357 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&wt=xml} hits=0 status=0 QTime=0
   [junit4]   2> 135357 WARN  
(recoveryExecutor-1119-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.u.UpdateLog Starting log replay 
tlog{file=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.9/solr/build/solr-core/test/J3/temp/solr.search.TestRecovery_ECF06E1ACF02CADC-001/data-dir-14-001/tlog/tlog.0000000000000000001.0
 refcount=1}  active=false starting pos=0 inSortedOrder=false
   [junit4]   2> 135631 INFO  
(replayUpdatesExecutor-1108-thread-1-processing-x:collection1) [    
x:collection1 ] o.a.s.u.DirectUpdateHandler2 Reordered DBQs detected.  
Update=add{flags=a,_version_=1,id=RDBQ2_3} DBQs=[DBQ{version=2,q=_root_:RDBQ2_1 
_root_:RDBQ2_2 id:RDBQ2_3 _root_:RDBQ2_4}]
   [junit4]   2> 135987 INFO  
(searcherExecutor-1117-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 135988 INFO  
(recoveryExecutor-1119-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[RDBQ2_1, RDBQ2_2 (3), 
RDBQ2_3 (1), RDBQ2_4 (4)],deleteByQuery=_root_:RDBQ2_1 _root_:RDBQ2_2 
id:RDBQ2_3 _root_:RDBQ2_4 (-2)} 0 630
   [junit4]   2> 135989 WARN  
(recoveryExecutor-1119-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.u.UpdateLog Log replay finished. recoveryInfo=RecoveryInfo{adds=4 
deletes=0 deleteByQuery=1 errors=0 positionOfStart=0}
   [junit4]   2> 135989 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&wt=xml} hits=6 status=0 QTime=0
   [junit4]   2> 135990 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> 135990 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1215682944
   [junit4]   2> 135991 INFO  (coreCloseExecutor-1123-thread-1) [     ] 
o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@536350b1
   [junit4]   2> 135991 INFO  (coreCloseExecutor-1123-thread-1) [     ] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1 tag=SolrCore@536350b1
   [junit4]   2> 135991 INFO  (coreCloseExecutor-1123-thread-1) [     ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@b236dde: rootName = null, 
domain = solr.core.collection1, service url = null, agent id = null] for 
registry solr.core.collection1/com.codahale.metrics.MetricRegistry@75df52dd
   [junit4]   2> 136005 INFO  (coreCloseExecutor-1123-thread-1) [     ] 
o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close()  ... SKIPPED 
(unnecessary).
   [junit4]   2> 136319 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.node tag=null
   [junit4]   2> 136319 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@3fa37cad: rootName = null, 
domain = solr.node, service url = null, agent id = null] for registry 
solr.node/com.codahale.metrics.MetricRegistry@3f4dcacf
   [junit4]   2> 136325 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.jvm tag=null
   [junit4]   2> 136325 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@597c8317: rootName = null, 
domain = solr.jvm, service url = null, agent id = null] for registry 
solr.jvm/com.codahale.metrics.MetricRegistry@4722053d
   [junit4]   2> 136328 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.jetty tag=null
   [junit4]   2> 136328 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@5ea15d20: rootName = null, 
domain = solr.jetty, service url = null, agent id = null] for registry 
solr.jetty/com.codahale.metrics.MetricRegistry@6f7f124a
   [junit4]   2> 136339 INFO  
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.SolrTestCaseJ4 ###Ending 
testLogReplayWithReorderedDBQByAsterixAndChildDocs
   [junit4]   2> 136343 INFO  
(TEST-TestRecovery.testVersionsOnRestart-seed#[ECF06E1ACF02CADC]) [     ] 
o.a.s.SolrTestCaseJ4 ###Starting testVersionsOnRestart
   [junit4]   2> 136343 INFO  
(TEST-TestRecovery.testVersionsOnRestart-seed#[ECF06E1ACF02CADC]) [     ] 
o.a.s.SolrTestCaseJ4 updateLog impl=solr.UpdateLog
   [junit4]   2> 136343 INFO  
(TEST-TestRecovery.testVersionsOnRestart-seed#[ECF06E1ACF02CADC]) [     ] 
o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 136352 INFO  
(TEST-TestRecovery.testVersionsOnRestart-seed#[ECF06E1ACF02CADC]) [     ] 
o.a.s.c.SolrResourceLoader Added 2 libs to classloader, from paths: 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.9/solr/core/src/test-files/solr/collection1/lib,
 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.9/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 136372 INFO  
(TEST-TestRecovery.testVersionsOnRestart-seed#[ECF06E1ACF02CADC]) [     ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.9.1
   [junit4]   2> 136372 WARN  
(TEST-TestRecovery.testVersionsOnRestart-seed#[ECF06E1ACF02CADC]) [     ] 
o.a.s.c.SolrConfig solrconfig.xml: <jmx> is no longer supported, use 
solr.xml:/metrics/reporter section instead
   [junit4]   2> 136373 INFO  
(TEST-TestRecovery.testVersionsOnRestart-seed#[ECF06E1ACF02CADC]) [     ] 
o.a.s.SolrTestCaseJ4 Created dataDir: 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.9/solr/build/solr-core/test/J3/temp/solr.search.TestRecovery_ECF06E1ACF02CADC-001/data-dir-15-001
   [junit4]   2> 136375 INFO  
(TEST-TestRecovery.testVersionsOnRestart-seed#[ECF06E1ACF02CADC]) [     ] 
o.a.s.s.IndexSchema Schema name=test
   [junit4]   2> 136378 INFO  
(TEST-TestRecovery.testVersionsOnRestart-seed#[ECF06E1ACF02CADC]) [     ] 
o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 137235 WARN  
(TEST-TestRecovery.testVersionsOnRestart-seed#[ECF06E1ACF02CADC]) [     ] 
o.a.s.c.CoreContainer Unable to create 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.9/solr/core/src/test-files/solr/userfiles].
  Features requiring this directory may fail.
   [junit4]   2>           => java.security.AccessControlException: access 
denied ("java.io.FilePermission" 
"/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.9/solr/core/src/test-files/solr/userfiles"
 "write")
   [junit4]   2>        at 
java.security.AccessControlContext.checkPermission(AccessControlContext.java:472)
   [junit4]   2> java.security.AccessControlException: access denied 
("java.io.FilePermission" 
"/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.9/solr/core/src/test-files/solr/userfiles"
 "write")
   [junit4]   2>        at 
java.security.AccessControlContext.checkPermission(AccessControlContext.java:472)
 ~[?:1.8.0_291]
   [junit4]   2>        at 
java.security.AccessController.checkPermission(AccessController.java:886) 
~[?:1.8.0_291]
   [junit4]   2>        at 
java.lang.SecurityManager.checkPermission(SecurityManager.java:549) 
~[?:1.8.0_291]
   [junit4]   2>        at 
java.lang.SecurityManager.checkWrite(SecurityManager.java:979) ~[?:1.8.0_291]
   [junit4]   2>        at sun.nio.fs.UnixPath.checkWrite(UnixPath.java:801) 
~[?:?]
   [junit4]   2>        at 
sun.nio.fs.UnixFileSystemProvider.createDirectory(UnixFileSystemProvider.java:376)
 ~[?:?]
   [junit4]   2>        at java.nio.file.Files.createDirectory(Files.java:674) 
~[?:1.8.0_291]
   [junit4]   2>        at 
java.nio.file.Files.createAndCheckIsDirectory(Files.java:781) ~[?:1.8.0_291]
   [junit4]   2>        at 
java.nio.file.Files.createDirectories(Files.java:727) ~[?:1.8.0_291]
   [junit4]   2>        at 
org.apache.solr.core.CoreContainer.<init>(CoreContainer.java:377) [java/:?]
   [junit4]   2>        at 
org.apache.solr.core.CoreContainer.<init>(CoreContainer.java:342) [java/:?]
   [junit4]   2>        at 
org.apache.solr.util.TestHarness.<init>(TestHarness.java:183) [java/:?]
   [junit4]   2>        at 
org.apache.solr.util.TestHarness.<init>(TestHarness.java:156) [java/:?]
   [junit4]   2>        at 
org.apache.solr.util.TestHarness.<init>(TestHarness.java:162) [java/:?]
   [junit4]   2>        at 
org.apache.solr.util.TestHarness.<init>(TestHarness.java:112) [java/:?]
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.createCore(SolrTestCaseJ4.java:812) [java/:?]
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:802) [java/:?]
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:663) [java/:?]
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:652) [java/:?]
   [junit4]   2>        at 
org.apache.solr.search.TestRecovery.beforeTest(TestRecovery.java:80) [test/:?]
   [junit4]   2>        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native 
Method) ~[?:1.8.0_291]
   [junit4]   2>        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) 
~[?:1.8.0_291]
   [junit4]   2>        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
 ~[?:1.8.0_291]
   [junit4]   2>        at java.lang.reflect.Method.invoke(Method.java:498) 
~[?:1.8.0_291]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:972)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at org.junit.rules.RunRules.evaluate(RunRules.java:20) 
[junit-4.13.1.jar:4.13.1]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
 [java/:?]
   [junit4]   2>        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
 [java/:?]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
 [java/:?]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
 [java/:?]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
 [java/:?]
   [junit4]   2>        at org.junit.rules.RunRules.evaluate(RunRules.java:20) 
[junit-4.13.1.jar:4.13.1]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at org.junit.rules.RunRules.evaluate(RunRules.java:20) 
[junit-4.13.1.jar:4.13.1]
   [junit4]   2>        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
 [java/:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
 [java/:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
 [java/:?]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
 [java/:?]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
 [java/:?]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
 [java/:?]
   [junit4]   2>        at org.junit.rules.RunRules.evaluate(RunRules.java:20) 
[junit-4.13.1.jar:4.13.1]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at java.lang.Thread.run(Thread.java:748) [?:1.8.0_291]
   [junit4]   2> 137237 WARN  
(TEST-TestRecovery.testVersionsOnRestart-seed#[ECF06E1ACF02CADC]) [     ] 
o.a.s.f.DistribPackageStore Unable to create 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.9/solr/core/src/test-files/solr/filestore]
 directory in SOLR_HOME 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.9/solr/core/src/test-files/solr].
  Features requiring this directory may fail.
   [junit4]   2>           => java.security.AccessControlException: access 
denied ("java.io.FilePermission" 
"/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.9/solr/core/src/test-files/solr/filestore"
 "write")
   [junit4]   2>        at 
java.security.AccessControlContext.checkPermission(AccessControlContext.java:472)
   [junit4]   2> java.security.AccessControlException: access denied 
("java.io.FilePermission" 
"/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.9/solr/core/src/test-files/solr/filestore"
 "write")
   [junit4]   2>        at 
java.security.AccessControlContext.checkPermission(AccessControlContext.java:472)
 ~[?:1.8.0_291]
   [junit4]   2>        at 
java.security.AccessController.checkPermission(AccessController.java:886) 
~[?:1.8.0_291]
   [junit4]   2>        at 
java.lang.SecurityManager.checkPermission(SecurityManager.java:549) 
~[?:1.8.0_291]
   [junit4]   2>        at 
java.lang.SecurityManager.checkWrite(SecurityManager.java:979) ~[?:1.8.0_291]
   [junit4]   2>        at java.io.File.mkdir(File.java:1348) ~[?:1.8.0_291]
   [junit4]   2>        at java.io.File.mkdirs(File.java:1380) ~[?:1.8.0_291]
   [junit4]   2>        at 
org.apache.solr.filestore.DistribPackageStore.ensurePackageStoreDir(DistribPackageStore.java:561)
 [java/:?]
   [junit4]   2>        at 
org.apache.solr.filestore.DistribPackageStore.<init>(DistribPackageStore.java:81)
 [java/:?]
   [junit4]   2>        at 
org.apache.solr.filestore.PackageStoreAPI.<init>(PackageStoreAPI.java:78) 
[java/:?]
   [junit4]   2>        at 
org.apache.solr.core.CoreContainer.load(CoreContainer.java:678) [java/:?]
   [junit4]   2>        at 
org.apache.solr.util.TestHarness.<init>(TestHarness.java:184) [java/:?]
   [junit4]   2>        at 
org.apache.solr.util.TestHarness.<init>(TestHarness.java:156) [java/:?]
   [junit4]   2>        at 
org.apache.solr.util.TestHarness.<init>(TestHarness.java:162) [java/:?]
   [junit4]   2>        at 
org.apache.solr.util.TestHarness.<init>(TestHarness.java:112) [java/:?]
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.createCore(SolrTestCaseJ4.java:812) [java/:?]
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:802) [java/:?]
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:663) [java/:?]
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:652) [java/:?]
   [junit4]   2>        at 
org.apache.solr.search.TestRecovery.beforeTest(TestRecovery.java:80) [test/:?]
   [junit4]   2>        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native 
Method) ~[?:1.8.0_291]
   [junit4]   2>        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) 
~[?:1.8.0_291]
   [junit4]   2>        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
 ~[?:1.8.0_291]
   [junit4]   2>        at java.lang.reflect.Method.invoke(Method.java:498) 
~[?:1.8.0_291]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:972)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at org.junit.rules.RunRules.evaluate(RunRules.java:20) 
[junit-4.13.1.jar:4.13.1]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
 [java/:?]
   [junit4]   2>        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
 [java/:?]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
 [java/:?]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
 [java/:?]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
 [java/:?]
   [junit4]   2>        at org.junit.rules.RunRules.evaluate(RunRules.java:20) 
[junit-4.13.1.jar:4.13.1]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at org.junit.rules.RunRules.evaluate(RunRules.java:20) 
[junit-4.13.1.jar:4.13.1]
   [junit4]   2>        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
 [java/:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
 [java/:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
 [java/:?]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
 [java/:?]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
 [java/:?]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
 [java/:?]
   [junit4]   2>        at org.junit.rules.RunRules.evaluate(RunRules.java:20) 
[junit-4.13.1.jar:4.13.1]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at java.lang.Thread.run(Thread.java:748) [?:1.8.0_291]
   [junit4]   2> 137238 INFO  
(TEST-TestRecovery.testVersionsOnRestart-seed#[ECF06E1ACF02CADC]) [     ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 137239 WARN  
(TEST-TestRecovery.testVersionsOnRestart-seed#[ECF06E1ACF02CADC]) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@117477b0[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 137239 WARN  
(TEST-TestRecovery.testVersionsOnRestart-seed#[ECF06E1ACF02CADC]) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@117477b0[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 137243 WARN  
(TEST-TestRecovery.testVersionsOnRestart-seed#[ECF06E1ACF02CADC]) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@76383b27[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 137243 WARN  
(TEST-TestRecovery.testVersionsOnRestart-seed#[ECF06E1ACF02CADC]) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@76383b27[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 137245 WARN  
(TEST-TestRecovery.testVersionsOnRestart-seed#[ECF06E1ACF02CADC]) [     ] 
o.a.s.c.CoreContainer Not all security plugins configured!  
authentication=disabled authorization=disabled.  Solr is only as secure as you 
make it. Consider configuring authentication/authorization before exposing Solr 
to users internal or external.  See https://s.apache.org/solrsecurity for more 
info
   [junit4]   2> 137274 INFO  
(TEST-TestRecovery.testVersionsOnRestart-seed#[ECF06E1ACF02CADC]) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@62262f17
 

[...truncated too long message...]

  x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=43, maxMergeAtOnceExplicit=42, maxMergedSegmentMB=45.89453125, 
floorSegmentMB=0.5458984375, forceMergeDeletesPctAllowed=5.006947369632168, 
segmentsPerTier=16.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0, 
deletesPctAllowed=24.447760479128064
   [junit4]   2> 219881 WARN  (coreLoadExecutor-1980-thread-1) [    
x:collection1 ] o.a.s.r.ManagedResourceStorage Cannot write to config directory 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.9/solr/core/src/test-files/solr/collection1/conf
 ; switching to use InMemory storage instead.
   [junit4]   2> 219881 INFO  (coreLoadExecutor-1980-thread-1) [    
x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 219883 WARN  
(recoveryExecutor-1984-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.u.UpdateLog Starting log replay 
tlog{file=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.9/solr/build/solr-core/test/J3/temp/solr.search.TestRecovery_ECF06E1ACF02CADC-001/data-dir-33-001/tlog/tlog.0000000000000000001
 refcount=2}  active=false starting pos=0 inSortedOrder=false
   [junit4]   2> 219884 INFO  
(searcherExecutor-1982-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 219884 INFO  
(TEST-TestRecovery.testNewDBQAndDocMatchingOldDBQDuringLogReplay-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&wt=xml} hits=0 status=0 QTime=0
   [junit4]   2> 219886 INFO  
(TEST-TestRecovery.testNewDBQAndDocMatchingOldDBQDuringLogReplay-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={wt=json&indent=true}{deleteByQuery=id:B2 OR id:B4 
(-1706360070540886016)} 0 1
   [junit4]   2> 219886 INFO  
(replayUpdatesExecutor-1973-thread-1-processing-x:collection1) [    
x:collection1 ] o.a.s.u.DirectUpdateHandler2 Reordered DBQs detected.  
Update=add{flags=a,_version_=1706360069704122368,id=B0} 
DBQs=[DBQ{version=1706360070540886016,q=id:B2 OR id:B4}]
   [junit4]   2> 219899 INFO  
(TEST-TestRecovery.testNewDBQAndDocMatchingOldDBQDuringLogReplay-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={wt=json&indent=true}{add=[B6 (1706360070542983168)]} 0 12
   [junit4]   2> 219899 INFO  
(replayUpdatesExecutor-1973-thread-1-processing-x:collection1) [    
x:collection1 ] o.a.s.u.DirectUpdateHandler2 Reordered DBQs detected.  
Update=add{flags=a,_version_=1706360069705170944,id=B1} 
DBQs=[DBQ{version=1706360070540886016,q=id:B2 OR id:B4}]
   [junit4]   2> 219899 INFO  
(TEST-TestRecovery.testNewDBQAndDocMatchingOldDBQDuringLogReplay-seed#[ECF06E1ACF02CADC])
 [    x:collection1 ] o.a.s.u.p.DistributedUpdateProcessor Ignoring commit 
while not ACTIVE - state: REPLAYING replay: false
   [junit4]   2> 219899 INFO  
(TEST-TestRecovery.testNewDBQAndDocMatchingOldDBQDuringLogReplay-seed#[ECF06E1ACF02CADC])
 [    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  
webapp=null path=null params={}{commit=} 0 0
   [junit4]   2> 219909 INFO  
(replayUpdatesExecutor-1973-thread-1-processing-x:collection1) [    
x:collection1 ] o.a.s.u.DirectUpdateHandler2 Reordered DBQs detected.  
Update=add{flags=a,_version_=1706360069705170945,id=B2} 
DBQs=[DBQ{version=1706360070540886016,q=id:B2 OR id:B4}]
   [junit4]   2> 220136 INFO  
(replayUpdatesExecutor-1973-thread-1-processing-x:collection1) [    
x:collection1 ] o.a.s.u.DirectUpdateHandler2 Reordered DBQs detected.  
Update=add{flags=a,_version_=1706360069714608128,id=B3} 
DBQs=[DBQ{version=1706360070540886016,q=id:B2 OR id:B4}]
   [junit4]   2> 220142 INFO  
(replayUpdatesExecutor-1973-thread-1-processing-x:collection1) [    
x:collection1 ] o.a.s.u.DirectUpdateHandler2 Reordered DBQs detected.  
Update=add{flags=a,_version_=1706360069715656704,id=B4} 
DBQs=[DBQ{version=1706360070540886016,q=id:B2 OR id:B4}]
   [junit4]   2> 220148 INFO  
(replayUpdatesExecutor-1973-thread-1-processing-x:collection1) [    
x:collection1 ] o.a.s.u.DirectUpdateHandler2 Reordered DBQs detected.  
Update=add{flags=a,_version_=1706360069715656705,id=B5} 
DBQs=[DBQ{version=1706360070540886016,q=id:B2 OR id:B4}]
   [junit4]   2> 220527 INFO  
(searcherExecutor-1982-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 220528 INFO  
(recoveryExecutor-1984-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[B0 
(1706360069704122368), B1 (1706360069705170944), B2 (1706360069705170945), B3 
(1706360069714608128), B4 (1706360069715656704), B5 
(1706360069715656705)],deleteByQuery=id:B1 OR id:B3 OR id:B6 
(-1706360069705170946)} 0 644
   [junit4]   2> 220528 WARN  
(recoveryExecutor-1984-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.u.UpdateLog Log replay finished. recoveryInfo=RecoveryInfo{adds=6 
deletes=0 deleteByQuery=1 errors=0 positionOfStart=0}
   [junit4]   2> 220528 INFO  
(TEST-TestRecovery.testNewDBQAndDocMatchingOldDBQDuringLogReplay-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&fl=id&sort=id+asc&wt=xml} hits=4 status=0 QTime=0
   [junit4]   2> 220529 INFO  
(TEST-TestRecovery.testNewDBQAndDocMatchingOldDBQDuringLogReplay-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> 220529 INFO  
(TEST-TestRecovery.testNewDBQAndDocMatchingOldDBQDuringLogReplay-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1458927799
   [junit4]   2> 220530 INFO  (coreCloseExecutor-1988-thread-1) [     ] 
o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@4a6d881f
   [junit4]   2> 220531 INFO  (coreCloseExecutor-1988-thread-1) [     ] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1 tag=SolrCore@4a6d881f
   [junit4]   2> 220531 INFO  (coreCloseExecutor-1988-thread-1) [     ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@7bda4cc: rootName = null, 
domain = solr.core.collection1, service url = null, agent id = null] for 
registry solr.core.collection1/com.codahale.metrics.MetricRegistry@6fdbe81a
   [junit4]   2> 220543 INFO  (coreCloseExecutor-1988-thread-1) [     ] 
o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close()  ... SKIPPED 
(unnecessary).
   [junit4]   2> 220554 INFO  
(TEST-TestRecovery.testNewDBQAndDocMatchingOldDBQDuringLogReplay-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.node tag=null
   [junit4]   2> 220554 INFO  
(TEST-TestRecovery.testNewDBQAndDocMatchingOldDBQDuringLogReplay-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@51d03bb2: rootName = null, 
domain = solr.node, service url = null, agent id = null] for registry 
solr.node/com.codahale.metrics.MetricRegistry@73d26c61
   [junit4]   2> 220560 INFO  
(TEST-TestRecovery.testNewDBQAndDocMatchingOldDBQDuringLogReplay-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.jvm tag=null
   [junit4]   2> 220560 INFO  
(TEST-TestRecovery.testNewDBQAndDocMatchingOldDBQDuringLogReplay-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@456e8d2c: rootName = null, 
domain = solr.jvm, service url = null, agent id = null] for registry 
solr.jvm/com.codahale.metrics.MetricRegistry@4722053d
   [junit4]   2> 220562 INFO  
(TEST-TestRecovery.testNewDBQAndDocMatchingOldDBQDuringLogReplay-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.jetty tag=null
   [junit4]   2> 220562 INFO  
(TEST-TestRecovery.testNewDBQAndDocMatchingOldDBQDuringLogReplay-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@3d749d21: rootName = null, 
domain = solr.jetty, service url = null, agent id = null] for registry 
solr.jetty/com.codahale.metrics.MetricRegistry@6f7f124a
   [junit4]   2> 220563 INFO  
(TEST-TestRecovery.testNewDBQAndDocMatchingOldDBQDuringLogReplay-seed#[ECF06E1ACF02CADC])
 [     ] o.a.s.SolrTestCaseJ4 ###Ending 
testNewDBQAndDocMatchingOldDBQDuringLogReplay
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.9/solr/build/solr-core/test/J3/temp/solr.search.TestRecovery_ECF06E1ACF02CADC-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene87): 
{_root_=PostingsFormat(name=Asserting), 
id=PostingsFormat(name=LuceneVarGapFixedInterval)}, 
docValues:{_version_=DocValuesFormat(name=Asserting), 
val_i_dvo=DocValuesFormat(name=Lucene80)}, maxPointsInLeafNode=2034, 
maxMBSortInHeap=7.831956573577312, 
sim=Asserting(RandomSimilarity(queryNorm=false): {}), locale=mt-MT, 
timezone=Europe/Bucharest
   [junit4]   2> NOTE: Linux 4.15.0-147-generic amd64/Oracle Corporation 
1.8.0_291 (64-bit)/cpus=4,threads=1,free=242840752,total=446693376
   [junit4]   2> NOTE: All tests run in this JVM: [TestSolrCLIRunExample, 
ScriptEngineTest, TestSolrFieldCacheBean, CloudExitableDirectoryReaderTest, 
HdfsRecoveryZkTest, ClassificationUpdateProcessorIntegrationTest, 
SolrSlf4jReporterTest, TestDFISimilarityFactory, 
TestPerFieldSimilarityWithDefaultOverride, TokenizerChainTest, 
TestLMJelinekMercerSimilarityFactory, TestSchemaField, TestFastLRUCache, 
TestBlendedInfixSuggestions, BasicAuthStandaloneTest, TestCoreContainer, 
TestRecovery]
   [junit4] Completed [79/939 (1!)] on J3 in 91.18s, 20 tests, 1 error <<< 
FAILURES!

[...truncated 55415 lines...]

---------------------------------------------------------------------
To unsubscribe, e-mail: builds-unsubscr...@lucene.apache.org
For additional commands, e-mail: builds-h...@lucene.apache.org