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

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([A9FD920F8B0169D0:41213FED78E973F0]: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 440522800 and allocated 
threshold 396754944

        at 
org.apache.solr.handler.component.SearchHandler.handleRequestBody(SearchHandler.java:320)
        at 
org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:216)
        at org.apache.solr.core.SolrCore.execute(SolrCore.java:2638)
        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 16407 lines...]
   [junit4] Suite: org.apache.solr.util.TestCircuitBreaker
   [junit4]   2> 2437715 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-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-BadApples-Tests-8.x/solr/server/solr/configsets/_default/conf'
   [junit4]   2> 2437715 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [     ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 2437716 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Created dataDir: 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.util.TestCircuitBreaker_A9FD920F8B0169D0-001/data-dir-316-001
   [junit4]   2> 2437716 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 2437716 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via: 
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
   [junit4]   2> 2437717 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [     ] 
o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 2437722 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [     ] 
o.a.s.c.SolrResourceLoader Added 2 libs to classloader, from paths: 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/core/src/test-files/solr/collection1/lib,
 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 2437737 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [     ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.9.0
   [junit4]   2> 2437746 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [     ] 
o.a.s.s.IndexSchema Schema name=test
   [junit4]   2> 2437752 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [     ] 
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 2438928 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [     ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 2438928 WARN  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@4c5d28fe[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2438928 WARN  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@4c5d28fe[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2438931 WARN  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@5b212b83[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2438931 WARN  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@5b212b83[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2438932 WARN  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-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> 2438959 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@15d111bd
   [junit4]   2> 2438965 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@15d111bd
   [junit4]   2> 2438965 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@15d111bd
   [junit4]   2> 2438966 INFO  (coreLoadExecutor-23651-thread-1) [     ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 2438973 INFO  (coreLoadExecutor-23651-thread-1) [    
x:collection1 ] o.a.s.c.SolrResourceLoader Added 2 libs to classloader, from 
paths: 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/core/src/test-files/solr/collection1/lib,
 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 2438990 INFO  (coreLoadExecutor-23651-thread-1) [    
x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.9.0
   [junit4]   2> 2439009 INFO  (coreLoadExecutor-23651-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema Schema name=test
   [junit4]   2> 2439015 INFO  (coreLoadExecutor-23651-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field 
id
   [junit4]   2> 2439022 INFO  (coreLoadExecutor-23651-thread-1) [    
x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from instancedir 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/core/src/test-files/solr/collection1,
 trusted=true
   [junit4]   2> 2439022 INFO  (coreLoadExecutor-23651-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@15d111bd
   [junit4]   2> 2439022 INFO  (coreLoadExecutor-23651-thread-1) [    
x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/core/src/test-files/solr/collection1],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.util.TestCircuitBreaker_A9FD920F8B0169D0-001/data-dir-316-001/]
   [junit4]   2> 2439023 INFO  (coreLoadExecutor-23651-thread-1) [    
x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=12, maxMergeAtOnceExplicit=16, maxMergedSegmentMB=76.841796875, 
floorSegmentMB=1.1025390625, forceMergeDeletesPctAllowed=18.96499297587498, 
segmentsPerTier=36.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0, 
deletesPctAllowed=41.469080552360765
   [junit4]   2> 2439059 INFO  (coreLoadExecutor-23651-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2439059 INFO  (coreLoadExecutor-23651-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2439060 INFO  (coreLoadExecutor-23651-thread-1) [    
x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=49, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.2708625552269808]
   [junit4]   2> 2439060 INFO  (coreLoadExecutor-23651-thread-1) [    
x:collection1 ] o.a.s.r.ManagedResourceStorage File-based storage initialized 
to use dir: 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/core/src/test-files/solr/collection1/conf
   [junit4]   2> 2439061 INFO  (coreLoadExecutor-23651-thread-1) [    
x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 2439062 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [     ] 
o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 2439062 INFO  
(searcherExecutor-23653-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 2439062 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[1]} 0 0
   [junit4]   2> 2439064 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[2]} 0 0
   [junit4]   2> 2439064 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[3]} 0 0
   [junit4]   2> 2439065 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[1]} 0 0
   [junit4]   2> 2439065 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[2]} 0 0
   [junit4]   2> 2439065 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[3]} 0 0
   [junit4]   2> 2439072 INFO  
(searcherExecutor-23653-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 2439072 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{commit=} 0 6
   [junit4]   2> 2439073 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[1]} 0 0
   [junit4]   2> 2439073 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[2]} 0 0
   [junit4]   2> 2439073 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[3]} 0 0
   [junit4]   2> 2439074 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[1]} 0 0
   [junit4]   2> 2439074 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[2]} 0 0
   [junit4]   2> 2439074 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[3]} 0 0
   [junit4]   2> 2439080 INFO  
(searcherExecutor-23653-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 2439080 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{commit=} 0 6
   [junit4]   2> 2439081 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[1]} 0 0
   [junit4]   2> 2439081 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[2]} 0 0
   [junit4]   2> 2439081 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[3]} 0 0
   [junit4]   2> 2439082 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[1]} 0 0
   [junit4]   2> 2439082 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[2]} 0 0
   [junit4]   2> 2439082 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[3]} 0 0
   [junit4]   2> 2439088 INFO  
(searcherExecutor-23653-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 2439088 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{commit=} 0 5
   [junit4]   2> 2439089 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[1]} 0 0
   [junit4]   2> 2439089 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[2]} 0 0
   [junit4]   2> 2439089 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[3]} 0 0
   [junit4]   2> 2439089 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[1]} 0 0
   [junit4]   2> 2439090 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[2]} 0 0
   [junit4]   2> 2439090 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[3]} 0 0
   [junit4]   2> 2439096 INFO  
