Build:
https://ci-builds.apache.org/job/Lucene/job/Lucene-Solr-BadApples-Tests-master/4/
3 tests failed.
FAILED: org.apache.solr.util.TestCircuitBreaker.testBuildingMemoryPressure
Error Message:
Number of failed queries is not correct expected:<1> but was:<5>
Stack Trace:
java.lang.AssertionError: Number of failed queries is not correct expected:<1>
but was:<5>
at
__randomizedtesting.SeedInfo.seed([513D70A324CB1B9:BA9EFBDA1DC05D10]:0)
at org.junit.Assert.fail(Assert.java:88)
at org.junit.Assert.failNotEquals(Assert.java:834)
at org.junit.Assert.assertEquals(Assert.java:645)
at
org.apache.solr.util.TestCircuitBreaker.testBuildingMemoryPressure(TestCircuitBreaker.java:152)
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)
FAILED: org.apache.solr.servlet.TestRequestRateLimiter.testConcurrentQueries
Error Message:
Incoming accepted new request count did not match. Expected 5 incoming 25
Stack Trace:
java.lang.AssertionError: Incoming accepted new request count did not match.
Expected 5 incoming 25
at
__randomizedtesting.SeedInfo.seed([513D70A324CB1B9:4788342FB22BC498]:0)
at org.junit.Assert.fail(Assert.java:88)
at org.junit.Assert.assertTrue(Assert.java:41)
at
org.apache.solr.servlet.TestRequestRateLimiter.testConcurrentQueries(TestRequestRateLimiter.java:74)
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)
FAILED: org.apache.solr.servlet.TestRequestRateLimiter.testSlotBorrowing
Error Message:
Incoming slots borrowed count did not match. Expected > 0 incoming 0
Stack Trace:
java.lang.AssertionError: Incoming slots borrowed count did not match. Expected
> 0 incoming 0
at
__randomizedtesting.SeedInfo.seed([513D70A324CB1B9:B40431355D1A4A1D]:0)
at org.junit.Assert.fail(Assert.java:88)
at org.junit.Assert.assertTrue(Assert.java:41)
at
org.apache.solr.servlet.TestRequestRateLimiter.testSlotBorrowing(TestRequestRateLimiter.java:106)
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)
Build Log:
[...truncated 12343 lines...]
[junit4] Suite: org.apache.solr.servlet.TestRequestRateLimiter
[junit4] 2> 608546 INFO
(SUITE-TestRequestRateLimiter-seed#[513D70A324CB1B9]-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-master/solr/server/solr/configsets/_default/conf'
[junit4] 2> 608546 INFO
(SUITE-TestRequestRateLimiter-seed#[513D70A324CB1B9]-worker) [ ]
o.a.s.SolrTestCaseJ4 Created dataDir:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-master/solr/build/solr-core/test/J0/temp/solr.servlet.TestRequestRateLimiter_513D70A324CB1B9-001/data-dir-59-001
[junit4] 2> 608547 WARN
(SUITE-TestRequestRateLimiter-seed#[513D70A324CB1B9]-worker) [ ]
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=30 numCloses=30
[junit4] 2> 608547 INFO
(SUITE-TestRequestRateLimiter-seed#[513D70A324CB1B9]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false)
w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 608560 INFO
(SUITE-TestRequestRateLimiter-seed#[513D70A324CB1B9]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (true) 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> 608560 INFO
(SUITE-TestRequestRateLimiter-seed#[513D70A324CB1B9]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 608561 INFO
(SUITE-TestRequestRateLimiter-seed#[513D70A324CB1B9]-worker) [ ]
o.a.s.c.MiniSolrCloudCluster Starting cluster of 1 servers in
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-master/solr/build/solr-core/test/J0/temp/solr.servlet.TestRequestRateLimiter_513D70A324CB1B9-001/tempDir-001
[junit4] 2> 608561 INFO
(SUITE-TestRequestRateLimiter-seed#[513D70A324CB1B9]-worker) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 608562 INFO (ZkTestServer Run Thread) [ ]
o.a.s.c.ZkTestServer client port: 0.0.0.0/0.0.0.0:0
[junit4] 2> 608562 INFO (ZkTestServer Run Thread) [ ]
o.a.s.c.ZkTestServer Starting server
[junit4] 2> 608563 WARN (ZkTestServer Run Thread) [ ]
o.a.z.s.ServerCnxnFactory maxCnxns is not configured, using default value 0.
[junit4] 2> 608662 INFO
(SUITE-TestRequestRateLimiter-seed#[513D70A324CB1B9]-worker) [ ]
o.a.s.c.ZkTestServer start zk server on port: 32805
[junit4] 2> 608662 INFO
(SUITE-TestRequestRateLimiter-seed#[513D70A324CB1B9]-worker) [ ]
o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:32805
[junit4] 2> 608662 INFO
(SUITE-TestRequestRateLimiter-seed#[513D70A324CB1B9]-worker) [ ]
o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:32805
[junit4] 2> 608662 INFO
(SUITE-TestRequestRateLimiter-seed#[513D70A324CB1B9]-worker) [ ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1 32805
[junit4] 2> 608665 INFO
(SUITE-TestRequestRateLimiter-seed#[513D70A324CB1B9]-worker) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 608669 INFO (zkConnectionManagerCallback-4833-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 608669 INFO
(SUITE-TestRequestRateLimiter-seed#[513D70A324CB1B9]-worker) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 608671 INFO
(SUITE-TestRequestRateLimiter-seed#[513D70A324CB1B9]-worker) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 608673 INFO (zkConnectionManagerCallback-4835-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 608673 INFO
(SUITE-TestRequestRateLimiter-seed#[513D70A324CB1B9]-worker) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 608677 INFO
(SUITE-TestRequestRateLimiter-seed#[513D70A324CB1B9]-worker) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 608690 INFO (zkConnectionManagerCallback-4837-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 608690 INFO
(SUITE-TestRequestRateLimiter-seed#[513D70A324CB1B9]-worker) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 608799 INFO (jetty-launcher-4838-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 608799 INFO (jetty-launcher-4838-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 608799 INFO (jetty-launcher-4838-thread-1) [ ]
o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git:
a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 11.0.4+10-LTS
[junit4] 2> 608800 INFO (jetty-launcher-4838-thread-1) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 608800 INFO (jetty-launcher-4838-thread-1) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 608800 INFO (jetty-launcher-4838-thread-1) [ ]
o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 608800 INFO (jetty-launcher-4838-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@1ddd79a7{/solr,null,AVAILABLE}
[junit4] 2> 608801 INFO (jetty-launcher-4838-thread-1) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@12bb9b0f{ssl, (ssl, alpn,
http/1.1, h2)}{127.0.0.1:۳۴۲۸۳}
[junit4] 2> 608801 INFO (jetty-launcher-4838-thread-1) [ ]
o.e.j.s.Server Started @۶۰۸۹۵۳ms
[junit4] 2> 608802 INFO (jetty-launcher-4838-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=34283}
[junit4] 2> 608802 ERROR (jetty-launcher-4838-thread-1) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 608802 INFO (jetty-launcher-4838-thread-1) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 608802 INFO (jetty-launcher-4838-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
9.0.0
[junit4] 2> 608802 INFO (jetty-launcher-4838-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 608802 INFO (jetty-launcher-4838-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-master/solr
[junit4] 2> 608802 INFO (jetty-launcher-4838-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2020-08-08T23:19:01.889464Z
[junit4] 2> 608811 INFO (jetty-launcher-4838-thread-1) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 608823 INFO (zkConnectionManagerCallback-4840-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 608823 INFO (jetty-launcher-4838-thread-1) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 608824 INFO (jetty-launcher-4838-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 608931 INFO (jetty-launcher-4838-thread-1) [ ]
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 608932 WARN (jetty-launcher-4838-thread-1) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@4dcae723[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 608932 WARN (jetty-launcher-4838-thread-1) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@4dcae723[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 608935 WARN (jetty-launcher-4838-thread-1) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@44649c64[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 608935 WARN (jetty-launcher-4838-thread-1) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@44649c64[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 608949 INFO (jetty-launcher-4838-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:32805/solr
[junit4] 2> 608950 INFO (jetty-launcher-4838-thread-1)
[n:127.0.0.1:34283_solr ] o.a.s.c.c.ConnectionManager Waiting for client to
connect to ZooKeeper
[junit4] 2> 608951 INFO (zkConnectionManagerCallback-4850-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 608951 INFO (jetty-launcher-4838-thread-1)
[n:127.0.0.1:34283_solr ] o.a.s.c.c.ConnectionManager Client is connected
to ZooKeeper
[junit4] 2> 609137 INFO (jetty-launcher-4838-thread-1)
[n:127.0.0.1:34283_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:34283_solr
[junit4] 2> 609138 INFO (jetty-launcher-4838-thread-1)
[n:127.0.0.1:34283_solr ] o.a.s.c.Overseer Overseer
(id=72066586179207172-127.0.0.1:34283_solr-n_0000000000) starting
[junit4] 2> 609158 INFO
(OverseerStateUpdate-72066586179207172-127.0.0.1:34283_solr-n_0000000000)
[n:127.0.0.1:34283_solr ] o.a.s.c.Overseer Starting to work on the main
queue : 127.0.0.1:34283_solr
[junit4] 2> 609158 INFO (jetty-launcher-4838-thread-1)
[n:127.0.0.1:34283_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:34283_solr
[junit4] 2> 609159 INFO
(OverseerStateUpdate-72066586179207172-127.0.0.1:34283_solr-n_0000000000)
[n:127.0.0.1:34283_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 609161 INFO (jetty-launcher-4838-thread-1)
[n:127.0.0.1:34283_solr ] o.a.s.p.PackageLoader /packages.json updated to
version -1
[junit4] 2> 609161 WARN (jetty-launcher-4838-thread-1)
[n:127.0.0.1:34283_solr ] 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> 609222 INFO (jetty-launcher-4838-thread-1)
[n:127.0.0.1:34283_solr ] o.a.s.h.a.MetricsHistoryHandler No .system
collection, keeping metrics history in memory.
[junit4] 2> 609303 INFO (jetty-launcher-4838-thread-1)
[n:127.0.0.1:34283_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_34283.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@37356883
[junit4] 2> 609326 INFO (jetty-launcher-4838-thread-1)
[n:127.0.0.1:34283_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_34283.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@37356883
[junit4] 2> 609326 INFO (jetty-launcher-4838-thread-1)
[n:127.0.0.1:34283_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_34283.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@37356883
[junit4] 2> 609328 INFO (jetty-launcher-4838-thread-1)
[n:127.0.0.1:34283_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-master/solr/build/solr-core/test/J0/temp/solr.servlet.TestRequestRateLimiter_513D70A324CB1B9-001/tempDir-001/node1
[junit4] 2> 609342 INFO
(SUITE-TestRequestRateLimiter-seed#[513D70A324CB1B9]-worker) [ ]
o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=1
[junit4] 2> 609343 INFO
(SUITE-TestRequestRateLimiter-seed#[513D70A324CB1B9]-worker) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 609344 INFO (zkConnectionManagerCallback-4865-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 609344 INFO
(SUITE-TestRequestRateLimiter-seed#[513D70A324CB1B9]-worker) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 609345 INFO
(SUITE-TestRequestRateLimiter-seed#[513D70A324CB1B9]-worker) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 609346 INFO
(SUITE-TestRequestRateLimiter-seed#[513D70A324CB1B9]-worker) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:32805/solr ready
[junit4] 2> 609389 INFO
(TEST-TestRequestRateLimiter.testConcurrentQueries-seed#[513D70A324CB1B9]) [
] o.a.s.SolrTestCaseJ4 ###Starting testConcurrentQueries
[junit4] 2> 609547 INFO (qtp1564566764-7928) [n:127.0.0.1:34283_solr
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
pullReplicas=0&name=c1&nrtReplicas=1&action=CREATE&numShards=1&tlogReplicas=0&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 609550 INFO
(OverseerThreadFactory-4855-thread-1-processing-n:127.0.0.1:34283_solr)
[n:127.0.0.1:34283_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection
c1
[junit4] 2> 609551 INFO
(OverseerThreadFactory-4855-thread-1-processing-n:127.0.0.1:34283_solr)
[n:127.0.0.1:34283_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/protwords.txt to /configs/c1.AUTOCREATED/protwords.txt
[junit4] 2> 609553 INFO
(OverseerThreadFactory-4855-thread-1-processing-n:127.0.0.1:34283_solr)
[n:127.0.0.1:34283_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/managed-schema to /configs/c1.AUTOCREATED/managed-schema
[junit4] 2> 609555 INFO
(OverseerThreadFactory-4855-thread-1-processing-n:127.0.0.1:34283_solr)
[n:127.0.0.1:34283_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/solrconfig.xml to /configs/c1.AUTOCREATED/solrconfig.xml
[junit4] 2> 609566 INFO
(OverseerThreadFactory-4855-thread-1-processing-n:127.0.0.1:34283_solr)
[n:127.0.0.1:34283_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/contractions_it.txt to
/configs/c1.AUTOCREATED/lang/contractions_it.txt
[junit4] 2> 609569 INFO
(OverseerThreadFactory-4855-thread-1-processing-n:127.0.0.1:34283_solr)
[n:127.0.0.1:34283_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_no.txt to
/configs/c1.AUTOCREATED/lang/stopwords_no.txt
[junit4] 2> 609592 INFO
(OverseerThreadFactory-4855-thread-1-processing-n:127.0.0.1:34283_solr)
[n:127.0.0.1:34283_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_hy.txt to
/configs/c1.AUTOCREATED/lang/stopwords_hy.txt
[junit4] 2> 609594 INFO
(OverseerThreadFactory-4855-thread-1-processing-n:127.0.0.1:34283_solr)
[n:127.0.0.1:34283_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stemdict_nl.txt to
/configs/c1.AUTOCREATED/lang/stemdict_nl.txt
[junit4] 2> 609596 INFO
(OverseerThreadFactory-4855-thread-1-processing-n:127.0.0.1:34283_solr)
[n:127.0.0.1:34283_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/contractions_ca.txt to
/configs/c1.AUTOCREATED/lang/contractions_ca.txt
[junit4] 2> 609598 INFO
(OverseerThreadFactory-4855-thread-1-processing-n:127.0.0.1:34283_solr)
[n:127.0.0.1:34283_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_id.txt to
/configs/c1.AUTOCREATED/lang/stopwords_id.txt
[junit4] 2> 609600 INFO
(OverseerThreadFactory-4855-thread-1-processing-n:127.0.0.1:34283_solr)
[n:127.0.0.1:34283_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_et.txt to
/configs/c1.AUTOCREATED/lang/stopwords_et.txt
[junit4] 2> 609602 INFO
(OverseerThreadFactory-4855-thread-1-processing-n:127.0.0.1:34283_solr)
[n:127.0.0.1:34283_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_ga.txt to
/configs/c1.AUTOCREATED/lang/stopwords_ga.txt
[junit4] 2> 609613 INFO
(OverseerThreadFactory-4855-thread-1-processing-n:127.0.0.1:34283_solr)
[n:127.0.0.1:34283_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_da.txt to
/configs/c1.AUTOCREATED/lang/stopwords_da.txt
[junit4] 2> 609627 INFO
(OverseerThreadFactory-4855-thread-1-processing-n:127.0.0.1:34283_solr)
[n:127.0.0.1:34283_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_hi.txt to
/configs/c1.AUTOCREATED/lang/stopwords_hi.txt
[junit4] 2> 609629 INFO
(OverseerThreadFactory-4855-thread-1-processing-n:127.0.0.1:34283_solr)
[n:127.0.0.1:34283_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_ja.txt to
/configs/c1.AUTOCREATED/lang/stopwords_ja.txt
[junit4] 2> 609632 INFO
(OverseerThreadFactory-4855-thread-1-processing-n:127.0.0.1:34283_solr)
[n:127.0.0.1:34283_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_pt.txt to
/configs/c1.AUTOCREATED/lang/stopwords_pt.txt
[junit4] 2> 609634 INFO
(OverseerThreadFactory-4855-thread-1-processing-n:127.0.0.1:34283_solr)
[n:127.0.0.1:34283_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_hu.txt to
/configs/c1.AUTOCREATED/lang/stopwords_hu.txt
[junit4] 2> 609636 INFO
(OverseerThreadFactory-4855-thread-1-processing-n:127.0.0.1:34283_solr)
[n:127.0.0.1:34283_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_el.txt to
/configs/c1.AUTOCREATED/lang/stopwords_el.txt
[junit4] 2> 609638 INFO
(OverseerThreadFactory-4855-thread-1-processing-n:127.0.0.1:34283_solr)
[n:127.0.0.1:34283_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_ru.txt to
/configs/c1.AUTOCREATED/lang/stopwords_ru.txt
[junit4] 2> 609640 INFO
(OverseerThreadFactory-4855-thread-1-processing-n:127.0.0.1:34283_solr)
[n:127.0.0.1:34283_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_tr.txt to
/configs/c1.AUTOCREATED/lang/stopwords_tr.txt
[junit4] 2> 609642 INFO
(OverseerThreadFactory-4855-thread-1-processing-n:127.0.0.1:34283_solr)
[n:127.0.0.1:34283_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_ar.txt to
/configs/c1.AUTOCREATED/lang/stopwords_ar.txt
[junit4] 2> 609644 INFO
(OverseerThreadFactory-4855-thread-1-processing-n:127.0.0.1:34283_solr)
[n:127.0.0.1:34283_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/userdict_ja.txt to
/configs/c1.AUTOCREATED/lang/userdict_ja.txt
[junit4] 2> 609646 INFO
(OverseerThreadFactory-4855-thread-1-processing-n:127.0.0.1:34283_solr)
[n:127.0.0.1:34283_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_it.txt to
/configs/c1.AUTOCREATED/lang/stopwords_it.txt
[junit4] 2> 609649 INFO
(OverseerThreadFactory-4855-thread-1-processing-n:127.0.0.1:34283_solr)
[n:127.0.0.1:34283_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_eu.txt to
/configs/c1.AUTOCREATED/lang/stopwords_eu.txt
[junit4] 2> 609651 INFO
(OverseerThreadFactory-4855-thread-1-processing-n:127.0.0.1:34283_solr)
[n:127.0.0.1:34283_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_cz.txt to
/configs/c1.AUTOCREATED/lang/stopwords_cz.txt
[junit4] 2> 609653 INFO
(OverseerThreadFactory-4855-thread-1-processing-n:127.0.0.1:34283_solr)
[n:127.0.0.1:34283_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stoptags_ja.txt to
/configs/c1.AUTOCREATED/lang/stoptags_ja.txt
[junit4] 2> 609655 INFO
(OverseerThreadFactory-4855-thread-1-processing-n:127.0.0.1:34283_solr)
[n:127.0.0.1:34283_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/contractions_fr.txt to
/configs/c1.AUTOCREATED/lang/contractions_fr.txt
[junit4] 2> 609657 INFO
(OverseerThreadFactory-4855-thread-1-processing-n:127.0.0.1:34283_solr)
[n:127.0.0.1:34283_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_fa.txt to
/configs/c1.AUTOCREATED/lang/stopwords_fa.txt
[junit4] 2> 609659 INFO
(OverseerThreadFactory-4855-thread-1-processing-n:127.0.0.1:34283_solr)
[n:127.0.0.1:34283_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_de.txt to
/configs/c1.AUTOCREATED/lang/stopwords_de.txt
[junit4] 2> 609661 INFO
(OverseerThreadFactory-4855-thread-1-processing-n:127.0.0.1:34283_solr)
[n:127.0.0.1:34283_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/contractions_ga.txt to
/configs/c1.AUTOCREATED/lang/contractions_ga.txt
[junit4] 2> 609663 INFO
(OverseerThreadFactory-4855-thread-1-processing-n:127.0.0.1:34283_solr)
[n:127.0.0.1:34283_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_ca.txt to
/configs/c1.AUTOCREATED/lang/stopwords_ca.txt
[junit4] 2> 609665 INFO
(OverseerThreadFactory-4855-thread-1-processing-n:127.0.0.1:34283_solr)
[n:127.0.0.1:34283_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_nl.txt to
/configs/c1.AUTOCREATED/lang/stopwords_nl.txt
[junit4] 2> 609668 INFO
(OverseerThreadFactory-4855-thread-1-processing-n:127.0.0.1:34283_solr)
[n:127.0.0.1:34283_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_bg.txt to
/configs/c1.AUTOCREATED/lang/stopwords_bg.txt
[junit4] 2> 609670 INFO
(OverseerThreadFactory-4855-thread-1-processing-n:127.0.0.1:34283_solr)
[n:127.0.0.1:34283_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_es.txt to
/configs/c1.AUTOCREATED/lang/stopwords_es.txt
[junit4] 2> 609672 INFO
(OverseerThreadFactory-4855-thread-1-processing-n:127.0.0.1:34283_solr)
[n:127.0.0.1:34283_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_en.txt to
/configs/c1.AUTOCREATED/lang/stopwords_en.txt
[junit4] 2> 609674 INFO
(OverseerThreadFactory-4855-thread-1-processing-n:127.0.0.1:34283_solr)
[n:127.0.0.1:34283_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_lv.txt to
/configs/c1.AUTOCREATED/lang/stopwords_lv.txt
[junit4] 2> 609676 INFO
(OverseerThreadFactory-4855-thread-1-processing-n:127.0.0.1:34283_solr)
[n:127.0.0.1:34283_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_th.txt to
/configs/c1.AUTOCREATED/lang/stopwords_th.txt
[junit4] 2> 609678 INFO
(OverseerThreadFactory-4855-thread-1-processing-n:127.0.0.1:34283_solr)
[n:127.0.0.1:34283_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_ro.txt to
/configs/c1.AUTOCREATED/lang/stopwords_ro.txt
[junit4] 2> 609680 INFO
(OverseerThreadFactory-4855-thread-1-processing-n:127.0.0.1:34283_solr)
[n:127.0.0.1:34283_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_fr.txt to
/configs/c1.AUTOCREATED/lang/stopwords_fr.txt
[junit4] 2> 609682 INFO
(OverseerThreadFactory-4855-thread-1-processing-n:127.0.0.1:34283_solr)
[n:127.0.0.1:34283_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_sv.txt to
/configs/c1.AUTOCREATED/lang/stopwords_sv.txt
[junit4] 2> 609701 INFO
(OverseerThreadFactory-4855-thread-1-processing-n:127.0.0.1:34283_solr)
[n:127.0.0.1:34283_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_fi.txt to
/configs/c1.AUTOCREATED/lang/stopwords_fi.txt
[junit4] 2> 609703 INFO
(OverseerThreadFactory-4855-thread-1-processing-n:127.0.0.1:34283_solr)
[n:127.0.0.1:34283_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/hyphenations_ga.txt to
/configs/c1.AUTOCREATED/lang/hyphenations_ga.txt
[junit4] 2> 609705 INFO
(OverseerThreadFactory-4855-thread-1-processing-n:127.0.0.1:34283_solr)
[n:127.0.0.1:34283_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_gl.txt to
/configs/c1.AUTOCREATED/lang/stopwords_gl.txt
[junit4] 2> 609707 INFO
(OverseerThreadFactory-4855-thread-1-processing-n:127.0.0.1:34283_solr)
[n:127.0.0.1:34283_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/synonyms.txt to /configs/c1.AUTOCREATED/synonyms.txt
[junit4] 2> 609709 INFO
(OverseerThreadFactory-4855-thread-1-processing-n:127.0.0.1:34283_solr)
[n:127.0.0.1:34283_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/stopwords.txt to /configs/c1.AUTOCREATED/stopwords.txt
[junit4] 2> 609835 INFO
(OverseerStateUpdate-72066586179207172-127.0.0.1:34283_solr-n_0000000000)
[n:127.0.0.1:34283_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"c1",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"c1_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:34283/solr";,
[junit4] 2> "node_name":"127.0.0.1:34283_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 610152 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr
x:c1_shard1_replica_n1 ] o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node2&collection.configName=c1.AUTOCREATED&newCollection=true&name=c1_shard1_replica_n1&action=CREATE&numShards=1&collection=c1&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 610152 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr
x:c1_shard1_replica_n1 ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 1000 transient cores
[junit4] 2> 610188 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.c.SolrConfig Using Lucene
MatchVersion: 9.0.0
[junit4] 2> 610283 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.c.CoreContainer Creating
SolrCore 'c1_shard1_replica_n1' using configuration from configset
c1.AUTOCREATED, trusted=true
[junit4] 2> 610297 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.s.IndexSchema Schema
name=default-config
[junit4] 2> 610808 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.s.IndexSchema Loaded
schema default-config/1.6 with uniqueid field id
[junit4] 2> 610809 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.m.r.SolrJmxReporter JMX
monitoring for 'solr_34283.solr.core.c1.shard1.replica_n1' (registry
'solr.core.c1.shard1.replica_n1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@37356883
[junit4] 2> 610809 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.c.SolrCore
[[c1_shard1_replica_n1] ] Opening new SolrCore at
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-master/solr/build/solr-core/test/J0/temp/solr.servlet.TestRequestRateLimiter_513D70A324CB1B9-001/tempDir-001/node1/c1_shard1_replica_n1],
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-master/solr/build/solr-core/test/J0/temp/solr.servlet.TestRequestRateLimiter_513D70A324CB1B9-001/tempDir-001/node1/c1_shard1_replica_n1/data/]
[junit4] 2> 611044 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.u.UpdateHandler Using
UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 611044 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.u.UpdateLog Initializing
UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 611054 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.u.CommitTracker Hard
AutoCommit: if uncommitted for 15000ms;
[junit4] 2> 611054 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.u.CommitTracker Soft
AutoCommit: disabled
[junit4] 2> 611057 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage
Configured ZooKeeperStorageIO with znodeBase: /configs/c1.AUTOCREATED
[junit4] 2> 611058 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage
Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/c1.AUTOCREATED
[junit4] 2> 611058 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.s.ZkIndexSchemaReader
Creating ZooKeeper watch for the managed schema at
/configs/c1.AUTOCREATED/managed-schema
[junit4] 2> 611059 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.s.ZkIndexSchemaReader
Current schema version 0 is already the latest
[junit4] 2> 611059 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.h.c.SpellCheckComponent
Initializing spell checkers
[junit4] 2> 611059 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.s.DirectSolrSpellChecker
init: {name=default, field=_text_, classname=solr.DirectSolrSpellChecker,
distanceMeasure=internal, accuracy=0.5, maxEdits=2, minPrefix=1,
maxInspections=5, minQueryLength=4, maxQueryFrequency=0.01}
[junit4] 2> 611061 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.h.ReplicationHandler
Commits will be reserved for 10000 ms
[junit4] 2> 611061 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.u.UpdateLog Could not find
max version in index or recent updates, using new clock 1674501154823733248
[junit4] 2> 611080 INFO
(searcherExecutor-4867-thread-1-processing-n:127.0.0.1:34283_solr
x:c1_shard1_replica_n1 c:c1 s:shard1 r:core_node2) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.c.QuerySenderListener
QuerySenderListener done.
[junit4] 2> 611080 INFO
(searcherExecutor-4867-thread-1-processing-n:127.0.0.1:34283_solr
x:c1_shard1_replica_n1 c:c1 s:shard1 r:core_node2) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.h.c.SpellCheckComponent
Loading spell index for spellchecker: default
[junit4] 2> 611082 INFO
(searcherExecutor-4867-thread-1-processing-n:127.0.0.1:34283_solr
x:c1_shard1_replica_n1 c:c1 s:shard1 r:core_node2) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.c.SolrCore
[c1_shard1_replica_n1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 611093 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.c.ZkShardTerms Successful
update of terms at /collections/c1/terms/shard1 to Terms{values={core_node2=0},
version=0}
[junit4] 2> 611093 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.c.ShardLeaderElectionContextBase make sure parent is created
/collections/c1/leaders/shard1
[junit4] 2> 611097 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 611097 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 611097 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync
replicas to https://127.0.0.1:34283/solr/c1_shard1_replica_n1/
[junit4] 2> 611098 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync
Success - now sync replicas to me
[junit4] 2> 611098 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.c.SyncStrategy
https://127.0.0.1:34283/solr/c1_shard1_replica_n1/ has no replicas
[junit4] 2> 611098 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node
/collections/c1/leaders/shard1/leader after winning as
/collections/c1/leader_elect/shard1/election/72066586179207172-core_node2-n_0000000000
[junit4] 2> 611109 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
https://127.0.0.1:34283/solr/c1_shard1_replica_n1/ shard1
[junit4] 2> 611211 INFO (zkCallback-4849-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/collections/c1/state.json] for
collection [c1] has occurred - updating... (live nodes size: [1])
[junit4] 2> 611211 INFO (zkCallback-4849-thread-2) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/collections/c1/state.json] for
collection [c1] has occurred - updating... (live nodes size: [1])
[junit4] 2> 611212 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.c.ZkController I am the
leader, no recovery necessary
[junit4] 2> 611214 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&coreNodeName=core_node2&collection.configName=c1.AUTOCREATED&newCollection=true&name=c1_shard1_replica_n1&action=CREATE&numShards=1&collection=c1&shard=shard1&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=1062
[junit4] 2> 611216 INFO (qtp1564566764-7928) [n:127.0.0.1:34283_solr
] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most
45 seconds. Check all shard replicas
[junit4] 2> 611339 INFO (zkCallback-4849-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/collections/c1/state.json] for
collection [c1] has occurred - updating... (live nodes size: [1])
[junit4] 2> 611339 INFO (zkCallback-4849-thread-3) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/collections/c1/state.json] for
collection [c1] has occurred - updating... (live nodes size: [1])
[junit4] 2> 611340 INFO (zkCallback-4849-thread-2) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/collections/c1/state.json] for
collection [c1] has occurred - updating... (live nodes size: [1])
[junit4] 2> 611350 INFO (qtp1564566764-7928) [n:127.0.0.1:34283_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={pullReplicas=0&name=c1&nrtReplicas=1&action=CREATE&numShards=1&tlogReplicas=0&wt=javabin&version=2}
status=0 QTime=1803
[junit4] 2> 611351 INFO
(TEST-TestRequestRateLimiter.testConcurrentQueries-seed#[513D70A324CB1B9]) [
] o.a.s.c.MiniSolrCloudCluster waitForActiveCollection: c1
[junit4] 2> 611552 INFO
(OverseerCollectionConfigSetProcessor-72066586179207172-127.0.0.1:34283_solr-n_0000000000)
[n:127.0.0.1:34283_solr ] o.a.s.c.OverseerTaskQueue Response ZK path:
/overseer/collection-queue-work/qnr-0000000000 doesn't exist. Requestor may
have disconnected from ZooKeeper
[junit4] 2> 611651 INFO (zkCallback-4849-thread-2) [ ]
o.a.s.s.ZkIndexSchemaReader A schema change: WatchedEvent state:SyncConnected
type:NodeDataChanged path:/configs/c1.AUTOCREATED/managed-schema, has occurred
- updating schema from ZooKeeper ...
[junit4] 2> 611651 INFO (qtp1564566764-7929) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema
Persisted managed schema version 1 at /configs/c1.AUTOCREATED/managed-schema
[junit4] 2> 611652 INFO (zkCallback-4849-thread-2) [ ]
o.a.s.s.ZkIndexSchemaReader Retrieved schema version 1 from Zookeeper
[junit4] 2> 611654 INFO (qtp1564566764-7929) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.c.ZkShardTerms Successful
update of terms at /collections/c1/terms/shard1 to Terms{values={core_node2=1},
version=1}
[junit4] 2> 611654 INFO (qtp1564566764-7929) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[0 (1674501155443441664)]} 0 297
[junit4] 2> 611656 INFO (zkCallback-4849-thread-2) [ ]
o.a.s.s.IndexSchema Schema name=default-config
[junit4] 2> 611684 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[1 (1674501155476996096)]} 0 12
[junit4] 2> 611685 INFO (qtp1564566764-7928) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[2 (1674501155478044672)]} 0 0
[junit4] 2> 611828 INFO (qtp1564566764-7929) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[3 (1674501155626942464)]} 0 0
[junit4] 2> 611829 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[4 (1674501155629039616)]} 0 0
[junit4] 2> 611830 INFO (qtp1564566764-7928) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[5 (1674501155630088192)]} 0 0
[junit4] 2> 611831 INFO (qtp1564566764-7929) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[6 (1674501155631136768)]} 0 0
[junit4] 2> 611832 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[7 (1674501155632185344)]} 0 0
[junit4] 2> 611833 INFO (qtp1564566764-7928) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[8 (1674501155633233920)]} 0 0
[junit4] 2> 611834 INFO (qtp1564566764-7929) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[9 (1674501155634282496)]} 0 0
[junit4] 2> 611835 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[10 (1674501155635331072)]} 0 0
[junit4] 2> 611836 INFO (qtp1564566764-7928) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[11 (1674501155636379648)]} 0 0
[junit4] 2> 611837 INFO (qtp1564566764-7929) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[12 (1674501155637428224)]} 0 0
[junit4] 2> 611838 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[13 (1674501155638476800)]} 0 0
[junit4] 2> 611847 INFO (qtp1564566764-7928) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[14 (1674501155646865408)]} 0 0
[junit4] 2> 611848 INFO (qtp1564566764-7929) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[15 (1674501155647913984)]} 0 0
[junit4] 2> 611848 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[16 (1674501155648962560)]} 0 0
[junit4] 2> 611849 INFO (qtp1564566764-7928) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[17 (1674501155650011136)]} 0 0
[junit4] 2> 611859 INFO (qtp1564566764-7929) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[18 (1674501155660496896)]} 0 0
[junit4] 2> 611860 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[19 (1674501155661545472)]} 0 0
[junit4] 2> 611861 INFO (qtp1564566764-7928) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[20 (1674501155662594048)]} 0 0
[junit4] 2> 611862 INFO (qtp1564566764-7929) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[21 (1674501155663642624)]} 0 0
[junit4] 2> 611871 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[22 (1674501155673079808)]} 0 0
[junit4] 2> 611872 INFO (qtp1564566764-7928) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[23 (1674501155674128384)]} 0 0
[junit4] 2> 611873 INFO (qtp1564566764-7929) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[24 (1674501155675176960)]} 0 0
[junit4] 2> 611874 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[25 (1674501155676225536)]} 0 0
[junit4] 2> 611883 INFO (qtp1564566764-7928) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[26 (1674501155685662720)]} 0 0
[junit4] 2> 611884 INFO (qtp1564566764-7929) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[27 (1674501155686711296)]} 0 0
[junit4] 2> 611885 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[28 (1674501155687759872)]} 0 0
[junit4] 2> 611886 INFO (qtp1564566764-7928) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[29 (1674501155688808448)]} 0 0
[junit4] 2> 611895 INFO (qtp1564566764-7929) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[30 (1674501155698245632)]} 0 0
[junit4] 2> 611897 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[31 (1674501155699294208)]} 0 0
[junit4] 2> 611898 INFO (qtp1564566764-7928) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[32 (1674501155700342784)]} 0 0
[junit4] 2> 611899 INFO (qtp1564566764-7929) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[33 (1674501155702439936)]} 0 0
[junit4] 2> 611900 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[34 (1674501155703488512)]} 0 0
[junit4] 2> 611901 INFO (qtp1564566764-7928) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[35 (1674501155704537088)]} 0 0
[junit4] 2> 611902 INFO (qtp1564566764-7929) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[36 (1674501155705585664)]} 0 0
[junit4] 2> 611903 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[37 (1674501155706634240)]} 0 0
[junit4] 2> 611921 INFO (qtp1564566764-7928) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[38 (1674501155724460032)]} 0 0
[junit4] 2> 611922 INFO (qtp1564566764-7929) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[39 (1674501155725508608)]} 0 0
[junit4] 2> 611923 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[40 (1674501155726557184)]} 0 0
[junit4] 2> 611924 INFO (qtp1564566764-7928) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[41 (1674501155727605760)]} 0 0
[junit4] 2> 611925 INFO (qtp1564566764-7929) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[42 (1674501155728654336)]} 0 0
[junit4] 2> 611926 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[43 (1674501155730751488)]} 0 0
[junit4] 2> 611927 INFO (qtp1564566764-7928) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[44 (1674501155730751489)]} 0 0
[junit4] 2> 611928 INFO (qtp1564566764-7929) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[45 (1674501155731800064)]} 0 0
[junit4] 2> 611929 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[46 (1674501155732848640)]} 0 0
[junit4] 2> 611929 INFO (qtp1564566764-7928) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[47 (1674501155733897216)]} 0 0
[junit4] 2> 611930 INFO (qtp1564566764-7929) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[48 (1674501155734945792)]} 0 0
[junit4] 2> 611931 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[49 (1674501155735994368)]} 0 0
[junit4] 2> 611945 INFO (qtp1564566764-7928) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[50 (1674501155749625856)]} 0 0
[junit4] 2> 611946 INFO (qtp1564566764-7929) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[51 (1674501155750674432)]} 0 0
[junit4] 2> 611947 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[52 (1674501155751723008)]} 0 0
[junit4] 2> 611948 INFO (qtp1564566764-7928) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[53 (1674501155752771584)]} 0 0
[junit4] 2> 611949 INFO (qtp1564566764-7929) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[54 (1674501155753820160)]} 0 0
[junit4] 2> 611950 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[55 (1674501155754868736)]} 0 0
[junit4] 2> 611950 INFO (qtp1564566764-7928) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[56 (1674501155755917312)]} 0 0
[junit4] 2> 611951 INFO (qtp1564566764-7929) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[57 (1674501155756965888)]} 0 0
[junit4] 2> 611952 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[58 (1674501155758014464)]} 0 0
[junit4] 2> 611953 INFO (qtp1564566764-7928) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[59 (1674501155759063040)]} 0 0
[junit4] 2> 611954 INFO (qtp1564566764-7929) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[60 (1674501155760111616)]} 0 0
[junit4] 2> 611955 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[61 (1674501155761160192)]} 0 0
[junit4] 2> 611956 INFO (qtp1564566764-7928) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[62 (1674501155762208768)]} 0 0
[junit4] 2> 611957 INFO (qtp1564566764-7929) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[63 (1674501155763257344)]} 0 0
[junit4] 2> 611958 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[64 (1674501155764305920)]} 0 0
[junit4] 2> 611959 INFO (qtp1564566764-7928) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[65 (1674501155765354496)]} 0 0
[junit4] 2> 611969 INFO (qtp1564566764-7929) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[66 (1674501155774791680)]} 0 0
[junit4] 2> 611970 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[67 (1674501155775840256)]} 0 0
[junit4] 2> 611970 INFO (qtp1564566764-7928) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[68 (1674501155776888832)]} 0 0
[junit4] 2> 611971 INFO (qtp1564566764-7929) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[69 (1674501155777937408)]} 0 0
[junit4] 2> 611972 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[70 (1674501155778985984)]} 0 0
[junit4] 2> 611981 INFO (qtp1564566764-7928) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[71 (1674501155788423168)]} 0 0
[junit4] 2> 611982 INFO (qtp1564566764-7929) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[72 (1674501155789471744)]} 0 0
[junit4] 2> 611983 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[73 (1674501155790520320)]} 0 0
[junit4] 2> 611984 INFO (qtp1564566764-7928) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[74 (1674501155791568896)]} 0 0
[junit4] 2> 611993 INFO (qtp1564566764-7929) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[75 (1674501155801006080)]} 0 0
[junit4] 2> 611995 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[76 (1674501155803103232)]} 0 0
[junit4] 2> 611996 INFO (qtp1564566764-7928) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[77 (1674501155804151808)]} 0 0
[junit4] 2> 611997 INFO (qtp1564566764-7929) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[78 (1674501155805200384)]} 0 0
[junit4] 2> 612010 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[79 (1674501155817783296)]} 0 0
[junit4] 2> 612011 INFO (qtp1564566764-7928) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[80 (1674501155819880448)]} 0 0
[junit4] 2> 612012 INFO (qtp1564566764-7929) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[81 (1674501155820929024)]} 0 0
[junit4] 2> 612013 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[82 (1674501155821977600)]} 0 0
[junit4] 2> 612014 INFO (qtp1564566764-7928) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[83 (1674501155821977601)]} 0 0
[junit4] 2> 612015 INFO (qtp1564566764-7929) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[84 (1674501155823026176)]} 0 0
[junit4] 2> 612015 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[85 (1674501155824074752)]} 0 0
[junit4] 2> 612016 INFO (qtp1564566764-7928) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[86 (1674501155825123328)]} 0 0
[junit4] 2> 612017 INFO (qtp1564566764-7929) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[87 (1674501155826171904)]} 0 0
[junit4] 2> 612018 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[88 (1674501155827220480)]} 0 0
[junit4] 2> 612019 INFO (qtp1564566764-7928) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[89 (1674501155828269056)]} 0 0
[junit4] 2> 612020 INFO (qtp1564566764-7929) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[90 (1674501155829317632)]} 0 0
[junit4] 2> 612021 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[91 (1674501155830366208)]} 0 0
[junit4] 2> 612022 INFO (qtp1564566764-7928) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[92 (1674501155831414784)]} 0 0
[junit4] 2> 612023 INFO (qtp1564566764-7929) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[93 (1674501155832463360)]} 0 0
[junit4] 2> 612024 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[94 (1674501155833511936)]} 0 0
[junit4] 2> 612025 INFO (qtp1564566764-7928) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[95 (1674501155834560512)]} 0 0
[junit4] 2> 612034 INFO (qtp1564566764-7929) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[96 (1674501155843997696)]} 0 0
[junit4] 2> 612035 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[97 (1674501155845046272)]} 0 0
[junit4] 2> 612036 INFO (qtp1564566764-7928) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[98 (1674501155846094848)]} 0 0
[junit4] 2> 612037 INFO (qtp1564566764-7929) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[99 (1674501155847143424)]} 0 0
[junit4] 2> 612068 INFO
(searcherExecutor-4867-thread-1-processing-n:127.0.0.1:34283_solr
x:c1_shard1_replica_n1 c:c1 s:shard1 r:core_node2) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.c.QuerySenderListener
QuerySenderListener done.
[junit4] 2> 612071 INFO
(searcherExecutor-4867-thread-1-processing-n:127.0.0.1:34283_solr
x:c1_shard1_replica_n1 c:c1 s:shard1 r:core_node2) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.c.SolrCore
[c1_shard1_replica_n1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 612092 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [c1_shard1_replica_n1] webapp=/solr
path=/update
params={_stateVer_=c1:4&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
0 41
[junit4] 2> 612094 INFO (qtp1564566764-7928) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.c.S.Request
[c1_shard1_replica_n1] webapp=/solr path=/select
params={q=*:*&_stateVer_=c1:4&wt=javabin&version=2} hits=100 status=0 QTime=0
[junit4] 2> 612217 INFO (qtp1564566764-7976) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.c.S.Request
[c1_shard1_replica_n1] webapp=/solr path=/select
params={q=*:*&_stateVer_=c1:4&wt=javabin&version=2} hits=100 status=0 QTime=0
[junit4] 2> 612311 INFO (qtp1564566764-7983) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.c.S.Request
[c1_shard1_replica_n1] webapp=/solr path=/select
params={q=*:*&_stateVer_=c1:4&wt=javabin&version=2} hits=100 status=0 QTime=0
[junit4] 2> 612400 INFO (qtp1564566764-7992) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.c.S.Request
[c1_shard1_replica_n1] webapp=/solr path=/select
params={q=*:*&_stateVer_=c1:4&wt=javabin&version=2} hits=100 status=0 QTime=0
[junit4] 2> 612475 INFO (qtp1564566764-7976) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.c.S.Request
[c1_shard1_replica_n1] webapp=/solr path=/select
params={q=*:*&_stateVer_=c1:4&wt=javabin&version=2} hits=100 status=0 QTime=0
[junit4] 2> 612526 INFO (qtp1564566764-7998) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.c.S.Request
[c1_shard1_replica_n1] webapp=/solr path=/select
params={q=*:*&_stateVer_=c1:4&wt=javabin&version=2} hits=100 status=0 QTime=0
[junit4] 2> 612721 INFO (qtp1564566764-7977) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.c.S.Request
[c1_shard1_replica_n1] webapp=/solr path=/select
params={q=*:*&_stateVer_=c1:4&wt=javabin&version=2} hits=100 status=0 QTime=0
[junit4] 2> 612723 INFO (qtp1564566764-7977) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.c.S.Request
[c1_shard1_replica_n1] webapp=/solr path=/select
params={q=*:*&_stateVer_=c1:4&wt=javabin&version=2} hits=100 status=0 QTime=0
[junit4] 2> 612723 INFO (qtp1564566764-7997) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.c.S.Request
[c1_shard1_replica_n1] webapp=/solr path=/select
params={q=*:*&_stateVer_=c1:4&wt=javabin&version=2} hits=100 status=0 QTime=0
[junit4] 2> 612788 INFO (qtp1564566764-7929) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.c.S.Request
[c1_shard1_replica_n1] webapp=/solr path=/select
params={q=*:*&_stateVer_=c1:4&wt=javabin&version=2} hits=100 status=0 QTime=0
[junit4] 2> 612900 INFO (qtp1564566764-7976) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.c.S.Request
[c1_shard1_replica_n1] webapp=/solr path=/select
params={q=*:*&_stateVer_=c1:4&wt=javabin&version=2} hits=100 status=0 QTime=0
[junit4] 2> 612921 INFO (qtp1564566764-7999) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.c.S.Request
[c1_shard1_replica_n1] webapp=/solr path=/select
params={q=*:*&_stateVer_=c1:4&wt=javabin&version=2} hits=100 status=0 QTime=0
[junit4] 2> 612978 INFO (qtp1564566764-7998) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.c.S.Request
[c1_shard1_replica_n1] webapp=/solr path=/select
params={q=*:*&_stateVer_=c1:4&wt=javabin&version=2} hits=100 status=0 QTime=0
[junit4] 2> 613004 INFO (qtp1564566764-7997) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.c.S.Request
[c1_shard1_replica_n1] webapp=/solr path=/select
params={q=*:*&_stateVer_=c1:4&wt=javabin&version=2} hits=100 status=0 QTime=0
[junit4] 2> 613005 INFO (qtp1564566764-7997) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.c.S.Request
[c1_shard1_replica_n1] webapp=/solr path=/select
params={q=*:*&_stateVer_=c1:4&wt=javabin&version=2} hits=100 status=0 QTime=0
[junit4] 2> 613008 INFO (qtp1564566764-7979) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.c.S.Request
[c1_shard1_replica_n1] webapp=/solr path=/select
params={q=*:*&_stateVer_=c1:4&wt=javabin&version=2} hits=100 status=0 QTime=0
[junit4] 2> 613035 INFO (qtp1564566764-7992) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.c.S.Request
[c1_shard1_replica_n1] webapp=/solr path=/select
params={q=*:*&_stateVer_=c1:4&wt=javabin&version=2} hits=100 status=0 QTime=0
[junit4] 2> 613060 INFO (qtp1564566764-7983) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.c.S.Request
[c1_shard1_replica_n1] webapp=/solr path=/select
params={q=*:*&_stateVer_=c1:4&wt=javabin&version=2} hits=100 status=0 QTime=0
[junit4] 2> 613087 INFO (qtp1564566764-7977) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.c.S.Request
[c1_shard1_replica_n1] webapp=/solr path=/select
params={q=*:*&_stateVer_=c1:4&wt=javabin&version=2} hits=100 status=0 QTime=0
[junit4] 2> 613121 INFO (qtp1564566764-7928) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.c.S.Request
[c1_shard1_replica_n1] webapp=/solr path=/select
params={q=*:*&_stateVer_=c1:4&wt=javabin&version=2} hits=100 status=0 QTime=0
[junit4] 2> 613133 INFO (qtp1564566764-7992) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.c.S.Request
[c1_shard1_replica_n1] webapp=/solr path=/select
params={q=*:*&_stateVer_=c1:4&wt=javabin&version=2} hits=100 status=0 QTime=0
[junit4] 2> 613134 INFO (qtp1564566764-7997) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.c.S.Request
[c1_shard1_replica_n1] webapp=/solr path=/select
params={q=*:*&_stateVer_=c1:4&wt=javabin&version=2} hits=100 status=0 QTime=0
[junit4] 2> 613157 INFO (zkCallback-4849-thread-2) [ ]
o.a.s.s.IndexSchema Loaded schema default-config/1.6 with uniqueid field id
[junit4] 2> 613157 INFO (zkCallback-4849-thread-2) [ ]
o.a.s.s.ZkIndexSchemaReader Finished refreshing schema in 1505 ms
[junit4] 2> 613159 INFO (qtp1564566764-7993) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.c.S.Request
[c1_shard1_replica_n1] webapp=/solr path=/select
params={q=*:*&_stateVer_=c1:4&wt=javabin&version=2} hits=100 status=0 QTime=0
[junit4] 2> 613166 INFO (qtp1564566764-7998) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.c.S.Request
[c1_shard1_replica_n1] webapp=/solr path=/select
params={q=*:*&_stateVer_=c1:4&wt=javabin&version=2} hits=100 status=0 QTime=0
[junit4] 2> 613203 INFO (qtp1564566764-8001) [n:127.0.0.1:34283_solr c:c1
s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.c.S.Request
[c1_shard1_replica_n1] webapp=/solr path=/select
params={q=*:*&_stateVer_=c1:4&wt=javabin&version=2} hits=100 status=0 QTime=0
[junit4] 2> 613206 INFO
(TEST-TestRequestRateLimiter.testConcurrentQueries-seed#[513D70A324CB1B9]) [
] o.a.s.SolrTestCaseJ4 ###Ending testConcurrentQueries
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=TestRequestRateLimiter -Dtests.method=testConcurrentQueries
-Dtests.seed=513D70A324CB1B9 -Dtests.multiplier=2 -Dtests.slow=true
-Dtests.badapples=true -Dtests.locale=fa-IR
-Dtests.timezone=America/Indiana/Vincennes -Dtests.asserts=true
-Dtests.file.encoding=UTF-8
[junit4] FAILURE 3.86s J0 | TestRequestRateLimiter.testConcurrentQueries <<<
[junit4] > Throwable #1: java.lang.AssertionError: Incoming accepted new
request count did not match. Expected 5 incoming 25
[junit4] > at
__randomizedtesting.SeedInfo.seed([513D70A324CB1B9:4788342FB22BC498]:0)
[junit4] > at
org.apache.solr.servlet.TestRequestRateLimiter.testConcurrentQueries(TestRequestRateLimiter.java:74)
[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] 2> 613238 INFO
(TEST-TestRequestRateLimiter.testSlotBorrowing-seed#[513D70A324CB1B9]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testSlotBorrowing
[junit4] 2> 613239 INFO (qtp1564566764-7927) [n:127.0.0.1:34283_solr
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
pullReplicas=0&name=c2&nrtReplicas=1&action=CREATE&numShards=1&tlogReplicas=0&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 613254 INFO
(OverseerThreadFactory-4855-thread-2-processing-n:127.0.0.1:34283_solr)
[n:127.0.0.1:34283_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection
c2
[junit4] 2> 613255 INFO
(OverseerThreadFactory-4855-thread-2-processing-n:127.0.0.1:34283_solr)
[n:127.0.0.1:34283_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/protwords.txt to /configs/c2.AUTOCREATED/protwords.txt
[junit4] 2> 613257 INFO
(OverseerThreadFactory-4855-thread-2-processing-n:127.0.0.1:34283_solr)
[n:127.0.0.1:34283_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/managed-schema to /configs/c2.AUTOCREATED/managed-schema
[junit4] 2> 613259 INFO
(OverseerThreadFactory-4855-thread-2-processing-n:127.0.0.1:34283_solr)
[n:127.0.0.1:34283_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/solrconfig.xml to /configs/c2.AUTOCREATED/solrconfig.xml
[junit4] 2> 613262 INFO
(OverseerThreadFactory-4855-thread-2-processing-n:127.0.0.1:34283_solr)
[n:127.0.0.1:34283_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/contractions_it.txt to
/configs/c2.AUTOCREATED/lang/contractions_it.txt
[junit4] 2> 613264 INFO
(OverseerThreadFactory-4855-thread-2-processing-n:127.0.0.1:34283_solr)
[n:127.0.0.1:34283_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_no.txt to
/configs/c2.AUTOCREATED/lang/stopwords_no.txt
[junit4] 2> 613266 INFO (OverseerThreadFac
[...truncated too long message...]
cuitBreaker-4826-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> 838431 INFO (TestCircuitBreaker-4826-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> 838431 INFO (TestCircuitBreaker-4826-thread-3) [ ]
o.a.s.u.TestCircuitBreaker BuildingUpMemoryPressureCircuitBreaker: Returning
unblocking value for count 3
[junit4] 2> 838431 INFO (TestCircuitBreaker-4826-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> 838431 INFO (TestCircuitBreaker-4826-thread-4) [ ]
o.a.s.u.TestCircuitBreaker Blocking query from
BuildingUpMemoryPressureCircuitBreaker for count 4
[junit4] 2> 838432 INFO (TestCircuitBreaker-4826-thread-4) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=name:"john+smith"&qt=&start=0&rows=20&version=2.2} status=503 QTime=0
[junit4] 2> 838433 INFO
(TEST-TestCircuitBreaker.testBuildingMemoryPressure-seed#[513D70A324CB1B9]) [
] o.a.s.SolrTestCaseJ4 ###Ending testBuildingMemoryPressure
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestCircuitBreaker
-Dtests.method=testBuildingMemoryPressure -Dtests.seed=513D70A324CB1B9
-Dtests.multiplier=2 -Dtests.slow=true -Dtests.badapples=true
-Dtests.locale=ar-IL -Dtests.timezone=America/Knox_IN -Dtests.asserts=true
-Dtests.file.encoding=UTF-8
[junit4] FAILURE 0.02s J2 | TestCircuitBreaker.testBuildingMemoryPressure <<<
[junit4] > Throwable #1: java.lang.AssertionError: Number of failed
queries is not correct expected:<1> but was:<5>
[junit4] > at
__randomizedtesting.SeedInfo.seed([513D70A324CB1B9:BA9EFBDA1DC05D10]:0)
[junit4] > at
org.apache.solr.util.TestCircuitBreaker.testBuildingMemoryPressure(TestCircuitBreaker.java:152)
[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] 2> 838454 INFO
(TEST-TestCircuitBreaker.testCBFakeMemoryPressure-seed#[513D70A324CB1B9]) [
] o.a.s.SolrTestCaseJ4 ###Starting testCBFakeMemoryPressure
[junit4] 2> 838454 INFO
(TEST-TestCircuitBreaker.testCBFakeMemoryPressure-seed#[513D70A324CB1B9]) [
] 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> 838455 INFO
(TEST-TestCircuitBreaker.testCBFakeMemoryPressure-seed#[513D70A324CB1B9]) [
] o.a.s.SolrTestCaseJ4 ###Ending testCBFakeMemoryPressure
[junit4] 2> 838460 INFO
(TEST-TestCircuitBreaker.testCBAlwaysTrips-seed#[513D70A324CB1B9]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testCBAlwaysTrips
[junit4] 2> 838461 INFO
(TEST-TestCircuitBreaker.testCBAlwaysTrips-seed#[513D70A324CB1B9]) [ ]
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> 838461 INFO
(TEST-TestCircuitBreaker.testCBAlwaysTrips-seed#[513D70A324CB1B9]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending testCBAlwaysTrips
[junit4] 2> 838477 INFO
(TEST-TestCircuitBreaker.testResponseWithCBTiming-seed#[513D70A324CB1B9]) [
] o.a.s.SolrTestCaseJ4 ###Starting testResponseWithCBTiming
[junit4] 2> 838479 INFO
(TEST-TestCircuitBreaker.testResponseWithCBTiming-seed#[513D70A324CB1B9]) [
] o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&wt=xml&debugQuery=true} hits=3 status=0 QTime=1
[junit4] 2> 838496 INFO
(TEST-TestCircuitBreaker.testResponseWithCBTiming-seed#[513D70A324CB1B9]) [
] o.a.s.SolrTestCaseJ4 ###Ending testResponseWithCBTiming
[junit4] 2> 838496 INFO
(SUITE-TestCircuitBreaker-seed#[513D70A324CB1B9]-worker) [ ]
o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> 838496 INFO
(SUITE-TestCircuitBreaker-seed#[513D70A324CB1B9]-worker) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=272034595
[junit4] 2> 838497 INFO (coreCloseExecutor-4828-thread-1) [ ]
o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@33a05d21
[junit4] 2> 838497 INFO (coreCloseExecutor-4828-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection1 tag=SolrCore@33a05d21
[junit4] 2> 838497 INFO (coreCloseExecutor-4828-thread-1) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@76e6e2de: rootName = null,
domain = solr.core.collection1, service url = null, agent id = null] for
registry solr.core.collection1/com.codahale.metrics.MetricRegistry@639459a5
[junit4] 2> 838559 INFO (coreCloseExecutor-4828-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close() ... SKIPPED
(unnecessary).
[junit4] 2> 838560 INFO
(SUITE-TestCircuitBreaker-seed#[513D70A324CB1B9]-worker) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node
tag=null
[junit4] 2> 838560 INFO
(SUITE-TestCircuitBreaker-seed#[513D70A324CB1B9]-worker) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@56245582: rootName = null,
domain = solr.node, service url = null, agent id = null] for registry
solr.node/com.codahale.metrics.MetricRegistry@583fd08b
[junit4] 2> 838575 INFO
(SUITE-TestCircuitBreaker-seed#[513D70A324CB1B9]-worker) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm
tag=null
[junit4] 2> 838575 INFO
(SUITE-TestCircuitBreaker-seed#[513D70A324CB1B9]-worker) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@26d3c0fc: rootName = null,
domain = solr.jvm, service url = null, agent id = null] for registry
solr.jvm/com.codahale.metrics.MetricRegistry@79ff6490
[junit4] 2> 838591 INFO
(SUITE-TestCircuitBreaker-seed#[513D70A324CB1B9]-worker) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty
tag=null
[junit4] 2> 838591 INFO
(SUITE-TestCircuitBreaker-seed#[513D70A324CB1B9]-worker) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@125432af: rootName = null,
domain = solr.jetty, service url = null, agent id = null] for registry
solr.jetty/com.codahale.metrics.MetricRegistry@46d06879
[junit4] 2> NOTE: leaving temporary files on disk at:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-master/solr/build/solr-core/test/J2/temp/solr.util.TestCircuitBreaker_513D70A324CB1B9-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene86):
{title_stringNoNorms=PostingsFormat(name=Direct),
title_stemmed=PostingsFormat(name=Asserting),
multiDefault=PostingsFormat(name=Direct), inStock_b1=Lucene84,
_root_=PostingsFormat(name=Asserting),
name=PostingsFormat(name=LuceneVarGapFixedInterval),
id=PostingsFormat(name=LuceneVarGapFixedInterval), text=Lucene84,
title=PostingsFormat(name=Asserting),
title_lettertok=PostingsFormat(name=LuceneVarGapFixedInterval)},
docValues:{range_facet_l_dv=DocValuesFormat(name=Lucene80),
intDefault=DocValuesFormat(name=Asserting),
id_i1=DocValuesFormat(name=Asserting),
range_facet_i_dv=DocValuesFormat(name=Asserting),
intDvoDefault=DocValuesFormat(name=Lucene80),
timestamp=DocValuesFormat(name=Asserting),
range_facet_l=DocValuesFormat(name=Asserting)}, maxPointsInLeafNode=1188,
maxMBSortInHeap=7.715713433318056,
sim=Asserting(RandomSimilarity(queryNorm=true): {}), locale=ar-IL,
timezone=America/Knox_IN
[junit4] 2> NOTE: Linux 4.15.0-112-generic amd64/Oracle Corporation 11.0.4
(64-bit)/cpus=8,threads=1,free=87997896,total=536870912
[junit4] 2> NOTE: All tests run in this JVM: [TestSchemaField,
DynamicMapsTest, FuzzySearchTest, BinaryUpdateRequestHandlerTest,
FieldAnalysisRequestHandlerTest, SolrTestCaseJ4Test,
TestLeaderElectionZkExpiry, TestFieldCacheSort, TestLegacyNumericUtils,
HdfsWriteToMultipleCollectionsTest, PrimitiveFieldTypeTest,
DistributedExpandComponentTest, RegexBoostProcessorTest,
TestSlowCompositeReaderWrapper, DistributedFacetPivotWhiteBoxTest,
TestShardHandlerFactory, BasicAuthOnSingleNodeTest, DeleteStatusTest,
TestSQLHandlerNonCloud, TestFieldTypeCollectionResource, DeleteNodeTest,
TestSolr4Spatial2, TestFuzzyAnalyzedSuggestions, NotRequiredUniqueKeyTest,
TestRangeQuery, ShardRoutingCustomTest, TokenizerChainTest,
TestInPlaceUpdatesDistrib, SuggesterWFSTTest, TestHttpServletCarrier,
SolrXmlInZkTest, TlogReplayBufferedWhileIndexingTest, TestXmlQParserPlugin,
ResourceLoaderTest, TestDocumentBuilder, TestMiniSolrCloudClusterSSL,
TestLogWatcher, TestIndexingPerformance, TestCollectionAPI, BitVectorTest,
OverseerSolrResponseTest, TestLuceneMatchVersion, ReplicationFactorTest,
ThreadDumpHandlerTest, RankQParserPluginTest, TestTolerantSearch,
HdfsThreadLeakTest, TestCoreContainer, JWTAuthPluginIntegrationTest,
TestCloudPhrasesIdentificationComponent, PeerSyncReplicationTest,
ShowFileRequestHandlerTest, TestSortableTextField, TestSimpleQParserPlugin,
TestSolrXml, TestDistributedStatsComponentCardinality, TestPullReplica,
SolrMetricsIntegrationTest, OrderedExecutorTest, TestDocTermOrdsUninvertLimit,
TestJsonRangeFacets, TestRebalanceLeaders, XmlInterpolationTest,
OverseerTaskQueueTest, TestCircuitBreaker]
[junit4] Completed [232/864 (2!)] on J2 in 5.23s, 4 tests, 1 failure <<<
FAILURES!
[...truncated 54055 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
