You are viewing a plain text version of this content. The canonical link for it is here.
Posted to builds@lucene.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2021/04/19 16:32:57 UTC
[JENKINS] Lucene » Lucene-Solr-NightlyTests-8.x - Build # 246 - Still Unstable!
Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-Solr-NightlyTests-8.x/246/
2 tests failed.
FAILED: org.apache.solr.cloud.autoscaling.AutoScalingHandlerTest.testReadApi
Error Message:
expected:<2> but was:<3>
Stack Trace:
java.lang.AssertionError: expected:<2> but was:<3>
at __randomizedtesting.SeedInfo.seed([D4545B73F748F947:837DA0C62CBA1B5C]:0)
at org.junit.Assert.fail(Assert.java:89)
at org.junit.Assert.failNotEquals(Assert.java:835)
at org.junit.Assert.assertEquals(Assert.java:647)
at org.junit.Assert.assertEquals(Assert.java:633)
at org.apache.solr.cloud.autoscaling.AutoScalingHandlerTest.testReadApi(AutoScalingHandlerTest.java:920)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
FAILED: org.apache.solr.util.TestCircuitBreaker.testResponseWithCBTiming
Error Message:
Exception during query
Stack Trace:
java.lang.RuntimeException: Exception during query
at __randomizedtesting.SeedInfo.seed([D4545B73F748F947:3C88F69104A0E367]:0)
at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:1023)
at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:983)
at org.apache.solr.util.TestCircuitBreaker.testResponseWithCBTiming(TestCircuitBreaker.java:245)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
Caused by: org.apache.solr.common.SolrException: Circuit Breakers tripped Memory Circuit Breaker triggered as JVM heap usage values are greater than allocated threshold.Seen JVM heap memory usage 490310024 and allocated threshold 399507456
at org.apache.solr.handler.component.SearchHandler.handleRequestBody(SearchHandler.java:322)
at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:216)
at org.apache.solr.core.SolrCore.execute(SolrCore.java:2637)
at org.apache.solr.util.TestHarness.query(TestHarness.java:346)
at org.apache.solr.util.TestHarness.query(TestHarness.java:328)
at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:997)
... 45 more
Build Log:
[...truncated 14839 lines...]
[junit4] Suite: org.apache.solr.util.TestCircuitBreaker
[junit4] 2> 2740819 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-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-NightlyTests-8.x/checkout/solr/server/solr/configsets/_default/conf'
[junit4] 2> 2740819 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 2740819 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ ] o.a.s.SolrTestCaseJ4 Created dataDir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.util.TestCircuitBreaker_D4545B73F748F947-001/data-dir-117-001
[junit4] 2> 2740819 WARN (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=4 numCloses=4
[junit4] 2> 2740819 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ ] o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 2740821 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
[junit4] 2> 2740822 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 2740828 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ ] o.a.s.c.SolrResourceLoader Added 2 libs to classloader, from paths: [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 2740855 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.9.0
[junit4] 2> 2740875 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ ] o.a.s.s.IndexSchema Schema name=test
[junit4] 2> 2740887 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 2743130 WARN (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ ] o.a.s.c.CoreContainer Unable to create [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/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-NightlyTests-8.x/checkout/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-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/userfiles" "write")
[junit4] 2> at java.security.AccessControlContext.checkPermission(AccessControlContext.java:472) ~[?:1.8.0_281]
[junit4] 2> at java.security.AccessController.checkPermission(AccessController.java:886) ~[?:1.8.0_281]
[junit4] 2> at java.lang.SecurityManager.checkPermission(SecurityManager.java:549) ~[?:1.8.0_281]
[junit4] 2> at java.lang.SecurityManager.checkWrite(SecurityManager.java:979) ~[?:1.8.0_281]
[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_281]
[junit4] 2> at java.nio.file.Files.createAndCheckIsDirectory(Files.java:781) ~[?:1.8.0_281]
[junit4] 2> at java.nio.file.Files.createDirectories(Files.java:727) ~[?:1.8.0_281]
[junit4] 2> at org.apache.solr.core.CoreContainer.<init>(CoreContainer.java:377) [java/:?]
[junit4] 2> at org.apache.solr.core.CoreContainer.<init>(CoreContainer.java:342) [java/:?]
[junit4] 2> at org.apache.solr.util.TestHarness.<init>(TestHarness.java:183) [java/:?]
[junit4] 2> at org.apache.solr.util.TestHarness.<init>(TestHarness.java:156) [java/:?]
[junit4] 2> at org.apache.solr.util.TestHarness.<init>(TestHarness.java:162) [java/:?]
[junit4] 2> at org.apache.solr.util.TestHarness.<init>(TestHarness.java:112) [java/:?]
[junit4] 2> at org.apache.solr.SolrTestCaseJ4.createCore(SolrTestCaseJ4.java:812) [java/:?]
[junit4] 2> at org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:802) [java/:?]
[junit4] 2> at org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:663) [java/:?]
[junit4] 2> at org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:652) [java/:?]
[junit4] 2> at org.apache.solr.util.TestCircuitBreaker.setUpClass(TestCircuitBreaker.java:61) [test/:?]
[junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[?:1.8.0_281]
[junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[?:1.8.0_281]
[junit4] 2> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[?:1.8.0_281]
[junit4] 2> at java.lang.reflect.Method.invoke(Method.java:498) ~[?:1.8.0_281]
[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.junit.rules.RunRules.evaluate(RunRules.java:20) [junit-4.13.1.jar:4.13.1]
[junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) [java/:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) [java/:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) [java/:?]
[junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) [java/:?]
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) [java/:?]
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) [java/:?]
[junit4] 2> at org.junit.rules.RunRules.evaluate(RunRules.java:20) [junit-4.13.1.jar:4.13.1]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at java.lang.Thread.run(Thread.java:748) [?:1.8.0_281]
[junit4] 2> 2743131 WARN (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ ] o.a.s.f.DistribPackageStore Unable to create [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/filestore] directory in SOLR_HOME [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/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-NightlyTests-8.x/checkout/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-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/filestore" "write")
[junit4] 2> at java.security.AccessControlContext.checkPermission(AccessControlContext.java:472) ~[?:1.8.0_281]
[junit4] 2> at java.security.AccessController.checkPermission(AccessController.java:886) ~[?:1.8.0_281]
[junit4] 2> at java.lang.SecurityManager.checkPermission(SecurityManager.java:549) ~[?:1.8.0_281]
[junit4] 2> at java.lang.SecurityManager.checkWrite(SecurityManager.java:979) ~[?:1.8.0_281]
[junit4] 2> at java.io.File.mkdir(File.java:1311) ~[?:1.8.0_281]
[junit4] 2> at java.io.File.mkdirs(File.java:1343) ~[?:1.8.0_281]
[junit4] 2> at org.apache.solr.filestore.DistribPackageStore.ensurePackageStoreDir(DistribPackageStore.java:561) [java/:?]
[junit4] 2> at org.apache.solr.filestore.DistribPackageStore.<init>(DistribPackageStore.java:81) [java/:?]
[junit4] 2> at org.apache.solr.filestore.PackageStoreAPI.<init>(PackageStoreAPI.java:78) [java/:?]
[junit4] 2> at org.apache.solr.core.CoreContainer.load(CoreContainer.java:678) [java/:?]
[junit4] 2> at org.apache.solr.util.TestHarness.<init>(TestHarness.java:184) [java/:?]
[junit4] 2> at org.apache.solr.util.TestHarness.<init>(TestHarness.java:156) [java/:?]
[junit4] 2> at org.apache.solr.util.TestHarness.<init>(TestHarness.java:162) [java/:?]
[junit4] 2> at org.apache.solr.util.TestHarness.<init>(TestHarness.java:112) [java/:?]
[junit4] 2> at org.apache.solr.SolrTestCaseJ4.createCore(SolrTestCaseJ4.java:812) [java/:?]
[junit4] 2> at org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:802) [java/:?]
[junit4] 2> at org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:663) [java/:?]
[junit4] 2> at org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:652) [java/:?]
[junit4] 2> at org.apache.solr.util.TestCircuitBreaker.setUpClass(TestCircuitBreaker.java:61) [test/:?]
[junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[?:1.8.0_281]
[junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[?:1.8.0_281]
[junit4] 2> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[?:1.8.0_281]
[junit4] 2> at java.lang.reflect.Method.invoke(Method.java:498) ~[?:1.8.0_281]
[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.junit.rules.RunRules.evaluate(RunRules.java:20) [junit-4.13.1.jar:4.13.1]
[junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) [java/:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) [java/:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) [java/:?]
[junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) [java/:?]
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) [java/:?]
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) [java/:?]
[junit4] 2> at org.junit.rules.RunRules.evaluate(RunRules.java:20) [junit-4.13.1.jar:4.13.1]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at java.lang.Thread.run(Thread.java:748) [?:1.8.0_281]
[junit4] 2> 2743132 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 2743132 WARN (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 2743134 WARN (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@bd013f1[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2743134 WARN (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@bd013f1[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2743137 WARN (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 2743139 WARN (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@253713e9[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2743139 WARN (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@253713e9[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2743140 WARN (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-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> 2743170 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3e38158a
[junit4] 2> 2743177 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3e38158a
[junit4] 2> 2743177 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3e38158a
[junit4] 2> 2743178 INFO (coreLoadExecutor-14205-thread-1) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 2743188 INFO (coreLoadExecutor-14205-thread-1) [ x:collection1 ] o.a.s.c.SolrResourceLoader Added 2 libs to classloader, from paths: [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 2743209 INFO (coreLoadExecutor-14205-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.9.0
[junit4] 2> 2743220 INFO (coreLoadExecutor-14205-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Schema name=test
[junit4] 2> 2743235 INFO (coreLoadExecutor-14205-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 2743241 INFO (coreLoadExecutor-14205-thread-1) [ x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1, trusted=true
[junit4] 2> 2743242 INFO (coreLoadExecutor-14205-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@3e38158a
[junit4] 2> 2743242 INFO (coreLoadExecutor-14205-thread-1) [ x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.util.TestCircuitBreaker_D4545B73F748F947-001/data-dir-117-001/]
[junit4] 2> 2743243 INFO (coreLoadExecutor-14205-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@582a8117
[junit4] 2> 2743302 INFO (coreLoadExecutor-14205-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2743302 INFO (coreLoadExecutor-14205-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2743303 INFO (coreLoadExecutor-14205-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=1478702331, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
[junit4] 2> 2743304 WARN (coreLoadExecutor-14205-thread-1) [ x:collection1 ] o.a.s.r.ManagedResourceStorage Cannot write to config directory /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1/conf ; switching to use InMemory storage instead.
[junit4] 2> 2743305 INFO (coreLoadExecutor-14205-thread-1) [ x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 2743306 INFO (searcherExecutor-14207-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 2743436 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 2743437 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 2743442 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 2
[junit4] 2> 2743442 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 2743445 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 2
[junit4] 2> 2743446 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 2743449 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 3
[junit4] 2> 2743455 INFO (searcherExecutor-14207-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 2743455 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 5
[junit4] 2> 2743457 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 1
[junit4] 2> 2743461 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 3
[junit4] 2> 2743462 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 2743465 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 2
[junit4] 2> 2743465 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 2743468 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 2
[junit4] 2> 2743474 INFO (searcherExecutor-14207-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 2743474 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 6
[junit4] 2> 2743477 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 2
[junit4] 2> 2743484 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 5
[junit4] 2> 2743487 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 2
[junit4] 2> 2743498 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 9
[junit4] 2> 2743500 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 1
[junit4] 2> 2743524 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 23
[junit4] 2> 2743531 INFO (searcherExecutor-14207-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 2743531 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 6
[junit4] 2> 2743532 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 2743535 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 2
[junit4] 2> 2743536 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 2743542 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 4
[junit4] 2> 2743543 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 2743545 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 2
[junit4] 2> 2743549 INFO (searcherExecutor-14207-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 2743550 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 4
[junit4] 2> 2743550 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 2743553 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 2
[junit4] 2> 2743554 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 2743558 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 4
[junit4] 2> 2743559 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 2743564 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 4
[junit4] 2> 2743569 INFO (searcherExecutor-14207-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 2743569 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 4
[junit4] 2> 2743570 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 2743572 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 1
[junit4] 2> 2743572 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 2743577 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 4
[junit4] 2> 2743578 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 2743583 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 4
[junit4] 2> 2743587 INFO (searcherExecutor-14207-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 2743588 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 4
[junit4] 2> 2743589 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 2743592 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 2
[junit4] 2> 2743592 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 2743597 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 4
[junit4] 2> 2743597 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 2743601 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 3
[junit4] 2> 2743605 INFO (searcherExecutor-14207-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 2743606 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 4
[junit4] 2> 2743606 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 2743609 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 2
[junit4] 2> 2743610 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 2743614 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 3
[junit4] 2> 2743615 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 2743619 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 3
[junit4] 2> 2743623 INFO (searcherExecutor-14207-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 2743623 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 4
[junit4] 2> 2743624 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 2743627 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 2
[junit4] 2> 2743629 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 2743634 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 4
[junit4] 2> 2743635 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 2743641 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 5
[junit4] 2> 2743647 INFO (searcherExecutor-14207-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 2743648 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 6
[junit4] 2> 2743650 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 1
[junit4] 2> 2743656 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 5
[junit4] 2> 2743657 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 2743661 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 3
[junit4] 2> 2743662 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 2743665 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 2
[junit4] 2> 2743668 INFO (searcherExecutor-14207-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 2743668 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 3
[junit4] 2> 2743669 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 2743671 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 2
[junit4] 2> 2743672 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 2743674 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 2
[junit4] 2> 2743675 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 2743677 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 2
[junit4] 2> 2743683 INFO (searcherExecutor-14207-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 2743683 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 5
[junit4] 2> 2743685 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 1
[junit4] 2> 2743686 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 1
[junit4] 2> 2743687 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 2743703 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 16
[junit4] 2> 2743704 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 2743708 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 3
[junit4] 2> 2743713 INFO (searcherExecutor-14207-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 2743713 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 5
[junit4] 2> 2743714 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 2743716 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 1
[junit4] 2> 2743716 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 2743720 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 3
[junit4] 2> 2743721 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 2743723 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 2
[junit4] 2> 2743727 INFO (searcherExecutor-14207-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 2743727 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 3
[junit4] 2> 2743730 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 1
[junit4] 2> 2743733 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 3
[junit4] 2> 2743734 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 2743736 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 2
[junit4] 2> 2743737 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 2743740 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 2
[junit4] 2> 2743744 INFO (searcherExecutor-14207-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 2743744 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 4
[junit4] 2> 2743744 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 2743747 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 2
[junit4] 2> 2743747 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 2743751 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 3
[junit4] 2> 2743751 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 2743754 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 2
[junit4] 2> 2743758 INFO (searcherExecutor-14207-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 2743758 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 3
[junit4] 2> 2743759 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 2743760 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 1
[junit4] 2> 2743761 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 2743764 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 2
[junit4] 2> 2743764 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 2743767 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 2
[junit4] 2> 2743771 INFO (searcherExecutor-14207-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 2743771 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 4
[junit4] 2> 2743772 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 2743774 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 1
[junit4] 2> 2743774 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 2743778 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 3
[junit4] 2> 2743778 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 2743782 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 3
[junit4] 2> 2743789 INFO (searcherExecutor-14207-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 2743789 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 7
[junit4] 2> 2743790 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 2743792 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 1
[junit4] 2> 2743793 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 2743796 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 2
[junit4] 2> 2743796 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 2743799 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 2
[junit4] 2> 2743803 INFO (searcherExecutor-14207-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 2743803 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 3
[junit4] 2> 2743803 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 2743805 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 1
[junit4] 2> 2743805 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 2743808 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 2
[junit4] 2> 2743809 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 2743811 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 2
[junit4] 2> 2743815 INFO (searcherExecutor-14207-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 2743816 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 4
[junit4] 2> 2743816 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 2743819 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 2
[junit4] 2> 2743820 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 1
[junit4] 2> 2743823 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 2
[junit4] 2> 2743824 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 2743826 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 2
[junit4] 2> 2743830 INFO (searcherExecutor-14207-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 2743830 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 3
[junit4] 2> 2743841 INFO (TEST-TestCircuitBreaker.testResponseWithCBTiming-seed#[D4545B73F748F947]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testResponseWithCBTiming
[junit4] 2> 2743841 INFO (TEST-TestCircuitBreaker.testResponseWithCBTiming-seed#[D4545B73F748F947]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&wt=xml&debugQuery=true} status=503 QTime=0
[junit4] 2> 2743842 ERROR (TEST-TestCircuitBreaker.testResponseWithCBTiming-seed#[D4545B73F748F947]) [ ] o.a.s.SolrTestCaseJ4 REQUEST FAILED: q=*:*&wt=xml&debugQuery=true:org.apache.solr.common.SolrException: Circuit Breakers tripped Memory Circuit Breaker triggered as JVM heap usage values are greater than allocated threshold.Seen JVM heap memory usage 490310024 and allocated threshold 399507456
[junit4] 2>
[junit4] 2> at org.apache.solr.handler.component.SearchHandler.handleRequestBody(SearchHandler.java:322)
[junit4] 2> at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:216)
[junit4] 2> at org.apache.solr.core.SolrCore.execute(SolrCore.java:2637)
[junit4] 2> at org.apache.solr.util.TestHarness.query(TestHarness.java:346)
[junit4] 2> at org.apache.solr.util.TestHarness.query(TestHarness.java:328)
[junit4] 2> at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:997)
[junit4] 2> at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:983)
[junit4] 2> at org.apache.solr.util.TestCircuitBreaker.testResponseWithCBTiming(TestCircuitBreaker.java:245)
[junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
[junit4] 2> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4] 2> at java.lang.reflect.Method.invoke(Method.java:498)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
[junit4] 2> at org.junit.rules.RunRules.evaluate(RunRules.java:20)
[junit4] 2> at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
[junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4] 2> at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
[junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
[junit4] 2> at org.junit.rules.RunRules.evaluate(RunRules.java:20)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
[junit4] 2> at org.junit.rules.RunRules.evaluate(RunRules.java:20)
[junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
[junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
[junit4] 2> at org.junit.rules.RunRules.evaluate(RunRules.java:20)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2>
[junit4] 2> 2743843 INFO (TEST-TestCircuitBreaker.testResponseWithCBTiming-seed#[D4545B73F748F947]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testResponseWithCBTiming
[junit4] 2> NOTE: download the large Jenkins line-docs file by running 'ant get-jenkins-line-docs' in the lucene directory.
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestCircuitBreaker -Dtests.method=testResponseWithCBTiming -Dtests.seed=D4545B73F748F947 -Dtests.multiplier=2 -Dtests.nightly=true -Dtests.slow=true -Dtests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/test-data/enwiki.random.lines.txt -Dtests.locale=th -Dtests.timezone=America/Montreal -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] ERROR 0.01s J1 | TestCircuitBreaker.testResponseWithCBTiming <<<
[junit4] > Throwable #1: java.lang.RuntimeException: Exception during query
[junit4] > at __randomizedtesting.SeedInfo.seed([D4545B73F748F947:3C88F69104A0E367]:0)
[junit4] > at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:1023)
[junit4] > at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:983)
[junit4] > at org.apache.solr.util.TestCircuitBreaker.testResponseWithCBTiming(TestCircuitBreaker.java:245)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] > Caused by: org.apache.solr.common.SolrException: Circuit Breakers tripped Memory Circuit Breaker triggered as JVM heap usage values are greater than allocated threshold.Seen JVM heap memory usage 490310024 and allocated threshold 399507456
[junit4] > at org.apache.solr.handler.component.SearchHandler.handleRequestBody(SearchHandler.java:322)
[junit4] > at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:216)
[junit4] > at org.apache.solr.core.SolrCore.execute(SolrCore.java:2637)
[junit4] > at org.apache.solr.util.TestHarness.query(TestHarness.java:346)
[junit4] > at org.apache.solr.util.TestHarness.query(TestHarness.java:328)
[junit4] > at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:997)
[junit4] > ... 45 more
[junit4] 2> 2743853 INFO (TEST-TestCircuitBreaker.testBuildingMemoryPressure-seed#[D4545B73F748F947]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testBuildingMemoryPressure
[junit4] 2> 2743876 INFO (TestCircuitBreaker-14211-thread-1) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=name:"john+smith"&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
[junit4] 2> 2743898 INFO (TestCircuitBreaker-14211-thread-2) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=name:"john+smith"&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
[junit4] 2> 2744037 INFO (TestCircuitBreaker-14211-thread-3) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=name:"john+smith"&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
[junit4] 2> 2744038 INFO (TestCircuitBreaker-14211-thread-2) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=name:"john+smith"&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
[junit4] 2> 2744038 INFO (TestCircuitBreaker-14211-thread-1) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=name:"john+smith"&qt=&start=0&rows=20&version=2.2} status=503 QTime=1
[junit4] 2> 2744040 INFO (TEST-TestCircuitBreaker.testBuildingMemoryPressure-seed#[D4545B73F748F947]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testBuildingMemoryPressure
[junit4] 2> 2744047 INFO (TEST-TestCircuitBreaker.testFakeCPUCircuitBreaker-seed#[D4545B73F748F947]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testFakeCPUCircuitBreaker
[junit4] 2> 2744055 INFO (TestCircuitBreaker-14212-thread-1) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=name:"john+smith"&qt=&start=0&rows=20&version=2.2} status=503 QTime=0
[junit4] 2> 2744055 INFO (TestCircuitBreaker-14212-thread-2) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=name:"john+smith"&qt=&start=0&rows=20&version=2.2} status=503 QTime=0
[junit4] 2> 2744056 INFO (TestCircuitBreaker-14212-thread-2) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=name:"john+smith"&qt=&start=0&rows=20&version=2.2} status=503 QTime=0
[junit4] 2> 2744056 INFO (TestCircuitBreaker-14212-thread-4) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=name:"john+smith"&qt=&start=0&rows=20&version=2.2} status=503 QTime=0
[junit4] 2> 2744056 INFO (TestCircuitBreaker-14212-thread-3) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=name:"john+smith"&qt=&start=0&rows=20&version=2.2} status=503 QTime=0
[junit4] 2> 2744057 INFO (TEST-TestCircuitBreaker.testFakeCPUCircuitBreaker-seed#[D4545B73F748F947]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testFakeCPUCircuitBreaker
[junit4] 2> 2744065 INFO (TEST-TestCircuitBreaker.testCBFakeMemoryPressure-seed#[D4545B73F748F947]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testCBFakeMemoryPressure
[junit4] 2> 2744066 INFO (TEST-TestCircuitBreaker.testCBFakeMemoryPressure-seed#[D4545B73F748F947]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=name:"john+smith"&qt=&start=0&rows=20&version=2.2} status=503 QTime=0
[junit4] 2> 2744067 INFO (TEST-TestCircuitBreaker.testCBFakeMemoryPressure-seed#[D4545B73F748F947]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testCBFakeMemoryPressure
[junit4] 2> 2744074 INFO (TEST-TestCircuitBreaker.testCBAlwaysTrips-seed#[D4545B73F748F947]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testCBAlwaysTrips
[junit4] 2> 2744075 INFO (TEST-TestCircuitBreaker.testCBAlwaysTrips-seed#[D4545B73F748F947]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=name:"john+smith"&qt=&start=0&rows=20&version=2.2} status=503 QTime=0
[junit4] 2> 2744076 INFO (TEST-TestCircuitBreaker.testCBAlwaysTrips-seed#[D4545B73F748F947]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testCBAlwaysTrips
[junit4] 2> 2744076 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> 2744076 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1635289220
[junit4] 2> 2744077 INFO (coreCloseExecutor-14214-thread-1) [ ] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@5117e32f
[junit4] 2> 2744077 INFO (coreCloseExecutor-14214-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1 tag=SolrCore@5117e32f
[junit4] 2> 2744077 INFO (coreCloseExecutor-14214-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@18180e13: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1/com.codahale.metrics.MetricRegistry@36637753
[junit4] 2> 2744090 INFO (coreCloseExecutor-14214-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close() ... SKIPPED (unnecessary).
[junit4] 2> 2744099 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node tag=null
[junit4] 2> 2744099 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1352b896: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node/com.codahale.metrics.MetricRegistry@3aad6216
[junit4] 2> 2744105 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm tag=null
[junit4] 2> 2744105 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1a481ad8: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm/com.codahale.metrics.MetricRegistry@65feaa28
[junit4] 2> 2744109 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty tag=null
[junit4] 2> 2744109 INFO (SUITE-TestCircuitBreaker-seed#[D4545B73F748F947]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@67e73d1b: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty/com.codahale.metrics.MetricRegistry@5d07c7ca
[junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.util.TestCircuitBreaker_D4545B73F748F947-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene87): {range_facet_l_dv=FST50, multiDefault=PostingsFormat(name=Asserting), _root_=Lucene84, intDefault=Lucene84, title=Lucene84, title_lettertok=FST50, range_facet_l=PostingsFormat(name=Asserting), title_stringNoNorms=PostingsFormat(name=Asserting), title_stemmed=Lucene84, inStock_b1=BlockTreeOrds(blocksize=128), name=FST50, id_i1=Lucene84, id=FST50, range_facet_i_dv=PostingsFormat(name=Asserting), text=BlockTreeOrds(blocksize=128), timestamp=PostingsFormat(name=Asserting)}, docValues:{range_facet_l_dv=DocValuesFormat(name=Asserting), range_facet_i_dv=DocValuesFormat(name=Lucene80), intDvoDefault=DocValuesFormat(name=Asserting), timestamp=DocValuesFormat(name=Lucene80)}, maxPointsInLeafNode=1888, maxMBSortInHeap=7.572741080128666, sim=Asserting(RandomSimilarity(queryNorm=false): {}), locale=th, timezone=America/Montreal
[junit4] 2> NOTE: Linux 5.4.0-45-generic amd64/Oracle Corporation 1.8.0_281 (64-bit)/cpus=4,threads=1,free=185159560,total=532152320
[junit4] 2> NOTE: All tests run in this JVM: [SyncSliceTest, TestSystemCollAutoCreate, TestSolrCoreProperties, TestObjectReleaseTracker, TestSolr4Spatial2, TestEmbeddedSolrServerAdminHandler, OverseerCollectionConfigSetProcessorTest, IgnoreLargeDocumentProcessorFactoryTest, SuggestComponentContextFilterQueryTest, TestJsonFacetsStatsParsing, WrapperMergePolicyFactoryTest, LeaderElectionIntegrationTest, TestExactSharedStatsCache, DeleteReplicaTest, TestFieldCacheVsDocValues, AtomicUpdatesTest, SuggesterWFSTTest, TestStressLucene, TimeZoneUtilsTest, HighlighterMaxOffsetTest, TestCloudDeduplication, RangeFacetCloudTest, TestInPlaceUpdatesDistrib, ZkStateWriterTest, SolrCmdDistributorTest, HttpTriggerListenerTest, HdfsRecoverLeaseTest, TestPivotHelperCode, ZkDynamicConfigTest, ZkNodePropsTest, AnalyticsQueryTest, TestCloudDeleteByQuery, LeaderTragicEventTest, HttpPartitionOnCommitTest, SpellCheckCollatorWithCollapseTest, ReindexCollectionTest, TestSchemaNameResource, MaxSizeAutoCommitTest, ChaosMonkeyNothingIsSafeTest, TestDistributedMap, TestSolrJ, BlockJoinFacetRandomTest, TestUseDocValuesAsStored, TestSerializedLuceneMatchVersion, TestMacros, OverseerSolrResponseUnsafeSerializationTest, SystemInfoHandlerTest, TestSolrCloudWithKerberosAlt, MetricsHistoryHandlerTest, TestCoreContainer, TestDistributedSearch, TestSolrConfigHandler, TestRangeQuery, TestJoin, BigEndianAscendingWordSerializerTest, RequestLoggingTest, TestQueryTypes, TestSearcherReuse, CreateRoutedAliasTest, AuditLoggerPluginTest, CircularListTest, RoutingToNodesWithPropertiesTest, WordBreakSolrSpellCheckerTest, TestMinHashQParser, ScheduledMaintenanceTriggerTest, TestCollationFieldDocValues, ByteBuffersDirectoryFactoryTest, TestSolrXml, TestPhraseSuggestions, TestNestedUpdateProcessor, CdcrUpdateLogTest, TestStreamBody, SolrGraphiteReporterTest, ProtectedTermFilterFactoryTest, ReplicationFactorTest, TestLFUCache, TestMergePolicyConfig, LargeFieldTest, TestSimUtils, TestSolrJacksonAnnotation, DaemonStreamApiTest, SearchRateTriggerTest, SolrCoreMetricManagerTest, HdfsDirectoryTest, DirectoryFactoriesTest, SampleTest, TestAtomicUpdateErrorCases, TestFieldSortValues, TermsComponentTest, TestCloudNestedDocsSort, SearchHandlerTest, CustomCollectionTest, CollectionsAPISolrJTest, DistribDocExpirationUpdateProcessorTest, DynamicMapsTest, TestSchemaManager, TestSortByMinMaxFunction, StressHdfsTest, TestRebalanceLeaders, UpdateParamsTest, VMParamsZkACLAndCredentialsProvidersTest, ZookeeperStatusHandlerTest, NodeLostTriggerIntegrationTest, TestStressVersions, TestClusterProperties, TestOverriddenPrefixQueryForCustomFieldType, TestCircuitBreaker]
[junit4] Completed [533/936 (1!)] on J1 in 3.58s, 5 tests, 1 error <<< FAILURES!
[...truncated 7 lines...]
[junit4] Suite: org.apache.solr.cloud.autoscaling.AutoScalingHandlerTest
[junit4] 2> 2744323 INFO (SUITE-AutoScalingHandlerTest-seed#[D4545B73F748F947]-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-NightlyTests-8.x/checkout/solr/server/solr/configsets/_default/conf'
[junit4] 2> 2744323 INFO (SUITE-AutoScalingHandlerTest-seed#[D4545B73F748F947]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 2744323 INFO (SUITE-AutoScalingHandlerTest-seed#[D4545B73F748F947]-worker) [ ] o.a.s.SolrTestCaseJ4 Created dataDir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.AutoScalingHandlerTest_D4545B73F748F947-001/data-dir-118-001
[junit4] 2> 2744324 WARN (SUITE-AutoScalingHandlerTest-seed#[D4545B73F748F947]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=21 numCloses=21
[junit4] 2> 2744324 INFO (SUITE-AutoScalingHandlerTest-seed#[D4545B73F748F947]-worker) [ ] o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 2744326 INFO (SUITE-AutoScalingHandlerTest-seed#[D4545B73F748F947]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
[junit4] 2> 2744327 INFO (SUITE-AutoScalingHandlerTest-seed#[D4545B73F748F947]-worker) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.AutoScalingHandlerTest_D4545B73F748F947-001/tempDir-001
[junit4] 2> 2744327 INFO (SUITE-AutoScalingHandlerTest-seed#[D4545B73F748F947]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 2744328 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer client port: 0.0.0.0/0.0.0.0:0
[junit4] 2> 2744328 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 2744329 WARN (ZkTestServer Run Thread) [ ] o.a.z.s.ServerCnxnFactory maxCnxns is not configured, using default value 0.
[junit4] 2> 2744428 INFO (SUITE-AutoScalingHandlerTest-seed#[D4545B73F748F947]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port: 43691
[junit4] 2> 2744428 INFO (SUITE-AutoScalingHandlerTest-seed#[D4545B73F748F947]-worker) [ ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:43691
[junit4] 2> 2744428 INFO (SUITE-AutoScalingHandlerTest-seed#[D4545B73F748F947]-worker) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:43691
[junit4] 2> 2744428 INFO (SUITE-AutoScalingHandlerTest-seed#[D4545B73F748F947]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 43691
[junit4] 2> 2744430 INFO (SUITE-AutoScalingHandlerTest-seed#[D4545B73F748F947]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2744435 INFO (zkConnectionManagerCallback-14218-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2744435 INFO (SUITE-AutoScalingHandlerTest-seed#[D4545B73F748F947]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2744441 INFO (SUITE-AutoScalingHandlerTest-seed#[D4545B73F748F947]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2744444 INFO (zkConnectionManagerCallback-14220-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2744444 INFO (SUITE-AutoScalingHandlerTest-seed#[D4545B73F748F947]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2744446 INFO (SUITE-AutoScalingHandlerTest-seed#[D4545B73F748F947]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2744448 INFO (zkConnectionManagerCallback-14222-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2744448 INFO (SUITE-AutoScalingHandlerTest-seed#[D4545B73F748F947]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2744557 INFO (jetty-launcher-14223-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 2744557 INFO (jetty-launcher-14223-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 2744558 INFO (jetty-launcher-14223-thread-1) [ ] o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; git: e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_281-b09
[junit4] 2> 2744563 INFO (jetty-launcher-14223-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 2744563 INFO (jetty-launcher-14223-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 2744563 INFO (jetty-launcher-14223-thread-2) [ ] o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; git: e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_281-b09
[junit4] 2> 2744566 INFO (jetty-launcher-14223-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2744566 INFO (jetty-launcher-14223-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2744566 INFO (jetty-launcher-14223-thread-2) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2744566 INFO (jetty-launcher-14223-thread-2) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2744566 INFO (jetty-launcher-14223-thread-1) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 2744566 INFO (jetty-launcher-14223-thread-2) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 2744567 INFO (jetty-launcher-14223-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@67a2abe5{/solr,null,AVAILABLE}
[junit4] 2> 2744567 INFO (jetty-launcher-14223-thread-2) [ ] o.e.j.s.h.
[...truncated too long message...]
] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster tag=null
[junit4] 2> 2761316 INFO (jetty-closer-14375-thread-3) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@2b88a8c6{SSL, (ssl, http/1.1)}{127.0.0.1:0}
[junit4] 2> 2761317 INFO (jetty-closer-14375-thread-3) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@62ae6a43{/solr,null,STOPPED}
[junit4] 2> 2761317 INFO (jetty-closer-14375-thread-3) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 2761417 INFO (jetty-closer-14375-thread-2) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@6df291cd{SSL, (ssl, http/1.1)}{127.0.0.1:0}
[junit4] 2> 2761419 INFO (jetty-closer-14375-thread-2) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@2d918552{/solr,null,STOPPED}
[junit4] 2> 2761419 INFO (jetty-closer-14375-thread-2) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 2761516 INFO (jetty-closer-14375-thread-1) [ ] o.a.s.c.Overseer Overseer (id=73361214417534982-127.0.0.1:37719_solr-n_0000000000) closing
[junit4] 2> 2761518 INFO (jetty-closer-14375-thread-1) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@55df881e{SSL, (ssl, http/1.1)}{127.0.0.1:0}
[junit4] 2> 2761519 INFO (jetty-closer-14375-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@67a2abe5{/solr,null,STOPPED}
[junit4] 2> 2761519 INFO (jetty-closer-14375-thread-1) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 2761520 INFO (SUITE-AutoScalingHandlerTest-seed#[D4545B73F748F947]-worker) [ ] o.a.s.c.ZkTestServer Shutting down ZkTestServer.
[junit4] 2> 2761522 WARN (SUITE-AutoScalingHandlerTest-seed#[D4545B73F748F947]-worker-SendThread(127.0.0.1:43691)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x104a1a2c5a60000.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x104a1a2c5a60000, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x104a1a2c5a60000, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) [zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> 2761623 WARN (SUITE-AutoScalingHandlerTest-seed#[D4545B73F748F947]-worker-SendThread(127.0.0.1:43691)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x104a1a2c5a60001.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x104a1a2c5a60001, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x104a1a2c5a60001, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) [zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> 2761725 WARN (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Watch limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 20 /solr/collections/readApiTestViolations/terms/shard1
[junit4] 2> 8 /solr/collections/testSuggestionsWithPayload.COLL/terms/shard1
[junit4] 2> 8 /solr/collections/testDiagnosticsWithPayload.COLL/state.json
[junit4] 2> 8 /solr/collections/testDiagnosticsWithPayload.COLL/terms/shard1
[junit4] 2> 7 /solr/configs/conf
[junit4] 2> 6 /solr/collections/testSuggestionsWithPayload.COLL/state.json
[junit4] 2> 5 /solr/collections/COLL1/state.json
[junit4] 2> 4 /solr/aliases.json
[junit4] 2> 3 /solr/collections/readApiTestViolations/collectionprops.json
[junit4] 2> 3 /solr/packages.json
[junit4] 2> 3 /solr/security.json
[junit4] 2> 2 /solr/collections/COLL1/terms/shard1
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 147 /solr/autoscaling.json
[junit4] 2> 81 /solr/collections/readApiTestViolations/state.json
[junit4] 2> 16 /solr/collections/testSuggestionsWithPayload.COLL/state.json
[junit4] 2> 16 /solr/collections/testDiagnosticsWithPayload.COLL/state.json
[junit4] 2> 8 /solr/collections/COLL1/state.json
[junit4] 2> 4 /solr/clusterprops.json
[junit4] 2> 4 /solr/clusterstate.json
[junit4] 2> 3 /solr/collections/readApiTestViolations/leader_elect/shard1/election/73361214417534984-core_node12-n_0000000001
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 95 /solr/overseer/queue
[junit4] 2> 28 /solr/overseer/collection-queue-work
[junit4] 2> 27 /solr/collections
[junit4] 2> 19 /solr/collections/readApiTestViolations/state.json
[junit4] 2> 15 /solr/live_nodes
[junit4] 2> 9 /solr/collections/testSuggestionsWithPayload.COLL/state.json
[junit4] 2> 9 /solr/collections/testDiagnosticsWithPayload.COLL/state.json
[junit4] 2> 5 /solr/collections/COLL1/state.json
[junit4] 2> 2 /solr/autoscaling/events/node_added_trigger1
[junit4] 2>
[junit4] 2> 2761730 INFO (SUITE-AutoScalingHandlerTest-seed#[D4545B73F748F947]-worker) [ ] o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:43691
[junit4] 2> 2761730 INFO (SUITE-AutoScalingHandlerTest-seed#[D4545B73F748F947]-worker) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:43691
[junit4] 2> 2761730 INFO (SUITE-AutoScalingHandlerTest-seed#[D4545B73F748F947]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 43691
[junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.AutoScalingHandlerTest_D4545B73F748F947-001
[junit4] 2> Apr 19, 2021 3:18:12 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 1 leaked thread(s).
[junit4] 2> NOTE: test params are: codec=Lucene87, sim=Asserting(RandomSimilarity(queryNorm=true): {}), locale=mt-MT, timezone=Europe/Guernsey
[junit4] 2> NOTE: Linux 5.4.0-45-generic amd64/Oracle Corporation 1.8.0_281 (64-bit)/cpus=4,threads=1,free=254057304,total=520617984
[junit4] 2> NOTE: All tests run in this JVM: [SyncSliceTest, TestSystemCollAutoCreate, TestSolrCoreProperties, TestObjectReleaseTracker, TestSolr4Spatial2, TestEmbeddedSolrServerAdminHandler, OverseerCollectionConfigSetProcessorTest, IgnoreLargeDocumentProcessorFactoryTest, SuggestComponentContextFilterQueryTest, TestJsonFacetsStatsParsing, WrapperMergePolicyFactoryTest, LeaderElectionIntegrationTest, TestExactSharedStatsCache, DeleteReplicaTest, TestFieldCacheVsDocValues, AtomicUpdatesTest, SuggesterWFSTTest, TestStressLucene, TimeZoneUtilsTest, HighlighterMaxOffsetTest, TestCloudDeduplication, RangeFacetCloudTest, TestInPlaceUpdatesDistrib, ZkStateWriterTest, SolrCmdDistributorTest, HttpTriggerListenerTest, HdfsRecoverLeaseTest, TestPivotHelperCode, ZkDynamicConfigTest, ZkNodePropsTest, AnalyticsQueryTest, TestCloudDeleteByQuery, LeaderTragicEventTest, HttpPartitionOnCommitTest, SpellCheckCollatorWithCollapseTest, ReindexCollectionTest, TestSchemaNameResource, MaxSizeAutoCommitTest, ChaosMonkeyNothingIsSafeTest, TestDistributedMap, TestSolrJ, BlockJoinFacetRandomTest, TestUseDocValuesAsStored, TestSerializedLuceneMatchVersion, TestMacros, OverseerSolrResponseUnsafeSerializationTest, SystemInfoHandlerTest, TestSolrCloudWithKerberosAlt, MetricsHistoryHandlerTest, TestCoreContainer, TestDistributedSearch, TestSolrConfigHandler, TestRangeQuery, TestJoin, BigEndianAscendingWordSerializerTest, RequestLoggingTest, TestQueryTypes, TestSearcherReuse, CreateRoutedAliasTest, AuditLoggerPluginTest, CircularListTest, RoutingToNodesWithPropertiesTest, WordBreakSolrSpellCheckerTest, TestMinHashQParser, ScheduledMaintenanceTriggerTest, TestCollationFieldDocValues, ByteBuffersDirectoryFactoryTest, TestSolrXml, TestPhraseSuggestions, TestNestedUpdateProcessor, CdcrUpdateLogTest, TestStreamBody, SolrGraphiteReporterTest, ProtectedTermFilterFactoryTest, ReplicationFactorTest, TestLFUCache, TestMergePolicyConfig, LargeFieldTest, TestSimUtils, TestSolrJacksonAnnotation, DaemonStreamApiTest, SearchRateTriggerTest, SolrCoreMetricManagerTest, HdfsDirectoryTest, DirectoryFactoriesTest, SampleTest, TestAtomicUpdateErrorCases, TestFieldSortValues, TermsComponentTest, TestCloudNestedDocsSort, SearchHandlerTest, CustomCollectionTest, CollectionsAPISolrJTest, DistribDocExpirationUpdateProcessorTest, DynamicMapsTest, TestSchemaManager, TestSortByMinMaxFunction, StressHdfsTest, TestRebalanceLeaders, UpdateParamsTest, VMParamsZkACLAndCredentialsProvidersTest, ZookeeperStatusHandlerTest, NodeLostTriggerIntegrationTest, TestStressVersions, TestClusterProperties, TestOverriddenPrefixQueryForCustomFieldType, TestCircuitBreaker, AutoScalingHandlerTest]
[junit4] Completed [536/936 (2!)] on J1 in 17.82s, 12 tests, 1 failure <<< FAILURES!
[...truncated 52244 lines...]
[JENKINS] Lucene » Lucene-Solr-NightlyTests-8.x - Build # 247 - Still Unstable!
Posted by Apache Jenkins Server <je...@builds.apache.org>.
Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-Solr-NightlyTests-8.x/247/
1 tests failed.
FAILED: org.apache.solr.util.TestCircuitBreaker.testResponseWithCBTiming
Error Message:
Exception during query
Stack Trace:
java.lang.RuntimeException: Exception during query
at __randomizedtesting.SeedInfo.seed([BFD5A029AAAF480:E321F7E06942EEA0]:0)
at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:1023)
at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:983)
at org.apache.solr.util.TestCircuitBreaker.testResponseWithCBTiming(TestCircuitBreaker.java:245)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
Caused by: org.apache.solr.common.SolrException: Circuit Breakers tripped Memory Circuit Breaker triggered as JVM heap usage values are greater than allocated threshold.Seen JVM heap memory usage 407422136 and allocated threshold 394788864
at org.apache.solr.handler.component.SearchHandler.handleRequestBody(SearchHandler.java:322)
at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:216)
at org.apache.solr.core.SolrCore.execute(SolrCore.java:2637)
at org.apache.solr.util.TestHarness.query(TestHarness.java:346)
at org.apache.solr.util.TestHarness.query(TestHarness.java:328)
at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:997)
... 45 more
Build Log:
[...truncated 15689 lines...]
[junit4] Suite: org.apache.solr.util.TestCircuitBreaker
[junit4] 2> 4159463 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-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-NightlyTests-8.x/checkout/solr/server/solr/configsets/_default/conf'
[junit4] 2> 4159464 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ ] o.a.s.SolrTestCaseJ4 Created dataDir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.util.TestCircuitBreaker_BFD5A029AAAF480-001/data-dir-59-001
[junit4] 2> 4159464 WARN (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=53 numCloses=53
[junit4] 2> 4159464 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 4159466 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 4159466 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 4159466 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 4159472 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ ] o.a.s.c.SolrResourceLoader Added 2 libs to classloader, from paths: [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 4159501 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.9.0
[junit4] 2> 4159516 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ ] o.a.s.s.IndexSchema Schema name=test
[junit4] 2> 4159523 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 4160085 WARN (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ ] o.a.s.c.CoreContainer Unable to create [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/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-NightlyTests-8.x/checkout/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-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/userfiles" "write")
[junit4] 2> at java.security.AccessControlContext.checkPermission(AccessControlContext.java:472) ~[?:1.8.0_281]
[junit4] 2> at java.security.AccessController.checkPermission(AccessController.java:886) ~[?:1.8.0_281]
[junit4] 2> at java.lang.SecurityManager.checkPermission(SecurityManager.java:549) ~[?:1.8.0_281]
[junit4] 2> at java.lang.SecurityManager.checkWrite(SecurityManager.java:979) ~[?:1.8.0_281]
[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_281]
[junit4] 2> at java.nio.file.Files.createAndCheckIsDirectory(Files.java:781) ~[?:1.8.0_281]
[junit4] 2> at java.nio.file.Files.createDirectories(Files.java:727) ~[?:1.8.0_281]
[junit4] 2> at org.apache.solr.core.CoreContainer.<init>(CoreContainer.java:377) [java/:?]
[junit4] 2> at org.apache.solr.core.CoreContainer.<init>(CoreContainer.java:342) [java/:?]
[junit4] 2> at org.apache.solr.util.TestHarness.<init>(TestHarness.java:183) [java/:?]
[junit4] 2> at org.apache.solr.util.TestHarness.<init>(TestHarness.java:156) [java/:?]
[junit4] 2> at org.apache.solr.util.TestHarness.<init>(TestHarness.java:162) [java/:?]
[junit4] 2> at org.apache.solr.util.TestHarness.<init>(TestHarness.java:112) [java/:?]
[junit4] 2> at org.apache.solr.SolrTestCaseJ4.createCore(SolrTestCaseJ4.java:812) [java/:?]
[junit4] 2> at org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:802) [java/:?]
[junit4] 2> at org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:663) [java/:?]
[junit4] 2> at org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:652) [java/:?]
[junit4] 2> at org.apache.solr.util.TestCircuitBreaker.setUpClass(TestCircuitBreaker.java:61) [test/:?]
[junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[?:1.8.0_281]
[junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[?:1.8.0_281]
[junit4] 2> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[?:1.8.0_281]
[junit4] 2> at java.lang.reflect.Method.invoke(Method.java:498) ~[?:1.8.0_281]
[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.junit.rules.RunRules.evaluate(RunRules.java:20) [junit-4.13.1.jar:4.13.1]
[junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) [java/:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) [java/:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) [java/:?]
[junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) [java/:?]
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) [java/:?]
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) [java/:?]
[junit4] 2> at org.junit.rules.RunRules.evaluate(RunRules.java:20) [junit-4.13.1.jar:4.13.1]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at java.lang.Thread.run(Thread.java:748) [?:1.8.0_281]
[junit4] 2> 4160086 WARN (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ ] o.a.s.f.DistribPackageStore Unable to create [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/filestore] directory in SOLR_HOME [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/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-NightlyTests-8.x/checkout/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-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/filestore" "write")
[junit4] 2> at java.security.AccessControlContext.checkPermission(AccessControlContext.java:472) ~[?:1.8.0_281]
[junit4] 2> at java.security.AccessController.checkPermission(AccessController.java:886) ~[?:1.8.0_281]
[junit4] 2> at java.lang.SecurityManager.checkPermission(SecurityManager.java:549) ~[?:1.8.0_281]
[junit4] 2> at java.lang.SecurityManager.checkWrite(SecurityManager.java:979) ~[?:1.8.0_281]
[junit4] 2> at java.io.File.mkdir(File.java:1311) ~[?:1.8.0_281]
[junit4] 2> at java.io.File.mkdirs(File.java:1343) ~[?:1.8.0_281]
[junit4] 2> at org.apache.solr.filestore.DistribPackageStore.ensurePackageStoreDir(DistribPackageStore.java:561) [java/:?]
[junit4] 2> at org.apache.solr.filestore.DistribPackageStore.<init>(DistribPackageStore.java:81) [java/:?]
[junit4] 2> at org.apache.solr.filestore.PackageStoreAPI.<init>(PackageStoreAPI.java:78) [java/:?]
[junit4] 2> at org.apache.solr.core.CoreContainer.load(CoreContainer.java:678) [java/:?]
[junit4] 2> at org.apache.solr.util.TestHarness.<init>(TestHarness.java:184) [java/:?]
[junit4] 2> at org.apache.solr.util.TestHarness.<init>(TestHarness.java:156) [java/:?]
[junit4] 2> at org.apache.solr.util.TestHarness.<init>(TestHarness.java:162) [java/:?]
[junit4] 2> at org.apache.solr.util.TestHarness.<init>(TestHarness.java:112) [java/:?]
[junit4] 2> at org.apache.solr.SolrTestCaseJ4.createCore(SolrTestCaseJ4.java:812) [java/:?]
[junit4] 2> at org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:802) [java/:?]
[junit4] 2> at org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:663) [java/:?]
[junit4] 2> at org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:652) [java/:?]
[junit4] 2> at org.apache.solr.util.TestCircuitBreaker.setUpClass(TestCircuitBreaker.java:61) [test/:?]
[junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[?:1.8.0_281]
[junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[?:1.8.0_281]
[junit4] 2> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[?:1.8.0_281]
[junit4] 2> at java.lang.reflect.Method.invoke(Method.java:498) ~[?:1.8.0_281]
[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.junit.rules.RunRules.evaluate(RunRules.java:20) [junit-4.13.1.jar:4.13.1]
[junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) [java/:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) [java/:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) [java/:?]
[junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) [java/:?]
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) [java/:?]
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) [java/:?]
[junit4] 2> at org.junit.rules.RunRules.evaluate(RunRules.java:20) [junit-4.13.1.jar:4.13.1]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at java.lang.Thread.run(Thread.java:748) [?:1.8.0_281]
[junit4] 2> 4160087 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 4160088 WARN (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 4160089 WARN (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@29c198b4[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 4160089 WARN (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@29c198b4[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 4160092 WARN (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 4160093 WARN (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@31e24b66[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 4160093 WARN (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@31e24b66[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 4160094 WARN (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-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> 4160122 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@341849c3
[junit4] 2> 4160128 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@341849c3
[junit4] 2> 4160128 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@341849c3
[junit4] 2> 4160129 INFO (coreLoadExecutor-70380-thread-1) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 4160137 INFO (coreLoadExecutor-70380-thread-1) [ x:collection1 ] o.a.s.c.SolrResourceLoader Added 2 libs to classloader, from paths: [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 4160153 INFO (coreLoadExecutor-70380-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.9.0
[junit4] 2> 4160171 INFO (coreLoadExecutor-70380-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Schema name=test
[junit4] 2> 4160178 INFO (coreLoadExecutor-70380-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 4160185 INFO (coreLoadExecutor-70380-thread-1) [ x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1, trusted=true
[junit4] 2> 4160185 INFO (coreLoadExecutor-70380-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@341849c3
[junit4] 2> 4160185 INFO (coreLoadExecutor-70380-thread-1) [ x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.util.TestCircuitBreaker_BFD5A029AAAF480-001/data-dir-59-001/]
[junit4] 2> 4160186 INFO (coreLoadExecutor-70380-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=47, maxMergeAtOnceExplicit=35, maxMergedSegmentMB=0.4365234375, floorSegmentMB=0.24609375, forceMergeDeletesPctAllowed=17.574231608553294, segmentsPerTier=33.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.3446971812475407, deletesPctAllowed=49.24835183209656
[junit4] 2> 4160224 INFO (coreLoadExecutor-70380-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 4160224 INFO (coreLoadExecutor-70380-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 4160225 INFO (coreLoadExecutor-70380-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=50, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 4160225 WARN (coreLoadExecutor-70380-thread-1) [ x:collection1 ] o.a.s.r.ManagedResourceStorage Cannot write to config directory /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1/conf ; switching to use InMemory storage instead.
[junit4] 2> 4160226 INFO (coreLoadExecutor-70380-thread-1) [ x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 4160228 INFO (searcherExecutor-70382-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 4160228 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 4160229 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 1
[junit4] 2> 4160231 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 4160231 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 4160232 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 4160232 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 4160233 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 4160243 INFO (searcherExecutor-70382-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 4160243 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 9
[junit4] 2> 4160243 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 4160243 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 4160244 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 4160244 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 4160245 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 4160245 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 4160251 INFO (searcherExecutor-70382-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 4160251 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 6
[junit4] 2> 4160252 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 4160252 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 4160252 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 4160253 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 4160253 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 4160253 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 4160259 INFO (searcherExecutor-70382-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 4160259 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 5
[junit4] 2> 4160260 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 4160260 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 4160260 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 4160261 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 4160261 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 4160261 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 4160267 INFO (searcherExecutor-70382-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 4160267 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 5
[junit4] 2> 4160268 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 4160268 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 4160268 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 4160268 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 4160269 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 4160269 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 4160275 INFO (searcherExecutor-70382-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 4160275 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 5
[junit4] 2> 4160275 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 4160276 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 4160276 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 4160276 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 4160276 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 4160277 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 4160282 INFO (searcherExecutor-70382-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 4160283 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 5
[junit4] 2> 4160283 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 4160283 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 4160284 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 4160284 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 4160284 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 4160284 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 4160290 INFO (searcherExecutor-70382-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 4160290 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 5
[junit4] 2> 4160291 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 4160291 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 4160291 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 4160291 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 4160292 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 4160292 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 4160297 INFO (searcherExecutor-70382-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 4160298 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 5
[junit4] 2> 4160298 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 4160298 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 4160299 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 4160299 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 4160299 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 4160300 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 4160305 INFO (searcherExecutor-70382-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 4160305 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 5
[junit4] 2> 4160306 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 4160306 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 4160306 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 4160306 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 4160307 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 4160307 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 4160321 INFO (searcherExecutor-70382-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 4160321 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 13
[junit4] 2> 4160321 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 4160322 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 4160322 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 4160322 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 4160323 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 4160323 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 4160328 INFO (searcherExecutor-70382-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 4160329 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 5
[junit4] 2> 4160329 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 4160329 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 4160330 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 4160330 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 4160330 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 4160330 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 4160336 INFO (searcherExecutor-70382-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 4160336 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 5
[junit4] 2> 4160337 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 4160337 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 4160337 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 4160338 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 4160338 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 4160338 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 4160344 INFO (searcherExecutor-70382-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 4160345 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 6
[junit4] 2> 4160345 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 4160345 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 4160345 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 4160346 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 4160350 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 3
[junit4] 2> 4160350 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 4160356 INFO (searcherExecutor-70382-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 4160356 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 5
[junit4] 2> 4160356 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 4160357 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 4160357 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 4160357 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 4160357 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 4160358 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 4160363 INFO (searcherExecutor-70382-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 4160363 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 5
[junit4] 2> 4160364 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 4160364 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 4160364 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 4160365 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 4160365 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 4160365 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 4160371 INFO (searcherExecutor-70382-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 4160371 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 5
[junit4] 2> 4160371 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 4160371 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 4160372 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 4160372 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 4160372 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 4160373 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 4160378 INFO (searcherExecutor-70382-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 4160378 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 5
[junit4] 2> 4160379 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 4160379 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 4160379 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 4160379 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 4160380 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 4160380 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 4160385 INFO (searcherExecutor-70382-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 4160385 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 5
[junit4] 2> 4160386 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 4160386 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 4160386 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 4160387 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 4160387 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 4160387 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 4160392 INFO (searcherExecutor-70382-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 4160393 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 5
[junit4] 2> 4160393 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 4160393 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 4160394 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 4160394 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 4160394 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 4160394 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 4160400 INFO (searcherExecutor-70382-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 4160400 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 5
[junit4] 2> 4160405 INFO (TEST-TestCircuitBreaker.testResponseWithCBTiming-seed#[BFD5A029AAAF480]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testResponseWithCBTiming
[junit4] 2> 4160406 INFO (TEST-TestCircuitBreaker.testResponseWithCBTiming-seed#[BFD5A029AAAF480]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&wt=xml&debugQuery=true} status=503 QTime=0
[junit4] 2> 4160406 ERROR (TEST-TestCircuitBreaker.testResponseWithCBTiming-seed#[BFD5A029AAAF480]) [ ] o.a.s.SolrTestCaseJ4 REQUEST FAILED: q=*:*&wt=xml&debugQuery=true:org.apache.solr.common.SolrException: Circuit Breakers tripped Memory Circuit Breaker triggered as JVM heap usage values are greater than allocated threshold.Seen JVM heap memory usage 407422136 and allocated threshold 394788864
[junit4] 2>
[junit4] 2> at org.apache.solr.handler.component.SearchHandler.handleRequestBody(SearchHandler.java:322)
[junit4] 2> at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:216)
[junit4] 2> at org.apache.solr.core.SolrCore.execute(SolrCore.java:2637)
[junit4] 2> at org.apache.solr.util.TestHarness.query(TestHarness.java:346)
[junit4] 2> at org.apache.solr.util.TestHarness.query(TestHarness.java:328)
[junit4] 2> at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:997)
[junit4] 2> at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:983)
[junit4] 2> at org.apache.solr.util.TestCircuitBreaker.testResponseWithCBTiming(TestCircuitBreaker.java:245)
[junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
[junit4] 2> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4] 2> at java.lang.reflect.Method.invoke(Method.java:498)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
[junit4] 2> at org.junit.rules.RunRules.evaluate(RunRules.java:20)
[junit4] 2> at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
[junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4] 2> at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
[junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
[junit4] 2> at org.junit.rules.RunRules.evaluate(RunRules.java:20)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
[junit4] 2> at org.junit.rules.RunRules.evaluate(RunRules.java:20)
[junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
[junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
[junit4] 2> at org.junit.rules.RunRules.evaluate(RunRules.java:20)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2>
[junit4] 2> 4160407 INFO (TEST-TestCircuitBreaker.testResponseWithCBTiming-seed#[BFD5A029AAAF480]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testResponseWithCBTiming
[junit4] 2> NOTE: download the large Jenkins line-docs file by running 'ant get-jenkins-line-docs' in the lucene directory.
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestCircuitBreaker -Dtests.method=testResponseWithCBTiming -Dtests.seed=BFD5A029AAAF480 -Dtests.multiplier=2 -Dtests.nightly=true -Dtests.slow=true -Dtests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/test-data/enwiki.random.lines.txt -Dtests.locale=pl -Dtests.timezone=America/Argentina/Rio_Gallegos -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] ERROR 0.01s J1 | TestCircuitBreaker.testResponseWithCBTiming <<<
[junit4] > Throwable #1: java.lang.RuntimeException: Exception during query
[junit4] > at __randomizedtesting.SeedInfo.seed([BFD5A029AAAF480:E321F7E06942EEA0]:0)
[junit4] > at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:1023)
[junit4] > at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:983)
[junit4] > at org.apache.solr.util.TestCircuitBreaker.testResponseWithCBTiming(TestCircuitBreaker.java:245)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] > Caused by: org.apache.solr.common.SolrException: Circuit Breakers tripped Memory Circuit Breaker triggered as JVM heap usage values are greater than allocated threshold.Seen JVM heap memory usage 407422136 and allocated threshold 394788864
[junit4] > at org.apache.solr.handler.component.SearchHandler.handleRequestBody(SearchHandler.java:322)
[junit4] > at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:216)
[junit4] > at org.apache.solr.core.SolrCore.execute(SolrCore.java:2637)
[junit4] > at org.apache.solr.util.TestHarness.query(TestHarness.java:346)
[junit4] > at org.apache.solr.util.TestHarness.query(TestHarness.java:328)
[junit4] > at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:997)
[junit4] > ... 45 more
[junit4] 2> 4160413 INFO (TEST-TestCircuitBreaker.testCBAlwaysTrips-seed#[BFD5A029AAAF480]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testCBAlwaysTrips
[junit4] 2> 4160413 INFO (TEST-TestCircuitBreaker.testCBAlwaysTrips-seed#[BFD5A029AAAF480]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=name:"john+smith"&qt=&start=0&rows=20&version=2.2} status=503 QTime=0
[junit4] 2> 4160414 INFO (TEST-TestCircuitBreaker.testCBAlwaysTrips-seed#[BFD5A029AAAF480]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testCBAlwaysTrips
[junit4] 2> 4160418 INFO (TEST-TestCircuitBreaker.testFakeCPUCircuitBreaker-seed#[BFD5A029AAAF480]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testFakeCPUCircuitBreaker
[junit4] 2> 4160419 INFO (TestCircuitBreaker-70386-thread-1) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=name:"john+smith"&qt=&start=0&rows=20&version=2.2} status=503 QTime=0
[junit4] 2> 4160419 INFO (TestCircuitBreaker-70386-thread-2) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=name:"john+smith"&qt=&start=0&rows=20&version=2.2} status=503 QTime=0
[junit4] 2> 4160425 INFO (TestCircuitBreaker-70386-thread-1) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=name:"john+smith"&qt=&start=0&rows=20&version=2.2} status=503 QTime=0
[junit4] 2> 4160425 INFO (TestCircuitBreaker-70386-thread-3) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=name:"john+smith"&qt=&start=0&rows=20&version=2.2} status=503 QTime=0
[junit4] 2> 4160425 INFO (TestCircuitBreaker-70386-thread-2) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=name:"john+smith"&qt=&start=0&rows=20&version=2.2} status=503 QTime=0
[junit4] 2> 4160426 INFO (TEST-TestCircuitBreaker.testFakeCPUCircuitBreaker-seed#[BFD5A029AAAF480]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testFakeCPUCircuitBreaker
[junit4] 2> 4160430 INFO (TEST-TestCircuitBreaker.testCBFakeMemoryPressure-seed#[BFD5A029AAAF480]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testCBFakeMemoryPressure
[junit4] 2> 4160431 INFO (TEST-TestCircuitBreaker.testCBFakeMemoryPressure-seed#[BFD5A029AAAF480]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=name:"john+smith"&qt=&start=0&rows=20&version=2.2} status=503 QTime=0
[junit4] 2> 4160431 INFO (TEST-TestCircuitBreaker.testCBFakeMemoryPressure-seed#[BFD5A029AAAF480]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testCBFakeMemoryPressure
[junit4] 2> 4160435 INFO (TEST-TestCircuitBreaker.testBuildingMemoryPressure-seed#[BFD5A029AAAF480]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testBuildingMemoryPressure
[junit4] 2> 4160459 INFO (TestCircuitBreaker-70387-thread-3) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=name:"john+smith"&qt=&start=0&rows=20&version=2.2} status=503 QTime=0
[junit4] 2> 4160461 INFO (TestCircuitBreaker-70387-thread-5) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=name:"john+smith"&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=2
[junit4] 2> 4160462 INFO (TestCircuitBreaker-70387-thread-2) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=name:"john+smith"&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=25
[junit4] 2> 4160462 INFO (TestCircuitBreaker-70387-thread-4) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=name:"john+smith"&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=18
[junit4] 2> 4160462 INFO (TestCircuitBreaker-70387-thread-1) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=name:"john+smith"&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=26
[junit4] 2> 4160463 INFO (TEST-TestCircuitBreaker.testBuildingMemoryPressure-seed#[BFD5A029AAAF480]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testBuildingMemoryPressure
[junit4] 2> 4160463 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> 4160463 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=880200772
[junit4] 2> 4160464 INFO (coreCloseExecutor-70389-thread-1) [ ] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@7a96ceda
[junit4] 2> 4160464 INFO (coreCloseExecutor-70389-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1 tag=SolrCore@7a96ceda
[junit4] 2> 4160464 INFO (coreCloseExecutor-70389-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@4742ae42: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1/com.codahale.metrics.MetricRegistry@4e9bdcc0
[junit4] 2> 4160478 INFO (coreCloseExecutor-70389-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close() ... SKIPPED (unnecessary).
[junit4] 2> 4160489 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node tag=null
[junit4] 2> 4160489 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@2b3e88c2: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node/com.codahale.metrics.MetricRegistry@4a70dd1d
[junit4] 2> 4160495 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm tag=null
[junit4] 2> 4160495 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@77fdcc0a: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm/com.codahale.metrics.MetricRegistry@3376066c
[junit4] 2> 4160497 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty tag=null
[junit4] 2> 4160497 INFO (SUITE-TestCircuitBreaker-seed#[BFD5A029AAAF480]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@37ce9e23: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty/com.codahale.metrics.MetricRegistry@36deddc1
[junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.util.TestCircuitBreaker_BFD5A029AAAF480-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene87): {title_stringNoNorms=PostingsFormat(name=LuceneVarGapFixedInterval), title_stemmed=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)), multiDefault=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)), inStock_b1=PostingsFormat(name=LuceneVarGapDocFreqInterval), _root_=PostingsFormat(name=LuceneVarGapFixedInterval), name=Lucene84, id=Lucene84, text=PostingsFormat(name=LuceneVarGapDocFreqInterval), title=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)), title_lettertok=Lucene84}, docValues:{range_facet_l_dv=DocValuesFormat(name=Direct), range_facet_i_dv=DocValuesFormat(name=Lucene80), intDvoDefault=DocValuesFormat(name=Asserting), timestamp=DocValuesFormat(name=Lucene80)}, maxPointsInLeafNode=2048, maxMBSortInHeap=5.378160929760242, sim=Asserting(RandomSimilarity(queryNorm=false): {}), locale=pl, timezone=America/Argentina/Rio_Gallegos
[junit4] 2> NOTE: Linux 5.4.0-45-generic amd64/Oracle Corporation 1.8.0_281 (64-bit)/cpus=4,threads=1,free=94513104,total=526909440
[junit4] 2> NOTE: All tests run in this JVM: [PurgeGraphTest, BasicFunctionalityTest, TestEmbeddedSolrServerAdminHandler, StressHdfsTest, HdfsBackupRepositoryIntegrationTest, OverseerCollectionConfigSetProcessorTest, RankFieldTest, UpdateParamsTest, TestRecoveryHdfs, TestSolrCloudWithKerberosAlt, AnalyticsQueryTest, DistributedQueryComponentOptimizationTest, AsyncCallRequestStatusResponseTest, TestImpersonationWithHadoopAuth, SearchHandlerTest, SuggesterWFSTTest, TestRestoreCore, TestChildDocTransformerHierarchy, ResponseHeaderTest, DistributedTermsComponentTest, RangeFacetCloudTest, NestedShardedAtomicUpdateTest, XsltUpdateRequestHandlerTest, TriggerEventQueueTest, TestReplicaProperties, CustomTermsComponentTest, HdfsRecoverLeaseTest, MetricsHistoryWithAuthIntegrationTest, TestSimComputePlanAction, EmbeddedSolrNoSerializeTest, DocValuesNotIndexedTest, SolrGraphiteReporterTest, TestRawTransformer, ClusterStateTest, TestSubQueryTransformerDistrib, TimeRoutedAliasUpdateProcessorTest, ZkNodePropsTest, CdcrBootstrapTest, CdcrUpdateLogTest, MetricsHistoryHandlerTest, TestLogWatcher, TestSimExtremeIndexing, TestStressLiveNodes, TestUseDocValuesAsStored, ZkStateWriterTest, TestValueSourceCache, MultiDestinationAuditLoggerTest, HttpPartitionOnCommitTest, TestStreamBody, TestExactSharedStatsCache, FieldAnalysisRequestHandlerTest, CdcrVersionReplicationTest, ClassificationUpdateProcessorTest, TestDynamicLoading, TestCircuitBreaker]
[junit4] Completed [753/936 (1!)] on J1 in 1.15s, 5 tests, 1 error <<< FAILURES!
[...truncated 51395 lines...]