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 2020/08/06 12:21:29 UTC
[JENKINS] Lucene » Lucene-Solr-Tests-master - Build # 5 - Still Failing!
Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-Solr-Tests-master/5/
All tests passed
Build Log:
[...truncated 66166 lines...]
BUILD FAILED
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-master/build.xml:635: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-master/build.xml:101: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-master/solr/build.xml:625: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-master/solr/build.xml:157: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-master/solr/solr-ref-guide/build.xml:172: Java returned: 1
Total time: 64 minutes 30 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
[JENKINS] Lucene » Lucene-Solr-Tests-master - Build # 6 - Still Failing!
Posted by Apache Jenkins Server <je...@builds.apache.org>.
Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-Solr-Tests-master/6/
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([8B677895089B04C1:63BBD577FB731EE1]:0)
at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:1002)
at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:962)
at org.apache.solr.util.TestCircuitBreaker.testResponseWithCBTiming(TestCircuitBreaker.java:161)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:566)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1754)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:942)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:978)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:992)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:370)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:819)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:470)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:951)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:836)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:887)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:898)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:370)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.lambda$forkTimeoutingTask$0(ThreadLeakControl.java:826)
at java.base/java.lang.Thread.run(Thread.java:834)
Caused by: org.apache.solr.common.SolrException: Circuit Breakers tripped org.apache.solr.util.circuitbreaker.MemoryCircuitBreaker seenMemory=408995248 allowedMemory=402653184
at org.apache.solr.handler.component.SearchHandler.handleRequestBody(SearchHandler.java:325)
at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:212)
at org.apache.solr.core.SolrCore.execute(SolrCore.java:2608)
at org.apache.solr.util.TestHarness.query(TestHarness.java:332)
at org.apache.solr.util.TestHarness.query(TestHarness.java:314)
at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:976)
... 41 more
Build Log:
[...truncated 12674 lines...]
[junit4] Suite: org.apache.solr.util.TestCircuitBreaker
[junit4] 2> 1161130 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ ] o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to test-framework derived value of '/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-master/solr/server/solr/configsets/_default/conf'
[junit4] 2> 1161139 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ ] o.a.s.SolrTestCaseJ4 Created dataDir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.util.TestCircuitBreaker_8B677895089B04C1-001/data-dir-81-001
[junit4] 2> 1161139 WARN (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=4 numCloses=4
[junit4] 2> 1161139 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 1161140 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason="", ssl=0.0/0.0, value=0.0/0.0, clientAuth=0.0/0.0)
[junit4] 2> 1161140 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 1161141 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 1161145 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0
[junit4] 2> 1161238 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ ] o.a.s.s.IndexSchema Schema name=test
[junit4] 2> 1161976 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1165695 WARN (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ ] o.a.s.c.CoreContainer Unable to create [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/userfiles]. Features requiring this directory may fail.
[junit4] 2> => java.security.AccessControlException: access denied ("java.io.FilePermission" "/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/userfiles" "write")
[junit4] 2> at java.base/java.security.AccessControlContext.checkPermission(AccessControlContext.java:472)
[junit4] 2> java.security.AccessControlException: access denied ("java.io.FilePermission" "/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/userfiles" "write")
[junit4] 2> at java.security.AccessControlContext.checkPermission(AccessControlContext.java:472) ~[?:?]
[junit4] 2> at java.security.AccessController.checkPermission(AccessController.java:897) ~[?:?]
[junit4] 2> at java.lang.SecurityManager.checkPermission(SecurityManager.java:322) ~[?:?]
[junit4] 2> at java.lang.SecurityManager.checkWrite(SecurityManager.java:752) ~[?:?]
[junit4] 2> at sun.nio.fs.UnixPath.checkWrite(UnixPath.java:824) ~[?:?]
[junit4] 2> at sun.nio.fs.UnixFileSystemProvider.createDirectory(UnixFileSystemProvider.java:377) ~[?:?]
[junit4] 2> at java.nio.file.Files.createDirectory(Files.java:689) ~[?:?]
[junit4] 2> at java.nio.file.Files.createAndCheckIsDirectory(Files.java:796) ~[?:?]
[junit4] 2> at java.nio.file.Files.createDirectories(Files.java:742) ~[?:?]
[junit4] 2> at org.apache.solr.core.CoreContainer.<init>(CoreContainer.java:364) [java/:?]
[junit4] 2> at org.apache.solr.core.CoreContainer.<init>(CoreContainer.java:325) [java/:?]
[junit4] 2> at org.apache.solr.util.TestHarness.<init>(TestHarness.java:170) [java/:?]
[junit4] 2> at org.apache.solr.util.TestHarness.<init>(TestHarness.java:143) [java/:?]
[junit4] 2> at org.apache.solr.util.TestHarness.<init>(TestHarness.java:149) [java/:?]
[junit4] 2> at org.apache.solr.util.TestHarness.<init>(TestHarness.java:112) [java/:?]
[junit4] 2> at org.apache.solr.SolrTestCaseJ4.createCore(SolrTestCaseJ4.java:810) [java/:?]
[junit4] 2> at org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:800) [java/:?]
[junit4] 2> at org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:661) [java/:?]
[junit4] 2> at org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:650) [java/:?]
[junit4] 2> at org.apache.solr.util.TestCircuitBreaker.setUpClass(TestCircuitBreaker.java:57) [test/:?]
[junit4] 2> at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[?:?]
[junit4] 2> at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[?:?]
[junit4] 2> at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[?:?]
[junit4] 2> at java.lang.reflect.Method.invoke(Method.java:566) ~[?:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1754) [randomizedtesting-runner-2.7.6.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:882) [randomizedtesting-runner-2.7.6.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:898) [randomizedtesting-runner-2.7.6.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [randomizedtesting-runner-2.7.6.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) [randomizedtesting-runner-2.7.6.jar:?]
[junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) [java/:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [randomizedtesting-runner-2.7.6.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.6.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) [randomizedtesting-runner-2.7.6.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [randomizedtesting-runner-2.7.6.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [randomizedtesting-runner-2.7.6.jar:?]
[junit4] 2> at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) [java/:?]
[junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) [java/:?]
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) [java/:?]
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) [java/:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [randomizedtesting-runner-2.7.6.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:370) [randomizedtesting-runner-2.7.6.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl.lambda$forkTimeoutingTask$0(ThreadLeakControl.java:826) [randomizedtesting-runner-2.7.6.jar:?]
[junit4] 2> at java.lang.Thread.run(Thread.java:834) [?:?]
[junit4] 2> 1165697 WARN (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ ] o.a.s.f.DistribPackageStore Unable to create [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/filestore] directory in SOLR_HOME [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-master/solr/core/src/test-files/solr]. Features requiring this directory may fail.
[junit4] 2> => java.security.AccessControlException: access denied ("java.io.FilePermission" "/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/filestore" "write")
[junit4] 2> at java.base/java.security.AccessControlContext.checkPermission(AccessControlContext.java:472)
[junit4] 2> java.security.AccessControlException: access denied ("java.io.FilePermission" "/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/filestore" "write")
[junit4] 2> at java.security.AccessControlContext.checkPermission(AccessControlContext.java:472) ~[?:?]
[junit4] 2> at java.security.AccessController.checkPermission(AccessController.java:897) ~[?:?]
[junit4] 2> at java.lang.SecurityManager.checkPermission(SecurityManager.java:322) ~[?:?]
[junit4] 2> at java.lang.SecurityManager.checkWrite(SecurityManager.java:752) ~[?:?]
[junit4] 2> at java.io.File.mkdir(File.java:1323) ~[?:?]
[junit4] 2> at java.io.File.mkdirs(File.java:1355) ~[?:?]
[junit4] 2> at org.apache.solr.filestore.DistribPackageStore.ensurePackageStoreDir(DistribPackageStore.java:560) [java/:?]
[junit4] 2> at org.apache.solr.filestore.DistribPackageStore.<init>(DistribPackageStore.java:80) [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:664) [java/:?]
[junit4] 2> at org.apache.solr.util.TestHarness.<init>(TestHarness.java:171) [java/:?]
[junit4] 2> at org.apache.solr.util.TestHarness.<init>(TestHarness.java:143) [java/:?]
[junit4] 2> at org.apache.solr.util.TestHarness.<init>(TestHarness.java:149) [java/:?]
[junit4] 2> at org.apache.solr.util.TestHarness.<init>(TestHarness.java:112) [java/:?]
[junit4] 2> at org.apache.solr.SolrTestCaseJ4.createCore(SolrTestCaseJ4.java:810) [java/:?]
[junit4] 2> at org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:800) [java/:?]
[junit4] 2> at org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:661) [java/:?]
[junit4] 2> at org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:650) [java/:?]
[junit4] 2> at org.apache.solr.util.TestCircuitBreaker.setUpClass(TestCircuitBreaker.java:57) [test/:?]
[junit4] 2> at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[?:?]
[junit4] 2> at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[?:?]
[junit4] 2> at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[?:?]
[junit4] 2> at java.lang.reflect.Method.invoke(Method.java:566) ~[?:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1754) [randomizedtesting-runner-2.7.6.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:882) [randomizedtesting-runner-2.7.6.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:898) [randomizedtesting-runner-2.7.6.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [randomizedtesting-runner-2.7.6.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) [randomizedtesting-runner-2.7.6.jar:?]
[junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) [java/:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [randomizedtesting-runner-2.7.6.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.6.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) [randomizedtesting-runner-2.7.6.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [randomizedtesting-runner-2.7.6.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [randomizedtesting-runner-2.7.6.jar:?]
[junit4] 2> at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) [java/:?]
[junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) [java/:?]
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) [java/:?]
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) [java/:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [randomizedtesting-runner-2.7.6.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:370) [randomizedtesting-runner-2.7.6.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl.lambda$forkTimeoutingTask$0(ThreadLeakControl.java:826) [randomizedtesting-runner-2.7.6.jar:?]
[junit4] 2> at java.lang.Thread.run(Thread.java:834) [?:?]
[junit4] 2> 1165715 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 1165738 WARN (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@63e285fd[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1165738 WARN (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@63e285fd[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1165754 WARN (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@e81a72d[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1165754 WARN (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@e81a72d[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1165776 WARN (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-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> 1166036 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@54ec3a88
[junit4] 2> 1166083 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@54ec3a88
[junit4] 2> 1166083 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@54ec3a88
[junit4] 2> 1166105 INFO (coreLoadExecutor-7743-thread-1) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 1000 transient cores
[junit4] 2> 1166131 INFO (coreLoadExecutor-7743-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0
[junit4] 2> 1166197 INFO (coreLoadExecutor-7743-thread-1) [ x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1, trusted=true
[junit4] 2> 1166236 INFO (coreLoadExecutor-7743-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Schema name=test
[junit4] 2> 1167133 INFO (coreLoadExecutor-7743-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1167207 INFO (coreLoadExecutor-7743-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@54ec3a88
[junit4] 2> 1167207 INFO (coreLoadExecutor-7743-thread-1) [ x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.util.TestCircuitBreaker_8B677895089B04C1-001/data-dir-81-001/]
[junit4] 2> 1167229 INFO (coreLoadExecutor-7743-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=33, maxMergeAtOnceExplicit=23, maxMergedSegmentMB=85.5791015625, floorSegmentMB=1.4091796875, forceMergeDeletesPctAllowed=25.77681911318748, segmentsPerTier=41.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0, deletesPctAllowed=35.91560488589247
[junit4] 2> 1167647 INFO (coreLoadExecutor-7743-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1167647 INFO (coreLoadExecutor-7743-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1167648 INFO (coreLoadExecutor-7743-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=15, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 1167649 WARN (coreLoadExecutor-7743-thread-1) [ x:collection1 ] o.a.s.r.ManagedResourceStorage Cannot write to config directory /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/conf ; switching to use InMemory storage instead.
[junit4] 2> 1167659 INFO (coreLoadExecutor-7743-thread-1) [ x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 1167664 INFO (searcherExecutor-7745-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 1167677 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 1167678 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 1167679 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 1167693 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 1167694 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 1167694 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 1167695 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 1167782 INFO (searcherExecutor-7745-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 1167784 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 88
[junit4] 2> 1167785 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 1167785 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 1167795 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 10
[junit4] 2> 1167796 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 1167796 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 1167797 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 1167831 INFO (searcherExecutor-7745-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 1167832 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 34
[junit4] 2> 1167832 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 1167833 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 1167833 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 1167834 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 1167834 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 1167852 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 1167897 INFO (searcherExecutor-7745-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 1167898 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 45
[junit4] 2> 1167899 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 1167899 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 1167916 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 16
[junit4] 2> 1167916 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 1167918 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 1167918 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 1167967 INFO (searcherExecutor-7745-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 1167968 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 49
[junit4] 2> 1167969 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 1167989 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 1167990 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 1167990 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 1167991 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 1167991 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 1168032 INFO (searcherExecutor-7745-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 1168051 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 59
[junit4] 2> 1168051 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 1168052 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 1168052 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 1168053 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 1168053 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 1168053 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 1168120 INFO (searcherExecutor-7745-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 1168120 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 66
[junit4] 2> 1168121 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 1168121 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 1168122 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 1168122 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 1168123 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 1168123 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 1168196 INFO (searcherExecutor-7745-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 1168196 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 51
[junit4] 2> 1168209 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 1168210 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 1168210 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 1168211 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 1168211 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 1168212 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 1168264 INFO (searcherExecutor-7745-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 1168264 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 52
[junit4] 2> 1168265 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 1168266 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 1168266 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 1168266 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 1168267 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 1168267 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 1168340 INFO (searcherExecutor-7745-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 1168340 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 72
[junit4] 2> 1168341 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 1168341 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 1168342 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 1168342 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 1168343 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 1168364 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 1168394 INFO (searcherExecutor-7745-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 1168395 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 30
[junit4] 2> 1168396 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 1168412 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 1168413 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 1168413 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 1168414 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 1168414 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 1168466 INFO (searcherExecutor-7745-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 1168477 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 62
[junit4] 2> 1168480 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 2
[junit4] 2> 1168480 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 1168481 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 1168481 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 1168502 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 1168502 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 1168548 INFO (searcherExecutor-7745-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 1168548 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 45
[junit4] 2> 1168549 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 1168549 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 1168550 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 1168550 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 1168571 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 1168571 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 1168617 INFO (searcherExecutor-7745-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 1168636 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 64
[junit4] 2> 1168636 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 1168637 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 1168637 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 1168638 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 1168638 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 1168639 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 1168692 INFO (searcherExecutor-7745-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 1168692 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 53
[junit4] 2> 1168709 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 16
[junit4] 2> 1168710 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 1168710 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 1168711 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 1168711 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 1168712 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 1168787 INFO (searcherExecutor-7745-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 1168787 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 75
[junit4] 2> 1168788 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 1168789 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 1168789 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 1168790 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 1168790 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 1168813 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 1168875 INFO (searcherExecutor-7745-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 1168908 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 94
[junit4] 2> 1168909 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 1168910 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 1168910 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 1168911 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 1168911 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 1168912 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 1168962 INFO (searcherExecutor-7745-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 1168962 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 50
[junit4] 2> 1168963 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 1168964 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 1168964 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 1168965 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 1168977 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 12
[junit4] 2> 1168978 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 1169028 INFO (searcherExecutor-7745-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 1169028 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 50
[junit4] 2> 1169029 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 1169029 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 1169030 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 1169030 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 1169031 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 1169031 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 1169069 INFO (searcherExecutor-7745-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 1169069 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 37
[junit4] 2> 1169070 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 1169071 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 1169091 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 1169092 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 1169092 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 1169093 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 1169142 INFO (searcherExecutor-7745-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 1169142 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 49
[junit4] 2> 1169163 INFO (TEST-TestCircuitBreaker.testResponseWithCBTiming-seed#[8B677895089B04C1]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testResponseWithCBTiming
[junit4] 2> 1169164 INFO (TEST-TestCircuitBreaker.testResponseWithCBTiming-seed#[8B677895089B04C1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&wt=xml&debugQuery=true} status=503 QTime=0
[junit4] 2> 1169185 ERROR (TEST-TestCircuitBreaker.testResponseWithCBTiming-seed#[8B677895089B04C1]) [ ] o.a.s.SolrTestCaseJ4 REQUEST FAILED: q=*:*&wt=xml&debugQuery=true:org.apache.solr.common.SolrException: Circuit Breakers tripped org.apache.solr.util.circuitbreaker.MemoryCircuitBreaker seenMemory=408995248 allowedMemory=402653184
[junit4] 2>
[junit4] 2> at org.apache.solr.handler.component.SearchHandler.handleRequestBody(SearchHandler.java:325)
[junit4] 2> at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:212)
[junit4] 2> at org.apache.solr.core.SolrCore.execute(SolrCore.java:2608)
[junit4] 2> at org.apache.solr.util.TestHarness.query(TestHarness.java:332)
[junit4] 2> at org.apache.solr.util.TestHarness.query(TestHarness.java:314)
[junit4] 2> at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:976)
[junit4] 2> at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:962)
[junit4] 2> at org.apache.solr.util.TestCircuitBreaker.testResponseWithCBTiming(TestCircuitBreaker.java:161)
[junit4] 2> at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit4] 2> at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
[junit4] 2> at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4] 2> at java.base/java.lang.reflect.Method.invoke(Method.java:566)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1754)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:942)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:978)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:992)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
[junit4] 2> at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
[junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4] 2> at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
[junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:370)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:819)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:470)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:951)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:836)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:887)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:898)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
[junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
[junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:370)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl.lambda$forkTimeoutingTask$0(ThreadLeakControl.java:826)
[junit4] 2> at java.base/java.lang.Thread.run(Thread.java:834)
[junit4] 2>
[junit4] 2> 1169186 INFO (TEST-TestCircuitBreaker.testResponseWithCBTiming-seed#[8B677895089B04C1]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testResponseWithCBTiming
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestCircuitBreaker -Dtests.method=testResponseWithCBTiming -Dtests.seed=8B677895089B04C1 -Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=mg -Dtests.timezone=Australia/Sydney -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] ERROR 0.05s J1 | TestCircuitBreaker.testResponseWithCBTiming <<<
[junit4] > Throwable #1: java.lang.RuntimeException: Exception during query
[junit4] > at __randomizedtesting.SeedInfo.seed([8B677895089B04C1:63BBD577FB731EE1]:0)
[junit4] > at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:1002)
[junit4] > at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:962)
[junit4] > at org.apache.solr.util.TestCircuitBreaker.testResponseWithCBTiming(TestCircuitBreaker.java:161)
[junit4] > at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit4] > at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
[junit4] > at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4] > at java.base/java.lang.reflect.Method.invoke(Method.java:566)
[junit4] > at java.base/java.lang.Thread.run(Thread.java:834)
[junit4] > Caused by: org.apache.solr.common.SolrException: Circuit Breakers tripped org.apache.solr.util.circuitbreaker.MemoryCircuitBreaker seenMemory=408995248 allowedMemory=402653184
[junit4] > at org.apache.solr.handler.component.SearchHandler.handleRequestBody(SearchHandler.java:325)
[junit4] > at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:212)
[junit4] > at org.apache.solr.core.SolrCore.execute(SolrCore.java:2608)
[junit4] > at org.apache.solr.util.TestHarness.query(TestHarness.java:332)
[junit4] > at org.apache.solr.util.TestHarness.query(TestHarness.java:314)
[junit4] > at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:976)
[junit4] > ... 41 more
[junit4] 2> 1169212 INFO (TEST-TestCircuitBreaker.testBuildingMemoryPressure-seed#[8B677895089B04C1]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testBuildingMemoryPressure
[junit4] 2> 1169215 INFO (TestCircuitBreaker-7749-thread-2) [ ] o.a.s.u.TestCircuitBreaker BuildingUpMemoryPressureCircuitBreaker: Returning unblocking value for count 1
[junit4] 2> 1169215 INFO (TestCircuitBreaker-7749-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> 1169216 INFO (TestCircuitBreaker-7749-thread-2) [ ] o.a.s.u.TestCircuitBreaker BuildingUpMemoryPressureCircuitBreaker: Returning unblocking value for count 2
[junit4] 2> 1169216 INFO (TestCircuitBreaker-7749-thread-4) [ ] o.a.s.u.TestCircuitBreaker BuildingUpMemoryPressureCircuitBreaker: Returning unblocking value for count 3
[junit4] 2> 1169216 INFO (TestCircuitBreaker-7749-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> 1169216 INFO (TestCircuitBreaker-7749-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=0
[junit4] 2> 1169229 INFO (TestCircuitBreaker-7749-thread-1) [ ] o.a.s.u.TestCircuitBreaker BuildingUpMemoryPressureCircuitBreaker: Returning unblocking value for count 0
[junit4] 2> 1169230 INFO (TestCircuitBreaker-7749-thread-3) [ ] o.a.s.u.TestCircuitBreaker Blocking query from BuildingUpMemoryPressureCircuitBreaker for count 4
[junit4] 2> 1169230 INFO (TestCircuitBreaker-7749-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> 1169230 INFO (TestCircuitBreaker-7749-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=17
[junit4] 2> 1169231 INFO (TEST-TestCircuitBreaker.testBuildingMemoryPressure-seed#[8B677895089B04C1]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testBuildingMemoryPressure
[junit4] 2> 1169328 INFO (TEST-TestCircuitBreaker.testCBAlwaysTrips-seed#[8B677895089B04C1]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testCBAlwaysTrips
[junit4] 2> 1169329 INFO (TEST-TestCircuitBreaker.testCBAlwaysTrips-seed#[8B677895089B04C1]) [ ] 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> 1169330 INFO (TEST-TestCircuitBreaker.testCBAlwaysTrips-seed#[8B677895089B04C1]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testCBAlwaysTrips
[junit4] 2> 1169361 INFO (TEST-TestCircuitBreaker.testCBFakeMemoryPressure-seed#[8B677895089B04C1]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testCBFakeMemoryPressure
[junit4] 2> 1169362 INFO (TEST-TestCircuitBreaker.testCBFakeMemoryPressure-seed#[8B677895089B04C1]) [ ] 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> 1169363 INFO (TEST-TestCircuitBreaker.testCBFakeMemoryPressure-seed#[8B677895089B04C1]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testCBFakeMemoryPressure
[junit4] 2> 1169363 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> 1169363 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=602077976
[junit4] 2> 1169376 INFO (coreCloseExecutor-7751-thread-1) [ ] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@4a4542c9
[junit4] 2> 1169376 INFO (coreCloseExecutor-7751-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1 tag=SolrCore@4a4542c9
[junit4] 2> 1169376 INFO (coreCloseExecutor-7751-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@5e312474: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1/com.codahale.metrics.MetricRegistry@64c36f7d
[junit4] 2> 1169497 INFO (coreCloseExecutor-7751-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close() ... SKIPPED (unnecessary).
[junit4] 2> 1169515 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node tag=null
[junit4] 2> 1169515 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@19be3e58: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node/com.codahale.metrics.MetricRegistry@6c739044
[junit4] 2> 1169538 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm tag=null
[junit4] 2> 1169538 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@67b8e807: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm/com.codahale.metrics.MetricRegistry@6d7255e2
[junit4] 2> 1169562 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty tag=null
[junit4] 2> 1169562 INFO (SUITE-TestCircuitBreaker-seed#[8B677895089B04C1]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@6c4afa0b: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty/com.codahale.metrics.MetricRegistry@2370ebc1
[junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.util.TestCircuitBreaker_8B677895089B04C1-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene86), sim=Asserting(RandomSimilarity(queryNorm=true): {}), locale=mg, timezone=Australia/Sydney
[junit4] 2> NOTE: Linux 4.4.0-170-generic amd64/Oracle Corporation 11.0.4 (64-bit)/cpus=8,threads=1,free=108406016,total=536870912
[junit4] 2> NOTE: All tests run in this JVM: [MetricsConfigTest, TransactionLogTest, OverseerStatusTest, SmileWriterTest, TestCloudPseudoReturnFields, TestCloudJSONFacetSKG, MaxScoreCollectorTest, TestCoreAdminApis, UnloadDistributedZkTest, TestManagedStopFilterFactory, SimpleFacetsTest, TestStressUserVersions, SplitHandlerTest, TestDeprecatedFilters, HighlighterConfigTest, TestStreamBody, QueryParsingTest, DirectSolrConnectionTest, UUIDUpdateProcessorFallbackTest, ZkShardTermsTest, CoreAdminHandlerTest, SegmentsInfoRequestHandlerTest, TestSolrQueryParser, TestExplainDocTransformer, BasicAuthIntegrationTest, RequestHandlersTest, TestSolrQueryResponse, TestConfigOverlay, MetricsHistoryIntegrationTest, DistributedVersionInfoTest, SparseHLLTest, TestFuzzyAnalyzedSuggestions, TestNestedDocsSort, TestConfigSets, TestCursorMarkWithoutUniqueKey, TestTlogReplica, DOMUtilTest, DistributedUpdateProcessorTest, TestLeaderElectionWithEmptyReplica, TestSweetSpotSimilarityFactory, XsltUpdateRequestHandlerTest, TestIndexSearcher, TestBlendedInfixSuggestions, CloneFieldUpdateProcessorFactoryTest, TestHdfsCloudBackupRestore, RegexBoostProcessorTest, PluginInfoTest, TaggingAttributeTest, V2ApiIntegrationTest, ReplaceNodeTest, SolrCloudExampleTest, PKIAuthenticationIntegrationTest, SimpleMLTQParserTest, DeleteLastCustomShardedReplicaTest, OpenExchangeRatesOrgProviderTest, TestDelegationWithHadoopAuth, SchemaVersionSpecificBehaviorTest, TestSchemaNameResource, TestSolr4Spatial, CollectionReloadTest, TestReplicationHandlerDiskOverFlow, ClusterStateMockUtilTest, SuggesterFSTTest, SpellCheckComponentTest, BasicFunctionalityTest, LeaderFailureAfterFreshStartTest, SyncSliceTest, TestRealTimeGet, CollectionsAPIDistributedZkTest, TestExternalRoleRuleBasedAuthorizationPlugin, TestQueryTypes, PathHierarchyTokenizerFactoryTest, TestConfigSetsAPIExclusivity, TestCloudManagedSchema, SignatureUpdateProcessorFactoryTest, OverriddenZkACLAndCredentialsProvidersTest, HighlighterWithoutStoredIdTest, TestSolrCoreParser, TestRestManager, TestXmlQParser, SolrCloudReportersTest, PackageManagerCLITest, AtomicUpdateRemovalJavabinTest, DistributedDebugComponentTest, TestCircuitBreaker]
[junit4] Completed [263/863 (1!)] on J1 in 8.74s, 4 tests, 1 error <<< FAILURES!
[...truncated 53516 lines...]
BUILD FAILED
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-master/build.xml:635: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-master/build.xml:101: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-master/solr/build.xml:625: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-master/solr/build.xml:157: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-master/solr/solr-ref-guide/build.xml:172: Java returned: 1
Total time: 113 minutes 42 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any