(searcherExecutor-23653-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 2439096 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{commit=} 0 5
   [junit4]   2> 2439096 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[1]} 0 0
   [junit4]   2> 2439097 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[2]} 0 0
   [junit4]   2> 2439097 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[3]} 0 0
   [junit4]   2> 2439097 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[1]} 0 0
   [junit4]   2> 2439097 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[2]} 0 0
   [junit4]   2> 2439098 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[3]} 0 0
   [junit4]   2> 2439103 INFO  
(searcherExecutor-23653-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 2439103 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{commit=} 0 5
   [junit4]   2> 2439104 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[1]} 0 0
   [junit4]   2> 2439104 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[2]} 0 0
   [junit4]   2> 2439104 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[3]} 0 0
   [junit4]   2> 2439105 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[1]} 0 0
   [junit4]   2> 2439105 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[2]} 0 0
   [junit4]   2> 2439105 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[3]} 0 0
   [junit4]   2> 2439111 INFO  
(searcherExecutor-23653-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 2439111 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{commit=} 0 5
   [junit4]   2> 2439111 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[1]} 0 0
   [junit4]   2> 2439111 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[2]} 0 0
   [junit4]   2> 2439112 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[3]} 0 0
   [junit4]   2> 2439112 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[1]} 0 0
   [junit4]   2> 2439112 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[2]} 0 0
   [junit4]   2> 2439113 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[3]} 0 0
   [junit4]   2> 2439118 INFO  
(searcherExecutor-23653-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 2439118 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{commit=} 0 5
   [junit4]   2> 2439118 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[1]} 0 0
   [junit4]   2> 2439119 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[2]} 0 0
   [junit4]   2> 2439119 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[3]} 0 0
   [junit4]   2> 2439119 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[1]} 0 0
   [junit4]   2> 2439119 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[2]} 0 0
   [junit4]   2> 2439120 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[3]} 0 0
   [junit4]   2> 2439125 INFO  
(searcherExecutor-23653-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 2439125 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{commit=} 0 5
   [junit4]   2> 2439126 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[1]} 0 0
   [junit4]   2> 2439126 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[2]} 0 0
   [junit4]   2> 2439126 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[3]} 0 0
   [junit4]   2> 2439126 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[1]} 0 0
   [junit4]   2> 2439127 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[2]} 0 0
   [junit4]   2> 2439127 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[3]} 0 0
   [junit4]   2> 2439132 INFO  
