[JENKINS] Lucene » Lucene-Solr-Tests-8.x - Build # 70 - Unstable!

[Apache Jenkins Server]

Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-Solr-Tests-8.x/70/

1 tests failed.
FAILED:  org.apache.solr.update.DirectUpdateHandlerTest.testPrepareCommit

Error Message:


Stack Trace:
java.lang.AssertionError
        at 
__randomizedtesting.SeedInfo.seed([40FF5ABB25C3B95C:E0429589CC916D35]:0)
        at org.junit.Assert.fail(Assert.java:86)
        at org.junit.Assert.assertTrue(Assert.java:41)
        at org.junit.Assert.assertTrue(Assert.java:52)
        at 
org.apache.solr.update.DirectUpdateHandlerTest.testPrepareCommit(DirectUpdateHandlerTest.java:405)
        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.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java: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.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.lang.Thread.run(Thread.java:748)




Build Log:
[...truncated 13514 lines...]
   [junit4] Suite: org.apache.solr.update.DirectUpdateHandlerTest
   [junit4]   2> 325334 INFO  
(SUITE-DirectUpdateHandlerTest-seed#[40FF5ABB25C3B95C]-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.x/solr/server/solr/configsets/_default/conf'
   [junit4]   2> 325334 INFO  
(SUITE-DirectUpdateHandlerTest-seed#[40FF5ABB25C3B95C]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Created dataDir: 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_40FF5ABB25C3B95C-001/data-dir-27-001
   [junit4]   2> 325334 WARN  
(SUITE-DirectUpdateHandlerTest-seed#[40FF5ABB25C3B95C]-worker) [     ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=4 numCloses=4
   [junit4]   2> 325334 INFO  
(SUITE-DirectUpdateHandlerTest-seed#[40FF5ABB25C3B95C]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 325336 INFO  
(SUITE-DirectUpdateHandlerTest-seed#[40FF5ABB25C3B95C]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via: 
@org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
   [junit4]   2> 325336 INFO  
(SUITE-DirectUpdateHandlerTest-seed#[40FF5ABB25C3B95C]-worker) [     ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 325337 INFO  
(SUITE-DirectUpdateHandlerTest-seed#[40FF5ABB25C3B95C]-worker) [     ] 
o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 325347 INFO  
(SUITE-DirectUpdateHandlerTest-seed#[40FF5ABB25C3B95C]-worker) [     ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.7.0
   [junit4]   2> 325375 INFO  
(SUITE-DirectUpdateHandlerTest-seed#[40FF5ABB25C3B95C]-worker) [     ] 
o.a.s.s.IndexSchema Schema name=test
   [junit4]   2> 325468 WARN  
(SUITE-DirectUpdateHandlerTest-seed#[40FF5ABB25C3B95C]-worker) [     ] 
o.a.s.s.IndexSchema Field text is not multivalued and destination for multiople 
copyFields (2)
   [junit4]   2> 325468 INFO  
(SUITE-DirectUpdateHandlerTest-seed#[40FF5ABB25C3B95C]-worker) [     ] 
o.a.s.s.IndexSchema Loaded schema test/1.4 with uniqueid field id
   [junit4]   2> 326542 WARN  
(SUITE-DirectUpdateHandlerTest-seed#[40FF5ABB25C3B95C]-worker) [     ] 
o.a.s.c.CoreContainer Unable to create 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/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.x/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.x/solr/core/src/test-files/solr/userfiles"
 "write")
   [junit4]   2>        at 
java.security.AccessControlContext.checkPermission(AccessControlContext.java:472)
 ~[?:1.8.0_252]
   [junit4]   2>        at 
java.security.AccessController.checkPermission(AccessController.java:886) 
~[?:1.8.0_252]
   [junit4]   2>        at 
java.lang.SecurityManager.checkPermission(SecurityManager.java:549) 
~[?:1.8.0_252]
   [junit4]   2>        at 
java.lang.SecurityManager.checkWrite(SecurityManager.java:979) ~[?:1.8.0_252]
   [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_252]
   [junit4]   2>        at 
java.nio.file.Files.createAndCheckIsDirectory(Files.java:781) ~[?:1.8.0_252]
   [junit4]   2>        at 
java.nio.file.Files.createDirectories(Files.java:727) ~[?:1.8.0_252]
   [junit4]   2>        at 
org.apache.solr.core.CoreContainer.<init>(CoreContainer.java:367) [java/:?]
   [junit4]   2>        at 
org.apache.solr.core.CoreContainer.<init>(CoreContainer.java:332) [java/:?]
   [junit4]   2>        at 
org.apache.solr.util.TestHarness.<init>(TestHarness.java:170) [java/:?]
   [junit4]   2>        at 
org.apache.solr.util.TestHarness.<init>(TestHarness.java:143) [java/:?]
   [junit4]   2>        at 
org.apache.solr.util.TestHarness.<init>(TestHarness.java:149) [java/:?]
   [junit4]   2>        at 
org.apache.solr.util.TestHarness.<init>(TestHarness.java:112) [java/:?]
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.createCore(SolrTestCaseJ4.java:807) [java/:?]
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:797) [java/:?]
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:658) [java/:?]
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:647) [java/:?]
   [junit4]   2>        at 
org.apache.solr.update.DirectUpdateHandlerTest.beforeClass(DirectUpdateHandlerTest.java:65)
 [test/:?]
   [junit4]   2>        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native 
Method) ~[?:1.8.0_252]
   [junit4]   2>        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) 
~[?:1.8.0_252]
   [junit4]   2>        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
 ~[?:1.8.0_252]
   [junit4]   2>        at java.lang.reflect.Method.invoke(Method.java:498) 
~[?:1.8.0_252]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:878)
 [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.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 
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_252]
   [junit4]   2> 326544 WARN  
(SUITE-DirectUpdateHandlerTest-seed#[40FF5ABB25C3B95C]-worker) [     ] 
o.a.s.f.DistribPackageStore Unable to create 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/filestore]
 directory in SOLR_HOME 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/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.x/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.x/solr/core/src/test-files/solr/filestore"
 "write")
   [junit4]   2>        at 
java.security.AccessControlContext.checkPermission(AccessControlContext.java:472)
 ~[?:1.8.0_252]
   [junit4]   2>        at 
java.security.AccessController.checkPermission(AccessController.java:886) 
~[?:1.8.0_252]
   [junit4]   2>        at 
java.lang.SecurityManager.checkPermission(SecurityManager.java:549) 
~[?:1.8.0_252]
   [junit4]   2>        at 
java.lang.SecurityManager.checkWrite(SecurityManager.java:979) ~[?:1.8.0_252]
   [junit4]   2>        at java.io.File.mkdir(File.java:1311) ~[?:1.8.0_252]
   [junit4]   2>        at java.io.File.mkdirs(File.java:1343) ~[?:1.8.0_252]
   [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:668) [java/:?]
   [junit4]   2>        at 
org.apache.solr.util.TestHarness.<init>(TestHarness.java:171) [java/:?]
   [junit4]   2>        at 
org.apache.solr.util.TestHarness.<init>(TestHarness.java:143) [java/:?]
   [junit4]   2>        at 
org.apache.solr.util.TestHarness.<init>(TestHarness.java:149) [java/:?]
   [junit4]   2>        at 
org.apache.solr.util.TestHarness.<init>(TestHarness.java:112) [java/:?]
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.createCore(SolrTestCaseJ4.java:807) [java/:?]
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:797) [java/:?]
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:658) [java/:?]
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:647) [java/:?]
   [junit4]   2>        at 
org.apache.solr.update.DirectUpdateHandlerTest.beforeClass(DirectUpdateHandlerTest.java:65)
 [test/:?]
   [junit4]   2>        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native 
Method) ~[?:1.8.0_252]
   [junit4]   2>        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) 
