Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Windows/9210/ Java: 64bit/jdk-13.0.2 -XX:+UseCompressedOops -XX:+UseG1GC
2 tests failed. 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([8724F5986D09D30C:C5BF16BDED6EA62D]: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:567) 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:830) 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([8724F5986D09D30C:363313A7025F28A8]: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:567) 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:830) Build Log: [...truncated 14934 lines...] [junit4] Suite: org.apache.solr.servlet.TestRequestRateLimiter [junit4] 2> 1598964 INFO (SUITE-TestRequestRateLimiter-seed#[8724F5986D09D30C]-worker) [ ] o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to test-framework derived value of 'C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\server\solr\configsets\_default\conf' [junit4] 2> 1598964 INFO (SUITE-TestRequestRateLimiter-seed#[8724F5986D09D30C]-worker) [ ] o.a.s.SolrTestCaseJ4 Created dataDir: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.servlet.TestRequestRateLimiter_8724F5986D09D30C-001\data-dir-136-001 [junit4] 2> 1598965 INFO (SUITE-TestRequestRateLimiter-seed#[8724F5986D09D30C]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false [junit4] 2> 1598966 INFO (SUITE-TestRequestRateLimiter-seed#[8724F5986D09D30C]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason="", value=0.0/0.0, ssl=0.0/0.0, clientAuth=0.0/0.0) [junit4] 2> 1598966 INFO (SUITE-TestRequestRateLimiter-seed#[8724F5986D09D30C]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom [junit4] 2> 1598966 INFO (SUITE-TestRequestRateLimiter-seed#[8724F5986D09D30C]-worker) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 1 servers in C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.servlet.TestRequestRateLimiter_8724F5986D09D30C-001\tempDir-001 [junit4] 2> 1598967 INFO (SUITE-TestRequestRateLimiter-seed#[8724F5986D09D30C]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 1598967 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer client port: 0.0.0.0/0.0.0.0:0 [junit4] 2> 1598967 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 1598969 WARN (ZkTestServer Run Thread) [ ] o.a.z.s.ServerCnxnFactory maxCnxns is not configured, using default value 0. [junit4] 2> 1599074 INFO (SUITE-TestRequestRateLimiter-seed#[8724F5986D09D30C]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port: 52502 [junit4] 2> 1599074 INFO (SUITE-TestRequestRateLimiter-seed#[8724F5986D09D30C]-worker) [ ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:52502 [junit4] 2> 1599074 INFO (SUITE-TestRequestRateLimiter-seed#[8724F5986D09D30C]-worker) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:52502 [junit4] 2> 1599074 INFO (SUITE-TestRequestRateLimiter-seed#[8724F5986D09D30C]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 52502 [junit4] 2> 1599076 INFO (SUITE-TestRequestRateLimiter-seed#[8724F5986D09D30C]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1599081 INFO (zkConnectionManagerCallback-11289-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1599082 INFO (SUITE-TestRequestRateLimiter-seed#[8724F5986D09D30C]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1599085 INFO (SUITE-TestRequestRateLimiter-seed#[8724F5986D09D30C]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1599088 INFO (zkConnectionManagerCallback-11291-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1599088 INFO (SUITE-TestRequestRateLimiter-seed#[8724F5986D09D30C]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1599089 INFO (SUITE-TestRequestRateLimiter-seed#[8724F5986D09D30C]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1599092 INFO (zkConnectionManagerCallback-11293-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1599092 INFO (SUITE-TestRequestRateLimiter-seed#[8724F5986D09D30C]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1599198 INFO (jetty-launcher-11294-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0) [junit4] 2> 1599198 INFO (jetty-launcher-11294-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ... [junit4] 2> 1599198 INFO (jetty-launcher-11294-thread-1) [ ] o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git: a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 13.0.2+8 [junit4] 2> 1599199 INFO (jetty-launcher-11294-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 1599199 INFO (jetty-launcher-11294-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 1599199 INFO (jetty-launcher-11294-thread-1) [ ] o.e.j.s.session node0 Scavenging every 660000ms [junit4] 2> 1599200 INFO (jetty-launcher-11294-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@5dad1381{/solr,null,AVAILABLE} [junit4] 2> 1599200 INFO (jetty-launcher-11294-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@4cb8a95a{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:52532} [junit4] 2> 1599200 INFO (jetty-launcher-11294-thread-1) [ ] o.e.j.s.Server Started @1600708ms [junit4] 2> 1599200 INFO (jetty-launcher-11294-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=52532} [junit4] 2> 1599201 ERROR (jetty-launcher-11294-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 1599201 INFO (jetty-launcher-11294-thread-1) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 1599201 INFO (jetty-launcher-11294-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 9.0.0 [junit4] 2> 1599201 INFO (jetty-launcher-11294-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 1599202 INFO (jetty-launcher-11294-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr [junit4] 2> 1599202 INFO (jetty-launcher-11294-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-08-10T05:54:31.313380Z [junit4] 2> 1599203 INFO (jetty-launcher-11294-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1599206 INFO (zkConnectionManagerCallback-11296-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1599206 INFO (jetty-launcher-11294-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1599207 INFO (jetty-launcher-11294-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 1599314 INFO (jetty-launcher-11294-thread-1) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true] [junit4] 2> 1599315 WARN (jetty-launcher-11294-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@6a950e0b[provider=null,keyStore=null,trustStore=null] [junit4] 2> 1599315 WARN (jetty-launcher-11294-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@6a950e0b[provider=null,keyStore=null,trustStore=null] [junit4] 2> 1599318 WARN (jetty-launcher-11294-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@27b9361d[provider=null,keyStore=null,trustStore=null] [junit4] 2> 1599318 WARN (jetty-launcher-11294-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@27b9361d[provider=null,keyStore=null,trustStore=null] [junit4] 2> 1599319 INFO (jetty-launcher-11294-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:52502/solr [junit4] 2> 1599320 INFO (jetty-launcher-11294-thread-1) [n:127.0.0.1:52532_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1599323 INFO (zkConnectionManagerCallback-11306-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1599323 INFO (jetty-launcher-11294-thread-1) [n:127.0.0.1:52532_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1599685 INFO (jetty-launcher-11294-thread-1) [n:127.0.0.1:52532_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:52532_solr [junit4] 2> 1599688 INFO (jetty-launcher-11294-thread-1) [n:127.0.0.1:52532_solr ] o.a.s.c.Overseer Overseer (id=72174122139385860-127.0.0.1:52532_solr-n_0000000000) starting [junit4] 2> 1599704 INFO (jetty-launcher-11294-thread-1) [n:127.0.0.1:52532_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:52532_solr [junit4] 2> 1599704 INFO (OverseerStateUpdate-72174122139385860-127.0.0.1:52532_solr-n_0000000000) [n:127.0.0.1:52532_solr ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:52532_solr [junit4] 2> 1599707 INFO (OverseerStateUpdate-72174122139385860-127.0.0.1:52532_solr-n_0000000000) [n:127.0.0.1:52532_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 1599708 INFO (jetty-launcher-11294-thread-1) [n:127.0.0.1:52532_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1 [junit4] 2> 1599709 WARN (jetty-launcher-11294-thread-1) [n:127.0.0.1:52532_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> 1599730 INFO (jetty-launcher-11294-thread-1) [n:127.0.0.1:52532_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 1599751 INFO (jetty-launcher-11294-thread-1) [n:127.0.0.1:52532_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_52532.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7e55e0fc [junit4] 2> 1599759 INFO (jetty-launcher-11294-thread-1) [n:127.0.0.1:52532_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_52532.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7e55e0fc [junit4] 2> 1599759 INFO (jetty-launcher-11294-thread-1) [n:127.0.0.1:52532_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_52532.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7e55e0fc [junit4] 2> 1599761 INFO (jetty-launcher-11294-thread-1) [n:127.0.0.1:52532_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.servlet.TestRequestRateLimiter_8724F5986D09D30C-001\tempDir-001\node1 [junit4] 2> 1599772 INFO (SUITE-TestRequestRateLimiter-seed#[8724F5986D09D30C]-worker) [ ] o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=1 [junit4] 2> 1599772 INFO (SUITE-TestRequestRateLimiter-seed#[8724F5986D09D30C]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1599775 INFO (zkConnectionManagerCallback-11321-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1599775 INFO (SUITE-TestRequestRateLimiter-seed#[8724F5986D09D30C]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1599777 INFO (SUITE-TestRequestRateLimiter-seed#[8724F5986D09D30C]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 1599777 INFO (SUITE-TestRequestRateLimiter-seed#[8724F5986D09D30C]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:52502/solr ready [junit4] 2> 1599797 INFO (TEST-TestRequestRateLimiter.testConcurrentQueries-seed#[8724F5986D09D30C]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testConcurrentQueries [junit4] 2> 1599800 INFO (qtp1115639653-16107) [n:127.0.0.1:52532_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> 1599806 INFO (OverseerThreadFactory-11311-thread-1-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection c1 [junit4] 2> 1599807 INFO (OverseerThreadFactory-11311-thread-1-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/managed-schema to /configs/c1.AUTOCREATED/managed-schema [junit4] 2> 1599812 INFO (OverseerThreadFactory-11311-thread-1-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/protwords.txt to /configs/c1.AUTOCREATED/protwords.txt [junit4] 2> 1599819 INFO (OverseerThreadFactory-11311-thread-1-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_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> 1599826 INFO (OverseerThreadFactory-11311-thread-1-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_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> 1599833 INFO (OverseerThreadFactory-11311-thread-1-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_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> 1599841 INFO (OverseerThreadFactory-11311-thread-1-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_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> 1599847 INFO (OverseerThreadFactory-11311-thread-1-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_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> 1599855 INFO (OverseerThreadFactory-11311-thread-1-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_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> 1599862 INFO (OverseerThreadFactory-11311-thread-1-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_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> 1599871 INFO (OverseerThreadFactory-11311-thread-1-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_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> 1599878 INFO (OverseerThreadFactory-11311-thread-1-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_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> 1599885 INFO (OverseerThreadFactory-11311-thread-1-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_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> 1599892 INFO (OverseerThreadFactory-11311-thread-1-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_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> 1599898 INFO (OverseerThreadFactory-11311-thread-1-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_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> 1599905 INFO (OverseerThreadFactory-11311-thread-1-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_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> 1599911 INFO (OverseerThreadFactory-11311-thread-1-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_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> 1599917 INFO (OverseerThreadFactory-11311-thread-1-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_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> 1599923 INFO (OverseerThreadFactory-11311-thread-1-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_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> 1599930 INFO (OverseerThreadFactory-11311-thread-1-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_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> 1599936 INFO (OverseerThreadFactory-11311-thread-1-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_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> 1599942 INFO (OverseerThreadFactory-11311-thread-1-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_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> 1599949 INFO (OverseerThreadFactory-11311-thread-1-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_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> 1599956 INFO (OverseerThreadFactory-11311-thread-1-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_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> 1599961 INFO (OverseerThreadFactory-11311-thread-1-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_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> 1599968 INFO (OverseerThreadFactory-11311-thread-1-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_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> 1599972 INFO (OverseerThreadFactory-11311-thread-1-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_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> 1599981 INFO (OverseerThreadFactory-11311-thread-1-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_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> 1599990 INFO (OverseerThreadFactory-11311-thread-1-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_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> 1599998 INFO (OverseerThreadFactory-11311-thread-1-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_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> 1600005 INFO (OverseerThreadFactory-11311-thread-1-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_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> 1600013 INFO (OverseerThreadFactory-11311-thread-1-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_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> 1600016 INFO (OverseerThreadFactory-11311-thread-1-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_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> 1600024 INFO (OverseerThreadFactory-11311-thread-1-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_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> 1600028 INFO (OverseerThreadFactory-11311-thread-1-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_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> 1600036 INFO (OverseerThreadFactory-11311-thread-1-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_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> 1600044 INFO (OverseerThreadFactory-11311-thread-1-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_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> 1600049 INFO (OverseerThreadFactory-11311-thread-1-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_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> 1600056 INFO (OverseerThreadFactory-11311-thread-1-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_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> 1600062 INFO (OverseerThreadFactory-11311-thread-1-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_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> 1600068 INFO (OverseerThreadFactory-11311-thread-1-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_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> 1600075 INFO (OverseerThreadFactory-11311-thread-1-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_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> 1600081 INFO (OverseerThreadFactory-11311-thread-1-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/solrconfig.xml to /configs/c1.AUTOCREATED/solrconfig.xml [junit4] 2> 1600087 INFO (OverseerThreadFactory-11311-thread-1-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/synonyms.txt to /configs/c1.AUTOCREATED/synonyms.txt [junit4] 2> 1600092 INFO (OverseerThreadFactory-11311-thread-1-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/stopwords.txt to /configs/c1.AUTOCREATED/stopwords.txt [junit4] 2> 1600213 INFO (OverseerStateUpdate-72174122139385860-127.0.0.1:52532_solr-n_0000000000) [n:127.0.0.1:52532_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":"http://127.0.0.1:52532/solr", [junit4] 2> "node_name":"127.0.0.1:52532_solr", [junit4] 2> "type":"NRT", [junit4] 2> "waitForFinalState":"false"} [junit4] 2> 1600434 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_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> 1600434 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_solr x:c1_shard1_replica_n1 ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 1000 transient cores [junit4] 2> 1600472 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_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> 1600488 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_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> 1600496 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_solr c:c1 s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.s.IndexSchema Schema name=default-config [junit4] 2> 1600625 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_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> 1600625 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_solr c:c1 s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_52532.solr.core.c1.shard1.replica_n1' (registry 'solr.core.c1.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7e55e0fc [junit4] 2> 1600625 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_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 [C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.servlet.TestRequestRateLimiter_8724F5986D09D30C-001\tempDir-001\node1\c1_shard1_replica_n1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.servlet.TestRequestRateLimiter_8724F5986D09D30C-001\tempDir-001\node1\c1_shard1_replica_n1\data\] [junit4] 2> 1600734 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_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> 1600734 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_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> 1600737 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_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> 1600737 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_solr c:c1 s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 1600740 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_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> 1600741 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_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> 1600741 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_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> 1600743 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_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> 1600744 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_solr c:c1 s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 1600744 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_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> 1600744 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_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> 1600744 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_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 1674616633142804480 [junit4] 2> 1600751 INFO (searcherExecutor-11323-thread-1-processing-n:127.0.0.1:52532_solr x:c1_shard1_replica_n1 c:c1 s:shard1 r:core_node2) [n:127.0.0.1:52532_solr c:c1 s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.c.QuerySenderListener QuerySenderListener done. [junit4] 2> 1600751 INFO (searcherExecutor-11323-thread-1-processing-n:127.0.0.1:52532_solr x:c1_shard1_replica_n1 c:c1 s:shard1 r:core_node2) [n:127.0.0.1:52532_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> 1600753 INFO (searcherExecutor-11323-thread-1-processing-n:127.0.0.1:52532_solr x:c1_shard1_replica_n1 c:c1 s:shard1 r:core_node2) [n:127.0.0.1:52532_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> 1600781 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_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> 1600781 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_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> 1600800 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_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> 1600800 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_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> 1600800 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_solr c:c1 s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:52532/solr/c1_shard1_replica_n1/ [junit4] 2> 1600801 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_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> 1600801 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_solr c:c1 s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.c.SyncStrategy http://127.0.0.1:52532/solr/c1_shard1_replica_n1/ has no replicas [junit4] 2> 1600801 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_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/72174122139385860-core_node2-n_0000000000 [junit4] 2> 1600807 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_solr c:c1 s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:52532/solr/c1_shard1_replica_n1/ shard1 [junit4] 2> 1600910 INFO (zkCallback-11305-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> 1600913 INFO (zkCallback-11305-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> 1600915 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_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> 1600921 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_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=487 [junit4] 2> 1600929 INFO (qtp1115639653-16107) [n:127.0.0.1:52532_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> 1601022 INFO (zkCallback-11305-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> 1601022 INFO (zkCallback-11305-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> 1601022 INFO (zkCallback-11305-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> 1601025 INFO (qtp1115639653-16107) [n:127.0.0.1:52532_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=1224 [junit4] 2> 1601025 INFO (TEST-TestRequestRateLimiter.testConcurrentQueries-seed#[8724F5986D09D30C]) [ ] o.a.s.c.MiniSolrCloudCluster waitForActiveCollection: c1 [junit4] 2> 1601121 INFO (qtp1115639653-16108) [n:127.0.0.1:52532_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> 1601121 INFO (zkCallback-11305-thread-4) [ ] 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> 1601121 INFO (zkCallback-11305-thread-4) [ ] o.a.s.s.ZkIndexSchemaReader Retrieved schema version 1 from Zookeeper [junit4] 2> 1601125 INFO (zkCallback-11305-thread-4) [ ] o.a.s.s.IndexSchema Schema name=default-config [junit4] 2> 1601129 INFO (qtp1115639653-16108) [n:127.0.0.1:52532_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> 1601129 INFO (qtp1115639653-16108) [n:127.0.0.1:52532_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 (1674616633538117632)]} 0 101 [junit4] 2> 1601133 INFO (qtp1115639653-16109) [n:127.0.0.1:52532_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 (1674616633550700544)]} 0 2 [junit4] 2> 1601133 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_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 (1674616633550700545)]} 0 1 [junit4] 2> 1601138 INFO (qtp1115639653-16107) [n:127.0.0.1:52532_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 (1674616633550700546)]} 0 0 [junit4] 2> 1601138 INFO (qtp1115639653-16108) [n:127.0.0.1:52532_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 (1674616633555943424)]} 0 0 [junit4] 2> 1601138 INFO (qtp1115639653-16109) [n:127.0.0.1:52532_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 (1674616633555943425)]} 0 0 [junit4] 2> 1601147 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_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 (1674616633565380608)]} 0 0 [junit4] 2> 1601149 INFO (qtp1115639653-16107) [n:127.0.0.1:52532_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 (1674616633567477760)]} 0 0 [junit4] 2> 1601149 INFO (qtp1115639653-16108) [n:127.0.0.1:52532_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 (1674616633567477761)]} 0 0 [junit4] 2> 1601149 INFO (qtp1115639653-16109) [n:127.0.0.1:52532_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 (1674616633567477762)]} 0 0 [junit4] 2> 1601153 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_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 (1674616633567477763)]} 0 0 [junit4] 2> 1601153 INFO (qtp1115639653-16107) [n:127.0.0.1:52532_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 (1674616633571672064)]} 0 0 [junit4] 2> 1601154 INFO (qtp1115639653-16108) [n:127.0.0.1:52532_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 (1674616633571672065)]} 0 0 [junit4] 2> 1601154 INFO (qtp1115639653-16109) [n:127.0.0.1:52532_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 (1674616633572720640)]} 0 0 [junit4] 2> 1601154 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_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 (1674616633572720641)]} 0 0 [junit4] 2> 1601157 INFO (qtp1115639653-16107) [n:127.0.0.1:52532_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 (1674616633575866368)]} 0 0 [junit4] 2> 1601157 INFO (qtp1115639653-16108) [n:127.0.0.1:52532_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 (1674616633575866369)]} 0 0 [junit4] 2> 1601157 INFO (qtp1115639653-16109) [n:127.0.0.1:52532_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 (1674616633575866370)]} 0 0 [junit4] 2> 1601157 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_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 (1674616633575866371)]} 0 0 [junit4] 2> 1601160 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_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 (1674616633579012096)]} 0 0 [junit4] 2> 1601161 INFO (qtp1115639653-16107) [n:127.0.0.1:52532_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 (1674616633580060672)]} 0 0 [junit4] 2> 1601162 INFO (qtp1115639653-16108) [n:127.0.0.1:52532_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 (1674616633581109248)]} 0 0 [junit4] 2> 1601164 INFO (qtp1115639653-16109) [n:127.0.0.1:52532_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 (1674616633581109249)]} 0 0 [junit4] 2> 1601165 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_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 (1674616633584254976)]} 0 0 [junit4] 2> 1601167 INFO (qtp1115639653-16107) [n:127.0.0.1:52532_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 (1674616633586352128)]} 0 0 [junit4] 2> 1601167 INFO (qtp1115639653-16108) [n:127.0.0.1:52532_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 (1674616633586352129)]} 0 0 [junit4] 2> 1601167 INFO (qtp1115639653-16109) [n:127.0.0.1:52532_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 (1674616633586352130)]} 0 0 [junit4] 2> 1601169 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_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 (1674616633588449280)]} 0 0 [junit4] 2> 1601173 INFO (qtp1115639653-16107) [n:127.0.0.1:52532_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 (1674616633592643584)]} 0 0 [junit4] 2> 1601174 INFO (qtp1115639653-16108) [n:127.0.0.1:52532_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 (1674616633593692160)]} 0 0 [junit4] 2> 1601177 INFO (qtp1115639653-16109) [n:127.0.0.1:52532_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 (1674616633596837888)]} 0 0 [junit4] 2> 1601181 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_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 (1674616633601032192)]} 0 0 [junit4] 2> 1601195 INFO (qtp1115639653-16107) [n:127.0.0.1:52532_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 (1674616633615712256)]} 0 0 [junit4] 2> 1601206 INFO (qtp1115639653-16108) [n:127.0.0.1:52532_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 (1674616633627246592)]} 0 0 [junit4] 2> 1601209 INFO (qtp1115639653-16109) [n:127.0.0.1:52532_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 (1674616633629343744)]} 0 0 [junit4] 2> 1601210 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_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 (1674616633631440896)]} 0 0 [junit4] 2> 1601212 INFO (qtp1115639653-16107) [n:127.0.0.1:52532_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 (1674616633633538048)]} 0 0 [junit4] 2> 1601213 INFO (qtp1115639653-16108) [n:127.0.0.1:52532_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 (1674616633634586624)]} 0 0 [junit4] 2> 1601214 INFO (qtp1115639653-16109) [n:127.0.0.1:52532_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 (1674616633634586625)]} 0 0 [junit4] 2> 1601217 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_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 (1674616633638780928)]} 0 0 [junit4] 2> 1601240 INFO (qtp1115639653-16107) [n:127.0.0.1:52532_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 (1674616633662898176)]} 0 0 [junit4] 2> 1601246 INFO (qtp1115639653-16108) [n:127.0.0.1:52532_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 (1674616633669189632)]} 0 0 [junit4] 2> 1601246 INFO (qtp1115639653-16109) [n:127.0.0.1:52532_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 (1674616633669189633)]} 0 0 [junit4] 2> 1601270 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_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 (1674616633694355456)]} 0 0 [junit4] 2> 1601276 INFO (qtp1115639653-16107) [n:127.0.0.1:52532_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 (1674616633700646912)]} 0 0 [junit4] 2> 1601277 INFO (qtp1115639653-16108) [n:127.0.0.1:52532_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 (1674616633701695488)]} 0 1 [junit4] 2> 1601279 INFO (qtp1115639653-16109) [n:127.0.0.1:52532_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 (1674616633703792640)]} 0 0 [junit4] 2> 1601283 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_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 (1674616633707986944)]} 0 0 [junit4] 2> 1601284 INFO (qtp1115639653-16107) [n:127.0.0.1:52532_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 (1674616633709035520)]} 0 0 [junit4] 2> 1601285 INFO (qtp1115639653-16108) [n:127.0.0.1:52532_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 (1674616633710084096)]} 0 0 [junit4] 2> 1601286 INFO (qtp1115639653-16109) [n:127.0.0.1:52532_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 (1674616633711132672)]} 0 0 [junit4] 2> 1601287 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_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 (1674616633712181248)]} 0 0 [junit4] 2> 1601288 INFO (qtp1115639653-16107) [n:127.0.0.1:52532_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 (1674616633713229824)]} 0 0 [junit4] 2> 1601290 INFO (qtp1115639653-16108) [n:127.0.0.1:52532_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 (1674616633715326976)]} 0 0 [junit4] 2> 1601290 INFO (qtp1115639653-16109) [n:127.0.0.1:52532_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 (1674616633715326977)]} 0 0 [junit4] 2> 1601291 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_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 (1674616633716375552)]} 0 0 [junit4] 2> 1601292 INFO (qtp1115639653-16107) [n:127.0.0.1:52532_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 (1674616633717424128)]} 0 0 [junit4] 2> 1601293 INFO (qtp1115639653-16108) [n:127.0.0.1:52532_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 (1674616633718472704)]} 0 0 [junit4] 2> 1601293 INFO (qtp1115639653-16109) [n:127.0.0.1:52532_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 (1674616633718472705)]} 0 0 [junit4] 2> 1601295 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_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 (1674616633720569856)]} 0 0 [junit4] 2> 1601295 INFO (qtp1115639653-16107) [n:127.0.0.1:52532_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 (1674616633720569857)]} 0 0 [junit4] 2> 1601297 INFO (qtp1115639653-16108) [n:127.0.0.1:52532_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 (1674616633722667008)]} 0 0 [junit4] 2> 1601307 INFO (qtp1115639653-16109) [n:127.0.0.1:52532_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 (1674616633733152768)]} 0 6 [junit4] 2> 1601309 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_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 (1674616633735249920)]} 0 0 [junit4] 2> 1601310 INFO (qtp1115639653-16107) [n:127.0.0.1:52532_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 (1674616633736298496)]} 0 0 [junit4] 2> 1601311 INFO (qtp1115639653-16108) [n:127.0.0.1:52532_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 (1674616633737347072)]} 0 0 [junit4] 2> 1601312 INFO (qtp1115639653-16109) [n:127.0.0.1:52532_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 (1674616633738395648)]} 0 0 [junit4] 2> 1601313 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_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 (1674616633739444224)]} 0 0 [junit4] 2> 1601315 INFO (qtp1115639653-16107) [n:127.0.0.1:52532_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 (1674616633741541376)]} 0 0 [junit4] 2> 1601315 INFO (qtp1115639653-16108) [n:127.0.0.1:52532_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 (1674616633741541377)]} 0 0 [junit4] 2> 1601318 INFO (qtp1115639653-16109) [n:127.0.0.1:52532_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 (1674616633744687104)]} 0 0 [junit4] 2> 1601318 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_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 (1674616633744687105)]} 0 0 [junit4] 2> 1601319 INFO (qtp1115639653-16107) [n:127.0.0.1:52532_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 (1674616633745735680)]} 0 0 [junit4] 2> 1601320 INFO (qtp1115639653-16108) [n:127.0.0.1:52532_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 (1674616633746784256)]} 0 0 [junit4] 2> 1601320 INFO (qtp1115639653-16109) [n:127.0.0.1:52532_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 (1674616633746784257)]} 0 0 [junit4] 2> 1601321 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_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 (1674616633747832832)]} 0 0 [junit4] 2> 1601322 INFO (qtp1115639653-16107) [n:127.0.0.1:52532_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 (1674616633748881408)]} 0 0 [junit4] 2> 1601322 INFO (qtp1115639653-16108) [n:127.0.0.1:52532_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 (1674616633748881409)]} 0 0 [junit4] 2> 1601322 INFO (qtp1115639653-16109) [n:127.0.0.1:52532_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 (1674616633748881410)]} 0 0 [junit4] 2> 1601322 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_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 (1674616633748881411)]} 0 0 [junit4] 2> 1601322 INFO (qtp1115639653-16107) [n:127.0.0.1:52532_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 (1674616633748881412)]} 0 0 [junit4] 2> 1601325 INFO (qtp1115639653-16108) [n:127.0.0.1:52532_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 (1674616633752027136)]} 0 0 [junit4] 2> 1601325 INFO (qtp1115639653-16109) [n:127.0.0.1:52532_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 (1674616633752027137)]} 0 0 [junit4] 2> 1601325 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_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 (1674616633752027138)]} 0 0 [junit4] 2> 1601325 INFO (qtp1115639653-16107) [n:127.0.0.1:52532_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 (1674616633752027139)]} 0 0 [junit4] 2> 1601325 INFO (qtp1115639653-16108) [n:127.0.0.1:52532_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 (1674616633752027140)]} 0 0 [junit4] 2> 1601329 INFO (qtp1115639653-16109) [n:127.0.0.1:52532_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 (1674616633756221440)]} 0 0 [junit4] 2> 1601329 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_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 (1674616633756221441)]} 0 0 [junit4] 2> 1601329 INFO (qtp1115639653-16107) [n:127.0.0.1:52532_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 (1674616633756221442)]} 0 0 [junit4] 2> 1601329 INFO (qtp1115639653-16108) [n:127.0.0.1:52532_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 (1674616633756221443)]} 0 0 [junit4] 2> 1601332 INFO (qtp1115639653-16109) [n:127.0.0.1:52532_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 (1674616633759367168)]} 0 0 [junit4] 2> 1601333 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_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 (1674616633760415744)]} 0 0 [junit4] 2> 1601333 INFO (qtp1115639653-16107) [n:127.0.0.1:52532_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 (1674616633760415745)]} 0 0 [junit4] 2> 1601333 INFO (qtp1115639653-16108) [n:127.0.0.1:52532_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 (1674616633760415746)]} 0 0 [junit4] 2> 1601336 INFO (qtp1115639653-16109) [n:127.0.0.1:52532_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 (1674616633763561472)]} 0 0 [junit4] 2> 1601337 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_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 (1674616633764610048)]} 0 0 [junit4] 2> 1601338 INFO (qtp1115639653-16107) [n:127.0.0.1:52532_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 (1674616633765658624)]} 0 0 [junit4] 2> 1601338 INFO (qtp1115639653-16108) [n:127.0.0.1:52532_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 (1674616633765658625)]} 0 0 [junit4] 2> 1601338 INFO (qtp1115639653-16109) [n:127.0.0.1:52532_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 (1674616633765658626)]} 0 0 [junit4] 2> 1601338 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_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 (1674616633765658627)]} 0 0 [junit4] 2> 1601354 INFO (searcherExecutor-11323-thread-1-processing-n:127.0.0.1:52532_solr x:c1_shard1_replica_n1 c:c1 s:shard1 r:core_node2) [n:127.0.0.1:52532_solr c:c1 s:shard1 r:core_node2 x:c1_shard1_replica_n1 ] o.a.s.c.QuerySenderListener QuerySenderListener done. [junit4] 2> 1601355 INFO (searcherExecutor-11323-thread-1-processing-n:127.0.0.1:52532_solr x:c1_shard1_replica_n1 c:c1 s:shard1 r:core_node2) [n:127.0.0.1:52532_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> 1601356 INFO (qtp1115639653-16107) [n:127.0.0.1:52532_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 14 [junit4] 2> 1601359 INFO (qtp1115639653-16108) [n:127.0.0.1:52532_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> 1601361 INFO (qtp1115639653-16109) [n:127.0.0.1:52532_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> 1601361 INFO (qtp1115639653-16108) [n:127.0.0.1:52532_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> 1601362 INFO (qtp1115639653-16109) [n:127.0.0.1:52532_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> 1601364 INFO (qtp1115639653-16107) [n:127.0.0.1:52532_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> 1601365 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_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> 1601365 INFO (qtp1115639653-16108) [n:127.0.0.1:52532_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> 1601367 INFO (qtp1115639653-16109) [n:127.0.0.1:52532_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> 1601369 INFO (qtp1115639653-16107) [n:127.0.0.1:52532_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> 1601369 INFO (qtp1115639653-16108) [n:127.0.0.1:52532_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> 1601369 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_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> 1601371 INFO (qtp1115639653-16109) [n:127.0.0.1:52532_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> 1601371 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_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> 1601372 INFO (qtp1115639653-16107) [n:127.0.0.1:52532_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> 1601373 INFO (qtp1115639653-16108) [n:127.0.0.1:52532_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> 1601374 INFO (qtp1115639653-16109) [n:127.0.0.1:52532_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> 1601375 INFO (qtp1115639653-16107) [n:127.0.0.1:52532_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> 1601375 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_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> 1601376 INFO (qtp1115639653-16108) [n:127.0.0.1:52532_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> 1601377 INFO (qtp1115639653-16109) [n:127.0.0.1:52532_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> 1601378 INFO (qtp1115639653-16107) [n:127.0.0.1:52532_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> 1601378 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_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> 1601379 INFO (qtp1115639653-16106) [n:127.0.0.1:52532_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> 1601379 INFO (qtp1115639653-16109) [n:127.0.0.1:52532_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> 1601379 INFO (qtp1115639653-16107) [n:127.0.0.1:52532_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> 1601381 INFO (TEST-TestRequestRateLimiter.testConcurrentQueries-seed#[8724F5986D09D30C]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testConcurrentQueries [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestRequestRateLimiter -Dtests.method=testConcurrentQueries -Dtests.seed=8724F5986D09D30C -Dtests.slow=true -Dtests.locale=en-ER -Dtests.timezone=Asia/Baku -Dtests.asserts=true -Dtests.file.encoding=US-ASCII [junit4] FAILURE 1.59s J1 | 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([8724F5986D09D30C:C5BF16BDED6EA62D]: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:567) [junit4] > at java.base/java.lang.Thread.run(Thread.java:830) [junit4] 2> 1601385 INFO (zkCallback-11305-thread-4) [ ] o.a.s.s.IndexSchema Loaded schema default-config/1.6 with uniqueid field id [junit4] 2> 1601385 INFO (zkCallback-11305-thread-4) [ ] o.a.s.s.ZkIndexSchemaReader Finished refreshing schema in 263 ms [junit4] 2> 1601399 INFO (TEST-TestRequestRateLimiter.testSlotBorrowing-seed#[8724F5986D09D30C]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testSlotBorrowing [junit4] 2> 1601399 INFO (qtp1115639653-16108) [n:127.0.0.1:52532_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> 1601413 INFO (OverseerCollectionConfigSetProcessor-72174122139385860-127.0.0.1:52532_solr-n_0000000000) [n:127.0.0.1:52532_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> 1601413 INFO (OverseerThreadFactory-11311-thread-2-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection c2 [junit4] 2> 1601413 INFO (OverseerThreadFactory-11311-thread-2-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/managed-schema to /configs/c2.AUTOCREATED/managed-schema [junit4] 2> 1601427 INFO (OverseerThreadFactory-11311-thread-2-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/protwords.txt to /configs/c2.AUTOCREATED/protwords.txt [junit4] 2> 1601445 INFO (OverseerThreadFactory-11311-thread-2-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_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> 1601465 INFO (OverseerThreadFactory-11311-thread-2-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/contractions_ca.txt to /configs/c2.AUTOCREATED/lang/contractions_ca.txt [junit4] 2> 1601489 INFO (OverseerThreadFactory-11311-thread-2-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stemdict_nl.txt to /configs/c2.AUTOCREATED/lang/stemdict_nl.txt [junit4] 2> 1601505 INFO (OverseerThreadFactory-11311-thread-2-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_hy.txt to /configs/c2.AUTOCREATED/lang/stopwords_hy.txt [junit4] 2> 1601526 INFO (OverseerThreadFactory-11311-thread-2-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_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> 1601537 INFO (OverseerThreadFactory-11311-thread-2-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_id.txt to /configs/c2.AUTOCREATED/lang/stopwords_id.txt [junit4] 2> 1601549 INFO (OverseerThreadFactory-11311-thread-2-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_et.txt to /configs/c2.AUTOCREATED/lang/stopwords_et.txt [junit4] 2> 1601565 INFO (OverseerThreadFactory-11311-thread-2-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_da.txt to /configs/c2.AUTOCREATED/lang/stopwords_da.txt [junit4] 2> 1601582 INFO (OverseerThreadFactory-11311-thread-2-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ga.txt to /configs/c2.AUTOCREATED/lang/stopwords_ga.txt [junit4] 2> 1601592 INFO (OverseerThreadFactory-11311-thread-2-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_hi.txt to /configs/c2.AUTOCREATED/lang/stopwords_hi.txt [junit4] 2> 1601601 INFO (OverseerThreadFactory-11311-thread-2-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ja.txt to /configs/c2.AUTOCREATED/lang/stopwords_ja.txt [junit4] 2> 1601611 INFO (OverseerThreadFactory-11311-thread-2-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_pt.txt to /configs/c2.AUTOCREATED/lang/stopwords_pt.txt [junit4] 2> 1601630 INFO (OverseerThreadFactory-11311-thread-2-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_hu.txt to /configs/c2.AUTOCREATED/lang/stopwords_hu.txt [junit4] 2> 1601650 INFO (OverseerThreadFactory-11311-thread-2-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_el.txt to /configs/c2.AUTOCREATED/lang/stopwords_el.txt [junit4] 2> 1601666 INFO (OverseerThreadFactory-11311-thread-2-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ru.txt to /configs/c2.AUTOCREATED/lang/stopwords_ru.txt [junit4] 2> 1601678 INFO (OverseerThreadFactory-11311-thread-2-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_tr.txt to /configs/c2.AUTOCREATED/lang/stopwords_tr.txt [junit4] 2> 1601689 INFO (OverseerThreadFactory-11311-thread-2-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ar.txt to /configs/c2.AUTOCREATED/lang/stopwords_ar.txt [junit4] 2> 1601702 INFO (OverseerThreadFactory-11311-thread-2-processing-n:127.0.0.1:52532_solr) [n:127.0.0.1:52532_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_ [...truncated too long message...] 0.1:52532_solr ] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close() ... SKIPPED (unnecessary). [junit4] 2> 1603367 INFO (coreCloseExecutor-11340-thread-2) [n:127.0.0.1:52532_solr ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.c2.shard1.leader tag=SolrCore@64cf8445 [junit4] 2> 1603367 INFO (coreCloseExecutor-11340-thread-2) [n:127.0.0.1:52532_solr ] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close() ... SKIPPED (unnecessary). [junit4] 2> 1603373 INFO (jetty-closer-11336-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node tag=null [junit4] 2> 1603373 INFO (jetty-closer-11336-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@2a538037: rootName = solr_52532, domain = solr.node, service url = null, agent id = null] for registry solr.node/com.codahale.metrics.MetricRegistry@7ed5e8bf [junit4] 2> 1603375 INFO (jetty-closer-11336-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm tag=null [junit4] 2> 1603375 INFO (jetty-closer-11336-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@167af610: rootName = solr_52532, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm/com.codahale.metrics.MetricRegistry@69b98df3 [junit4] 2> 1603379 INFO (jetty-closer-11336-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty tag=null [junit4] 2> 1603379 INFO (jetty-closer-11336-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1b3392e2: rootName = solr_52532, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty/com.codahale.metrics.MetricRegistry@ff14e4e [junit4] 2> 1603379 INFO (jetty-closer-11336-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster tag=null [junit4] 2> 1603381 INFO (closeThreadPool-11342-thread-2) [ ] o.a.s.c.Overseer Overseer (id=72174122139385860-127.0.0.1:52532_solr-n_0000000000) closing [junit4] 2> 1603381 INFO (OverseerStateUpdate-72174122139385860-127.0.0.1:52532_solr-n_0000000000) [n:127.0.0.1:52532_solr ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:52532_solr [junit4] 2> 1603382 INFO (closeThreadPool-11342-thread-1) [ ] o.a.s.c.Overseer Overseer (id=72174122139385860-127.0.0.1:52532_solr-n_0000000000) closing [junit4] 2> 1603485 INFO (jetty-closer-11336-thread-1) [ ] o.a.s.c.Overseer Overseer (id=72174122139385860-127.0.0.1:52532_solr-n_0000000000) closing [junit4] 2> 1603486 INFO (jetty-closer-11336-thread-1) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@4cb8a95a{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:0} [junit4] 2> 1603487 INFO (jetty-closer-11336-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@5dad1381{/solr,null,UNAVAILABLE} [junit4] 2> 1603487 INFO (jetty-closer-11336-thread-1) [ ] o.e.j.s.session node0 Stopped scavenging [junit4] 2> 1603488 INFO (SUITE-TestRequestRateLimiter-seed#[8724F5986D09D30C]-worker) [ ] o.a.s.c.ZkTestServer Shutting down ZkTestServer. [junit4] 2> 1603696 WARN (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Watch limit violations: [junit4] 2> Maximum concurrent create/delete watches above limit: [junit4] 2> [junit4] 2> 3 /solr/collections/c2/terms/shard1 [junit4] 2> 3 /solr/collections/c1/terms/shard1 [junit4] 2> 2 /solr/clusterprops.json [junit4] 2> 2 /solr/aliases.json [junit4] 2> [junit4] 2> Maximum concurrent data watches above limit: [junit4] 2> [junit4] 2> 10 /solr/collections/c2/state.json [junit4] 2> 10 /solr/collections/c1/state.json [junit4] 2> [junit4] 2> Maximum concurrent children watches above limit: [junit4] 2> [junit4] 2> 21 /solr/overseer/queue [junit4] 2> 8 /solr/overseer/collection-queue-work [junit4] 2> 6 /solr/collections [junit4] 2> 4 /solr/live_nodes [junit4] 2> [junit4] 2> 1603702 INFO (SUITE-TestRequestRateLimiter-seed#[8724F5986D09D30C]-worker) [ ] o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:52502 [junit4] 2> 1603702 INFO (SUITE-TestRequestRateLimiter-seed#[8724F5986D09D30C]-worker) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:52502 [junit4] 2> 1603702 INFO (SUITE-TestRequestRateLimiter-seed#[8724F5986D09D30C]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 52502 [junit4] 2> NOTE: leaving temporary files on disk at: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.servlet.TestRequestRateLimiter_8724F5986D09D30C-001 [junit4] 2> NOTE: test params are: codec=Asserting(Lucene86): {}, docValues:{}, maxPointsInLeafNode=682, maxMBSortInHeap=5.14855611275368, sim=Asserting(RandomSimilarity(queryNorm=true): {}), locale=en-ER, timezone=Asia/Baku [junit4] 2> NOTE: Windows 10 10.0 amd64/AdoptOpenJDK 13.0.2 (64-bit)/cpus=6,threads=1,free=149607496,total=277872640 [junit4] 2> NOTE: All tests run in this JVM: [DistributedQueryComponentCustomSortTest, TestExactStatsCacheCloud, TestReRankQParserPlugin, SmileWriterTest, ReindexCollectionTest, TestSolrJacksonAnnotation, TestFacetMethods, TestMaxTokenLenTokenizer, DeleteStatusTest, TlogReplayBufferedWhileIndexingTest, TermVectorComponentTest, NumberUtilsTest, AnalyticsMergeStrategyTest, TestLegacyNumericUtils, TestFieldCacheWithThreads, ConcurrentDeleteAndCreateCollectionTest, TestClusterProperties, TestReloadDeadlock, SolrJmxReporterTest, SolrTestCaseJ4Test, TestSolrJ, TestSchemaNameResource, HdfsThreadLeakTest, TestSortableTextField, TestNoOpRegenerator, HttpPartitionOnCommitTest, LeaderElectionTest, TestCloudPivotFacet, TestStressRecovery, TestFuzzyAnalyzedSuggestions, SpellCheckComponentTest, TestNRTOpen, ZkControllerTest, ConcurrentCreateRoutedAliasTest, UtilsToolTest, TestCoreDiscovery, SignatureUpdateProcessorFactoryTest, TestInfoStreamLogging, PeerSyncWithLeaderAndIndexFingerprintCachingTest, TestSolrCloudWithKerberosAlt, BasicAuthOnSingleNodeTest, DebugComponentTest, DistributedFacetPivotLongTailTest, TestHdfsUpdateLog, TestImpersonationWithHadoopAuth, TestLuceneIndexBackCompat, ClusterStateTest, DistributedVersionInfoTest, TestClusterStateMutator, MetricsHistoryHandlerTest, ZookeeperStatusHandlerTest, RankQParserPluginTest, SolrLogPostToolTest, BJQFilterAccessibleTest, TestRandomFlRTGCloud, SolrCoreTest, UniqFieldsUpdateProcessorFactoryTest, RandomizedTaggerTest, TestOrdValues, TestRandomDVFaceting, FieldMutatingUpdateProcessorTest, TestPostingsSolrHighlighter, TestPrepRecovery, TestReplicaProperties, DeleteInactiveReplicaTest, SolrXmlInZkTest, DateFieldTest, DistributedFacetSimpleRefinementLongTailTest, AtomicUpdatesTest, WordBreakSolrSpellCheckerTest, HDFSCollectionsAPITest, BufferStoreTest, TestTlogReplayVsRecovery, EchoParamsTest, TestRestoreCore, SolrIndexConfigTest, TestGraphMLResponseWriter, TestLegacyNumericRangeQueryBuilder, TestSimpleTextCodec, AddBlockUpdateTest, TestExplainDocTransformer, TestUniqueKeyFieldResource, ParsingFieldUpdateProcessorsTest, TestElisionMultitermQuery, AnalysisAfterCoreReloadTest, BasicFunctionalityTest, ConvertedLegacyTest, CursorPagingTest, DisMaxRequestHandlerTest, SampleTest, TestDistributedGrouping, TestDistributedSearch, ChaosMonkeyNothingIsSafeTest, CleanupOldIndexTest, DistribJoinFromCollectionTest, MetricsHistoryWithAuthIntegrationTest, MoveReplicaHDFSFailoverTest, MoveReplicaHDFSTest, MoveReplicaTest, NestedShardedAtomicUpdateTest, OverseerRolesTest, OverseerTest, PackageManagerCLITest, ReplicationFactorTest, TestShortCircuitedRequests, AsyncCallRequestStatusResponseTest, CollectionTooManyReplicasTest, CollectionsAPIAsyncDistributedZkTest, TestHdfsCloudBackupRestore, CdcrBidirectionalTest, CdcrBootstrapTest, TestHdfsBackupRestoreCore, TestReplicationHandler, TestHttpShardHandlerFactory, TestPivotHelperCode, TestTrackingShardHandlerFactory, TestNumericTokenStream, TestLogWatcher, JvmMetricsTest, SolrCoreMetricManagerTest, SolrRrdBackendFactoryTest, TestRestManager, TestBulkSchemaAPI, TestSchemaField, TestUseDocValuesAsStored2, SignificantTermsQParserPluginTest, SolrIndexSearcherTest, SpatialFilterTest, TestCollapseQParserPlugin, TestSolr4Spatial2, TestSolrCoreParser, TestTermsQParserPlugin, TestCloudJSONFacetSKG, TestDFISimilarityFactory, TestLMDirichletSimilarityFactory, TestNonDefinedSimilarityFactory, TestExactSharedStatsCache, JWTAuthPluginTest, NoCacheHeaderTest, ResponseHeaderTest, SolrRequestParserTest, TestRequestRateLimiter] [junit4] Completed [803/864 (1!)] on J1 in 6.79s, 2 tests, 2 failures <<< FAILURES! [...truncated 52124 lines...] [repro] Jenkins log URL: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Windows/9210/consoleText [repro] Revision: 35771c3cfe955c8631755b52cbb5de480285ded9 [repro] Ant options: "-Dargs=-XX:+UseCompressedOops -XX:+UseG1GC" [repro] JUnit rest result XML files will be moved to: ./repro-reports [repro] ant clean [...truncated 6 lines...] [repro] Test suites by module: [repro] solr\core [repro] TestRequestRateLimiter [repro] ant compile-test [...truncated 2468 lines...] [repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5 -Dtests.class="*.TestRequestRateLimiter" -Dtests.showOutput=onerror "-Dargs=-XX:+UseCompressedOops -XX:+UseG1GC" -Dtests.seed=8724F5986D09D30C -Dtests.slow=true -Dtests.locale=en-ER -Dtests.timezone=Asia/Baku -Dtests.asserts=true -Dtests.file.encoding=US-ASCII [...truncated 87 lines...] [repro] Failures w/original seeds: [repro] 0/5 failed: org.apache.solr.servlet.TestRequestRateLimiter [repro] Exiting with code 0 [...truncated 84 lines...]
--------------------------------------------------------------------- To unsubscribe, e-mail: builds-unsubscr...@lucene.apache.org For additional commands, e-mail: builds-h...@lucene.apache.org