(searcherExecutor-23653-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 2439132 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{commit=} 0 5
   [junit4]   2> 2439133 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[1]} 0 0
   [junit4]   2> 2439133 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[2]} 0 0
   [junit4]   2> 2439133 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[3]} 0 0
   [junit4]   2> 2439134 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[1]} 0 0
   [junit4]   2> 2439134 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[2]} 0 0
   [junit4]   2> 2439134 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[3]} 0 0
   [junit4]   2> 2439139 INFO  
(searcherExecutor-23653-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 2439139 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{commit=} 0 5
   [junit4]   2> 2439140 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[1]} 0 0
   [junit4]   2> 2439140 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[2]} 0 0
   [junit4]   2> 2439140 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[3]} 0 0
   [junit4]   2> 2439141 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[1]} 0 0
   [junit4]   2> 2439141 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[2]} 0 0
   [junit4]   2> 2439141 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[3]} 0 0
   [junit4]   2> 2439146 INFO  
(searcherExecutor-23653-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 2439147 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{commit=} 0 5
   [junit4]   2> 2439147 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[1]} 0 0
   [junit4]   2> 2439147 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[2]} 0 0
   [junit4]   2> 2439148 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[3]} 0 0
   [junit4]   2> 2439148 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[1]} 0 0
   [junit4]   2> 2439148 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[2]} 0 0
   [junit4]   2> 2439148 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[3]} 0 0
   [junit4]   2> 2439171 INFO  
(searcherExecutor-23653-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 2439171 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{commit=} 0 22
   [junit4]   2> 2439172 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[1]} 0 0
   [junit4]   2> 2439172 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[2]} 0 0
   [junit4]   2> 2439173 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[3]} 0 0
   [junit4]   2> 2439173 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[1]} 0 0
   [junit4]   2> 2439173 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[2]} 0 0
   [junit4]   2> 2439173 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[3]} 0 0
   [junit4]   2> 2439179 INFO  
(searcherExecutor-23653-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 2439179 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{commit=} 0 5
   [junit4]   2> 2439179 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[1]} 0 0
   [junit4]   2> 2439180 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[2]} 0 0
   [junit4]   2> 2439180 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[3]} 0 0
   [junit4]   2> 2439180 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[1]} 0 0
   [junit4]   2> 2439180 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[2]} 0 0
   [junit4]   2> 2439181 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[3]} 0 0
   [junit4]   2> 2439186 INFO  
(searcherExecutor-23653-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 2439186 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{commit=} 0 5
   [junit4]   2> 2439187 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[1]} 0 0
   [junit4]   2> 2439187 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[2]} 0 0
   [junit4]   2> 2439187 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[3]} 0 0
   [junit4]   2> 2439188 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[1]} 0 0
   [junit4]   2> 2439188 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[2]} 0 0
   [junit4]   2> 2439188 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[3]} 0 0
   [junit4]   2> 2439193 INFO  
(searcherExecutor-23653-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 2439194 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{commit=} 0 5
   [junit4]   2> 2439194 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[1]} 0 0
   [junit4]   2> 2439194 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[2]} 0 0
   [junit4]   2> 2439194 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[3]} 0 0
   [junit4]   2> 2439195 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[1]} 0 0
   [junit4]   2> 2439195 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[2]} 0 0
   [junit4]   2> 2439195 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[3]} 0 0
   [junit4]   2> 2439200 INFO  
(searcherExecutor-23653-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 2439201 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{commit=} 0 5
   [junit4]   2> 2439201 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[1]} 0 0
   [junit4]   2> 2439201 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[2]} 0 0
   [junit4]   2> 2439202 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[3]} 0 0
   [junit4]   2> 2439202 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[1]} 0 0
   [junit4]   2> 2439202 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[2]} 0 0
   [junit4]   2> 2439202 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[3]} 0 0
   [junit4]   2> 2439208 INFO  