~[?:1.8.0_252]
   [junit4]   2>        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
 ~[?:1.8.0_252]
   [junit4]   2>        at java.lang.reflect.Method.invoke(Method.java:498) 
~[?:1.8.0_252]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:878)
 [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.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 
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_252]
   [junit4]   2> 326545 INFO  
(SUITE-DirectUpdateHandlerTest-seed#[40FF5ABB25C3B95C]-worker) [     ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 326546 WARN  
(SUITE-DirectUpdateHandlerTest-seed#[40FF5ABB25C3B95C]-worker) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@25aefbab[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 326546 WARN  
(SUITE-DirectUpdateHandlerTest-seed#[40FF5ABB25C3B95C]-worker) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@25aefbab[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 326549 WARN  
(SUITE-DirectUpdateHandlerTest-seed#[40FF5ABB25C3B95C]-worker) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@2f9f2e0c[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 326549 WARN  
(SUITE-DirectUpdateHandlerTest-seed#[40FF5ABB25C3B95C]-worker) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@2f9f2e0c[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 326550 WARN  
(SUITE-DirectUpdateHandlerTest-seed#[40FF5ABB25C3B95C]-worker) [     ] 
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> 326579 INFO  
(SUITE-DirectUpdateHandlerTest-seed#[40FF5ABB25C3B95C]-worker) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@37ca4b3a
   [junit4]   2> 326585 INFO  
(SUITE-DirectUpdateHandlerTest-seed#[40FF5ABB25C3B95C]-worker) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@37ca4b3a
   [junit4]   2> 326585 INFO  
(SUITE-DirectUpdateHandlerTest-seed#[40FF5ABB25C3B95C]-worker) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@37ca4b3a
   [junit4]   2> 326586 INFO  (coreLoadExecutor-4791-thread-1) [     ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 326595 INFO  (coreLoadExecutor-4791-thread-1) [    
x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.7.0
   [junit4]   2> 326620 INFO  (coreLoadExecutor-4791-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema Schema name=test
   [junit4]   2> 326708 WARN  (coreLoadExecutor-4791-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema Field text is not multivalued and 
destination for multiople copyFields (2)
   [junit4]   2> 326708 INFO  (coreLoadExecutor-4791-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema Loaded schema test/1.4 with uniqueid field 
id
   [junit4]   2> 326719 INFO  (coreLoadExecutor-4791-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.x/solr/core/src/test-files/solr/collection1,
 trusted=true
   [junit4]   2> 326719 INFO  (coreLoadExecutor-4791-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@37ca4b3a
   [junit4]   2> 326719 INFO  (coreLoadExecutor-4791-thread-1) [    
x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_40FF5ABB25C3B95C-001/data-dir-27-001/]
   [junit4]   2> 326783 INFO  (coreLoadExecutor-4791-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 326783 INFO  (coreLoadExecutor-4791-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 326785 INFO  (coreLoadExecutor-4791-thread-1) [    
x:collection1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 326798 INFO  (coreLoadExecutor-4791-thread-1) [    
x:collection1 ] o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 326863 INFO  (coreLoadExecutor-4791-thread-1) [    
x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 326863 INFO  
(searcherExecutor-4793-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 326863 INFO  
(searcherExecutor-4793-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 326864 INFO  
(searcherExecutor-4793-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 326864 INFO  
(searcherExecutor-4793-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 326864 INFO  
(searcherExecutor-4793-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 326864 INFO  
(searcherExecutor-4793-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 326864 INFO  
(searcherExecutor-4793-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 326864 INFO  
(searcherExecutor-4793-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 326865 INFO  
(searcherExecutor-4793-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 326865 INFO  
(SUITE-DirectUpdateHandlerTest-seed#[40FF5ABB25C3B95C]-worker) [     ] 
o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 326867 INFO  
(searcherExecutor-4793-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 326868 INFO  
(TEST-DirectUpdateHandlerTest.testRequireUniqueKey-seed#[40FF5ABB25C3B95C]) [   
  ] o.a.s.SolrTestCaseJ4 ###Starting testRequireUniqueKey
   [junit4]   2> 326868 INFO  
(TEST-DirectUpdateHandlerTest.testRequireUniqueKey-seed#[40FF5ABB25C3B95C]) [   
  ] o.a.s.u.DirectUpdateHandler2 [collection1]  REMOVING ALL DOCUMENTS FROM 
INDEX
   [junit4]   2> 326868 INFO  
(TEST-DirectUpdateHandlerTest.testRequireUniqueKey-seed#[40FF5ABB25C3B95C]) [   
  ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}{deleteByQuery=*:*}
 0 0
   [junit4]   2> 326885 INFO  
(searcherExecutor-4793-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 326885 INFO  
(TEST-DirectUpdateHandlerTest.testRequireUniqueKey-seed#[40FF5ABB25C3B95C]) [   
 x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{commit=} 0 17
   [junit4]   2> 326890 INFO  
(TEST-DirectUpdateHandlerTest.testRequireUniqueKey-seed#[40FF5ABB25C3B95C]) [   
 x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[1]} 0 2
   [junit4]   2> 326891 INFO  
(TEST-DirectUpdateHandlerTest.testRequireUniqueKey-seed#[40FF5ABB25C3B95C]) [   
 x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{} 0 0
   [junit4]   2> 326891 INFO  
(TEST-DirectUpdateHandlerTest.testRequireUniqueKey-seed#[40FF5ABB25C3B95C]) [   
 x:collection1 ] o.a.s.h.RequestHandlerBase Ignoring exception matching 
ignore_exception
   [junit4]   2> 326891 INFO  
(TEST-DirectUpdateHandlerTest.testRequireUniqueKey-seed#[40FF5ABB25C3B95C]) [   
 x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{} 0 0
   [junit4]   2> 326891 INFO  
(TEST-DirectUpdateHandlerTest.testRequireUniqueKey-seed#[40FF5ABB25C3B95C]) [   
 x:collection1 ] o.a.s.h.RequestHandlerBase Ignoring exception matching id
   [junit4]   2> 326892 INFO  
(TEST-DirectUpdateHandlerTest.testRequireUniqueKey-seed#[40FF5ABB25C3B95C]) [   
  ] o.a.s.SolrTestCaseJ4 ###Ending testRequireUniqueKey
   [junit4]   2> 326904 INFO  
(TEST-DirectUpdateHandlerTest.testPrepareCommit-seed#[40FF5ABB25C3B95C]) [     
] o.a.s.SolrTestCaseJ4 ###Starting testPrepareCommit
   [junit4]   2> 326904 INFO  
(TEST-DirectUpdateHandlerTest.testPrepareCommit-seed#[40FF5ABB25C3B95C]) [     
] o.a.s.u.DirectUpdateHandler2 [collection1]  REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 326904 INFO  
(TEST-DirectUpdateHandlerTest.testPrepareCommit-seed#[40FF5ABB25C3B95C]) [     
] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}{deleteByQuery=*:*}
 0 0
   [junit4]   2> 326919 INFO  
(searcherExecutor-4793-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 326920 INFO  
(TEST-DirectUpdateHandlerTest.testPrepareCommit-seed#[40FF5ABB25C3B95C]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{commit=} 0 15
   [junit4]   2> 326921 INFO  
(TEST-DirectUpdateHandlerTest.testPrepareCommit-seed#[40FF5ABB25C3B95C]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[999]} 0 0
   [junit4]   2> 326970 INFO  
(searcherExecutor-4793-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 326970 INFO  
(TEST-DirectUpdateHandlerTest.testPrepareCommit-seed#[40FF5ABB25C3B95C]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{optimize=} 0 49
   [junit4]   2> 326971 INFO  
(TEST-DirectUpdateHandlerTest.testPrepareCommit-seed#[40FF5ABB25C3B95C]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{commit=} 0 0
   [junit4]   2> 326971 INFO  
(TEST-DirectUpdateHandlerTest.testPrepareCommit-seed#[40FF5ABB25C3B95C]) [     
] o.a.s.u.DirectUpdateHandlerTest FILES before addDoc=[_0.fdm, _0.fdt, _1.cfe, 
_1.cfs, _1.si, segments_4]
   [junit4]   2> 326972 INFO  
(TEST-DirectUpdateHandlerTest.testPrepareCommit-seed#[40FF5ABB25C3B95C]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[1]} 0 0
   [junit4]   2> 326972 INFO  
(TEST-DirectUpdateHandlerTest.testPrepareCommit-seed#[40FF5ABB25C3B95C]) [     
] o.a.s.u.DirectUpdateHandlerTest FILES before prepareCommit=[_0.fdm, _0.fdt, 
_1.cfe, _1.cfs, _1.si, _2.fdm, _2.fdt, _2_Lucene85FieldsIndex-doc_ids_4.tmp, 
_2_Lucene85FieldsIndexfile_pointers_5.tmp, segments_4]
   [junit4]   2> 327014 INFO  
(TEST-DirectUpdateHandlerTest.testPrepareCommit-seed#[40FF5ABB25C3B95C]) [     
] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={prepareCommit=true&wt=json&indent=true}{commit=} 0 41
   [junit4]   2> 327014 INFO  
(TEST-DirectUpdateHandlerTest.testPrepareCommit-seed#[40FF5ABB25C3B95C]) [     
] o.a.s.u.DirectUpdateHandlerTest FILES after prepareCommit=[_0.fdm, _0.fdt, 
_1.cfe, _1.cfs, _1.si, _2.cfe, _2.cfs, _2.si, pending_segments_5, segments_4]
   [junit4]   2> 327014 INFO  
(TEST-DirectUpdateHandlerTest.testPrepareCommit-seed#[40FF5ABB25C3B95C]) [     
] o.a.s.SolrTestCaseJ4 ###Ending testPrepareCommit
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=DirectUpdateHandlerTest -Dtests.method=testPrepareCommit 
-Dtests.seed=40FF5ABB25C3B95C -Dtests.multiplier=2 -Dtests.slow=true 
-Dtests.locale=nl-NL -Dtests.timezone=Europe/Volgograd -Dtests.asserts=true 
-Dtests.file.encoding=UTF-8
   [junit4] FAILURE 0.13s J1 | DirectUpdateHandlerTest.testPrepareCommit <<<
   [junit4]    > Throwable #1: java.lang.AssertionError
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([40FF5ABB25C3B95C:E0429589CC916D35]:0)
   [junit4]    >        at 
org.apache.solr.update.DirectUpdateHandlerTest.testPrepareCommit(DirectUpdateHandlerTest.java:405)
   [junit4]    >        at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> 327019 INFO  
(TEST-DirectUpdateHandlerTest.testExpungeDeletes-seed#[40FF5ABB25C3B95C]) [     
] o.a.s.SolrTestCaseJ4 ###Starting testExpungeDeletes
   [junit4]   2> 327020 INFO  
(TEST-DirectUpdateHandlerTest.testExpungeDeletes-seed#[40FF5ABB25C3B95C]) [     
] o.a.s.u.DirectUpdateHandler2 [collection1]  REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 327020 INFO  
(TEST-DirectUpdateHandlerTest.testExpungeDeletes-seed#[40FF5ABB25C3B95C]) [     
] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}{deleteByQuery=*:*}
 0 0
   [junit4]   2> 327026 INFO  
(searcherExecutor-4793-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 327027 INFO  
(TEST-DirectUpdateHandlerTest.testExpungeDeletes-seed#[40FF5ABB25C3B95C]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{commit=} 0 6
   [junit4]   2> 327028 INFO  
(TEST-DirectUpdateHandlerTest.testExpungeDeletes-seed#[40FF5ABB25C3B95C]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[1]} 0 0
   [junit4]   2> 327029 INFO  
(TEST-DirectUpdateHandlerTest.testExpungeDeletes-seed#[40FF5ABB25C3B95C]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[2]} 0 0
   [junit4]   2> 327076 INFO  
(searcherExecutor-4793-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 327077 INFO  
(TEST-DirectUpdateHandlerTest.testExpungeDeletes-seed#[40FF5ABB25C3B95C]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{commit=} 0 47
   [junit4]   2> 327078 INFO  
(TEST-DirectUpdateHandlerTest.testExpungeDeletes-seed#[40FF5ABB25C3B95C]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[3]} 0 0
   [junit4]   2> 327078 INFO  
(TEST-DirectUpdateHandlerTest.testExpungeDeletes-seed#[40FF5ABB25C3B95C]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[2]} 0 0
   [junit4]   2> 327079 INFO  
(TEST-DirectUpdateHandlerTest.testExpungeDeletes-seed#[40FF5ABB25C3B95C]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[4]} 0 0
   [junit4]   2> 327134 INFO  
(searcherExecutor-4793-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 327136 INFO  
(TEST-DirectUpdateHandlerTest.testExpungeDeletes-seed#[40FF5ABB25C3B95C]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{commit=} 0 56
   [junit4]   2> 327266 INFO  
(searcherExecutor-4793-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 327266 INFO  
(TEST-DirectUpdateHandlerTest.testExpungeDeletes-seed#[40FF5ABB25C3B95C]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{commit=} 0 129
   [junit4]   2> 327267 INFO  
(TEST-DirectUpdateHandlerTest.testExpungeDeletes-seed#[40FF5ABB25C3B95C]) [     
] o.a.s.SolrTestCaseJ4 ###Ending testExpungeDeletes
   [junit4]   2> 327269 INFO  
(TEST-DirectUpdateHandlerTest.testAddRollback-seed#[40FF5ABB25C3B95C]) [     ] 
o.a.s.SolrTestCaseJ4 ###Starting testAddRollback
   [junit4]   2> 327270 INFO  
(TEST-DirectUpdateHandlerTest.testAddRollback-seed#[40FF5ABB25C3B95C]) [     ] 
o.a.s.u.DirectUpdateHandler2 [collection1]  REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 327270 INFO  
(TEST-DirectUpdateHandlerTest.testAddRollback-seed#[40FF5ABB25C3B95C]) [     ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}{deleteByQuery=*:*}
 0 0
   [junit4]   2> 327284 INFO  
(searcherExecutor-4793-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 327285 INFO  
(TEST-DirectUpdateHandlerTest.testAddRollback-seed#[40FF5ABB25C3B95C]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{commit=} 0 15
   [junit4]   2> 327286 INFO  
(TEST-DirectUpdateHandlerTest.testAddRollback-seed#[40FF5ABB25C3B95C]) [     ] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> 327286 INFO  
(TEST-DirectUpdateHandlerTest.testAddRollback-seed#[40FF5ABB25C3B95C]) [     ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1831205459
   [junit4]   2> 327286 INFO  (coreCloseExecutor-4798-thread-1) [     ] 
o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@a74ca03
   [junit4]   2> 327286 INFO  (coreCloseExecutor-4798-thread-1) [     ] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1 tag=SolrCore@a74ca03
   [junit4]   2> 327286 INFO  (coreCloseExecutor-4798-thread-1) [     ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@46d3cb47: rootName = null, 
domain = solr.core.collection1, service url = null, agent id = null] for 
registry solr.core.collection1/com.codahale.metrics.MetricRegistry@3c9b46f0
   [junit4]   2> 327304 INFO  (coreCloseExecutor-4798-thread-1) [     ] 
o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close()  ... SKIPPED 
(unnecessary).
   [junit4]   2> 339416 ERROR (coreCloseExecutor-4798-thread-1) [     ] 
o.a.s.c.CachingDirectoryFactory Timeout waiting for all directory ref counts to 
be released - gave up waiting on 
CachedDir<<refCount=1;path=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_40FF5ABB25C3B95C-001/data-dir-27-001/index;done=false>>
   [junit4]   2> 339416 ERROR (coreCloseExecutor-4798-thread-1) [     ] 
o.a.s.c.CachingDirectoryFactory Error closing 
directory:org.apache.solr.common.SolrException: Timeout waiting for all 
directory ref counts to be released - gave up waiting on 
CachedDir<<refCount=1;path=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_40FF5ABB25C3B95C-001/data-dir-27-001/index;done=false>>
   [junit4]   2>        at 
org.apache.solr.core.CachingDirectoryFactory.close(CachingDirectoryFactory.java:182)
   [junit4]   2>        at 
org.apache.solr.core.SolrCore.close(SolrCore.java:1689)
   [junit4]   2>        at 
org.apache.solr.core.SolrCores.lambda$close$0(SolrCores.java:138)
   [junit4]   2>        at 
java.util.concurrent.FutureTask.run(FutureTask.java:266)
   [junit4]   2>        at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:218)
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> 
   [junit4]   2> 339416 ERROR (coreCloseExecutor-4798-thread-1) [     ] 
o.a.s.c.SolrCore java.lang.AssertionError: 1
   [junit4]   2>        at 
org.apache.solr.core.CachingDirectoryFactory.close(CachingDirectoryFactory.java:196)
   [junit4]   2>        at 
org.apache.solr.core.SolrCore.close(SolrCore.java:1689)
   [junit4]   2>        at 
org.apache.solr.core.SolrCores.lambda$close$0(SolrCores.java:138)
   [junit4]   2>        at 
java.util.concurrent.FutureTask.run(FutureTask.java:266)
   [junit4]   2>        at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:218)
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> 
   [junit4]   2> 339416 ERROR (coreCloseExecutor-4798-thread-1) [     ] 
o.a.s.c.SolrCores Error shutting down core:java.lang.AssertionError: 1
   [junit4]   2>        at 
org.apache.solr.core.CachingDirectoryFactory.close(CachingDirectoryFactory.java:196)
   [junit4]   2>        at 
org.apache.solr.core.SolrCore.close(SolrCore.java:1689)
   [junit4]   2>        at 
org.apache.solr.core.SolrCores.lambda$close$0(SolrCores.java:138)
   [junit4]   2>        at 
java.util.concurrent.FutureTask.run(FutureTask.java:266)
   [junit4]   2>        at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:218)
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> 
   [junit4]   2> 339417 INFO  
(TEST-DirectUpdateHandlerTest.testAddRollback-seed#[40FF5ABB25C3B95C]) [     ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node 
tag=null
   [junit4]   2> 339417 INFO  
(TEST-DirectUpdateHandlerTest.testAddRollback-seed#[40FF5ABB25C3B95C]) [     ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@457d3294: rootName = null, 
domain = solr.node, service url = null, agent id = null] for registry 
solr.node/com.codahale.metrics.MetricRegistry@40a7ac2b
   [junit4]   2> 339422 INFO  
(TEST-DirectUpdateHandlerTest.testAddRollback-seed#[40FF5ABB25C3B95C]) [     ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm 
tag=null
   [junit4]   2> 339422 INFO  
(TEST-DirectUpdateHandlerTest.testAddRollback-seed#[40FF5ABB25C3B95C]) [     ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@224bd077: rootName = null, 
domain = solr.jvm, service url = null, agent id = null] for registry 
solr.jvm/com.codahale.metrics.MetricRegistry@5003c805
   [junit4]   2> 339424 INFO  
(TEST-DirectUpdateHandlerTest.testAddRollback-seed#[40FF5ABB25C3B95C]) [     ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty 
tag=null
   [junit4]   2> 339424 INFO  
(TEST-DirectUpdateHandlerTest.testAddRollback-seed#[40FF5ABB25C3B95C]) [     ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@6f4338dc: rootName = null, 
domain = solr.jetty, service url = null, agent id = null] for registry 
solr.jetty/com.codahale.metrics.MetricRegistry@9ab2731
   [junit4]   2> 339426 INFO  
(TEST-DirectUpdateHandlerTest.testAddRollback-seed#[40FF5ABB25C3B95C]) [     ] 
o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 339433 INFO  
(TEST-DirectUpdateHandlerTest.testAddRollback-seed#[40FF5ABB25C3B95C]) [     ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.7.0
   [junit4]   2> 339454 INFO  
(TEST-DirectUpdateHandlerTest.testAddRollback-seed#[40FF5ABB25C3B95C]) [     ] 
o.a.s.SolrTestCaseJ4 Created dataDir: 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_40FF5ABB25C3B95C-001/data-dir-28-001
   [junit4]   2> 339459 INFO  
(TEST-DirectUpdateHandlerTest.testAddRollback-seed#[40FF5ABB25C3B95C]) [     ] 
o.a.s.s.IndexSchema Schema name=test
   [junit4]   2> 339545 WARN  
(TEST-DirectUpdateHandlerTest.testAddRollback-seed#[40FF5ABB25C3B95C]) [     ] 
o.a.s.s.IndexSchema Field text is not multivalued and destination for multiople 
copyFields (2)
   [junit4]   2> 339545 INFO  
(TEST-DirectUpdateHandlerTest.testAddRollback-seed#[40FF5ABB25C3B95C]) [     ] 
o.a.s.s.IndexSchema Loaded schema test/1.4 with uniqueid field id
   [junit4]   2> 340640 WARN  
(TEST-DirectUpdateHandlerTest.testAddRollback-seed#[40FF5ABB25C3B95C]) [     ] 
o.a.s.c.CoreContainer Unable to create 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/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.x/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.x/solr/core/src/test-files/solr/userfiles"
 "write")
   [junit4]   2>        at 
java.security.AccessControlContext.checkPermission(AccessControlContext.java:472)
 ~[?:1.8.0_252]
   [junit4]   2>        at 
java.security.AccessController.checkPermission(AccessController.java:886) 
~[?:1.8.0_252]
   [junit4]   2>        at 
java.lang.SecurityManager.checkPermission(SecurityManager.java:549) 
~[?:1.8.0_252]
   [junit4]   2>        at 
java.lang.SecurityManager.checkWrite(SecurityManager.java:979) ~[?:1.8.0_252]
   [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_252]
   [junit4]   2>        at 
java.nio.file.Files.createAndCheckIsDirectory(Files.java:781) ~[?:1.8.0_252]
   [junit4]   2>        at 
java.nio.file.Files.createDirectories(Files.java:727) ~[?:1.8.0_252]
   [junit4]   2>        at 
org.apache.solr.core.CoreContainer.<init>(CoreContainer.java:367) [java/:?]
   [junit4]   2>        at 
org.apache.solr.core.CoreContainer.<init>(CoreContainer.java:332) [java/:?]
   [junit4]   2>        at 
org.apache.solr.util.TestHarness.<init>(TestHarness.java:170) [java/:?]
   [junit4]   2>        at 
org.apache.solr.util.TestHarness.<init>(TestHarness.java:143) [java/:?]
   [junit4]   2>        at 
org.apache.solr.util.TestHarness.<init>(TestHarness.java:149) [java/:?]
   [junit4]   2>        at 
org.apache.solr.util.TestHarness.<init>(TestHarness.java:112) [java/:?]
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.createCore(SolrTestCaseJ4.java:807) [java/:?]
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:797) [java/:?]
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:658) [java/:?]
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:647) [java/:?]
   [junit4]   2>        at 
org.apache.solr.update.DirectUpdateHandlerTest.testAddRollback(DirectUpdateHandlerTest.java:223)
 [test/:?]
   [junit4]   2>        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native 
Method) ~[?:1.8.0_252]
   [junit4]   2>        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) 
~[?:1.8.0_252]
   [junit4]   2>        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
 ~[?:1.8.0_252]
   [junit4]   2>        at java.lang.reflect.Method.invoke(Method.java:498) 
~[?:1.8.0_252]
   [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.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 
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.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 
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_252]
   [junit4]   2> 340642 WARN  
(TEST-DirectUpdateHandlerTest.testAddRollback-seed#[40FF5ABB25C3B95C]) [     ] 
o.a.s.f.DistribPackageStore Unable to create 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/filestore]
 directory in SOLR_HOME 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/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.x/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.x/solr/core/src/test-files/solr/filestore"
 "write")
   [junit4]   2>        at 
java.security.AccessControlContext.checkPermission(AccessControlContext.java:472)
 ~[?:1.8.0_252]
   [junit4]   2>        at 
java.security.AccessController.checkPermission(AccessController.java:886) 
~[?:1.8.0_252]
   [junit4]   2>        at 
java.lang.SecurityManager.checkPermission(SecurityManager.java:549) 
~[?:1.8.0_252]
   [junit4]   2>        at 
java.lang.SecurityManager.checkWrite(SecurityManager.java:979) ~[?:1.8.0_252]
   [junit4]   2>        at java.io.File.mkdir(File.java:1311) ~[?:1.8.0_252]
   [junit4]   2>        at java.io.File.mkdirs(File.java:1343) ~[?:1.8.0_252]
   [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:668) [java/:?]
   [junit4]   2>        at 
org.apache.solr.util.TestHarness.<init>(TestHarness.java:171) [java/:?]
   [junit4]   2>        at 
org.apache.solr.util.TestHarness.<init>(TestHarness.java:143) [java/:?]
   [junit4]   2>        at 
org.apache.solr.util.TestHarness.<init>(TestHarness.java:149) [java/:?]
   [junit4]   2>        at 
org.apache.solr.util.TestHarness.<init>(TestHarness.java:112) [java/:?]
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.createCore(SolrTestCaseJ4.java:807) [java/:?]
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:797) [java/:?]
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:658) [java/:?]
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:647) [java/:?]
   [junit4]   2>        at 
org.apache.solr.update.DirectUpdateHandlerTest.testAddRollback(DirectUpdateHandlerTest.java:223)
 [test/:?]
   [junit4]   2>        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native 
Method) ~[?:1.8.0_252]
   [junit4]   2>        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) 
~[?:1.8.0_252]
   [junit4]   2>        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
 ~[?:1.8.0_252]
   [junit4]   2>        at java.lang.reflect.Method.invoke(Method.java:498) 
~[?:1.8.0_252]
   [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.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 
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.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 
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_252]
   [junit4]   2> 340643 INFO  
(TEST-DirectUpdateHandlerTest.testAddRollback-seed#[40FF5ABB25C3B95C]) [     ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 340644 WARN  
(TEST-DirectUpdateHandlerTest.testAddRollback-seed#[40FF5ABB25C3B95C]) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@1fb162e9[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 340644 WARN  
(TEST-DirectUpdateHandlerTest.testAddRollback-seed#[40FF5ABB25C3B95C]) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@1fb162e9[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 340647 WARN  
(TEST-DirectUpdateHandlerTest.testAddRollback-seed#[40FF5ABB25C3B95C]) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@73f20996[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 340647 WARN  
(TEST-DirectUpdateHandlerTest.testAddRollback-seed#[40FF5ABB25C3B95C]) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@73f20996[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 340648 WARN  
(TEST-DirectUpdateHandlerTest.testAddRollback-seed#[40FF5ABB25C3B95C]) [     ] 
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> 340679 INFO  
(TEST-DirectUpdateHandlerTest.testAddRollback-seed#[40FF5ABB25C3B95C]) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@37ca4b3a
   [junit4]   2> 340685 INFO  
(TEST-DirectUpdateHandlerTest.testAddRollback-seed#[40FF5ABB25C3B95C]) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@37ca4b3a
   [junit4]   2> 340685 INFO  
(TEST-DirectUpdateHandlerTest.testAddRollback-seed#[40FF5ABB25C3B95C]) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@37ca4b3a
   [junit4]   2> 340686 INFO  (coreLoadExecutor-4809-thread-1) [     ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 340700 INFO  (coreLoadExecutor-4809-thread-1) [    
x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.7.0
   [junit4]   2> 340724 INFO  (coreLoadExecutor-4809-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema Schema name=test
   [junit4]   2> 340815 WARN  (coreLoadExecutor-4809-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema Field text is not multivalued and 
destination for multiople copyFields (2)
   [junit4]   2> 340815 INFO  (coreLoadExecutor-4809-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema Loaded schema test/1.4 with uniqueid field 
id
   [junit4]   2> 340826 INFO  (coreLoadExecutor-4809-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.x/solr/core/src/test-files/solr/collection1,
 trusted=true
   [junit4]   2> 340826 INFO  (coreLoadExecutor-4809-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@37ca4b3a
   [junit4]   2> 340826 INFO  (coreLoadExecutor-4809-thread-1) [    
x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_40FF5ABB25C3B95C-001/data-dir-28-001/]
   [junit4]   2> 340887 INFO  (coreLoadExecutor-4809-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 340887 INFO  (coreLoadExecutor-4809-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 340889 INFO  (coreLoadExecutor-4809-thread-1) [    
x:collection1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 340902 INFO  (coreLoadExecutor-4809-thread-1) [    
x:collection1 ] o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 340963 INFO  (coreLoadExecutor-4809-thread-1) [    
x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 340964 INFO  
(searcherExecutor-4811-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 340964 INFO  
(searcherExecutor-4811-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 340964 INFO  
(searcherExecutor-4811-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 340964 INFO  
(searcherExecutor-4811-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 340965 INFO  
(TEST-DirectUpdateHandlerTest.testAddRollback-seed#[40FF5ABB25C3B95C]) [     ] 
o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 340966 INFO  
(searcherExecutor-4811-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 340966 INFO  
(searcherExecutor-4811-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 340967 INFO  
(TEST-DirectUpdateHandlerTest.testAddRollback-seed#[40FF5ABB25C3B95C]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[A]} 0 1
   [junit4]   2> 340967 INFO  
(searcherExecutor-4811-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 340967 INFO  
(searcherExecutor-4811-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 340968 INFO  
(searcherExecutor-4811-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 340969 INFO  
(searcherExecutor-4811-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 341027 INFO  (searcherExecutor-4811-thread-1) [     ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 341028 INFO  
(TEST-DirectUpdateHandlerTest.testAddRollback-seed#[40FF5ABB25C3B95C]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[B]} 0 0
   [junit4]   2> 341028 INFO  
(TEST-DirectUpdateHandlerTest.testAddRollback-seed#[40FF5ABB25C3B95C]) [     ] 
o.a.s.u.DirectUpdateHandler2 start rollback{}
   [junit4]   2> 341031 INFO  
(TEST-DirectUpdateHandlerTest.testAddRollback-seed#[40FF5ABB25C3B95C]) [     ] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 341031 INFO  
(TEST-DirectUpdateHandlerTest.testAddRollback-seed#[40FF5ABB25C3B95C]) [     ] 
o.a.s.u.DirectUpdateHandler2 end_rollback
   [junit4]   2> 341032 INFO  
(TEST-DirectUpdateHandlerTest.testAddRollback-seed#[40FF5ABB25C3B95C]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:A+OR+id:B&indent=true} hits=1 status=0 QTime=1
   [junit4]   2> 341040 INFO  
(TEST-DirectUpdateHandlerTest.testAddRollback-seed#[40FF5ABB25C3B95C]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[ZZZ]} 0 7
   [junit4]   2> 341100 INFO  
(searcherExecutor-4811-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 341100 INFO  
(TEST-DirectUpdateHandlerTest.testAddRollback-seed#[40FF5ABB25C3B95C]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{commit=} 0 59
   [junit4]   2> 341101 INFO  
(TEST-DirectUpdateHandlerTest.testAddRollback-seed#[40FF5ABB25C3B95C]) [     ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:ZZZ&wt=xml} 
hits=1 status=0 QTime=0
   [junit4]   2> 341102 INFO  
(TEST-DirectUpdateHandlerTest.testAddRollback-seed#[40FF5ABB25C3B95C]) [     ] 
o.a.s.SolrTestCaseJ4 ###Ending testAddRollback
   [junit4]   2> 341104 INFO  
(TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[40FF5ABB25C3B95C]) [     
] o.a.s.SolrTestCaseJ4 ###Starting testDeleteRollback
   [junit4]   2> 341105 INFO  
(TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[40FF5ABB25C3B95C]) [     
] o.a.s.u.DirectUpdateHandler2 [collection1]  REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 341105 INFO  
(TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[40FF5ABB25C3B95C]) [     
] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}{deleteByQuery=*:*}
 0 0
   [junit4]   2> 341119 INFO  
(searcherExecutor-4811-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 341119 INFO  
(TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[40FF5ABB25C3B95C]) [    
x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{commit=} 0 14
   [junit4]   2> 341120 INFO  
(TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[40FF5ABB25C3B95C]) [     
] o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> 341120 INFO  
(TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[40FF5ABB25C3B95C]) [     
] o.a.s.c.CoreContainer Shutting down CoreContainer instance=202332792
   [junit4]   2> 341120 INFO  (coreCloseExecutor-4816-thread-1) [     ] 
o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@365902aa
   [junit4]   2> 341120 INFO  (coreCloseExecutor-4816-thread-1) [     ] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1 tag=SolrCore@365902aa
   [junit4]   2> 341120 INFO  (coreCloseExecutor-4816-thread-1) [     ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@28c4e605: rootName = null, 
domain = solr.core.collection1, service url = null, agent id = null] for 
registry solr.core.collection1/com.codahale.metrics.MetricRegistry@12e53040
   [junit4]   2> 341140 INFO  (coreCloseExecutor-4816-thread-1) [     ] 
o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close()  ... SKIPPED 
(unnecessary).
   [junit4]   2> 341151 INFO  
(TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[40FF5ABB25C3B95C]) [     
] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node 
tag=null
   [junit4]   2> 341151 INFO  
(TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[40FF5ABB25C3B95C]) [     
] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@2f5dc1a: rootName = null, 
domain = solr.node, service url = null, agent id = null] for registry 
solr.node/com.codahale.metrics.MetricRegistry@2d9432e5
   [junit4]   2> 341156 INFO  
(TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[40FF5ABB25C3B95C]) [     
] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm 
tag=null
   [junit4]   2> 341156 INFO  
(TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[40FF5ABB25C3B95C]) [     
] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@55ce72b: rootName = null, 
domain = solr.jvm, service url = null, agent id = null] for registry 
solr.jvm/com.codahale.metrics.MetricRegistry@5003c805
   [junit4]   2> 341158 INFO  
(TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[40FF5ABB25C3B95C]) [     
] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty 
tag=null
   [junit4]   2> 341158 INFO  
(TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[40FF5ABB25C3B95C]) [     
] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@61b95827: rootName = null, 
domain = solr.jetty, service url = null, agent id = null] for registry 
solr.jetty/com.codahale.metrics.MetricRegistry@9ab2731
   [junit4]   2> 341160 INFO  
(TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[40FF5ABB25C3B95C]) [     
] o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 341167 INFO  
(TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[40FF5ABB25C3B95C]) [     
] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.7.0
   [junit4]   2> 341187 INFO  
(TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[40FF5ABB25C3B95C]) [     
] o.a.s.SolrTestCaseJ4 Created dataDir: 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_40FF5ABB25C3B95C-001/data-dir-29-001
   [junit4]   2> 341191 INFO  
(TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[40FF5ABB25C3B95C]) [     
] o.a.s.s.IndexSchema Schema name=test
   [junit4]   2> 341275 WARN  
(TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[40FF5ABB25C3B95C]) [     
] o.a.s.s.IndexSchema Field text is not multivalued and destination for 
multiople copyFields (2)
   [junit4]   2> 341275 INFO  
(TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[40FF5ABB25C3B95C]) [     
] o.a.s.s.IndexSchema Loaded schema test/1.4 with uniqueid field id
   [junit4]   2> 342352 WARN  
(TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[40FF5ABB25C3B95C]) [     
] o.a.s.c.CoreContainer Unable to create 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/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.x/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.x/solr/core/src/test-files/solr/userfiles"
 "write")
   [junit4]   2>        at 
java.security.AccessControlContext.checkPermission(AccessControlContext.java:472)
 ~[?:1.8.0_252]
   [junit4]   2>        at 
java.security.AccessController.checkPermission(AccessController.java:886) 
~[?:1.8.0_252]
   [junit4]   2>        at 
java.lang.SecurityManager.checkPermission(SecurityManager.java:549) 
~[?:1.8.0_252]
   [junit4]   2>        at 
java.lang.SecurityManager.checkWrite(SecurityManager.java:979) ~[?:1.8.0_252]
   [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_252]
   [junit4]   2>        at 
java.nio.file.Files.createAndCheckIsDirectory(Files.java:781) ~[?:1.8.0_252]
   [junit4]   2>        at 
java.nio.file.Files.createDirectories(Files.java:727) ~[?:1.8.0_252]
   [junit4]   2>        at 
org.apache.solr.core.CoreContainer.<init>(CoreContainer.java:367) [java/:?]
   [junit4]   2>        at 
org.apache.solr.core.CoreContainer.<init>(CoreContainer.java:332) [java/:?]
   [junit4]   2>        at 
org.apache.solr.util.TestHarness.<init>(TestHarness.java:170) [java/:?]
   [junit4]   2>        at 
org.apache.solr.util.TestHarness.<init>(TestHarness.java:143) [java/:?]
   [junit4]   2>        at 
org.apache.solr.util.TestHarness.<init>(TestHarness.java:149) [java/:?]
   [junit4]   2>        at 
org.apache.solr.util.TestHarness.<init>(TestHarness.java:112) [java/:?]
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.createCore(SolrTestCaseJ4.java:807) [java/:?]
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:797) [java/:?]
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:658) [java/:?]
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:647) [java/:?]
   [junit4]   2>        at 
org.apache.solr.update.DirectUpdateHandlerTest.testDeleteRollback(DirectUpdateHandlerTest.java:282)
 [test/:?]
   [junit4]   2>        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native 
Method) ~[?:1.8.0_252]
   [junit4]   2>        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) 
~[?:1.8.0_252]
   [junit4]   2>        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
 ~[?:1.8.0_252]
   [junit4]   2>        at java.lang.reflect.Method.invoke(Method.java:498) 
~[?:1.8.0_252]
   [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.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 
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.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 
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_252]
   [junit4]   2> 342354 WARN  
(TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[40FF5ABB25C3B95C]) [     
] o.a.s.f.DistribPackageStore Unable to create 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/filestore]
 directory in SOLR_HOME 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/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.x/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.x/solr/core/src/test-files/solr/filestore"
 "write")
   [junit4]   2>        at 
java.security.AccessControlContext.checkPermission(AccessControlContext.java:472)
 ~[?:1.8.0_252]
   [junit4]   2>        at 
java.security.AccessController.checkPermission(AccessController.java:886) 
~[?:1.8.0_252]
   [junit4]   2>        at 
java.lang.SecurityManager.checkPermission(SecurityManager.java:549) 
~[?:1.8.0_252]
   [junit4]   2>        at 
java.lang.SecurityManager.checkWrite(SecurityManager.java:979) ~[?:1.8.0_252]
   [junit4]   2>        at java.io.File.mkdir(File.java:1311) ~[?:1.8.0_252]
   [junit4]   2>        at java.io.File.mkdirs(File.java:1343) ~[?:1.8.0_252]
   [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:668) [java/:?]
   [junit4]   2>        at 
org.apache.solr.util.TestHarness.<init>(TestHarness.java:171) [java/:?]
   [junit4]   2>        at 
org.apache.solr.util.TestHarness.<init>(TestHarness.java:143) [java/:?]
   [junit4]   2>        at 
org.apache.solr.util.TestHarness.<init>(TestHarness.java:149) [java/:?]
   [junit4]   2>        at 
org.apache.solr.util.TestHarness.<init>(TestHarness.java:112) [java/:?]
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.createCore(SolrTestCaseJ4.java:807) [java/:?]
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:797) [java/:?]
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:658) [java/:?]
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:647) [java/:?]
   [junit4]   2>        at 
org.apache.solr.update.DirectUpdateHandlerTest.testDeleteRollback(DirectUpdateHandlerTest.java:282)
 [test/:?]
   [junit4]   2>        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native 
Method) ~[?:1.8.0_252]
   [junit4]   2>        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) 
~[?:1.8.0_252]
   [junit4]   2>        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
 ~[?:1.8.0_252]
   [junit4]   2>        at java.lang.reflect.Method.invoke(Method.java:498) 
~[?:1.8.0_252]
   [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.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 
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.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(TestRule

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

.a.s.SolrTestCaseJ4 ###Ending testBasics
   [junit4]   2> 342950 INFO  
(TEST-DirectUpdateHandlerTest.testPostSoftCommitEvents-seed#[40FF5ABB25C3B95C]) 
[     ] o.a.s.SolrTestCaseJ4 ###Starting testPostSoftCommitEvents
   [junit4]   2> 342950 INFO  
(TEST-DirectUpdateHandlerTest.testPostSoftCommitEvents-seed#[40FF5ABB25C3B95C]) 
[     ] o.a.s.u.DirectUpdateHandler2 [collection1]  REMOVING ALL DOCUMENTS FROM 
INDEX
   [junit4]   2> 342950 INFO  
(TEST-DirectUpdateHandlerTest.testPostSoftCommitEvents-seed#[40FF5ABB25C3B95C]) 
[     ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null 
params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}{deleteByQuery=*:*}
 0 0
   [junit4]   2> 342967 INFO  
(searcherExecutor-4829-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 342967 INFO  
(TEST-DirectUpdateHandlerTest.testPostSoftCommitEvents-seed#[40FF5ABB25C3B95C]) 
[    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  
webapp=null path=null params={}{commit=} 0 16
   [junit4]   2> 342969 INFO  
(TEST-DirectUpdateHandlerTest.testPostSoftCommitEvents-seed#[40FF5ABB25C3B95C]) 
[    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  
webapp=null path=null params={}{add=[999]} 0 1
   [junit4]   2> 342992 INFO  
(searcherExecutor-4829-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 342992 INFO  
(TEST-DirectUpdateHandlerTest.testPostSoftCommitEvents-seed#[40FF5ABB25C3B95C]) 
[    x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  
webapp=null path=null params={}{commit=} 0 22
   [junit4]   2> 342993 INFO  
(TEST-DirectUpdateHandlerTest.testPostSoftCommitEvents-seed#[40FF5ABB25C3B95C]) 
[     ] o.a.s.SolrTestCaseJ4 ###Ending testPostSoftCommitEvents
   [junit4]   2> 342993 INFO  
(SUITE-DirectUpdateHandlerTest-seed#[40FF5ABB25C3B95C]-worker) [     ] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> 342993 INFO  
(SUITE-DirectUpdateHandlerTest-seed#[40FF5ABB25C3B95C]-worker) [     ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=782763127
   [junit4]   2> 342999 INFO  (coreCloseExecutor-4834-thread-1) [     ] 
o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@11ad87fe
   [junit4]   2> 342999 INFO  (coreCloseExecutor-4834-thread-1) [     ] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1 tag=SolrCore@11ad87fe
   [junit4]   2> 342999 INFO  (coreCloseExecutor-4834-thread-1) [     ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@776eda23: rootName = null, 
domain = solr.core.collection1, service url = null, agent id = null] for 
registry solr.core.collection1/com.codahale.metrics.MetricRegistry@d00e2af
   [junit4]   2> 343015 INFO  (coreCloseExecutor-4834-thread-1) [     ] 
o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close()  ... SKIPPED 
(unnecessary).
   [junit4]   2> 343074 INFO  
(SUITE-DirectUpdateHandlerTest-seed#[40FF5ABB25C3B95C]-worker) [     ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node 
tag=null
   [junit4]   2> 343074 INFO  
(SUITE-DirectUpdateHandlerTest-seed#[40FF5ABB25C3B95C]-worker) [     ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@63cc149a: rootName = null, 
domain = solr.node, service url = null, agent id = null] for registry 
solr.node/com.codahale.metrics.MetricRegistry@62706489
   [junit4]   2> 343078 INFO  
(SUITE-DirectUpdateHandlerTest-seed#[40FF5ABB25C3B95C]-worker) [     ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm 
tag=null
   [junit4]   2> 343078 INFO  
(SUITE-DirectUpdateHandlerTest-seed#[40FF5ABB25C3B95C]-worker) [     ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@5f698b5: rootName = null, 
domain = solr.jvm, service url = null, agent id = null] for registry 
solr.jvm/com.codahale.metrics.MetricRegistry@5003c805
   [junit4]   2> 343090 INFO  
(SUITE-DirectUpdateHandlerTest-seed#[40FF5ABB25C3B95C]-worker) [     ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty 
tag=null
   [junit4]   2> 343090 INFO  
(SUITE-DirectUpdateHandlerTest-seed#[40FF5ABB25C3B95C]-worker) [     ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@430b4d53: rootName = null, 
domain = solr.jetty, service url = null, agent id = null] for registry 
solr.jetty/com.codahale.metrics.MetricRegistry@9ab2731
   [junit4]   2> 343093 ERROR 
(SUITE-DirectUpdateHandlerTest-seed#[40FF5ABB25C3B95C]-worker) [     ] 
o.a.s.c.SolrCore Too many close [count:-1] on 
org.apache.solr.core.SolrCore@a74ca03. Please report this exception to 
solr-u...@lucene.apache.org
   [junit4]   2> 343093 ERROR 
(SUITE-DirectUpdateHandlerTest-seed#[40FF5ABB25C3B95C]-worker) [     ] 
o.a.s.c.u.ObjectReleaseTracker 
   [junit4]   2>           => java.lang.AssertionError: Too many closes on 
SolrCore
   [junit4]   2>        at 
org.apache.solr.core.SolrCore.close(SolrCore.java:1560)
   [junit4]   2> java.lang.AssertionError: Too many closes on SolrCore
   [junit4]   2>        at 
org.apache.solr.core.SolrCore.close(SolrCore.java:1560) ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.common.util.ObjectReleaseTracker.tryClose(ObjectReleaseTracker.java:85)
 [java/:?]
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.teardownTestCases(SolrTestCaseJ4.java:328) 
[java/:?]
   [junit4]   2>        at sun.reflect.GeneratedMethodAccessor44.invoke(Unknown 
Source) ~[?:?]
   [junit4]   2>        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
 ~[?:1.8.0_252]
   [junit4]   2>        at java.lang.reflect.Method.invoke(Method.java:498) 
~[?:1.8.0_252]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:901)
 [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.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 
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_252]
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_40FF5ABB25C3B95C-001
   [junit4]   2> NOTE: test params are: codec=Lucene87, 
sim=Asserting(RandomSimilarity(queryNorm=false): {}), locale=nl-NL, 
timezone=Europe/Volgograd
   [junit4]   2> NOTE: Linux 4.15.0-108-generic amd64/Oracle Corporation 
1.8.0_252 (64-bit)/cpus=4,threads=1,free=180801680,total=520093696
   [junit4]   2> NOTE: All tests run in this JVM: [TestRTGBase, 
SubstringBytesRefFilterTest, DistributedFacetSimpleRefinementLongTailTest, 
InfoHandlerTest, XmlUpdateRequestHandlerTest, ForceLeaderTest, TestLogWatcher, 
ChaosMonkeyNothingIsSafeTest, SolrMetricsIntegrationTest, 
ConnectionManagerTest, MultiSolrCloudTestCaseTest, TestQuerySenderNoQuery, 
RAMDirectoryFactoryTest, DirectSolrSpellCheckerTest, SolrJmxReporterTest, 
ReplaceNodeTest, TestTlogReplica, TestDynamicFieldResource, 
InfixSuggestersTest, CollectionsAPISolrJTest, TestStandardQParsers, 
VersionInfoTest, TestCollectionAPIs, NumberUtilsTest, 
OverseerCollectionConfigSetProcessorTest, TestReplicationHandlerBackup, 
DirectUpdateHandlerTest]
   [junit4] Completed [106/919 (1!)] on J1 in 18.01s, 7 tests, 1 failure <<< 
FAILURES!

[...truncated 55020 lines...]

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