(searcherExecutor-23653-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 2439208 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{commit=} 0 5
   [junit4]   2> 2439208 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[1]} 0 0
   [junit4]   2> 2439209 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[2]} 0 0
   [junit4]   2> 2439209 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[3]} 0 0
   [junit4]   2> 2439209 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[1]} 0 0
   [junit4]   2> 2439209 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[2]} 0 0
   [junit4]   2> 2439210 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[3]} 0 0
   [junit4]   2> 2439215 INFO  
(searcherExecutor-23653-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 2439215 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{commit=} 0 5
   [junit4]   2> 2439215 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[1]} 0 0
   [junit4]   2> 2439216 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[2]} 0 0
   [junit4]   2> 2439216 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[3]} 0 0
   [junit4]   2> 2439216 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[1]} 0 0
   [junit4]   2> 2439217 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[2]} 0 0
   [junit4]   2> 2439217 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[3]} 0 0
   [junit4]   2> 2439222 INFO  
(searcherExecutor-23653-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 2439222 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{commit=} 0 5
   [junit4]   2> 2439223 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[1]} 0 0
   [junit4]   2> 2439223 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[2]} 0 0
   [junit4]   2> 2439223 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[3]} 0 0
   [junit4]   2> 2439223 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[1]} 0 0
   [junit4]   2> 2439224 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[2]} 0 0
   [junit4]   2> 2439224 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[3]} 0 0
   [junit4]   2> 2439229 INFO  
(searcherExecutor-23653-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 2439229 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{commit=} 0 5
   [junit4]   2> 2439233 INFO  
(TEST-TestCircuitBreaker.testResponseWithCBTiming-seed#[A9FD920F8B0169D0]) [    
 ] o.a.s.SolrTestCaseJ4 ###Starting testResponseWithCBTiming
   [junit4]   2> 2439234 INFO  
(TEST-TestCircuitBreaker.testResponseWithCBTiming-seed#[A9FD920F8B0169D0]) [    
 ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&wt=xml&debugQuery=true} status=503 QTime=0
   [junit4]   2> 2439234 ERROR 
(TEST-TestCircuitBreaker.testResponseWithCBTiming-seed#[A9FD920F8B0169D0]) [    
 ] 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 440522800 and 
allocated threshold 396754944
   [junit4]   2> 
   [junit4]   2>        at 
org.apache.solr.handler.component.SearchHandler.handleRequestBody(SearchHandler.java:320)
   [junit4]   2>        at 
org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:216)
   [junit4]   2>        at 
org.apache.solr.core.SolrCore.execute(SolrCore.java:2638)
   [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> 2439235 INFO  
(TEST-TestCircuitBreaker.testResponseWithCBTiming-seed#[A9FD920F8B0169D0]) [    
 ] o.a.s.SolrTestCaseJ4 ###Ending testResponseWithCBTiming
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestCircuitBreaker 
-Dtests.method=testResponseWithCBTiming -Dtests.seed=A9FD920F8B0169D0 
-Dtests.multiplier=2 -Dtests.slow=true -Dtests.badapples=true -Dtests.locale=es 
-Dtests.timezone=America/Santarem -Dtests.asserts=true 
-Dtests.file.encoding=UTF-8
   [junit4] ERROR   0.01s J2 | TestCircuitBreaker.testResponseWithCBTiming <<<
   [junit4]    > Throwable #1: java.lang.RuntimeException: Exception during 
query
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([A9FD920F8B0169D0:41213FED78E973F0]: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 440522800 and 
allocated threshold 396754944
   [junit4]    >        at 
org.apache.solr.handler.component.SearchHandler.handleRequestBody(SearchHandler.java:320)
   [junit4]    >        at 
org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:216)
   [junit4]    >        at 
org.apache.solr.core.SolrCore.execute(SolrCore.java:2638)
   [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> 2439242 INFO  
(TEST-TestCircuitBreaker.testCBAlwaysTrips-seed#[A9FD920F8B0169D0]) [     ] 
o.a.s.SolrTestCaseJ4 ###Starting testCBAlwaysTrips
   [junit4]   2> 2439242 INFO  
(TEST-TestCircuitBreaker.testCBAlwaysTrips-seed#[A9FD920F8B0169D0]) [     ] 
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> 2439243 INFO  
(TEST-TestCircuitBreaker.testCBAlwaysTrips-seed#[A9FD920F8B0169D0]) [     ] 
o.a.s.SolrTestCaseJ4 ###Ending testCBAlwaysTrips
   [junit4]   2> 2439246 INFO  
(TEST-TestCircuitBreaker.testBuildingMemoryPressure-seed#[A9FD920F8B0169D0]) [  
   ] o.a.s.SolrTestCaseJ4 ###Starting testBuildingMemoryPressure
   [junit4]   2> 2439247 INFO  (TestCircuitBreaker-23657-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> 2439247 INFO  (TestCircuitBreaker-23657-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> 2439247 INFO  (TestCircuitBreaker-23657-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} status=503 QTime=0
   [junit4]   2> 2439247 INFO  (TestCircuitBreaker-23657-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> 2439247 INFO  (TestCircuitBreaker-23657-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> 2439248 INFO  
(TEST-TestCircuitBreaker.testBuildingMemoryPressure-seed#[A9FD920F8B0169D0]) [  
   ] o.a.s.SolrTestCaseJ4 ###Ending testBuildingMemoryPressure
   [junit4]   2> 2439251 INFO  
(TEST-TestCircuitBreaker.testCBFakeMemoryPressure-seed#[A9FD920F8B0169D0]) [    
 ] o.a.s.SolrTestCaseJ4 ###Starting testCBFakeMemoryPressure
   [junit4]   2> 2439252 INFO  
(TEST-TestCircuitBreaker.testCBFakeMemoryPressure-seed#[A9FD920F8B0169D0]) [    
 ] 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> 2439252 INFO  
(TEST-TestCircuitBreaker.testCBFakeMemoryPressure-seed#[A9FD920F8B0169D0]) [    
 ] o.a.s.SolrTestCaseJ4 ###Ending testCBFakeMemoryPressure
   [junit4]   2> 2439255 INFO  
(TEST-TestCircuitBreaker.testFakeCPUCircuitBreaker-seed#[A9FD920F8B0169D0]) [   
  ] o.a.s.SolrTestCaseJ4 ###Starting testFakeCPUCircuitBreaker
   [junit4]   2> 2439256 INFO  (TestCircuitBreaker-23658-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> 2439256 INFO  (TestCircuitBreaker-23658-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> 2439256 INFO  (TestCircuitBreaker-23658-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> 2439256 INFO  (TestCircuitBreaker-23658-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> 2439257 INFO  (TestCircuitBreaker-23658-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> 2439257 INFO  
(TEST-TestCircuitBreaker.testFakeCPUCircuitBreaker-seed#[A9FD920F8B0169D0]) [   
  ] o.a.s.SolrTestCaseJ4 ###Ending testFakeCPUCircuitBreaker
   [junit4]   2> 2439258 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [     ] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> 2439258 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [     ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1854614960
   [junit4]   2> 2439258 INFO  (coreCloseExecutor-23660-thread-1) [     ] 
o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@6b5131d0
   [junit4]   2> 2439258 INFO  (coreCloseExecutor-23660-thread-1) [     ] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1 tag=SolrCore@6b5131d0
   [junit4]   2> 2439258 INFO  (coreCloseExecutor-23660-thread-1) [     ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@292528ab: rootName = null, 
domain = solr.core.collection1, service url = null, agent id = null] for 
registry solr.core.collection1/com.codahale.metrics.MetricRegistry@6246643a
   [junit4]   2> 2439269 INFO  (coreCloseExecutor-23660-thread-1) [     ] 
o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close()  ... SKIPPED 
(unnecessary).
   [junit4]   2> 2439270 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [     ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node 
tag=null
   [junit4]   2> 2439270 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [     ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@4130da00: rootName = null, 
domain = solr.node, service url = null, agent id = null] for registry 
solr.node/com.codahale.metrics.MetricRegistry@511e710a
   [junit4]   2> 2439274 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [     ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm 
tag=null
   [junit4]   2> 2439274 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [     ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@73f1c079: rootName = null, 
domain = solr.jvm, service url = null, agent id = null] for registry 
solr.jvm/com.codahale.metrics.MetricRegistry@780b1af1
   [junit4]   2> 2439276 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [     ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty 
tag=null
   [junit4]   2> 2439276 INFO  
(SUITE-TestCircuitBreaker-seed#[A9FD920F8B0169D0]-worker) [     ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@2c108715: rootName = null, 
domain = solr.jetty, service url = null, agent id = null] for registry 
solr.jetty/com.codahale.metrics.MetricRegistry@18167baa
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.util.TestCircuitBreaker_A9FD920F8B0169D0-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene87): 
{title_stringNoNorms=PostingsFormat(name=LuceneFixedGap), 
title_stemmed=PostingsFormat(name=LuceneVarGapFixedInterval), 
multiDefault=PostingsFormat(name=LuceneVarGapFixedInterval), 
inStock_b1=PostingsFormat(name=Direct), 
_root_=PostingsFormat(name=LuceneFixedGap), 
name=PostingsFormat(name=Asserting), id=PostingsFormat(name=Asserting), 
text=PostingsFormat(name=Direct), 
title=PostingsFormat(name=LuceneVarGapFixedInterval), 
title_lettertok=PostingsFormat(name=Asserting)}, 
docValues:{range_facet_l_dv=DocValuesFormat(name=Direct), 
range_facet_i_dv=DocValuesFormat(name=Lucene80), 
intDvoDefault=DocValuesFormat(name=Lucene80), 
timestamp=DocValuesFormat(name=Lucene80)}, maxPointsInLeafNode=1119, 
maxMBSortInHeap=6.92245224515577, 
sim=Asserting(RandomSimilarity(queryNorm=false): {}), locale=es, 
timezone=America/Santarem
   [junit4]   2> NOTE: Linux 5.4.0-45-generic amd64/Oracle Corporation 
1.8.0_281 (64-bit)/cpus=4,threads=1,free=61510264,total=529006592
   [junit4]   2> NOTE: All tests run in this JVM: [JvmMetricsTest, 
FieldMutatingUpdateProcessorTest, CoreAdminOperationTest, SparseHLLTest, 
TestLRUCache, TestHashQParserPlugin, PKIAuthenticationIntegrationTest, 
OverseerModifyCollectionTest, TestBooleanSimilarityFactory, 
TestSizeLimitedDistributedMap, SystemLogListenerTest, DocValuesMissingTest, 
DistributedFacetPivotWhiteBoxTest, SpatialHeatmapFacetsTest, 
RemoteQueryErrorTest, TestWordDelimiterFilterFactory, TestMaxTokenLenTokenizer, 
TestSimDistribStateManager, BlockDirectoryTest, HealthCheckHandlerTest, 
TestSnapshotCloudManager, SolrCloudExampleTest, DistributedFacetPivotLargeTest, 
CdcrWithNodesRestartsTest, TestContainerPlugin, TestOmitPositions, 
TestInPlaceUpdatesStandalone, NotRequiredUniqueKeyTest, 
StatelessScriptUpdateProcessorFactoryTest, TestReloadAndDeleteDocs, 
BinaryUpdateRequestHandlerTest, TestCloudInspectUtil, 
TestLeaderElectionWithEmptyReplica, BasicDistributedZk2Test, 
DistribJoinFromCollectionTest, ExternalFileFieldSortTest, 
SystemCollectionCompatTest, AdminHandlersProxyTest, TestSolrCachePerf, 
SuggestComponentTest, QueryElevationComponentTest, AlternateDirectoryTest, 
TestSurroundQueryParser, BasicAuthIntegrationTest, TestPKIAuthenticationPlugin, 
DefaultValueUpdateProcessorTest, HttpPartitionTest, 
TestCollectionsAPIViaSolrCloudCluster, 
TestDistributedStatsComponentCardinality, TestSolrCLIRunExample, 
TestSQLHandler, TestClusterStateMutator, TestManagedResource, 
SolrJmxReporterCloudTest, TestComplexPhraseQParserPlugin, 
DirectUpdateHandlerTest, TestDocumentBuilder, TestHdfsUpdateLog, 
RankQParserPluginTest, TestSolrCloudWithHadoopAuthPlugin, XmlInterpolationTest, 
TestUnInvertedFieldException, SpatialRPTFieldTypeTest, MigrateRouteKeyTest, 
SearchHandlerTest, ShardSplitTest, TestMinimalConfig, 
PropertiesRequestHandlerTest, HighlighterTest, BadComponentTest, 
TestExplainDocTransformer, RootFieldTest, CopyFieldTest, 
TestConfigSetImmutable, TestBlockCollapse, TestDocTermOrds, 
CurrencyRangeFacetCloudTest, AuthToolTest, TestUtils, SSLMigrationTest, 
TestUtilizeNode, IndexBasedSpellCheckerTest, TestConfigSetsAPI, 
DeleteShardTest, ImplicitSnitchTest, TestCustomDocTransformer, 
BackupRestoreApiErrorConditionsTest, 
ChaosMonkeyNothingIsSafeWithPullReplicasTest, FacetPivotSmallTest, 
DistributedQueryElevationComponentTest, NodeMutatorTest, DistanceUnitsTest, 
OrderedExecutorTest, SOLR749Test, TriggerIntegrationTest, TestInitParams, 
TestRequestStatusCollectionAPI, TestFilteredDocIdSet, 
DeleteInactiveReplicaTest, SolrInfoBeanTest, CollectionsAPIDistributedZkTest, 
TestNumericRangeQuery32, ConvertedLegacyTest, TestXmlQParser, 
BigEndianAscendingWordDeserializerTest, CdcrOpsAndBoundariesTest, 
CleanupOldIndexTest, TestXIncludeConfig, RegexBytesRefFilterTest, 
TestEmbeddedSolrServerConstructors, SuggesterTSTTest, 
TestJsonFacetsWithNestedObjects, LeaderVoteWaitTimeoutTest, 
ReplicationFactorTest, SyncSliceTest, TestOnReconnectListenerSupport, 
TestQueryingOnDownCollection, TestRandomFlRTGCloud, 
TestTolerantUpdateProcessorRandomCloud, TlogReplayBufferedWhileIndexingTest, 
UnloadDistributedZkTest, ZkControllerTest, ZkSolrClientTest, PurgeGraphTest, 
TestLocalFSCloudBackupRestore, TestReplicaProperties, 
IndexSizeTriggerMixedBoundsTest, SearchRateTriggerIntegrationTest, 
TriggerCooldownIntegrationTest, HdfsRecoverLeaseTest, RulesTest, 
PluginInfoTest, QueryResultKeyTest, TestCorePropertiesReload, TestCustomStream, 
TestImplicitCoreProperties, TestInfoStreamLogging, TestQuerySenderListener, 
TestSimpleTextCodec, TestSolrConfigHandler, RequestLoggingTest, TestCSVLoader, 
TestConfigReload, TestSolrConfigHandlerConcurrent, V2ApiIntegrationTest, 
XmlUpdateRequestHandlerTest, LukeRequestHandlerTest, 
SegmentsInfoRequestHandlerTest, TestApiFramework, TestCollectionAPIs, 
TestConfigsApi, ThreadDumpHandlerTest, ZookeeperStatusHandlerTest, 
CustomHighlightComponentTest, DebugComponentTest, 
DistributedDebugComponentTest, DistributedExpandComponentTest, 
DistributedFacetPivotSmallTest, TestExportWriter, TaggerTest, 
TestPostingsSolrHighlighter, TestSlowCompositeReaderWrapper, 
TestLegacyFieldReuse, TestLegacyTerms, TestMultiValuedNumericRangeQuery, 
TestNumericTokenStream, SolrMetricManagerTest, SolrMetricsIntegrationTest, 
SolrShardReporterTest, SubstringBytesRefFilterTest, TestFacetMethods, 
TestFaceting, TestIntervalFaceting, BadIndexSchemaTest, PrimitiveFieldTypeTest, 
RankFieldTest, SchemaApiFailureTest, TestCollationField, 
TestCollationFieldDocValues, TestHalfAndHalfDocValues, TestManagedSchema, 
TestRecoveryHdfs, TestJsonFacetErrors, TestJsonFacetRefinement, 
TestJsonFacetsStatsParsing, AggValueSourceTest, SortByFunctionTest, 
TestFunctionQuery, TestMinMaxOnMultiValuedField, BlockJoinFacetRandomTest, 
BlockJoinFacetSimpleTest, CrossCollectionJoinQueryTest, TestJsonRequest, 
TestBM25SimilarityFactory, TestDFRSimilarityFactory, TestIBSimilarityFactory, 
TestLegacyBM25SimilarityFactory, TestNonDefinedSimilarityFactory, 
TestDistribIDF, TestExactSharedStatsCache, TestLRUStatsCache, CacheHeaderTest, 
HttpSolrCallGetCoreTest, ConjunctionSolrSpellCheckerTest, 
FileBasedSpellCheckerTest, SpellCheckCollatorWithCollapseTest, 
TestSuggestSpellingConverter, SuggesterFSTTest, TestFuzzyAnalyzedSuggestions, 
TestFieldCacheSortRandom, AddBlockUpdateTest, MaxSizeAutoCommitTest, 
PeerSyncWithIndexFingerprintCachingTest, SolrCmdDistributorTest, 
CloneFieldUpdateProcessorFactoryTest, DocExpirationUpdateProcessorFactoryTest, 
RegexBoostProcessorTest, TestPartialUpdateDeduplication, 
TimeRoutedAliasUpdateProcessorTest, UUIDUpdateProcessorFallbackTest, 
FileUtilsTest, NumberUtilsTest, SimplePostToolTest, SolrLogPostToolTest, 
TestCircuitBreaker]
   [junit4] Completed [921/934 (1!)] on J2 in 1.72s, 5 tests, 1 error <<< 
FAILURES!

[...truncated 50768 lines...]
BUILD FAILED
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/build.xml:643:
 The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/build.xml:507:
 The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/build.xml:494:
 Source checkout is dirty (unversioned/missing files) after running tests!!! 
Offending files:
* solr/contrib/analytics/src/test-files/solr/filestore
* solr/contrib/analytics/src/test-files/solr/userfiles
* 
solr/contrib/dataimporthandler-extras/src/test-files/dihextras/solr/collection1/conf/dataimport.properties
* solr/contrib/dataimporthandler-extras/src/test-files/dihextras/solr/filestore
* solr/contrib/dataimporthandler-extras/src/test-files/dihextras/solr/userfiles
* solr/contrib/dataimporthandler/src/test-files/dih/solr/filestore
* solr/contrib/dataimporthandler/src/test-files/dih/solr/userfiles
* solr/contrib/extraction/src/test-files/extraction/solr/filestore
* solr/contrib/extraction/src/test-files/extraction/solr/userfiles
* solr/contrib/langid/src/test-files/langid/solr/filestore
* solr/contrib/langid/src/test-files/langid/solr/userfiles
* solr/contrib/ltr/src/test-files/solr/filestore
* solr/contrib/ltr/src/test-files/solr/userfiles
* solr/contrib/prometheus-exporter/src/test-files/solr/filestore
* solr/contrib/prometheus-exporter/src/test-files/solr/userfiles
* solr/contrib/velocity/src/test-files/velocity/solr/filestore
* solr/contrib/velocity/src/test-files/velocity/solr/userfiles
* solr/core/src/test-files/solr/filestore
* solr/core/src/test-files/solr/userfiles
* solr/solrj/src/test-files/solrj/solr/multicore/filestore
* solr/solrj/src/test-files/solrj/solr/multicore/userfiles

Total time: 71 minutes 45 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
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to