You are viewing a plain text version of this content. The canonical link for it is here.
Posted to builds@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2020/05/01 18:11:40 UTC
[JENKINS-Experimental-GC] Lucene-Solr-8.x-MacOSX (64bit/jdk-14) -
Build # 928 - Still Unstable!
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-8.x-MacOSX/928/
Java: 64bit/jdk-14 -XX:-UseCompressedOops -XX:+UnlockExperimentalVMOptions -XX:+UseZGC
2 tests failed.
FAILED: org.apache.solr.cloud.DeleteReplicaTest.deleteReplicaAndVerifyDirectoryCleanup
Error Message:
No registered leader was found after waiting for 4000ms , collection: deletereplica_test slice: shard1 saw state=DocCollection(deletereplica_test//collections/deletereplica_test/state.json/6)={ "pullReplicas":"0", "replicationFactor":"2", "shards":{"shard1":{ "range":"80000000-7fffffff", "state":"active", "replicas":{"core_node3":{ "core":"deletereplica_test_shard1_replica_n1", "base_url":"http://127.0.0.1:57272/solr", "node_name":"127.0.0.1:57272_solr", "state":"active", "type":"NRT", "force_set_state":"false"}}}}, "router":{"name":"compositeId"}, "maxShardsPerNode":"1", "autoAddReplicas":"false", "nrtReplicas":"2", "tlogReplicas":"0"} with live_nodes=[127.0.0.1:57273_solr, 127.0.0.1:57269_solr, 127.0.0.1:57270_solr, 127.0.0.1:57272_solr]
Stack Trace:
org.apache.solr.common.SolrException: No registered leader was found after waiting for 4000ms , collection: deletereplica_test slice: shard1 saw state=DocCollection(deletereplica_test//collections/deletereplica_test/state.json/6)={
"pullReplicas":"0",
"replicationFactor":"2",
"shards":{"shard1":{
"range":"80000000-7fffffff",
"state":"active",
"replicas":{"core_node3":{
"core":"deletereplica_test_shard1_replica_n1",
"base_url":"http://127.0.0.1:57272/solr",
"node_name":"127.0.0.1:57272_solr",
"state":"active",
"type":"NRT",
"force_set_state":"false"}}}},
"router":{"name":"compositeId"},
"maxShardsPerNode":"1",
"autoAddReplicas":"false",
"nrtReplicas":"2",
"tlogReplicas":"0"} with live_nodes=[127.0.0.1:57273_solr, 127.0.0.1:57269_solr, 127.0.0.1:57270_solr, 127.0.0.1:57272_solr]
at __randomizedtesting.SeedInfo.seed([FFC32FA5C547C1A:7F1CB640D81BD511]:0)
at org.apache.solr.common.cloud.ZkStateReader.getLeaderRetry(ZkStateReader.java:978)
at org.apache.solr.common.cloud.ZkStateReader.getLeaderRetry(ZkStateReader.java:955)
at org.apache.solr.cloud.DeleteReplicaTest.deleteReplicaAndVerifyDirectoryCleanup(DeleteReplicaTest.java:164)
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:564)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.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:368)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.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:368)
at java.base/java.lang.Thread.run(Thread.java:832)
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.TestSizeLimitedDistributedMap
Error Message:
1 thread leaked from SUITE scope at org.apache.solr.cloud.TestSizeLimitedDistributedMap: 1) Thread[id=23914, name=SessionTracker, state=TIMED_WAITING, group=TGRP-TestSizeLimitedDistributedMap] at java.base@14/java.lang.Thread.sleep(Native Method) at app//org.apache.zookeeper.server.SessionTrackerImpl.run(SessionTrackerImpl.java:151)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE scope at org.apache.solr.cloud.TestSizeLimitedDistributedMap:
1) Thread[id=23914, name=SessionTracker, state=TIMED_WAITING, group=TGRP-TestSizeLimitedDistributedMap]
at java.base@14/java.lang.Thread.sleep(Native Method)
at app//org.apache.zookeeper.server.SessionTrackerImpl.run(SessionTrackerImpl.java:151)
at __randomizedtesting.SeedInfo.seed([FFC32FA5C547C1A]:0)
Build Log:
[...truncated 15003 lines...]
[junit4] Suite: org.apache.solr.cloud.DeleteReplicaTest
[junit4] 2> 1438268 INFO (SUITE-DeleteReplicaTest-seed#[FFC32FA5C547C1A]-worker) [ ] o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to test-framework derived value of '/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/server/solr/configsets/_default/conf'
[junit4] 2> 1438269 INFO (SUITE-DeleteReplicaTest-seed#[FFC32FA5C547C1A]-worker) [ ] o.a.s.SolrTestCaseJ4 Created dataDir: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J4/temp/solr.cloud.DeleteReplicaTest_FFC32FA5C547C1A-001/data-dir-151-001
[junit4] 2> 1438269 WARN (SUITE-DeleteReplicaTest-seed#[FFC32FA5C547C1A]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=4 numCloses=4
[junit4] 2> 1438269 INFO (SUITE-DeleteReplicaTest-seed#[FFC32FA5C547C1A]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 1438270 INFO (SUITE-DeleteReplicaTest-seed#[FFC32FA5C547C1A]-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) w/ MAC_OS_X supressed clientAuth
[junit4] 2> 1438270 INFO (SUITE-DeleteReplicaTest-seed#[FFC32FA5C547C1A]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 1438301 INFO (TEST-DeleteReplicaTest.deleteReplicaOnIndexing-seed#[FFC32FA5C547C1A]) [ ] o.a.s.SolrTestCaseJ4 ###Starting deleteReplicaOnIndexing
[junit4] 2> 1438302 INFO (TEST-DeleteReplicaTest.deleteReplicaOnIndexing-seed#[FFC32FA5C547C1A]) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J4/temp/solr.cloud.DeleteReplicaTest_FFC32FA5C547C1A-001/tempDir-001
[junit4] 2> 1438302 INFO (TEST-DeleteReplicaTest.deleteReplicaOnIndexing-seed#[FFC32FA5C547C1A]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1438304 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer client port: 0.0.0.0/0.0.0.0:0
[junit4] 2> 1438304 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 1438405 INFO (TEST-DeleteReplicaTest.deleteReplicaOnIndexing-seed#[FFC32FA5C547C1A]) [ ] o.a.s.c.ZkTestServer start zk server on port: 56542
[junit4] 2> 1438406 INFO (TEST-DeleteReplicaTest.deleteReplicaOnIndexing-seed#[FFC32FA5C547C1A]) [ ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:56542
[junit4] 2> 1438406 INFO (TEST-DeleteReplicaTest.deleteReplicaOnIndexing-seed#[FFC32FA5C547C1A]) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:56542
[junit4] 2> 1438406 INFO (TEST-DeleteReplicaTest.deleteReplicaOnIndexing-seed#[FFC32FA5C547C1A]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 56542
[junit4] 2> 1438409 INFO (TEST-DeleteReplicaTest.deleteReplicaOnIndexing-seed#[FFC32FA5C547C1A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1438423 INFO (zkConnectionManagerCallback-9709-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1438423 INFO (TEST-DeleteReplicaTest.deleteReplicaOnIndexing-seed#[FFC32FA5C547C1A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1438428 INFO (TEST-DeleteReplicaTest.deleteReplicaOnIndexing-seed#[FFC32FA5C547C1A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1438432 INFO (zkConnectionManagerCallback-9711-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1438433 INFO (TEST-DeleteReplicaTest.deleteReplicaOnIndexing-seed#[FFC32FA5C547C1A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1438434 INFO (TEST-DeleteReplicaTest.deleteReplicaOnIndexing-seed#[FFC32FA5C547C1A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1438442 INFO (zkConnectionManagerCallback-9713-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1438442 INFO (TEST-DeleteReplicaTest.deleteReplicaOnIndexing-seed#[FFC32FA5C547C1A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1438556 WARN (jetty-launcher-9714-thread-2) [ ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23
[junit4] 2> 1438556 WARN (jetty-launcher-9714-thread-1) [ ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23
[junit4] 2> 1438556 WARN (jetty-launcher-9714-thread-3) [ ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23
[junit4] 2> 1438556 INFO (jetty-launcher-9714-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 1438556 INFO (jetty-launcher-9714-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 1438556 INFO (jetty-launcher-9714-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 1438556 INFO (jetty-launcher-9714-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 1438556 INFO (jetty-launcher-9714-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 1438556 INFO (jetty-launcher-9714-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 1438556 INFO (jetty-launcher-9714-thread-2) [ ] o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git: a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 14+36
[junit4] 2> 1438556 INFO (jetty-launcher-9714-thread-3) [ ] o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git: a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 14+36
[junit4] 2> 1438556 INFO (jetty-launcher-9714-thread-1) [ ] o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git: a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 14+36
[junit4] 2> 1438559 WARN (jetty-launcher-9714-thread-4) [ ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23
[junit4] 2> 1438560 INFO (jetty-launcher-9714-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 1438560 INFO (jetty-launcher-9714-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 1438560 INFO (jetty-launcher-9714-thread-4) [ ] o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git: a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 14+36
[junit4] 2> 1438575 INFO (jetty-launcher-9714-thread-3) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1438576 INFO (jetty-launcher-9714-thread-3) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1438576 INFO (jetty-launcher-9714-thread-3) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 1438589 INFO (jetty-launcher-9714-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1438589 INFO (jetty-launcher-9714-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1438590 INFO (jetty-launcher-9714-thread-1) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 1438593 INFO (jetty-launcher-9714-thread-2) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1438593 INFO (jetty-launcher-9714-thread-2) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1438593 INFO (jetty-launcher-9714-thread-2) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 1438594 INFO (jetty-launcher-9714-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@53b3b9d5{/solr,null,AVAILABLE}
[junit4] 2> 1438594 INFO (jetty-launcher-9714-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@209de3a9{/solr,null,AVAILABLE}
[junit4] 2> 1438595 INFO (jetty-launcher-9714-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@3ab55520{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:56548}
[junit4] 2> 1438596 INFO (jetty-launcher-9714-thread-1) [ ] o.e.j.s.Server Started @1438774ms
[junit4] 2> 1438596 INFO (jetty-launcher-9714-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=56548}
[junit4] 2> 1438596 INFO (jetty-launcher-9714-thread-4) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1438596 INFO (jetty-launcher-9714-thread-4) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1438596 INFO (jetty-launcher-9714-thread-4) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 1438596 ERROR (jetty-launcher-9714-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1438596 INFO (jetty-launcher-9714-thread-1) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1438596 INFO (jetty-launcher-9714-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.6.0
[junit4] 2> 1438596 INFO (jetty-launcher-9714-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1438596 INFO (jetty-launcher-9714-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr
[junit4] 2> 1438596 INFO (jetty-launcher-9714-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-05-01T17:35:32.888789Z
[junit4] 2> 1438597 INFO (jetty-launcher-9714-thread-3) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@326923e8{/solr,null,AVAILABLE}
[junit4] 2> 1438598 INFO (jetty-launcher-9714-thread-4) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@39aa9602{/solr,null,AVAILABLE}
[junit4] 2> 1438598 INFO (jetty-launcher-9714-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1438598 INFO (jetty-launcher-9714-thread-3) [ ] o.e.j.s.AbstractConnector Started ServerConnector@305181e2{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:56549}
[junit4] 2> 1438598 INFO (jetty-launcher-9714-thread-3) [ ] o.e.j.s.Server Started @1438777ms
[junit4] 2> 1438598 INFO (jetty-launcher-9714-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=56549}
[junit4] 2> 1438598 ERROR (jetty-launcher-9714-thread-3) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1438598 INFO (jetty-launcher-9714-thread-3) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1438598 INFO (jetty-launcher-9714-thread-3) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.6.0
[junit4] 2> 1438599 INFO (jetty-launcher-9714-thread-3) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1438599 INFO (jetty-launcher-9714-thread-3) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr
[junit4] 2> 1438599 INFO (jetty-launcher-9714-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@577d7521{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:56547}
[junit4] 2> 1438599 INFO (jetty-launcher-9714-thread-2) [ ] o.e.j.s.Server Started @1438777ms
[junit4] 2> 1438599 INFO (jetty-launcher-9714-thread-3) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-05-01T17:35:32.891032Z
[junit4] 2> 1438599 INFO (jetty-launcher-9714-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=56547}
[junit4] 2> 1438599 ERROR (jetty-launcher-9714-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1438599 INFO (jetty-launcher-9714-thread-2) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1438599 INFO (jetty-launcher-9714-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.6.0
[junit4] 2> 1438599 INFO (jetty-launcher-9714-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1438599 INFO (jetty-launcher-9714-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr
[junit4] 2> 1438599 INFO (jetty-launcher-9714-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-05-01T17:35:32.891418Z
[junit4] 2> 1438600 INFO (jetty-launcher-9714-thread-3) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1438601 INFO (jetty-launcher-9714-thread-4) [ ] o.e.j.s.AbstractConnector Started ServerConnector@13612f7f{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:56550}
[junit4] 2> 1438601 INFO (jetty-launcher-9714-thread-4) [ ] o.e.j.s.Server Started @1438780ms
[junit4] 2> 1438601 INFO (jetty-launcher-9714-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=56550}
[junit4] 2> 1438601 ERROR (jetty-launcher-9714-thread-4) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1438601 INFO (jetty-launcher-9714-thread-4) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1438601 INFO (jetty-launcher-9714-thread-4) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.6.0
[junit4] 2> 1438601 INFO (jetty-launcher-9714-thread-4) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1438601 INFO (jetty-launcher-9714-thread-4) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr
[junit4] 2> 1438601 INFO (jetty-launcher-9714-thread-4) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-05-01T17:35:32.893970Z
[junit4] 2> 1438611 INFO (jetty-launcher-9714-thread-2) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1438616 INFO (zkConnectionManagerCallback-9716-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1438616 INFO (jetty-launcher-9714-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1438617 INFO (jetty-launcher-9714-thread-4) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1438617 INFO (zkConnectionManagerCallback-9718-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1438618 INFO (jetty-launcher-9714-thread-3) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1438625 INFO (zkConnectionManagerCallback-9720-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1438626 INFO (jetty-launcher-9714-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1438627 INFO (jetty-launcher-9714-thread-2) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1438632 INFO (jetty-launcher-9714-thread-3) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1438636 INFO (zkConnectionManagerCallback-9722-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1438637 INFO (jetty-launcher-9714-thread-4) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1438653 INFO (jetty-launcher-9714-thread-4) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1438653 INFO (jetty-launcher-9714-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1438955 INFO (jetty-launcher-9714-thread-3) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 1438955 INFO (jetty-launcher-9714-thread-4) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 1438958 WARN (jetty-launcher-9714-thread-3) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@1c3f7cb8[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1438958 WARN (jetty-launcher-9714-thread-3) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@1c3f7cb8[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1438972 WARN (jetty-launcher-9714-thread-3) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@3c0930bb[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1438972 WARN (jetty-launcher-9714-thread-4) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@6ce6159[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1438972 WARN (jetty-launcher-9714-thread-3) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@3c0930bb[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1438973 WARN (jetty-launcher-9714-thread-4) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@6ce6159[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1438974 INFO (jetty-launcher-9714-thread-3) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:56542/solr
[junit4] 2> 1438985 WARN (jetty-launcher-9714-thread-4) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@3516cc1d[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1438985 WARN (jetty-launcher-9714-thread-4) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@3516cc1d[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1438987 INFO (jetty-launcher-9714-thread-3) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1438987 INFO (jetty-launcher-9714-thread-4) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:56542/solr
[junit4] 2> 1438988 INFO (zkConnectionManagerCallback-9746-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1438988 INFO (jetty-launcher-9714-thread-3) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1438990 INFO (jetty-launcher-9714-thread-4) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1438999 INFO (zkConnectionManagerCallback-9750-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1439000 INFO (jetty-launcher-9714-thread-4) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1439005 INFO (jetty-launcher-9714-thread-2) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 1439013 WARN (jetty-launcher-9714-thread-2) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@622f702f[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1439013 WARN (jetty-launcher-9714-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@622f702f[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1439079 WARN (jetty-launcher-9714-thread-2) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@42501089[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1439079 WARN (jetty-launcher-9714-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@42501089[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1439082 INFO (jetty-launcher-9714-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:56542/solr
[junit4] 2> 1439094 INFO (jetty-launcher-9714-thread-2) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1439095 INFO (zkConnectionManagerCallback-9758-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1439098 INFO (jetty-launcher-9714-thread-2) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1439107 INFO (jetty-launcher-9714-thread-3) [n:127.0.0.1:56549_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1439110 INFO (zkConnectionManagerCallback-9760-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1439126 INFO (jetty-launcher-9714-thread-3) [n:127.0.0.1:56549_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1439224 INFO (jetty-launcher-9714-thread-1) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 1439238 INFO (jetty-launcher-9714-thread-2) [n:127.0.0.1:56547_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1439239 INFO (jetty-launcher-9714-thread-4) [n:127.0.0.1:56550_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1439240 INFO (zkConnectionManagerCallback-9765-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1439240 INFO (jetty-launcher-9714-thread-2) [n:127.0.0.1:56547_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1439241 INFO (zkConnectionManagerCallback-9763-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1439241 INFO (jetty-launcher-9714-thread-4) [n:127.0.0.1:56550_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1439246 WARN (jetty-launcher-9714-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@7195354f[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1439246 WARN (jetty-launcher-9714-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@7195354f[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1439276 WARN (jetty-launcher-9714-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@1444602[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1439276 WARN (jetty-launcher-9714-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@1444602[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1439282 INFO (jetty-launcher-9714-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:56542/solr
[junit4] 2> 1439285 INFO (jetty-launcher-9714-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1439296 INFO (zkConnectionManagerCallback-9778-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1439296 INFO (jetty-launcher-9714-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1439432 INFO (jetty-launcher-9714-thread-1) [n:127.0.0.1:56548_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1439448 INFO (zkConnectionManagerCallback-9780-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1439467 INFO (jetty-launcher-9714-thread-1) [n:127.0.0.1:56548_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1439582 INFO (jetty-launcher-9714-thread-1) [n:127.0.0.1:56548_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:56548_solr
[junit4] 2> 1439586 INFO (jetty-launcher-9714-thread-1) [n:127.0.0.1:56548_solr ] o.a.s.c.Overseer Overseer (id=72143468320456718-127.0.0.1:56548_solr-n_0000000000) starting
[junit4] 2> 1439623 INFO (OverseerStateUpdate-72143468320456718-127.0.0.1:56548_solr-n_0000000000) [n:127.0.0.1:56548_solr ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:56548_solr
[junit4] 2> 1439627 INFO (jetty-launcher-9714-thread-1) [n:127.0.0.1:56548_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:56548_solr
[junit4] 2> 1439640 INFO (zkCallback-9779-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1439652 INFO (jetty-launcher-9714-thread-1) [n:127.0.0.1:56548_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 1439652 WARN (jetty-launcher-9714-thread-1) [n:127.0.0.1:56548_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> 1439713 INFO (jetty-launcher-9714-thread-1) [n:127.0.0.1:56548_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 1439783 INFO (jetty-launcher-9714-thread-1) [n:127.0.0.1:56548_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_56548.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7cfe7d36
[junit4] 2> 1439811 INFO (jetty-launcher-9714-thread-1) [n:127.0.0.1:56548_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_56548.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7cfe7d36
[junit4] 2> 1439812 INFO (jetty-launcher-9714-thread-1) [n:127.0.0.1:56548_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_56548.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7cfe7d36
[junit4] 2> 1439816 INFO (jetty-launcher-9714-thread-1) [n:127.0.0.1:56548_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J4/temp/solr.cloud.DeleteReplicaTest_FFC32FA5C547C1A-001/tempDir-001/node1/.
[junit4] 2> 1440116 INFO (jetty-launcher-9714-thread-2) [n:127.0.0.1:56547_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1440157 INFO (jetty-launcher-9714-thread-2) [n:127.0.0.1:56547_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:56547_solr as DOWN
[junit4] 2> 1440166 INFO (jetty-launcher-9714-thread-2) [n:127.0.0.1:56547_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 1440166 INFO (jetty-launcher-9714-thread-2) [n:127.0.0.1:56547_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:56547_solr
[junit4] 2> 1440187 INFO (zkCallback-9779-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1440196 INFO (zkCallback-9764-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1440219 INFO (jetty-launcher-9714-thread-2) [n:127.0.0.1:56547_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 1440220 WARN (jetty-launcher-9714-thread-2) [n:127.0.0.1:56547_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> 1440243 INFO (jetty-launcher-9714-thread-2) [n:127.0.0.1:56547_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 1440284 INFO (jetty-launcher-9714-thread-2) [n:127.0.0.1:56547_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_56547.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7cfe7d36
[junit4] 2> 1440319 INFO (jetty-launcher-9714-thread-2) [n:127.0.0.1:56547_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_56547.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7cfe7d36
[junit4] 2> 1440319 INFO (jetty-launcher-9714-thread-2) [n:127.0.0.1:56547_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_56547.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7cfe7d36
[junit4] 2> 1440322 INFO (jetty-launcher-9714-thread-2) [n:127.0.0.1:56547_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J4/temp/solr.cloud.DeleteReplicaTest_FFC32FA5C547C1A-001/tempDir-001/node2/.
[junit4] 2> 1440460 INFO (jetty-launcher-9714-thread-3) [n:127.0.0.1:56549_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 1440461 INFO (jetty-launcher-9714-thread-4) [n:127.0.0.1:56550_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 1440498 INFO (jetty-launcher-9714-thread-4) [n:127.0.0.1:56550_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:56550_solr as DOWN
[junit4] 2> 1440498 INFO (jetty-launcher-9714-thread-3) [n:127.0.0.1:56549_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:56549_solr as DOWN
[junit4] 2> 1440501 INFO (jetty-launcher-9714-thread-4) [n:127.0.0.1:56550_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 1440501 INFO (jetty-launcher-9714-thread-4) [n:127.0.0.1:56550_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:56550_solr
[junit4] 2> 1440502 INFO (jetty-launcher-9714-thread-3) [n:127.0.0.1:56549_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 1440502 INFO (jetty-launcher-9714-thread-3) [n:127.0.0.1:56549_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:56549_solr
[junit4] 2> 1440508 INFO (zkCallback-9764-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (4)
[junit4] 2> 1440508 INFO (zkCallback-9779-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (4)
[junit4] 2> 1440508 INFO (zkCallback-9759-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (4)
[junit4] 2> 1440509 INFO (zkCallback-9762-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (4)
[junit4] 2> 1440514 INFO (jetty-launcher-9714-thread-4) [n:127.0.0.1:56550_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 1440514 INFO (jetty-launcher-9714-thread-3) [n:127.0.0.1:56549_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 1440515 WARN (jetty-launcher-9714-thread-4) [n:127.0.0.1:56550_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> 1440515 WARN (jetty-launcher-9714-thread-3) [n:127.0.0.1:56549_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> 1440533 INFO (jetty-launcher-9714-thread-3) [n:127.0.0.1:56549_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 1440534 INFO (jetty-launcher-9714-thread-4) [n:127.0.0.1:56550_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 1440576 INFO (jetty-launcher-9714-thread-4) [n:127.0.0.1:56550_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_56550.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7cfe7d36
[junit4] 2> 1440618 INFO (jetty-launcher-9714-thread-3) [n:127.0.0.1:56549_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_56549.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7cfe7d36
[junit4] 2> 1440633 INFO (jetty-launcher-9714-thread-4) [n:127.0.0.1:56550_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_56550.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7cfe7d36
[junit4] 2> 1440633 INFO (jetty-launcher-9714-thread-4) [n:127.0.0.1:56550_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_56550.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7cfe7d36
[junit4] 2> 1440635 INFO (jetty-launcher-9714-thread-4) [n:127.0.0.1:56550_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J4/temp/solr.cloud.DeleteReplicaTest_FFC32FA5C547C1A-001/tempDir-001/node4/.
[junit4] 2> 1440658 INFO (jetty-launcher-9714-thread-3) [n:127.0.0.1:56549_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_56549.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7cfe7d36
[junit4] 2> 1440658 INFO (jetty-launcher-9714-thread-3) [n:127.0.0.1:56549_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_56549.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7cfe7d36
[junit4] 2> 1440660 INFO (jetty-launcher-9714-thread-3) [n:127.0.0.1:56549_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J4/temp/solr.cloud.DeleteReplicaTest_FFC32FA5C547C1A-001/tempDir-001/node3/.
[junit4] 2> 1440692 INFO (TEST-DeleteReplicaTest.deleteReplicaOnIndexing-seed#[FFC32FA5C547C1A]) [ ] o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=4
[junit4] 2> 1440693 INFO (TEST-DeleteReplicaTest.deleteReplicaOnIndexing-seed#[FFC32FA5C547C1A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1440702 INFO (zkConnectionManagerCallback-9815-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1440702 INFO (TEST-DeleteReplicaTest.deleteReplicaOnIndexing-seed#[FFC32FA5C547C1A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1440735 INFO (TEST-DeleteReplicaTest.deleteReplicaOnIndexing-seed#[FFC32FA5C547C1A]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 1440744 INFO (TEST-DeleteReplicaTest.deleteReplicaOnIndexing-seed#[FFC32FA5C547C1A]) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:56542/solr ready
[junit4] 2> 1440771 INFO (qtp497472187-14878) [n:127.0.0.1:56550_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params collection.configName=conf&name=deleteReplicaOnIndexing&nrtReplicas=2&action=CREATE&numShards=1&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 1440807 INFO (OverseerThreadFactory-9787-thread-1-processing-n:127.0.0.1:56548_solr) [n:127.0.0.1:56548_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection deleteReplicaOnIndexing
[junit4] 2> 1440962 INFO (qtp497472187-14888) [n:127.0.0.1:56550_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=0
[junit4] 2> 1440966 INFO (qtp879930846-14860) [n:127.0.0.1:56548_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=0
[junit4] 2> 1440968 INFO (qtp1505394790-14885) [n:127.0.0.1:56547_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=0
[junit4] 2> 1440973 INFO (qtp1050044480-14871) [n:127.0.0.1:56549_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=0
[junit4] 2> 1440976 INFO (qtp497472187-14873) [n:127.0.0.1:56550_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=0
[junit4] 2> 1440978 INFO (qtp879930846-14875) [n:127.0.0.1:56548_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=0
[junit4] 2> 1440980 INFO (qtp1505394790-14886) [n:127.0.0.1:56547_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=0
[junit4] 2> 1440981 INFO (qtp1050044480-14874) [n:127.0.0.1:56549_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=0
[junit4] 2> 1441009 INFO (OverseerStateUpdate-72143468320456718-127.0.0.1:56548_solr-n_0000000000) [n:127.0.0.1:56548_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"deleteReplicaOnIndexing",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"deleteReplicaOnIndexing_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:56549/solr",
[junit4] 2> "node_name":"127.0.0.1:56549_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1441019 INFO (OverseerStateUpdate-72143468320456718-127.0.0.1:56548_solr-n_0000000000) [n:127.0.0.1:56548_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"deleteReplicaOnIndexing",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"deleteReplicaOnIndexing_shard1_replica_n2",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:56547/solr",
[junit4] 2> "node_name":"127.0.0.1:56547_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1441229 INFO (qtp1050044480-14877) [n:127.0.0.1:56549_solr x:deleteReplicaOnIndexing_shard1_replica_n1 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=deleteReplicaOnIndexing_shard1_replica_n1&action=CREATE&numShards=1&collection=deleteReplicaOnIndexing&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1441229 INFO (qtp1505394790-14884) [n:127.0.0.1:56547_solr x:deleteReplicaOnIndexing_shard1_replica_n2 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf&newCollection=true&name=deleteReplicaOnIndexing_shard1_replica_n2&action=CREATE&numShards=1&collection=deleteReplicaOnIndexing&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1441280 INFO (qtp1505394790-14884) [n:127.0.0.1:56547_solr c:deleteReplicaOnIndexing s:shard1 r:core_node4 x:deleteReplicaOnIndexing_shard1_replica_n2 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.6.0
[junit4] 2> 1441285 INFO (qtp1050044480-14877) [n:127.0.0.1:56549_solr c:deleteReplicaOnIndexing s:shard1 r:core_node3 x:deleteReplicaOnIndexing_shard1_replica_n1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.6.0
[junit4] 2> 1441298 INFO (qtp1505394790-14884) [n:127.0.0.1:56547_solr c:deleteReplicaOnIndexing s:shard1 r:core_node4 x:deleteReplicaOnIndexing_shard1_replica_n2 ] o.a.s.s.IndexSchema Schema name=minimal
[junit4] 2> 1441300 INFO (qtp1505394790-14884) [n:127.0.0.1:56547_solr c:deleteReplicaOnIndexing s:shard1 r:core_node4 x:deleteReplicaOnIndexing_shard1_replica_n2 ] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 1441300 INFO (qtp1505394790-14884) [n:127.0.0.1:56547_solr c:deleteReplicaOnIndexing s:shard1 r:core_node4 x:deleteReplicaOnIndexing_shard1_replica_n2 ] o.a.s.c.CoreContainer Creating SolrCore 'deleteReplicaOnIndexing_shard1_replica_n2' using configuration from configset conf, trusted=true
[junit4] 2> 1441301 INFO (qtp1505394790-14884) [n:127.0.0.1:56547_solr c:deleteReplicaOnIndexing s:shard1 r:core_node4 x:deleteReplicaOnIndexing_shard1_replica_n2 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_56547.solr.core.deleteReplicaOnIndexing.shard1.replica_n2' (registry 'solr.core.deleteReplicaOnIndexing.shard1.replica_n2') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7cfe7d36
[junit4] 2> 1441303 INFO (qtp1505394790-14884) [n:127.0.0.1:56547_solr c:deleteReplicaOnIndexing s:shard1 r:core_node4 x:deleteReplicaOnIndexing_shard1_replica_n2 ] o.a.s.c.SolrCore [[deleteReplicaOnIndexing_shard1_replica_n2] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J4/temp/solr.cloud.DeleteReplicaTest_FFC32FA5C547C1A-001/tempDir-001/node2/./deleteReplicaOnIndexing_shard1_replica_n2], dataDir=[/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J4/temp/solr.cloud.DeleteReplicaTest_FFC32FA5C547C1A-001/tempDir-001/node2/./deleteReplicaOnIndexing_shard1_replica_n2/data/]
[junit4] 2> 1441316 INFO (qtp1050044480-14877) [n:127.0.0.1:56549_solr c:deleteReplicaOnIndexing s:shard1 r:core_node3 x:deleteReplicaOnIndexing_shard1_replica_n1 ] o.a.s.s.IndexSchema Schema name=minimal
[junit4] 2> 1441318 INFO (qtp1050044480-14877) [n:127.0.0.1:56549_solr c:deleteReplicaOnIndexing s:shard1 r:core_node3 x:deleteReplicaOnIndexing_shard1_replica_n1 ] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 1441318 INFO (qtp1050044480-14877) [n:127.0.0.1:56549_solr c:deleteReplicaOnIndexing s:shard1 r:core_node3 x:deleteReplicaOnIndexing_shard1_replica_n1 ] o.a.s.c.CoreContainer Creating SolrCore 'deleteReplicaOnIndexing_shard1_replica_n1' using configuration from configset conf, trusted=true
[junit4] 2> 1441319 INFO (qtp1050044480-14877) [n:127.0.0.1:56549_solr c:deleteReplicaOnIndexing s:shard1 r:core_node3 x:deleteReplicaOnIndexing_shard1_replica_n1 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_56549.solr.core.deleteReplicaOnIndexing.shard1.replica_n1' (registry 'solr.core.deleteReplicaOnIndexing.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7cfe7d36
[junit4] 2> 1441319 INFO (qtp1050044480-14877) [n:127.0.0.1:56549_solr c:deleteReplicaOnIndexing s:shard1 r:core_node3 x:deleteReplicaOnIndexing_shard1_replica_n1 ] o.a.s.c.SolrCore [[deleteReplicaOnIndexing_shard1_replica_n1] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J4/temp/solr.cloud.DeleteReplicaTest_FFC32FA5C547C1A-001/tempDir-001/node3/./deleteReplicaOnIndexing_shard1_replica_n1], dataDir=[/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J4/temp/solr.cloud.DeleteReplicaTest_FFC32FA5C547C1A-001/tempDir-001/node3/./deleteReplicaOnIndexing_shard1_replica_n1/data/]
[junit4] 2> 1441438 INFO (qtp1505394790-14884) [n:127.0.0.1:56547_solr c:deleteReplicaOnIndexing s:shard1 r:core_node4 x:deleteReplicaOnIndexing_shard1_replica_n2 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1441442 INFO (qtp1505394790-14884) [n:127.0.0.1:56547_solr c:deleteReplicaOnIndexing s:shard1 r:core_node4 x:deleteReplicaOnIndexing_shard1_replica_n2 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1441465 INFO (qtp1505394790-14884) [n:127.0.0.1:56547_solr c:deleteReplicaOnIndexing s:shard1 r:core_node4 x:deleteReplicaOnIndexing_shard1_replica_n2 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1441465 INFO (qtp1505394790-14884) [n:127.0.0.1:56547_solr c:deleteReplicaOnIndexing s:shard1 r:core_node4 x:deleteReplicaOnIndexing_shard1_replica_n2 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1441475 INFO (qtp1505394790-14884) [n:127.0.0.1:56547_solr c:deleteReplicaOnIndexing s:shard1 r:core_node4 x:deleteReplicaOnIndexing_shard1_replica_n2 ] o.a.s.s.SolrIndexSearcher Opening [Searcher@69d58d48[deleteReplicaOnIndexing_shard1_replica_n2] main]
[junit4] 2> 1441492 INFO (qtp1505394790-14884) [n:127.0.0.1:56547_solr c:deleteReplicaOnIndexing s:shard1 r:core_node4 x:deleteReplicaOnIndexing_shard1_replica_n2 ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf
[junit4] 2> 1441500 INFO (qtp1505394790-14884) [n:127.0.0.1:56547_solr c:deleteReplicaOnIndexing s:shard1 r:core_node4 x:deleteReplicaOnIndexing_shard1_replica_n2 ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 1441501 INFO (qtp1505394790-14884) [n:127.0.0.1:56547_solr c:deleteReplicaOnIndexing s:shard1 r:core_node4 x:deleteReplicaOnIndexing_shard1_replica_n2 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 1441501 INFO (qtp1505394790-14884) [n:127.0.0.1:56547_solr c:deleteReplicaOnIndexing s:shard1 r:core_node4 x:deleteReplicaOnIndexing_shard1_replica_n2 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1665510445723680768
[junit4] 2> 1441525 INFO (searcherExecutor-9817-thread-1-processing-n:127.0.0.1:56547_solr x:deleteReplicaOnIndexing_shard1_replica_n2 c:deleteReplicaOnIndexing s:shard1 r:core_node4) [n:127.0.0.1:56547_solr c:deleteReplicaOnIndexing s:shard1 r:core_node4 x:deleteReplicaOnIndexing_shard1_replica_n2 ] o.a.s.c.SolrCore [deleteReplicaOnIndexing_shard1_replica_n2] Registered new searcher Searcher@69d58d48[deleteReplicaOnIndexing_shard1_replica_n2] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1441526 INFO (qtp1050044480-14877) [n:127.0.0.1:56549_solr c:deleteReplicaOnIndexing s:shard1 r:core_node3 x:deleteReplicaOnIndexing_shard1_replica_n1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1441527 INFO (qtp1050044480-14877) [n:127.0.0.1:56549_solr c:deleteReplicaOnIndexing s:shard1 r:core_node3 x:deleteReplicaOnIndexing_shard1_replica_n1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1441535 INFO (qtp1050044480-14877) [n:127.0.0.1:56549_solr c:deleteReplicaOnIndexing s:shard1 r:core_node3 x:deleteReplicaOnIndexing_shard1_replica_n1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1441535 INFO (qtp1050044480-14877) [n:127.0.0.1:56549_solr c:deleteReplicaOnIndexing s:shard1 r:core_node3 x:deleteReplicaOnIndexing_shard1_replica_n1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1441538 INFO (qtp1050044480-14877) [n:127.0.0.1:56549_solr c:deleteReplicaOnIndexing s:shard1 r:core_node3 x:deleteReplicaOnIndexing_shard1_replica_n1 ] o.a.s.s.SolrIndexSearcher Opening [Searcher@45942069[deleteReplicaOnIndexing_shard1_replica_n1] main]
[junit4] 2> 1441558 INFO (qtp1050044480-14877) [n:127.0.0.1:56549_solr c:deleteReplicaOnIndexing s:shard1 r:core_node3 x:deleteReplicaOnIndexing_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf
[junit4] 2> 1441562 INFO (qtp1050044480-14877) [n:127.0.0.1:56549_solr c:deleteReplicaOnIndexing s:shard1 r:core_node3 x:deleteReplicaOnIndexing_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 1441563 INFO (qtp1050044480-14877) [n:127.0.0.1:56549_solr c:deleteReplicaOnIndexing s:shard1 r:core_node3 x:deleteReplicaOnIndexing_shard1_replica_n1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 1441563 INFO (qtp1050044480-14877) [n:127.0.0.1:56549_solr c:deleteReplicaOnIndexing s:shard1 r:core_node3 x:deleteReplicaOnIndexing_shard1_replica_n1 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1665510445788692480
[junit4] 2> 1441577 INFO (qtp1505394790-14884) [n:127.0.0.1:56547_solr c:deleteReplicaOnIndexing s:shard1 r:core_node4 x:deleteReplicaOnIndexing_shard1_replica_n2 ] o.a.s.c.ZkShardTerms Successful update of terms at /collections/deleteReplicaOnIndexing/terms/shard1 to Terms{values={core_node4=0}, version=0}
[junit4] 2> 1441578 INFO (qtp1505394790-14884) [n:127.0.0.1:56547_solr c:deleteReplicaOnIndexing s:shard1 r:core_node4 x:deleteReplicaOnIndexing_shard1_replica_n2 ] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/deleteReplicaOnIndexing/leaders/shard1
[junit4] 2> 1441593 INFO (searcherExecutor-9819-thread-1-processing-n:127.0.0.1:56549_solr x:deleteReplicaOnIndexing_shard1_replica_n1 c:deleteReplicaOnIndexing s:shard1 r:core_node3) [n:127.0.0.1:56549_solr c:deleteReplicaOnIndexing s:shard1 r:core_node3 x:deleteReplicaOnIndexing_shard1_replica_n1 ] o.a.s.c.SolrCore [deleteReplicaOnIndexing_shard1_replica_n1] Registered new searcher Searcher@45942069[deleteReplicaOnIndexing_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1441649 INFO (qtp1050044480-14877) [n:127.0.0.1:56549_solr c:deleteReplicaOnIndexing s:shard1 r:core_node3 x:deleteReplicaOnIndexing_shard1_replica_n1 ] o.a.s.c.ZkShardTerms Successful update of terms at /collections/deleteReplicaOnIndexing/terms/shard1 to Terms{values={core_node3=0, core_node4=0}, version=1}
[junit4] 2> 1441649 INFO (qtp1050044480-14877) [n:127.0.0.1:56549_solr c:deleteReplicaOnIndexing s:shard1 r:core_node3 x:deleteReplicaOnIndexing_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/deleteReplicaOnIndexing/leaders/shard1
[junit4] 2> 1441660 INFO (qtp1505394790-14884) [n:127.0.0.1:56547_solr c:deleteReplicaOnIndexing s:shard1 r:core_node4 x:deleteReplicaOnIndexing_shard1_replica_n2 ] o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for shard shard1: total=2 found=1 timeoute in=9990ms
[junit4] 2> 1442171 INFO (qtp1505394790-14884) [n:127.0.0.1:56547_solr c:deleteReplicaOnIndexing s:shard1 r:core_node4 x:deleteReplicaOnIndexing_shard1_replica_n2 ] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 1442171 INFO (qtp1505394790-14884) [n:127.0.0.1:56547_solr c:deleteReplicaOnIndexing s:shard1 r:core_node4 x:deleteReplicaOnIndexing_shard1_replica_n2 ] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 1442171 INFO (qtp1505394790-14884) [n:127.0.0.1:56547_solr c:deleteReplicaOnIndexing s:shard1 r:core_node4 x:deleteReplicaOnIndexing_shard1_replica_n2 ] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:56547/solr/deleteReplicaOnIndexing_shard1_replica_n2/
[junit4] 2> 1442173 INFO (qtp1505394790-14884) [n:127.0.0.1:56547_solr c:deleteReplicaOnIndexing s:shard1 r:core_node4 x:deleteReplicaOnIndexing_shard1_replica_n2 ] o.a.s.u.PeerSync PeerSync: core=deleteReplicaOnIndexing_shard1_replica_n2 url=http://127.0.0.1:56547/solr START replicas=[http://127.0.0.1:56549/solr/deleteReplicaOnIndexing_shard1_replica_n1/] nUpdates=100
[junit4] 2> 1442173 INFO (qtp1505394790-14884) [n:127.0.0.1:56547_solr c:deleteReplicaOnIndexing s:shard1 r:core_node4 x:deleteReplicaOnIndexing_shard1_replica_n2 ] o.a.s.u.PeerSync PeerSync: core=deleteReplicaOnIndexing_shard1_replica_n2 url=http://127.0.0.1:56547/solr DONE. We have no versions. sync failed.
[junit4] 2> 1442177 INFO (qtp1050044480-14871) [n:127.0.0.1:56549_solr c:deleteReplicaOnIndexing s:shard1 r:core_node3 x:deleteReplicaOnIndexing_shard1_replica_n1 ] o.a.s.c.S.Request [deleteReplicaOnIndexing_shard1_replica_n1] webapp=/solr path=/get params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1442177 INFO (qtp1505394790-14884) [n:127.0.0.1:56547_solr c:deleteReplicaOnIndexing s:shard1 r:core_node4 x:deleteReplicaOnIndexing_shard1_replica_n2 ] o.a.s.c.SyncStrategy Leader's attempt to sync with shard failed, moving to the next candidate
[junit4] 2> 1442177 INFO (qtp1505394790-14884) [n:127.0.0.1:56547_solr c:deleteReplicaOnIndexing s:shard1 r:core_node4 x:deleteReplicaOnIndexing_shard1_replica_n2 ] o.a.s.c.ShardLeaderElectionContext We failed sync, but we have no versions - we can't sync in that case - we were active before, so become leader anyway
[junit4] 2> 1442178 INFO (qtp1505394790-14884) [n:127.0.0.1:56547_solr c:deleteReplicaOnIndexing s:shard1 r:core_node4 x:deleteReplicaOnIndexing_shard1_replica_n2 ] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/deleteReplicaOnIndexing/leaders/shard1/leader after winning as /collections/deleteReplicaOnIndexing/leader_elect/shard1/election/72143468320456715-core_node4-n_0000000000
[junit4] 2> 1442183 INFO (qtp1505394790-14884) [n:127.0.0.1:56547_solr c:deleteReplicaOnIndexing s:shard1 r:core_node4 x:deleteReplicaOnIndexing_shard1_replica_n2 ] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:56547/solr/deleteReplicaOnIndexing_shard1_replica_n2/ shard1
[junit4] 2> 1442292 INFO (zkCallback-9764-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/deleteReplicaOnIndexing/state.json] for collection [deleteReplicaOnIndexing] has occurred - updating... (live nodes size: [4])
[junit4] 2> 1442302 INFO (qtp1505394790-14884) [n:127.0.0.1:56547_solr c:deleteReplicaOnIndexing s:shard1 r:core_node4 x:deleteReplicaOnIndexing_shard1_replica_n2 ] o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 1442308 INFO (qtp1505394790-14884) [n:127.0.0.1:56547_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf&newCollection=true&name=deleteReplicaOnIndexing_shard1_replica_n2&action=CREATE&numShards=1&collection=deleteReplicaOnIndexing&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=1079
[junit4] 2> 1442413 INFO (zkCallback-9764-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/deleteReplicaOnIndexing/state.json] for collection [deleteReplicaOnIndexing] has occurred - updating... (live nodes size: [4])
[junit4] 2> 1442414 INFO (zkCallback-9764-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/deleteReplicaOnIndexing/state.json] for collection [deleteReplicaOnIndexing] has occurred - updating... (live nodes size: [4])
[junit4] 2> 1442689 INFO (qtp1050044480-14877) [n:127.0.0.1:56549_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=deleteReplicaOnIndexing_shard1_replica_n1&action=CREATE&numShards=1&collection=deleteReplicaOnIndexing&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=1461
[junit4] 2> 1442693 INFO (qtp497472187-14878) [n:127.0.0.1:56550_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> 1442798 INFO (zkCallback-9762-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/deleteReplicaOnIndexing/state.json] for collection [deleteReplicaOnIndexing] has occurred - updating... (live nodes size: [4])
[junit4] 2> 1442798 INFO (zkCallback-9764-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/deleteReplicaOnIndexing/state.json] for collection [deleteReplicaOnIndexing] has occurred - updating... (live nodes size: [4])
[junit4] 2> 1442798 INFO (zkCallback-9759-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/deleteReplicaOnIndexing/state.json] for collection [deleteReplicaOnIndexing] has occurred - updating... (live nodes size: [4])
[junit4] 2> 1442798 INFO (zkCallback-9764-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/deleteReplicaOnIndexing/state.json] for collection [deleteReplicaOnIndexing] has occurred - updating... (live nodes size: [4])
[junit4] 2> 1442799 INFO (zkCallback-9759-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/deleteReplicaOnIndexing/state.json] for collection [deleteReplicaOnIndexing] has occurred - updating... (live nodes size: [4])
[junit4] 2> 1442799 INFO (qtp497472187-14878) [n:127.0.0.1:56550_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={collection.configName=conf&name=deleteReplicaOnIndexing&nrtReplicas=2&action=CREATE&numShards=1&wt=javabin&version=2} status=0 QTime=2028
[junit4] 2> 1442799 INFO (TEST-DeleteReplicaTest.deleteReplicaOnIndexing-seed#[FFC32FA5C547C1A]) [ ] o.a.s.c.SolrCloudTestCase waitForState (deleteReplicaOnIndexing):
[junit4] 2> 1442805 INFO (TEST-DeleteReplicaTest.deleteReplicaOnIndexing-seed#[FFC32FA5C547C1A]) [ ] o.a.s.c.SolrCloudTestCase active replica count: 2 expected replica count: 2
[junit4] 2> 1442806 INFO (TEST-DeleteReplicaTest.deleteReplicaOnIndexing-seed#[FFC32FA5C547C1A]) [ ] o.a.s.c.SolrCloudTestCase active replica count: 2 expected replica count: 2
[junit4] 2> 1442807 INFO (OverseerCollectionConfigSetProcessor-72143468320456718-127.0.0.1:56548_solr-n_0000000000) [n:127.0.0.1:56548_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> 1442807 INFO (TEST-DeleteReplicaTest.deleteReplicaOnIndexing-seed#[FFC32FA5C547C1A]) [ ] o.a.s.c.SolrCloudTestCase active replica count: 2 expected replica count: 2
[junit4] 2> 1442825 INFO (qtp1505394790-14886) [n:127.0.0.1:56547_solr c:deleteReplicaOnIndexing s:shard1 r:core_node4 x:deleteReplicaOnIndexing_shard1_replica_n2 ] o.a.s.c.ZkShardTerms Successful update of terms at /collections/deleteReplicaOnIndexing/terms/shard1 to Terms{values={core_node3=1, core_node4=1}, version=2}
[junit4] 2> 1442826 INFO (qtp1505394790-15026) [n:127.0.0.1:56547_solr c:deleteReplicaOnIndexing s:shard1 r:core_node4 x:deleteReplicaOnIndexing_shard1_replica_n2 ] o.a.s.c.ZkShardTerms Failed to save terms, version is not a match, retrying
[junit4] 2> 1442826 INFO (qtp1505394790-14885) [n:127.0.0.1:56547_solr c:deleteReplicaOnIndexing s:shard1 r:core_node4 x:deleteReplicaOnIndexing_shard1_replica_n2 ] o.a.s.c.ZkShardTerms Failed to save terms, version is not a match, retrying
[junit4] 2> 1442827 INFO (qtp1505394790-14880) [n:127.0.0.1:56547_solr c:deleteReplicaOnIndexing s:shard1 r:core_node4 x:deleteReplicaOnIndexing_shard1_replica_n2 ] o.a.s.c.ZkShardTerms Failed to save terms, version is not a match, retrying
[junit4] 2> 1442827 INFO (qtp1505394790-15019) [n:127.0.0.1:56547_solr c:deleteReplicaOnIndexing s:shard1 r:core_node4 x:deleteReplicaOnIndexing_shard1_replica_n2 ] o.a.s.c.ZkShardTerms Failed to save terms, version is not a match, retrying
[junit4] 2> 1442828 INFO (qtp1505394790-15022) [n:127.0.0.1:56547_solr c:deleteReplicaOnIndexing s:shard1 r:core_node4 x:deleteReplicaOnIndexing_shard1_replica_n2 ] o.a.s.c.ZkShardTerms Failed to save terms, version is not a match, retrying
[junit4] 2> 1442847 INFO (qtp1050044480-14871) [n:127.0.0.1:56549_solr c:deleteReplicaOnIndexing s:shard1 r:core_node3 x:deleteReplicaOnIndexing_shard1_replica_n1 ] o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1] webapp=/solr path=/update params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:56547/solr/deleteReplicaOnIndexing_shard1_replica_n2/&wt=javabin&version=2}{add=[100000 (1665510447104655363)]} 0 5
[junit4] 2> 1442847 INFO (qtp1050044480-15075) [n:127.0.0.1:56549_solr c:deleteReplicaOnIndexing s:shard1 r:core_node3 x:deleteReplicaOnIndexing_shard1_replica_n1 ] o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1] webapp=/solr path=/update params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:56547/solr/deleteReplicaOnIndexing_shard1_replica_n2/&wt=javabin&version=2}{add=[50000 (1665510447107801089)]} 0 0
[junit4] 2> 1442847 INFO (qtp1050044480-14871) [n:127.0.0.1:56549_solr c:deleteReplicaOnIndexing s:shard1 r:core_node3 x:deleteReplicaOnIndexing_shard1_replica_n1 ] o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1] webapp=/solr path=/update params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:56547/solr/deleteReplicaOnIndexing_shard1_replica_n2/&wt=javabin&version=2}{add=[60000 (1665510447107801088)]} 0 0
[junit4] 2> 1442847 INFO (qtp1505394790-15019) [n:127.0.0.1:56547_solr c:deleteReplicaOnIndexing s:shard1 r:core_node4 x:deleteReplicaOnIndexing_shard1_replica_n2 ] o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2] webapp=/solr path=/update params={wt=javabin&version=2}{add=[50000 (1665510447107801089)]} 0 25
[junit4] 2> 1442847 INFO (qtp1505394790-14886) [n:127.0.0.1:56547_solr c:deleteReplicaOnIndexing s:shard1 r:core_node4 x:deleteReplicaOnIndexing_shard1_replica_n2 ] o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2] webapp=/solr path=/update params={wt=javabin&version=2}{add=[100000 (1665510447104655363)]} 0 32
[junit4] 2> 1442847 INFO (qtp1505394790-15022) [n:127.0.0.1:56547_solr c:deleteReplicaOnIndexing s:shard1 r:core_node4 x:deleteReplicaOnIndexing_shard1_replica_n2 ] o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2] webapp=/solr path=/update params={wt=javabin&version=2}{add=[60000 (1665510447107801088)]} 0 25
[junit4] 2> 1442853 INFO (qtp1050044480-15075) [n:127.0.0.1:56549_solr c:deleteReplicaOnIndexing s:shard1 r:core_node3 x:deleteReplicaOnIndexing_shard1_replica_n1 ] o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1] webapp=/solr path=/update params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:56547/solr/deleteReplicaOnIndexing_shard1_replica_n2/&wt=javabin&version=2}{add=[110000 (1665510447111995392)]} 0 0
[junit4] 2> 1442853 INFO (qtp1505394790-15033) [n:127.0.0.1:56547_solr c:deleteReplicaOnIndexing s:shard1 r:core_node4 x:deleteReplicaOnIndexing_shard1_replica_n2 ] o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2] webapp=/solr path=/update params={wt=javabin&version=2}{add=[110000 (1665510447111995392)]} 0 28
[junit4] 2> 1442854 INFO (qtp1050044480-14870) [n:127.0.0.1:56549_solr c:deleteReplicaOnIndexing s:shard1 r:core_node3 x:deleteReplicaOnIndexing_shard1_replica_n1 ] o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1] webapp=/solr path=/update params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:56547/solr/deleteReplicaOnIndexing_shard1_replica_n2/&wt=javabin&version=2}{add=[120000 (1665510447104655361)]} 0 10
[junit4] 2> 1442855 INFO (qtp1505394790-14880) [n:127.0.0.1:56547_solr c:deleteReplicaOnIndexing s:shard1 r:core_node4 x:deleteReplicaOnIndexing_shard1_replica_n2 ] o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2] webapp=/solr path=/update params={wt=javabin&version=2}{add=[120000 (1665510447104655361)]} 0 40
[junit4] 2> 1442861 INFO (qtp1050044480-15075) [n:127.0.0.1:56549_solr c:deleteReplicaOnIndexing s:shard1 r:core_node3 x:deleteReplicaOnIndexing_shard1_replica_n1 ] o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1] webapp=/solr path=/update params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:56547/solr/deleteReplicaOnIndexing_shard1_replica_n2/&wt=javabin&version=2}{add=[20000 (1665510447114092544)]} 0 7
[junit4] 2> 1442861 INFO (qtp1050044480-15081) [n:127.0.0.1:56549_solr c:deleteReplicaOnIndexing s:shard1 r:core_node3 x:deleteReplicaOnIndexing_shard1_replica_n1 ] o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1] webapp=/solr path=/update params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:56547/solr/deleteReplicaOnIndexing_shard1_replica_n2/&wt=javabin&version=2}{add=[0 (1665510447116189696)]} 0 8
[junit4] 2> 1442861 INFO (qtp1050044480-14870) [n:127.0.0.1:56549_solr c:deleteReplicaOnIndexing s:shard1 r:core_node3 x:deleteReplicaOnIndexing_shard1_replica_n1 ] o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1] webapp=/solr path=/update params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:56547/solr/deleteReplicaOnIndexing_shard1_replica_n2/&wt=javabin&version=2}{add=[80000 (1665510447104655360)]} 0 0
[junit4] 2> 1442861 INFO (qtp1050044480-15081) [n:127.0.0.1:56549_solr c:deleteReplicaOnIndexing s:shard1 r:core_node3 x:deleteReplicaOnIndexing_shard1_replica_n1 ] o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1] webapp=/solr path=/update params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:56547/solr/deleteReplicaOnIndexing_shard1_replica_n2/&wt=javabin&version=2}{add=[170000 (1665510447123529728)]} 0 0
[junit4] 2> 1442861 INFO (qtp1050044480-14870) [n:127.0.0.1:56549_solr c:deleteReplicaOnIndexing s:shard1 r:core_node3 x:deleteReplicaOnIndexing_shard1_replica_n1 ] o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1] webapp=/solr path=/update params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:56547/solr/deleteReplicaOnIndexing_shard1_replica_n2/&wt=javabin&version=2}{add=[70000 (1665510447120384001)]} 0 0
[junit4] 2> 1442862 INFO (qtp1050044480-15093) [n:127.0.0.1:56549_solr c:deleteReplicaOnIndexing s:shard1 r:core_node3 x:deleteReplicaOnIndexing_shard1_replica_n1 ] o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1] webapp=/solr path=/update params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:56547/solr/deleteReplicaOnIndexing_shard1_replica_n2/&wt=javabin&version=2}{add=[150000 (1665510447120384000)]} 0 0
[junit4] 2> 1442862 INFO (qtp1505394790-15037) [n:127.0.0.1:56547_solr c:deleteReplicaOnIndexing s:shard1 r:core_node4 x:deleteReplicaOnIndexing_shard1_replica_n2 ] o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2] webapp=/solr path=/update params={wt=javabin&version=2}{add=[20000 (1665510447114092544)]} 0 35
[junit4] 2> 1442862 INFO (qtp1505394790-14884) [n:127.0.0.1:56547_solr c:deleteReplicaOnIndexing s:shard1 r:core_node4 x:deleteReplicaOnIndexing_shard1_replica_n2 ] o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2] webapp=/solr path=/update params={wt=javabin&version=2}{add=[80000 (1665510447104655360)]} 0 47
[junit4] 2> 1442862 INFO (qtp1505394790-15056) [n:127.0.0.1:56547_solr c:deleteReplicaOnIndexing s:shard1 r:core_node4 x:deleteReplicaOnIndexing_shard1_replica_n2 ] o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2] webapp=/solr path=/update params={wt=javabin&version=2}{add=[170000 (1665510447123529728)]} 0 26
[junit4] 2> 1442862 INFO (qtp1505394790-15044) [n:127.0.0.1:56547_solr c:deleteReplicaOnIndexing s:shard1 r:core_node4 x:deleteReplicaOnIndexing_shard1_replica_n2 ] o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2] webapp=/solr path=/update params={wt=javabin&version=2}{add=[70000 (1665510447120384001)]} 0 28
[junit4] 2> 1442863 INFO (qtp1505394790-15049) [n:127.0.0.1:56547_solr c:deleteReplicaOnIndexing s:shard1 r:core_node4 x:deleteReplicaOnIndexing_shard1_replica_n2 ] o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2] webapp=/solr path=/update params={wt=javabin&version=2}{add=[150000 (1665510447120384000)]} 0 30
[junit4] 2> 1442863 INFO (qtp1505394790-15042) [n:127.0.0.1:56547_solr c:deleteReplicaOnIndexing s:shard1 r:core_node4 x:deleteReplicaOnIndexing_shard1_replica_n2 ] o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2] webapp=/solr path=/update params={wt=javabin&version=2}{add=[0 (1665510447116189696)]} 0 34
[junit4] 2> 1442866 INFO (qtp1050044480-14874) [n:127.0.0.1:56549_solr c:deleteReplicaOnIndexing s:shard1 r:core_node3 x:deleteReplicaOnIndexing_shard1_replica_n1 ] o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1] webapp=/solr path=/update params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:56547/solr/deleteReplicaOnIndexing_shard1_replica_n2/&wt=javabin&version=2}{add=[130000 (1665510447109898240)]} 0 22
[junit4] 2> 1442866 INFO (qtp1050044480-14877) [n:127.0.0.1:56549_solr c:deleteReplicaOnIndexing s:shard1 r:core_node3 x:deleteReplicaOnIndexing_shard1_replica_n1 ] o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1] webapp=/solr path=/update params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:56547/solr/deleteReplicaOnIndexing_shard1_replica_n2/&wt=javabin&version=2}{add=[90000 (1665510447104655362)]} 0 24
[junit4] 2> 1442871 INFO (qtp1505394790-14885) [n:127.0.0.1:56547_solr c:deleteReplicaOnIndexing s:shard1 r:core_node4 x:deleteReplicaOnIndexing_shard1_replica_n2 ] o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2] webapp=/solr path=/update params={wt=javabin&version=2}{add=[90000 (1665510447104655362)]} 0 57
[junit4] 2> 1442873 INFO (qtp1050044480-14871) [n:127.0.0.1:56549_solr c:deleteReplicaOnIndexing s:shard1 r:core_node3 x:deleteReplicaOnIndexing_shard1_replica_n1 ] o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1] webapp=/solr path=/update params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:56547/solr/deleteReplicaOnIndexing_shard1_replica_n2/&wt=javabin&version=2}{add=[40000 (1665510447108849664)]} 0 20
[junit4] 2> 1442874 INFO (qtp1505394790-15024) [n:127.0.0.1:56547_solr c:deleteReplicaOnIndexing s:shard1 r:core_node4 x:deleteReplicaOnIndexing_shard1_replica_n2 ] o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2] webapp=/solr path=/update params={wt=javabin&version=2}{add=[40000 (1665510447108849664)]} 0 52
[junit4] 2> 1442874 INFO (qtp1050044480-15103) [n:127.0.0.1:56549_solr c:deleteReplicaOnIndexing s:shard1 r:core_node3 x:deleteReplicaOnIndexing_shard1_replica_n1 ] o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1] webapp=/solr path=/update params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:56547/solr/deleteReplicaOnIndexing_shard1_replica_n2/&wt=javabin&version=2}{add=[10000 (1665510447119335424)]} 0 0
[junit4] 2> 1442874 INFO (qtp1050044480-15103) [n:127.0.0.1:56549_solr c:deleteReplicaOnIndexing s:shard1 r:core_node3 x:deleteReplicaOnIndexing_shard1_replica_n1 ] o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1] webapp=/solr path=/update params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:56547/solr/deleteReplicaOnIndexing_shard1_replica_n2/&wt=javabin&version=2}{add=[190000 (1665510447128772608)]} 0 0
[junit4] 2> 1442875 INFO (qtp1050044480-15103) [n:127.0.0.1:56549_solr c:deleteReplicaOnIndexing s:shard1 r:core_node3 x:deleteReplicaOnIndexing_shard1_replica_n1 ] o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1] webapp=/solr path=/update params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:56547/solr/deleteReplicaOnIndexing_shard1_replica_n2/&wt=javabin&version=2}{add=[30000 (1665510447129821184)]} 0 0
[junit4] 2> 1442876 INFO (qtp1050044480-15103) [n:127.0.0.1:56549_solr c:deleteReplicaOnIndexing s:shard1 r:core_node3 x:deleteReplicaOnIndexing_shard1_replica_n1 ] o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1] webapp=/solr path=/update params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:56547/solr/deleteReplicaOnIndexing_shard1_replica_n2/&wt=javabin&version=2}{add=[210000 (1665510447135064064)]} 0 0
[junit4] 2> 1442876 INFO (qtp1050044480-14870) [n:127.0.0.1:56549_solr c:deleteReplicaOnIndexing s:shard1 r:core_node3 x:deleteReplicaOnIndexing_shard1_replica_n1 ] o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1] webapp=/solr path=/update params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:56547/solr/deleteReplicaOnIndexing_shard1_replica_n2/&wt=javabin&version=2}{add=[200000 (1665510447134015488)]} 0 0
[junit4] 2> 1442876 INFO (qtp1050044480-14870) [n:127.0.0.1:56549_solr c:deleteReplicaOnIndexing s:shard1 r:core_node3 x:deleteReplicaOnIndexing_shard1_replica_n1 ] o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1] webapp=/solr path=/update params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:56547/solr/deleteReplicaOnIndexing_shard1_replica_n2/&wt=javabin&version=2}{add=[100001 (1665510447139258368)]} 0 0
[junit4] 2> 1442876 INFO (qtp1050044480-15103) [n:127.0.0.1:56549_solr c:deleteReplicaOnIndexing s:shard1 r:core_node3 x:deleteReplicaOnIndexing_shard1_replica_n1 ] o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1] webapp=/solr path=/update params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:56547/solr/deleteReplicaOnIndexing_shard1_replica_n2/&wt=javabin&version=2}{add=[50001 (1665510447141355520)]} 0 0
[junit4] 2> 1442876 INFO (qtp1050044480-14870) [n:127.0.0.1:56549_solr c:deleteReplicaOnIndexing s:shard1 r:core_node3 x:deleteReplicaOnIndexing_shard1_replica_n1 ] o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1] webapp=/solr path=/update params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:56547/solr/deleteReplicaOnIndexing_shard1_replica_n2/&wt=javabin&version=2}{add=[220000 (1665510447142404096)]} 0 0
[junit4] 2> 1442877 INFO (qtp1050044480-15103) [n:127.0.0.1:56549_solr c:deleteReplicaOnIndexing s:shard1 r:core_node3 x:deleteReplicaOnIndexing_shard1_replica_n1 ] o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1] webapp=/solr path=/update params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:56547/solr/deleteReplicaOnIndexing_shard1_replica_n2/&wt=javabin&version=2}{add=[160000 (1665510447143452672)]} 0 0
[junit4] 2> 1442877 INFO (qtp1050044480-14870) [n:127.0.0.1:56549_solr c:deleteReplicaOnIndexing s:shard1 r:core_node3 x:deleteReplicaOnIndexing_shard1_replica_n1 ] o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1] webapp=/solr path=/update params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:56547/solr/deleteReplicaOnIndexing_shard1_replica_n2/&wt=javabin&version=2}{add=[140000 (1665510447140306944)]} 0 0
[junit4] 2> 1442877 INFO (qtp1505394790-15063) [n:127.0.0.1:56547_solr c:deleteReplicaOnIndexing s:shard1 r:core_node4 x:deleteReplicaOnIndexing_shard1_replica_n2 ] o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2] webapp=/solr path=/update params={wt=javabin&version=2}{add=[30000 (1665510447129821184)]} 0 35
[junit4] 2> 1442877 INFO (qtp1505394790-15073) [n:127.0.0.1:56547_solr c:deleteReplicaOnIndexing s:shard1 r:core_node4 x:deleteReplicaOnIndexing_shard1_replica_n2 ] o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2] webapp=/solr path=/update params={wt=javabin&version=2}{add=[200000 (1665510447134015488)]} 0 30
[junit4] 2> 1442877 INFO (qtp1050044480-15103) [n:127.0.0.1:56549_solr c:deleteReplicaOnIndexing s:shard1 r:core_node3 x:deleteReplicaOnIndexing_shard1_replica_n1 ] o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1] webapp=/solr path=/update params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:56547/solr/deleteReplicaOnIndexing_shard1_replica_n2/&wt=javabin&version=2}{add=[280000 (1665510447150792704)]} 0 0
[junit4] 2> 1442877 INFO (qtp1505394790-15048) [n:127.0.0.1:56547_solr c:deleteReplicaOnIndexing s:shard1 r:core_node4 x:deleteReplicaOnIndexing_shard1_replica_n2 ] o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2] webapp=/solr path=/update params={wt=javabin&version=2}{add=[10000 (1665510447119335424)]} 0 44
[junit4] 2> 1442877 INFO (qtp1050044480-15110) [n:127.0.0.1:56549_solr c:deleteReplicaOnIndexing s:shard1 r:core_node3 x:deleteReplicaOnIndexing_shard1_replica_n1 ] o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1] webapp=/solr path=/update params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:56547/solr/deleteReplicaOnIndexing_shard1_replica_n2/&wt=javabin&version=2}{add=[270000 (1665510447139258369)]} 0 1
[junit4] 2> 1442877 INFO (qtp1505394790-15026) [n:127.0.0.1:56547_solr c:deleteReplicaOnIndexing s:shard1 r:core_node4 x:deleteReplicaOnIndexing_shard1_replica_n2 ] o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2] webapp=/solr path=/update params={wt=javabin&version=2}{add=[130000 (1665510447109898240)]} 0 54
[junit4] 2> 1442877 INFO (qtp1505394790-15066) [n:127.0.0.1:56547_solr c:deleteReplicaOnIndexing s:shard1 r:core_node4 x:deleteReplicaOnIndexing_shard1_replica_n2 ] o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2] webapp=/solr path=/update params={wt=javabin&version=2}{add=[190000 (1665510447128772608)]} 0 37
[junit4] 2> 1442877 INFO (qtp1505394790-15019) [n:127.0.0.1:56547_solr c:deleteReplicaOnIndexing s:shard1 r:core_node4 x:deleteReplicaOnIndexing_shard1_replica_n2 ] o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2] webapp=/solr path=/update params={wt=javabin&version=2}{add=[100001 (1665510447139258368)]} 0 26
[junit4] 2> 1442877 INFO (qtp1505394790-14886) [n:127.0.0.1:56547_solr c:deleteReplicaOnIndexing s:shard1 r:core_node4 x:deleteReplicaOnIndexing_shard1_replica_n2 ] o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2] webapp=/solr path=/update params={wt=javabin&version=2}{add=[210000 (1665510447135064064)]} 0 30
[junit4] 2> 1442878 INFO (qtp1505394790-15033) [n:127.0.0.1:56547_solr c:deleteReplicaOnIndexing s:shard1 r:core_node4 x:deleteReplicaOnIndexing_shard1_replica_n2 ] o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n2] webapp=/solr path=/update params={wt=javabin&version=2}{add=[50001 (1665510447141355520)]} 0 24
[junit4] 2> 1442878 INFO (qtp1050044480-15093) [n:127.0.0.1:56549_solr c:deleteReplicaOnIndexing s:shard1 r:core_node3 x:deleteReplicaOnIndexing_shard1_replica_n1 ] o.a.s.u.p.LogUpdateProcessorFactory [deleteReplicaOnIndexing_shard1_replica_n1] webapp=/solr path=/update params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:56547/solr/deleteReplicaOnIndexing_shard1_replica_n2/&wt=javabin&version=2}{add=[120001 (1665510447152889856)]} 0 0
[junit4] 2> 1442878 INFO (qtp1505394790-15068) [n:127.0.0.1:56547_solr c:deleteReplicaOnIndexing s:shard1 r:core_node4 x:deleteReplicaOnIndexing_shard1_replica_n2 ] o.a.s.u.p.LogUpdateProcessorFactory [del
[...truncated too long message...]
TestSizeLimitedDistributedMap.testContains-seed#[FFC32FA5C547C1A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1840719 INFO (zkConnectionManagerCallback-14242-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1840720 INFO (TEST-TestSizeLimitedDistributedMap.testContains-seed#[FFC32FA5C547C1A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1840838 INFO (TEST-TestSizeLimitedDistributedMap.testContains-seed#[FFC32FA5C547C1A]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testContains
[junit4] 2> 1840873 INFO (TEST-TestSizeLimitedDistributedMap.testSize-seed#[FFC32FA5C547C1A]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testSize
[junit4] 2> 1840876 INFO (TEST-TestSizeLimitedDistributedMap.testSize-seed#[FFC32FA5C547C1A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1840879 INFO (zkConnectionManagerCallback-14244-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1840880 INFO (TEST-TestSizeLimitedDistributedMap.testSize-seed#[FFC32FA5C547C1A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1841007 INFO (TEST-TestSizeLimitedDistributedMap.testSize-seed#[FFC32FA5C547C1A]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testSize
[junit4] 2> 1841026 INFO (TEST-TestSizeLimitedDistributedMap.testClear-seed#[FFC32FA5C547C1A]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testClear
[junit4] 2> 1841027 INFO (TEST-TestSizeLimitedDistributedMap.testClear-seed#[FFC32FA5C547C1A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1841032 INFO (zkConnectionManagerCallback-14246-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1841032 INFO (TEST-TestSizeLimitedDistributedMap.testClear-seed#[FFC32FA5C547C1A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1841165 INFO (TEST-TestSizeLimitedDistributedMap.testClear-seed#[FFC32FA5C547C1A]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testClear
[junit4] 2> 1841166 INFO (SUITE-TestSizeLimitedDistributedMap-seed#[FFC32FA5C547C1A]-worker) [ ] o.a.s.c.ZkTestServer Shutting down ZkTestServer.
[junit4] 2> 1841385 INFO (SUITE-TestSizeLimitedDistributedMap-seed#[FFC32FA5C547C1A]-worker) [ ] o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:61416
[junit4] 2> 1841386 INFO (SUITE-TestSizeLimitedDistributedMap-seed#[FFC32FA5C547C1A]-worker) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:61416
[junit4] 2> 1841386 INFO (SUITE-TestSizeLimitedDistributedMap-seed#[FFC32FA5C547C1A]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 61416
[junit4] 2> 1841389 INFO (SUITE-TestSizeLimitedDistributedMap-seed#[FFC32FA5C547C1A]-worker) [ ] o.a.s.SolrTestCaseJ4 ------------------------------------------------------- Done waiting for tracked resources to be released
[junit4] 2> May 01, 2020 5:42:15 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 1 leaked thread(s).
[junit4] 2> May 01, 2020 5:42:26 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> SEVERE: 1 thread leaked from SUITE scope at org.apache.solr.cloud.TestSizeLimitedDistributedMap:
[junit4] 2> 1) Thread[id=23914, name=SessionTracker, state=TIMED_WAITING, group=TGRP-TestSizeLimitedDistributedMap]
[junit4] 2> at java.base@14/java.lang.Thread.sleep(Native Method)
[junit4] 2> at app//org.apache.zookeeper.server.SessionTrackerImpl.run(SessionTrackerImpl.java:151)
[junit4] 2> May 01, 2020 5:42:26 PM com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
[junit4] 2> INFO: Starting to interrupt leaked threads:
[junit4] 2> 1) Thread[id=23914, name=SessionTracker, state=TIMED_WAITING, group=TGRP-TestSizeLimitedDistributedMap]
[junit4] 2> 1851680 ERROR (SessionTracker) [ ] o.a.z.s.ZooKeeperCriticalThread Severe unrecoverable error, from thread : SessionTracker
[junit4] 2> => java.lang.InterruptedException: sleep interrupted
[junit4] 2> at java.base/java.lang.Thread.sleep(Native Method)
[junit4] 2> java.lang.InterruptedException: sleep interrupted
[junit4] 2> at java.lang.Thread.sleep(Native Method) [?:?]
[junit4] 2> at org.apache.zookeeper.server.SessionTrackerImpl.run(SessionTrackerImpl.java:151) ~[zookeeper-3.5.7.jar:3.5.7]
[junit4] 2> May 01, 2020 5:42:26 PM com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
[junit4] 2> INFO: All leaked threads terminated.
[junit4] 2> NOTE: test params are: codec=Lucene84, sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@683afe4c), locale=ksb, timezone=Europe/Vienna
[junit4] 2> NOTE: Mac OS X 10.14.6 x86_64/AdoptOpenJDK 14 (64-bit)/cpus=6,threads=1,free=339738624,total=536870912
[junit4] 2> NOTE: All tests run in this JVM: [SolrGraphiteReporterTest, TestSimNodeAddedTrigger, TestSweetSpotSimilarityFactory, TestExactStatsCache, TestSimpleTrackingShardHandler, HighlighterTest, TestJsonFacets, TaggingAttributeTest, TransactionLogTest, JWTVerificationkeyResolverTest, TriggerIntegrationTest, TestDynamicFieldCollectionResource, HDFSCollectionsAPITest, TestPKIAuthenticationPlugin, SearchRateTriggerTest, DistributedUpdateProcessorTest, TestFastOutputStream, BadCopyFieldTest, TestJmxIntegration, TestExclusionRuleCollectionAccess, TestSSLRandomization, HttpPartitionTest, AnalyticsQueryTest, DeleteLastCustomShardedReplicaTest, TestDynamicLoadingUrl, TestFileDictionaryLookup, TestNumericTerms64, TestSolrCLIRunExample, BJQParserTest, DirectoryFactoryTest, CursorPagingTest, SortSpecParsingTest, TestSearcherReuse, SolrCloudExampleTest, TestRawResponseWriter, TestUtilizeNode, DocValuesTest, MetricsHistoryIntegrationTest, TestPayloadCheckQParserPlugin, CSVRequestHandlerTest, TestFieldCacheSortRandom, NodeAddedTriggerIntegrationTest, TestInitQParser, BasicZkTest, TestSolrCachePerf, TestSort, TestConfigOverlay, TestInPlaceUpdatesRequiredField, PingRequestHandlerTest, CdcrOpsAndBoundariesTest, TestConfigReload, TestQuerySenderNoQuery, AutoScalingHandlerTest, HdfsNNFailoverTest, FileBasedSpellCheckerTest, SubstringBytesRefFilterTest, TestDeleteCollectionOnDownNodes, RestoreTriggerStateTest, DocValuesNotIndexedTest, SoftAutoCommitTest, TestSolrCloudWithDelegationTokens, SearchHandlerTest, SuggesterTest, TestManagedResource, XMLAtomicUpdateMultivalueTest, IndexSizeTriggerMixedBoundsTest, TestStreamBody, JavaBinAtomicUpdateMultivalueTest, DistanceUnitsTest, TestSolrDeletionPolicy1, TestSerializedLuceneMatchVersion, TestFunctionQuery, DistributedSpellCheckComponentTest, TestDocTermOrds, TestBulkSchemaConcurrent, AsyncCallRequestStatusResponseTest, TestSlowCompositeReaderWrapper, PreAnalyzedFieldManagedSchemaCloudTest, ClassificationUpdateProcessorIntegrationTest, PeerSyncWithBufferUpdatesTest, TriLevelCompositeIdRoutingTest, ClusterStateUpdateTest, TestReplicationHandlerDiskOverFlow, TestSolrConfigHandlerCloud, RuleEngineTest, BlockCacheTest, TestClusterStateMutator, TestSizeLimitedDistributedMap]
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestSizeLimitedDistributedMap -Dtests.seed=FFC32FA5C547C1A -Dtests.slow=true -Dtests.locale=ksb -Dtests.timezone=Europe/Vienna -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] ERROR 0.00s J3 | TestSizeLimitedDistributedMap (suite) <<<
[junit4] > Throwable #1: com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE scope at org.apache.solr.cloud.TestSizeLimitedDistributedMap:
[junit4] > 1) Thread[id=23914, name=SessionTracker, state=TIMED_WAITING, group=TGRP-TestSizeLimitedDistributedMap]
[junit4] > at java.base@14/java.lang.Thread.sleep(Native Method)
[junit4] > at app//org.apache.zookeeper.server.SessionTrackerImpl.run(SessionTrackerImpl.java:151)
[junit4] > at __randomizedtesting.SeedInfo.seed([FFC32FA5C547C1A]:0)
[junit4] Completed [564/907 (2!)] on J3 in 13.95s, 9 tests, 1 error <<< FAILURES!
[...truncated 45952 lines...]
[repro] Jenkins log URL: https://jenkins.thetaphi.de/job/Lucene-Solr-8.x-MacOSX/928/consoleText
[repro] Revision: 4010f4e2209f9f824328badb4e998ea02a4d298b
[repro] Ant options: "-Dargs=-XX:-UseCompressedOops -XX:+UnlockExperimentalVMOptions -XX:+UseZGC"
[repro] Repro line: ant test -Dtestcase=DeleteReplicaTest -Dtests.method=deleteReplicaAndVerifyDirectoryCleanup -Dtests.seed=FFC32FA5C547C1A -Dtests.slow=true -Dtests.locale=eo -Dtests.timezone=Etc/GMT+7 -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[repro] Repro line: ant test -Dtestcase=TestSizeLimitedDistributedMap -Dtests.seed=FFC32FA5C547C1A -Dtests.slow=true -Dtests.locale=ksb -Dtests.timezone=Europe/Vienna -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[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] DeleteReplicaTest
[repro] TestSizeLimitedDistributedMap
[repro] ant compile-test
[...truncated 3484 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=10 -Dtests.class="*.DeleteReplicaTest|*.TestSizeLimitedDistributedMap" -Dtests.showOutput=onerror "-Dargs=-XX:-UseCompressedOops -XX:+UnlockExperimentalVMOptions -XX:+UseZGC" -Dtests.seed=FFC32FA5C547C1A -Dtests.slow=true -Dtests.locale=eo -Dtests.timezone=Etc/GMT+7 -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[...truncated 181 lines...]
[repro] Failures w/original seeds:
[repro] 0/5 failed: org.apache.solr.cloud.DeleteReplicaTest
[repro] 0/5 failed: org.apache.solr.cloud.TestSizeLimitedDistributedMap
[repro] Exiting with code 0
[...truncated 73 lines...]
[JENKINS] Lucene-Solr-8.x-MacOSX (64bit/jdk-11.0.6) - Build # 929 -
Still Unstable!
Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-8.x-MacOSX/929/
Java: 64bit/jdk-11.0.6 -XX:+UseCompressedOops -XX:+UseParallelGC
2 tests failed.
FAILED: org.apache.solr.cloud.LeaderFailoverAfterPartitionTest.test
Error Message:
Timeout occurred while waiting response from server at: http://127.0.0.1:54489
Stack Trace:
org.apache.solr.client.solrj.SolrServerException: Timeout occurred while waiting response from server at: http://127.0.0.1:54489
at __randomizedtesting.SeedInfo.seed([60AA2D37950A1386:E8FE12ED3BF67E7E]:0)
at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:676)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:265)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:248)
at org.apache.solr.client.solrj.impl.LBSolrClient.doRequest(LBSolrClient.java:368)
at org.apache.solr.client.solrj.impl.LBSolrClient.request(LBSolrClient.java:296)
at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.sendRequest(BaseCloudSolrClient.java:1147)
at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.requestWithRetryOnStaleState(BaseCloudSolrClient.java:910)
at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.request(BaseCloudSolrClient.java:842)
at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:211)
at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:228)
at org.apache.solr.cloud.AbstractFullDistribZkTestBase.createServers(AbstractFullDistribZkTestBase.java:338)
at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:1079)
at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:1053)
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:368)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.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:368)
at java.base/java.lang.Thread.run(Thread.java:834)
Caused by: java.net.SocketTimeoutException: Read timed out
at java.base/java.net.SocketInputStream.socketRead0(Native Method)
at java.base/java.net.SocketInputStream.socketRead(SocketInputStream.java:115)
at java.base/java.net.SocketInputStream.read(SocketInputStream.java:168)
at java.base/java.net.SocketInputStream.read(SocketInputStream.java:140)
at org.apache.http.impl.io.SessionInputBufferImpl.streamRead(SessionInputBufferImpl.java:137)
at org.apache.http.impl.io.SessionInputBufferImpl.fillBuffer(SessionInputBufferImpl.java:153)
at org.apache.http.impl.io.SessionInputBufferImpl.readLine(SessionInputBufferImpl.java:280)
at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:138)
at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:56)
at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:259)
at org.apache.http.impl.DefaultBHttpClientConnection.receiveResponseHeader(DefaultBHttpClientConnection.java:163)
at org.apache.http.impl.conn.CPoolProxy.receiveResponseHeader(CPoolProxy.java:157)
at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:273)
at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:125)
at org.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:272)
at org.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:186)
at org.apache.http.impl.execchain.RetryExec.execute(RetryExec.java:89)
at org.apache.http.impl.execchain.RedirectExec.execute(RedirectExec.java:110)
at org.apache.http.impl.client.InternalHttpClient.doExecute(InternalHttpClient.java:185)
at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:83)
at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:56)
at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:564)
... 42 more
FAILED: org.apache.solr.cloud.ReplaceNodeTest.test
Error Message:
Expecting no cores but found some: {replacenodetest_coll_shard1_replica_n21={name=replacenodetest_coll_shard1_replica_n21,instanceDir=/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.ReplaceNodeTest_60AA2D37950A1386-001/tempDir-001/node4/./replacenodetest_coll_shard1_replica_n21,dataDir=/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.ReplaceNodeTest_60AA2D37950A1386-001/tempDir-001/node4/./replacenodetest_coll_shard1_replica_n21/data/,config=solrconfig.xml,schema=schema.xml,startTime=Sat May 02 05:38:05 ACWST 2020,uptime=35844,lastPublished=active,configVersion=0,cloud={collection=replacenodetest_coll,shard=shard1,replica=core_node22,replicaType=NRT},index={numDocs=0,maxDoc=0,deletedDocs=0,indexHeapUsageBytes=0,version=3,segmentCount=0,current=false,hasDeletions=false,directory=org.apache.lucene.store.MockDirectoryWrapper:MockDirectoryWrapper(RAMDirectory@5e1fa9d5 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@353c70f9),segmentsFile=segments_1,segmentsFileSizeInBytes=-1,userData={},sizeInBytes=135,size=135 bytes}},replacenodetest_coll_shard5_replica_n23={name=replacenodetest_coll_shard5_replica_n23,instanceDir=/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.ReplaceNodeTest_60AA2D37950A1386-001/tempDir-001/node4/./replacenodetest_coll_shard5_replica_n23,dataDir=/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.ReplaceNodeTest_60AA2D37950A1386-001/tempDir-001/node4/./replacenodetest_coll_shard5_replica_n23/data/,config=solrconfig.xml,schema=schema.xml,startTime=Sat May 02 05:38:14 ACWST 2020,uptime=26825,lastPublished=active,configVersion=0,cloud={collection=replacenodetest_coll,shard=shard5,replica=core_node24,replicaType=NRT},index={numDocs=0,maxDoc=0,deletedDocs=0,indexHeapUsageBytes=0,version=3,segmentCount=0,current=false,hasDeletions=false,directory=org.apache.lucene.store.MockDirectoryWrapper:MockDirectoryWrapper(RAMDirectory@63732fd8 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@62f0ef4f),segmentsFile=segments_1,segmentsFileSizeInBytes=-1,userData={},sizeInBytes=135,size=135 bytes}}} expected:<0> but was:<2>
Stack Trace:
java.lang.AssertionError: Expecting no cores but found some: {replacenodetest_coll_shard1_replica_n21={name=replacenodetest_coll_shard1_replica_n21,instanceDir=/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.ReplaceNodeTest_60AA2D37950A1386-001/tempDir-001/node4/./replacenodetest_coll_shard1_replica_n21,dataDir=/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.ReplaceNodeTest_60AA2D37950A1386-001/tempDir-001/node4/./replacenodetest_coll_shard1_replica_n21/data/,config=solrconfig.xml,schema=schema.xml,startTime=Sat May 02 05:38:05 ACWST 2020,uptime=35844,lastPublished=active,configVersion=0,cloud={collection=replacenodetest_coll,shard=shard1,replica=core_node22,replicaType=NRT},index={numDocs=0,maxDoc=0,deletedDocs=0,indexHeapUsageBytes=0,version=3,segmentCount=0,current=false,hasDeletions=false,directory=org.apache.lucene.store.MockDirectoryWrapper:MockDirectoryWrapper(RAMDirectory@5e1fa9d5 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@353c70f9),segmentsFile=segments_1,segmentsFileSizeInBytes=-1,userData={},sizeInBytes=135,size=135 bytes}},replacenodetest_coll_shard5_replica_n23={name=replacenodetest_coll_shard5_replica_n23,instanceDir=/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.ReplaceNodeTest_60AA2D37950A1386-001/tempDir-001/node4/./replacenodetest_coll_shard5_replica_n23,dataDir=/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.ReplaceNodeTest_60AA2D37950A1386-001/tempDir-001/node4/./replacenodetest_coll_shard5_replica_n23/data/,config=solrconfig.xml,schema=schema.xml,startTime=Sat May 02 05:38:14 ACWST 2020,uptime=26825,lastPublished=active,configVersion=0,cloud={collection=replacenodetest_coll,shard=shard5,replica=core_node24,replicaType=NRT},index={numDocs=0,maxDoc=0,deletedDocs=0,indexHeapUsageBytes=0,version=3,segmentCount=0,current=false,hasDeletions=false,directory=org.apache.lucene.store.MockDirectoryWrapper:MockDirectoryWrapper(RAMDirectory@63732fd8 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@62f0ef4f),segmentsFile=segments_1,segmentsFileSizeInBytes=-1,userData={},sizeInBytes=135,size=135 bytes}}} expected:<0> but was:<2>
at __randomizedtesting.SeedInfo.seed([60AA2D37950A1386:E8FE12ED3BF67E7E]:0)
at org.junit.Assert.fail(Assert.java:88)
at org.junit.Assert.failNotEquals(Assert.java:834)
at org.junit.Assert.assertEquals(Assert.java:645)
at org.apache.solr.cloud.ReplaceNodeTest.test(ReplaceNodeTest.java:142)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:566)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.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:368)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.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:368)
at java.base/java.lang.Thread.run(Thread.java:834)
Build Log:
[...truncated 15044 lines...]
[junit4] Suite: org.apache.solr.cloud.ReplaceNodeTest
[junit4] 2> 1461784 INFO (SUITE-ReplaceNodeTest-seed#[60AA2D37950A1386]-worker) [ ] o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to test-framework derived value of '/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/server/solr/configsets/_default/conf'
[junit4] 2> 1461784 INFO (SUITE-ReplaceNodeTest-seed#[60AA2D37950A1386]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 1461785 INFO (SUITE-ReplaceNodeTest-seed#[60AA2D37950A1386]-worker) [ ] o.a.s.SolrTestCaseJ4 Created dataDir: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.ReplaceNodeTest_60AA2D37950A1386-001/data-dir-77-001
[junit4] 2> 1461785 WARN (SUITE-ReplaceNodeTest-seed#[60AA2D37950A1386]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=20 numCloses=20
[junit4] 2> 1461785 INFO (SUITE-ReplaceNodeTest-seed#[60AA2D37950A1386]-worker) [ ] o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 1461786 INFO (SUITE-ReplaceNodeTest-seed#[60AA2D37950A1386]-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) w/ MAC_OS_X supressed clientAuth
[junit4] 2> 1461786 INFO (SUITE-ReplaceNodeTest-seed#[60AA2D37950A1386]-worker) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 6 servers in /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.ReplaceNodeTest_60AA2D37950A1386-001/tempDir-001
[junit4] 2> 1461786 INFO (SUITE-ReplaceNodeTest-seed#[60AA2D37950A1386]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1461787 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer client port: 0.0.0.0/0.0.0.0:0
[junit4] 2> 1461787 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 1461888 INFO (SUITE-ReplaceNodeTest-seed#[60AA2D37950A1386]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port: 54101
[junit4] 2> 1461888 INFO (SUITE-ReplaceNodeTest-seed#[60AA2D37950A1386]-worker) [ ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:54101
[junit4] 2> 1461888 INFO (SUITE-ReplaceNodeTest-seed#[60AA2D37950A1386]-worker) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:54101
[junit4] 2> 1461888 INFO (SUITE-ReplaceNodeTest-seed#[60AA2D37950A1386]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 54101
[junit4] 2> 1461891 INFO (SUITE-ReplaceNodeTest-seed#[60AA2D37950A1386]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1461896 INFO (zkConnectionManagerCallback-9983-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1461896 INFO (SUITE-ReplaceNodeTest-seed#[60AA2D37950A1386]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1461902 INFO (SUITE-ReplaceNodeTest-seed#[60AA2D37950A1386]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1461906 INFO (zkConnectionManagerCallback-9985-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1461906 INFO (SUITE-ReplaceNodeTest-seed#[60AA2D37950A1386]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1461907 INFO (SUITE-ReplaceNodeTest-seed#[60AA2D37950A1386]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1461913 INFO (zkConnectionManagerCallback-9987-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1461913 INFO (SUITE-ReplaceNodeTest-seed#[60AA2D37950A1386]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1462027 WARN (jetty-launcher-9988-thread-5) [ ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23
[junit4] 2> 1462027 INFO (jetty-launcher-9988-thread-5) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 1462027 INFO (jetty-launcher-9988-thread-5) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 1462027 WARN (jetty-launcher-9988-thread-6) [ ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23
[junit4] 2> 1462027 WARN (jetty-launcher-9988-thread-3) [ ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23
[junit4] 2> 1462027 INFO (jetty-launcher-9988-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 1462027 INFO (jetty-launcher-9988-thread-5) [ ] o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git: a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 11.0.6+10
[junit4] 2> 1462027 INFO (jetty-launcher-9988-thread-6) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 1462027 INFO (jetty-launcher-9988-thread-6) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 1462027 WARN (jetty-launcher-9988-thread-2) [ ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23
[junit4] 2> 1462027 INFO (jetty-launcher-9988-thread-6) [ ] o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git: a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 11.0.6+10
[junit4] 2> 1462027 INFO (jetty-launcher-9988-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 1462027 INFO (jetty-launcher-9988-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 1462027 INFO (jetty-launcher-9988-thread-2) [ ] o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git: a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 11.0.6+10
[junit4] 2> 1462027 WARN (jetty-launcher-9988-thread-4) [ ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23
[junit4] 2> 1462027 INFO (jetty-launcher-9988-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 1462027 INFO (jetty-launcher-9988-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 1462027 INFO (jetty-launcher-9988-thread-4) [ ] o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git: a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 11.0.6+10
[junit4] 2> 1462027 INFO (jetty-launcher-9988-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 1462027 INFO (jetty-launcher-9988-thread-3) [ ] o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git: a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 11.0.6+10
[junit4] 2> 1462027 WARN (jetty-launcher-9988-thread-1) [ ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23
[junit4] 2> 1462027 INFO (jetty-launcher-9988-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 1462027 INFO (jetty-launcher-9988-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 1462027 INFO (jetty-launcher-9988-thread-1) [ ] o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git: a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 11.0.6+10
[junit4] 2> 1462037 INFO (jetty-launcher-9988-thread-4) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1462037 INFO (jetty-launcher-9988-thread-4) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1462037 INFO (jetty-launcher-9988-thread-4) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 1462038 INFO (jetty-launcher-9988-thread-2) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1462038 INFO (jetty-launcher-9988-thread-2) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1462038 INFO (jetty-launcher-9988-thread-2) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 1462039 INFO (jetty-launcher-9988-thread-4) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@3c53e254{/solr,null,AVAILABLE}
[junit4] 2> 1462040 INFO (jetty-launcher-9988-thread-4) [ ] o.e.j.s.AbstractConnector Started ServerConnector@28e28a25{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:?????}
[junit4] 2> 1462040 INFO (jetty-launcher-9988-thread-3) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1462040 INFO (jetty-launcher-9988-thread-3) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1462040 INFO (jetty-launcher-9988-thread-3) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 1462040 INFO (jetty-launcher-9988-thread-4) [ ] o.e.j.s.Server Started @???????ms
[junit4] 2> 1462040 INFO (jetty-launcher-9988-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=54108}
[junit4] 2> 1462040 ERROR (jetty-launcher-9988-thread-4) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1462040 INFO (jetty-launcher-9988-thread-4) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1462040 INFO (jetty-launcher-9988-thread-4) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.6.0
[junit4] 2> 1462040 INFO (jetty-launcher-9988-thread-4) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1462040 INFO (jetty-launcher-9988-thread-4) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr
[junit4] 2> 1462040 INFO (jetty-launcher-9988-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1462040 INFO (jetty-launcher-9988-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1462040 INFO (jetty-launcher-9988-thread-4) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-05-01T20:52:57.498485Z
[junit4] 2> 1462040 INFO (jetty-launcher-9988-thread-1) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 1462040 INFO (jetty-launcher-9988-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@16d9af64{/solr,null,AVAILABLE}
[junit4] 2> 1462041 INFO (jetty-launcher-9988-thread-3) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@6bb44c18{/solr,null,AVAILABLE}
[junit4] 2> 1462041 INFO (jetty-launcher-9988-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@6d528435{/solr,null,AVAILABLE}
[junit4] 2> 1462042 INFO (jetty-launcher-9988-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@2f9ea73f{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:?????}
[junit4] 2> 1462042 INFO (jetty-launcher-9988-thread-1) [ ] o.e.j.s.Server Started @???????ms
[junit4] 2> 1462042 INFO (jetty-launcher-9988-thread-3) [ ] o.e.j.s.AbstractConnector Started ServerConnector@422cb879{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:?????}
[junit4] 2> 1462042 INFO (jetty-launcher-9988-thread-3) [ ] o.e.j.s.Server Started @???????ms
[junit4] 2> 1462042 INFO (jetty-launcher-9988-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=54109}
[junit4] 2> 1462042 INFO (jetty-launcher-9988-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=54110}
[junit4] 2> 1462042 ERROR (jetty-launcher-9988-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1462042 INFO (jetty-launcher-9988-thread-1) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1462042 INFO (jetty-launcher-9988-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.6.0
[junit4] 2> 1462042 INFO (jetty-launcher-9988-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1462042 INFO (jetty-launcher-9988-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr
[junit4] 2> 1462042 INFO (jetty-launcher-9988-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-05-01T20:52:57.500778Z
[junit4] 2> 1462042 ERROR (jetty-launcher-9988-thread-3) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1462042 INFO (jetty-launcher-9988-thread-3) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1462042 INFO (jetty-launcher-9988-thread-3) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.6.0
[junit4] 2> 1462043 INFO (jetty-launcher-9988-thread-3) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1462043 INFO (jetty-launcher-9988-thread-3) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr
[junit4] 2> 1462043 INFO (jetty-launcher-9988-thread-3) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-05-01T20:52:57.501014Z
[junit4] 2> 1462044 INFO (jetty-launcher-9988-thread-4) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1462044 INFO (jetty-launcher-9988-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@728149a6{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:?????}
[junit4] 2> 1462044 INFO (jetty-launcher-9988-thread-2) [ ] o.e.j.s.Server Started @???????ms
[junit4] 2> 1462044 INFO (jetty-launcher-9988-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=54111}
[junit4] 2> 1462044 ERROR (jetty-launcher-9988-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1462044 INFO (jetty-launcher-9988-thread-2) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1462044 INFO (jetty-launcher-9988-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.6.0
[junit4] 2> 1462044 INFO (jetty-launcher-9988-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1462044 INFO (jetty-launcher-9988-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr
[junit4] 2> 1462044 INFO (jetty-launcher-9988-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-05-01T20:52:57.502908Z
[junit4] 2> 1462046 INFO (jetty-launcher-9988-thread-5) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1462046 INFO (jetty-launcher-9988-thread-5) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1462046 INFO (jetty-launcher-9988-thread-5) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 1462047 INFO (jetty-launcher-9988-thread-3) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1462049 INFO (jetty-launcher-9988-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1462050 INFO (zkConnectionManagerCallback-9990-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1462051 INFO (jetty-launcher-9988-thread-4) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1462051 INFO (jetty-launcher-9988-thread-5) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@49bc9fb2{/solr,null,AVAILABLE}
[junit4] 2> 1462054 INFO (jetty-launcher-9988-thread-4) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1462054 INFO (jetty-launcher-9988-thread-5) [ ] o.e.j.s.AbstractConnector Started ServerConnector@335118ad{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:?????}
[junit4] 2> 1462054 INFO (jetty-launcher-9988-thread-5) [ ] o.e.j.s.Server Started @???????ms
[junit4] 2> 1462054 INFO (jetty-launcher-9988-thread-5) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=54114}
[junit4] 2> 1462054 ERROR (jetty-launcher-9988-thread-5) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1462054 INFO (jetty-launcher-9988-thread-5) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1462054 INFO (jetty-launcher-9988-thread-5) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.6.0
[junit4] 2> 1462054 INFO (jetty-launcher-9988-thread-5) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1462054 INFO (jetty-launcher-9988-thread-5) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr
[junit4] 2> 1462055 INFO (jetty-launcher-9988-thread-5) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-05-01T20:52:57.513003Z
[junit4] 2> 1462055 INFO (jetty-launcher-9988-thread-2) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1462055 INFO (jetty-launcher-9988-thread-6) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1462055 INFO (jetty-launcher-9988-thread-6) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1462055 INFO (jetty-launcher-9988-thread-6) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 1462056 INFO (jetty-launcher-9988-thread-6) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@37663c85{/solr,null,AVAILABLE}
[junit4] 2> 1462057 INFO (zkConnectionManagerCallback-9994-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1462057 INFO (jetty-launcher-9988-thread-3) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1462057 INFO (jetty-launcher-9988-thread-6) [ ] o.e.j.s.AbstractConnector Started ServerConnector@173f7c6{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:?????}
[junit4] 2> 1462057 INFO (jetty-launcher-9988-thread-6) [ ] o.e.j.s.Server Started @???????ms
[junit4] 2> 1462057 INFO (jetty-launcher-9988-thread-6) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=54117}
[junit4] 2> 1462058 ERROR (jetty-launcher-9988-thread-6) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1462058 INFO (jetty-launcher-9988-thread-6) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1462058 INFO (jetty-launcher-9988-thread-6) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.6.0
[junit4] 2> 1462058 INFO (jetty-launcher-9988-thread-6) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1462058 INFO (jetty-launcher-9988-thread-6) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr
[junit4] 2> 1462058 INFO (jetty-launcher-9988-thread-6) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-05-01T20:52:57.516155Z
[junit4] 2> 1462059 INFO (jetty-launcher-9988-thread-5) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1462060 INFO (zkConnectionManagerCallback-9992-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1462060 INFO (jetty-launcher-9988-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1462061 INFO (jetty-launcher-9988-thread-3) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1462062 INFO (jetty-launcher-9988-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1462063 INFO (jetty-launcher-9988-thread-6) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1462063 INFO (zkConnectionManagerCallback-9996-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1462063 INFO (jetty-launcher-9988-thread-2) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1462066 INFO (jetty-launcher-9988-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1462066 INFO (zkConnectionManagerCallback-10000-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1462067 INFO (jetty-launcher-9988-thread-6) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1462068 INFO (zkConnectionManagerCallback-9998-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1462068 INFO (jetty-launcher-9988-thread-5) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1462069 INFO (jetty-launcher-9988-thread-6) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1462072 INFO (jetty-launcher-9988-thread-5) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1462503 INFO (jetty-launcher-9988-thread-4) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 1462513 WARN (jetty-launcher-9988-thread-4) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@47de0a34[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1462513 WARN (jetty-launcher-9988-thread-4) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@47de0a34[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1462518 INFO (jetty-launcher-9988-thread-6) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 1462522 WARN (jetty-launcher-9988-thread-4) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@1fadf1bc[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1462523 WARN (jetty-launcher-9988-thread-4) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@1fadf1bc[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1462524 WARN (jetty-launcher-9988-thread-6) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@66d3e01c[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1462524 WARN (jetty-launcher-9988-thread-6) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@66d3e01c[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1462544 INFO (jetty-launcher-9988-thread-4) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:54101/solr
[junit4] 2> 1462554 INFO (jetty-launcher-9988-thread-4) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1462554 INFO (zkConnectionManagerCallback-10030-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1462558 INFO (jetty-launcher-9988-thread-4) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1462559 WARN (jetty-launcher-9988-thread-6) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@1f133913[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1462562 WARN (jetty-launcher-9988-thread-6) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@1f133913[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1462563 INFO (jetty-launcher-9988-thread-6) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:54101/solr
[junit4] 2> 1462569 INFO (jetty-launcher-9988-thread-6) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1462570 INFO (zkConnectionManagerCallback-10034-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1462571 INFO (jetty-launcher-9988-thread-6) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1462600 INFO (jetty-launcher-9988-thread-2) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 1462603 WARN (jetty-launcher-9988-thread-2) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@cd0ca95[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1462603 WARN (jetty-launcher-9988-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@cd0ca95[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1462618 INFO (jetty-launcher-9988-thread-5) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 1462618 WARN (jetty-launcher-9988-thread-2) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@46e82587[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1462620 WARN (jetty-launcher-9988-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@46e82587[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1462620 INFO (jetty-launcher-9988-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:54101/solr
[junit4] 2> 1462626 WARN (jetty-launcher-9988-thread-5) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@845d388[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1462626 INFO (jetty-launcher-9988-thread-2) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1462627 WARN (jetty-launcher-9988-thread-5) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@845d388[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1462627 INFO (zkConnectionManagerCallback-10045-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1462627 INFO (jetty-launcher-9988-thread-2) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1462635 WARN (jetty-launcher-9988-thread-5) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@32ee7d9a[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1462635 WARN (jetty-launcher-9988-thread-5) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@32ee7d9a[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1462638 INFO (jetty-launcher-9988-thread-5) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:54101/solr
[junit4] 2> 1462641 INFO (jetty-launcher-9988-thread-5) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1462646 INFO (zkConnectionManagerCallback-10050-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1462649 INFO (jetty-launcher-9988-thread-5) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1462677 INFO (jetty-launcher-9988-thread-4) [n:127.0.0.1:54108_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1462682 INFO (zkConnectionManagerCallback-10052-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1462682 INFO (jetty-launcher-9988-thread-4) [n:127.0.0.1:54108_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1462696 INFO (jetty-launcher-9988-thread-6) [n:127.0.0.1:54117_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1462704 INFO (zkConnectionManagerCallback-10054-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1462705 INFO (jetty-launcher-9988-thread-6) [n:127.0.0.1:54117_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1462817 INFO (jetty-launcher-9988-thread-5) [n:127.0.0.1:54114_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1462820 INFO (zkConnectionManagerCallback-10056-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1462821 INFO (jetty-launcher-9988-thread-5) [n:127.0.0.1:54114_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1462826 INFO (jetty-launcher-9988-thread-3) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 1462827 INFO (jetty-launcher-9988-thread-1) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 1462830 WARN (jetty-launcher-9988-thread-3) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@4ca4518d[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1462830 WARN (jetty-launcher-9988-thread-3) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@4ca4518d[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1462830 WARN (jetty-launcher-9988-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@5520610e[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1462830 WARN (jetty-launcher-9988-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@5520610e[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1462837 WARN (jetty-launcher-9988-thread-3) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@2d5687c9[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1462837 WARN (jetty-launcher-9988-thread-3) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@2d5687c9[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1462840 INFO (jetty-launcher-9988-thread-3) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:54101/solr
[junit4] 2> 1462840 WARN (jetty-launcher-9988-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@3857c6b[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1462840 WARN (jetty-launcher-9988-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@3857c6b[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1462841 INFO (jetty-launcher-9988-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:54101/solr
[junit4] 2> 1462842 INFO (jetty-launcher-9988-thread-3) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1462844 INFO (jetty-launcher-9988-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1462847 INFO (zkConnectionManagerCallback-10069-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1462847 INFO (jetty-launcher-9988-thread-3) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1462848 INFO (zkConnectionManagerCallback-10072-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1462848 INFO (jetty-launcher-9988-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1462922 INFO (jetty-launcher-9988-thread-2) [n:127.0.0.1:54111_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1462923 INFO (zkConnectionManagerCallback-10074-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1462923 INFO (jetty-launcher-9988-thread-2) [n:127.0.0.1:54111_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1463026 INFO (jetty-launcher-9988-thread-1) [n:127.0.0.1:54109_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1463027 INFO (zkConnectionManagerCallback-10076-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1463028 INFO (jetty-launcher-9988-thread-1) [n:127.0.0.1:54109_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1463135 INFO (jetty-launcher-9988-thread-3) [n:127.0.0.1:54110_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1463141 INFO (zkConnectionManagerCallback-10078-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1463142 INFO (jetty-launcher-9988-thread-3) [n:127.0.0.1:54110_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1464270 INFO (jetty-launcher-9988-thread-4) [n:127.0.0.1:54108_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:54108_solr
[junit4] 2> 1464280 INFO (jetty-launcher-9988-thread-4) [n:127.0.0.1:54108_solr ] o.a.s.c.Overseer Overseer (id=72144244571439117-127.0.0.1:54108_solr-n_0000000000) starting
[junit4] 2> 1464370 INFO (OverseerStateUpdate-72144244571439117-127.0.0.1:54108_solr-n_0000000000) [n:127.0.0.1:54108_solr ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:54108_solr
[junit4] 2> 1464371 INFO (jetty-launcher-9988-thread-4) [n:127.0.0.1:54108_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:54108_solr
[junit4] 2> 1464383 INFO (OverseerStateUpdate-72144244571439117-127.0.0.1:54108_solr-n_0000000000) [n:127.0.0.1:54108_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1464405 INFO (jetty-launcher-9988-thread-4) [n:127.0.0.1:54108_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 1464405 WARN (jetty-launcher-9988-thread-4) [n:127.0.0.1:54108_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> 1464428 INFO (jetty-launcher-9988-thread-4) [n:127.0.0.1:54108_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 1464470 INFO (jetty-launcher-9988-thread-4) [n:127.0.0.1:54108_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_54108.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4660fde3
[junit4] 2> 1464480 INFO (jetty-launcher-9988-thread-4) [n:127.0.0.1:54108_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_54108.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4660fde3
[junit4] 2> 1464480 INFO (jetty-launcher-9988-thread-4) [n:127.0.0.1:54108_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_54108.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4660fde3
[junit4] 2> 1464481 INFO (jetty-launcher-9988-thread-4) [n:127.0.0.1:54108_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.ReplaceNodeTest_60AA2D37950A1386-001/tempDir-001/node4/.
[junit4] 2> 1464601 INFO (jetty-launcher-9988-thread-6) [n:127.0.0.1:54117_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1464613 INFO (jetty-launcher-9988-thread-2) [n:127.0.0.1:54111_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1464616 INFO (jetty-launcher-9988-thread-1) [n:127.0.0.1:54109_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1464626 INFO (jetty-launcher-9988-thread-5) [n:127.0.0.1:54114_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1464637 INFO (jetty-launcher-9988-thread-3) [n:127.0.0.1:54110_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1464649 INFO (jetty-launcher-9988-thread-6) [n:127.0.0.1:54117_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:54117_solr as DOWN
[junit4] 2> 1464654 INFO (jetty-launcher-9988-thread-2) [n:127.0.0.1:54111_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:54111_solr as DOWN
[junit4] 2> 1464659 INFO (jetty-launcher-9988-thread-6) [n:127.0.0.1:54117_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 1464659 INFO (jetty-launcher-9988-thread-6) [n:127.0.0.1:54117_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:54117_solr
[junit4] 2> 1464661 INFO (jetty-launcher-9988-thread-2) [n:127.0.0.1:54111_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 1464661 INFO (jetty-launcher-9988-thread-2) [n:127.0.0.1:54111_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:54111_solr
[junit4] 2> 1464661 INFO (jetty-launcher-9988-thread-1) [n:127.0.0.1:54109_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:54109_solr as DOWN
[junit4] 2> 1464667 INFO (jetty-launcher-9988-thread-5) [n:127.0.0.1:54114_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:54114_solr as DOWN
[junit4] 2> 1464667 INFO (zkCallback-10077-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (3)
[junit4] 2> 1464672 INFO (zkCallback-10073-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (3)
[junit4] 2> 1464672 INFO (zkCallback-10075-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (3)
[junit4] 2> 1464672 INFO (zkCallback-10055-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (3)
[junit4] 2> 1464672 INFO (zkCallback-10051-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (3)
[junit4] 2> 1464674 INFO (zkCallback-10053-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (3)
[junit4] 2> 1464678 INFO (jetty-launcher-9988-thread-1) [n:127.0.0.1:54109_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 1464678 INFO (jetty-launcher-9988-thread-1) [n:127.0.0.1:54109_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:54109_solr
[junit4] 2> 1464682 INFO (jetty-launcher-9988-thread-5) [n:127.0.0.1:54114_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 1464682 INFO (jetty-launcher-9988-thread-5) [n:127.0.0.1:54114_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:54114_solr
[junit4] 2> 1464688 INFO (jetty-launcher-9988-thread-3) [n:127.0.0.1:54110_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:54110_solr as DOWN
[junit4] 2> 1464689 INFO (zkCallback-10051-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1464690 INFO (zkCallback-10053-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1464690 INFO (zkCallback-10075-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1464690 INFO (jetty-launcher-9988-thread-2) [n:127.0.0.1:54111_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 1464690 INFO (zkCallback-10073-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (5)
[junit4] 2> 1464691 WARN (jetty-launcher-9988-thread-2) [n:127.0.0.1:54111_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> 1464691 INFO (zkCallback-10055-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1464693 INFO (jetty-launcher-9988-thread-6) [n:127.0.0.1:54117_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 1464693 WARN (jetty-launcher-9988-thread-6) [n:127.0.0.1:54117_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> 1464694 INFO (zkCallback-10075-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 1464695 INFO (zkCallback-10053-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 1464695 INFO (zkCallback-10077-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (5)
[junit4] 2> 1464696 INFO (zkCallback-10051-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 1464697 INFO (zkCallback-10055-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 1464701 INFO (jetty-launcher-9988-thread-3) [n:127.0.0.1:54110_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 1464702 INFO (jetty-launcher-9988-thread-3) [n:127.0.0.1:54110_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:54110_solr
[junit4] 2> 1464715 INFO (jetty-launcher-9988-thread-2) [n:127.0.0.1:54111_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 1464715 INFO (zkCallback-10073-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 1464720 INFO (zkCallback-10077-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 1464721 INFO (zkCallback-10053-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 1464721 INFO (zkCallback-10051-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 1464722 INFO (zkCallback-10075-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 1464722 INFO (jetty-launcher-9988-thread-1) [n:127.0.0.1:54109_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 1464723 INFO (zkCallback-10055-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 1464723 WARN (jetty-launcher-9988-thread-1) [n:127.0.0.1:54109_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> 1464726 INFO (jetty-launcher-9988-thread-5) [n:127.0.0.1:54114_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 1464727 WARN (jetty-launcher-9988-thread-5) [n:127.0.0.1:54114_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> 1464732 INFO (jetty-launcher-9988-thread-6) [n:127.0.0.1:54117_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 1464748 INFO (jetty-launcher-9988-thread-3) [n:127.0.0.1:54110_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 1464748 WARN (jetty-launcher-9988-thread-3) [n:127.0.0.1:54110_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> 1464754 INFO (jetty-launcher-9988-thread-1) [n:127.0.0.1:54109_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 1464762 INFO (jetty-launcher-9988-thread-5) [n:127.0.0.1:54114_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 1464780 INFO (jetty-launcher-9988-thread-3) [n:127.0.0.1:54110_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 1465835 INFO (jetty-launcher-9988-thread-2) [n:127.0.0.1:54111_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_54111.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4660fde3
[junit4] 2> 1466032 INFO (jetty-launcher-9988-thread-6) [n:127.0.0.1:54117_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_54117.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4660fde3
[junit4] 2> 1466200 INFO (jetty-launcher-9988-thread-3) [n:127.0.0.1:54110_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_54110.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4660fde3
[junit4] 2> 1466203 INFO (jetty-launcher-9988-thread-1) [n:127.0.0.1:54109_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_54109.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4660fde3
[junit4] 2> 1466206 INFO (jetty-launcher-9988-thread-5) [n:127.0.0.1:54114_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_54114.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4660fde3
[junit4] 2> 1466235 INFO (jetty-launcher-9988-thread-2) [n:127.0.0.1:54111_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_54111.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4660fde3
[junit4] 2> 1466235 INFO (jetty-launcher-9988-thread-2) [n:127.0.0.1:54111_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_54111.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4660fde3
[junit4] 2> 1466248 INFO (jetty-launcher-9988-thread-2) [n:127.0.0.1:54111_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.ReplaceNodeTest_60AA2D37950A1386-001/tempDir-001/node2/.
[junit4] 2> 1466290 INFO (jetty-launcher-9988-thread-6) [n:127.0.0.1:54117_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_54117.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4660fde3
[junit4] 2> 1466290 INFO (jetty-launcher-9988-thread-6) [n:127.0.0.1:54117_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_54117.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4660fde3
[junit4] 2> 1466298 INFO (jetty-launcher-9988-thread-6) [n:127.0.0.1:54117_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.ReplaceNodeTest_60AA2D37950A1386-001/tempDir-001/node6/.
[junit4] 2> 1466348 INFO (jetty-launcher-9988-thread-1) [n:127.0.0.1:54109_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_54109.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4660fde3
[junit4] 2> 1466348 INFO (jetty-launcher-9988-thread-5) [n:127.0.0.1:54114_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_54114.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4660fde3
[junit4] 2> 1466348 INFO (jetty-launcher-9988-thread-1) [n:127.0.0.1:54109_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_54109.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4660fde3
[junit4] 2> 1466348 INFO (jetty-launcher-9988-thread-3) [n:127.0.0.1:54110_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_54110.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4660fde3
[junit4] 2> 1466348 INFO (jetty-launcher-9988-thread-3) [n:127.0.0.1:54110_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_54110.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4660fde3
[junit4] 2> 1466348 INFO (jetty-launcher-9988-thread-5) [n:127.0.0.1:54114_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_54114.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4660fde3
[junit4] 2> 1466349 INFO (jetty-launcher-9988-thread-1) [n:127.0.0.1:54109_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.ReplaceNodeTest_60AA2D37950A1386-001/tempDir-001/node1/.
[junit4] 2> 1466350 INFO (jetty-launcher-9988-thread-5) [n:127.0.0.1:54114_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.ReplaceNodeTest_60AA2D37950A1386-001/tempDir-001/node5/.
[junit4] 2> 1466350 INFO (jetty-launcher-9988-thread-3) [n:127.0.0.1:54110_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.ReplaceNodeTest_60AA2D37950A1386-001/tempDir-001/node3/.
[junit4] 2> 1466370 INFO (SUITE-ReplaceNodeTest-seed#[60AA2D37950A1386]-worker) [ ] o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=6
[junit4] 2> 1466371 INFO (SUITE-ReplaceNodeTest-seed#[60AA2D37950A1386]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1466375 INFO (zkConnectionManagerCallback-10135-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1466375 INFO (SUITE-ReplaceNodeTest-seed#[60AA2D37950A1386]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1466380 INFO (SUITE-ReplaceNodeTest-seed#[60AA2D37950A1386]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (6)
[junit4] 2> 1466385 INFO (SUITE-ReplaceNodeTest-seed#[60AA2D37950A1386]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:54101/solr ready
[junit4] 2> 1466465 INFO (TEST-ReplaceNodeTest.test-seed#[60AA2D37950A1386]) [ ] o.a.s.SolrTestCaseJ4 ###Starting test
[junit4] 2> 1466465 INFO (TEST-ReplaceNodeTest.test-seed#[60AA2D37950A1386]) [ ] o.a.s.c.ReplaceNodeTest total_jettys: 6
[junit4] 2> 1466469 INFO (qtp559504740-13144) [n:127.0.0.1:54109_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params pullReplicas=0&collection.configName=conf1&maxShardsPerNode=3&name=replacenodetest_coll&nrtReplicas=2&action=CREATE&numShards=5&tlogReplicas=0&createNodeSet=127.0.0.1:54117_solr,127.0.0.1:54111_solr,127.0.0.1:54114_solr,127.0.0.1:54109_solr,127.0.0.1:54110_solr&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 1466477 INFO (OverseerThreadFactory-10095-thread-1-processing-n:127.0.0.1:54108_solr) [n:127.0.0.1:54108_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection replacenodetest_coll
[junit4] 2> 1466597 INFO (qtp559504740-13123) [n:127.0.0.1:54109_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=0
[junit4] 2> 1466600 INFO (qtp1033298287-13175) [n:127.0.0.1:54114_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=0
[junit4] 2> 1466603 INFO (qtp639987857-13138) [n:127.0.0.1:54108_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=0
[junit4] 2> 1466606 INFO (qtp1290493844-13148) [n:127.0.0.1:54110_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=0
[junit4] 2> 1466609 INFO (qtp263460928-13156) [n:127.0.0.1:54117_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=0
[junit4] 2> 1466612 INFO (qtp2085005406-13135) [n:127.0.0.1:54111_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=0
[junit4] 2> 1466614 INFO (qtp559504740-13142) [n:127.0.0.1:54109_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=0
[junit4] 2> 1466615 INFO (qtp1033298287-13174) [n:127.0.0.1:54114_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=0
[junit4] 2> 1466617 INFO (qtp639987857-13149) [n:127.0.0.1:54108_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=0
[junit4] 2> 1466618 INFO (qtp1290493844-13158) [n:127.0.0.1:54110_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=0
[junit4] 2> 1466619 INFO (qtp263460928-13166) [n:127.0.0.1:54117_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=0
[junit4] 2> 1466619 INFO (qtp2085005406-13137) [n:127.0.0.1:54111_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=0
[junit4] 2> 1466659 INFO (OverseerStateUpdate-72144244571439117-127.0.0.1:54108_solr-n_0000000000) [n:127.0.0.1:54108_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"replacenodetest_coll",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"replacenodetest_coll_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:54111/solr",
[junit4] 2> "node_name":"127.0.0.1:54111_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1466669 INFO (OverseerStateUpdate-72144244571439117-127.0.0.1:54108_solr-n_0000000000) [n:127.0.0.1:54108_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"replacenodetest_coll",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"replacenodetest_coll_shard1_replica_n2",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:54117/solr",
[junit4] 2> "node_name":"127.0.0.1:54117_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1466679 INFO (OverseerStateUpdate-72144244571439117-127.0.0.1:54108_solr-n_0000000000) [n:127.0.0.1:54108_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"replacenodetest_coll",
[junit4] 2> "shard":"shard2",
[junit4] 2> "core":"replacenodetest_coll_shard2_replica_n4",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:54110/solr",
[junit4] 2> "node_name":"127.0.0.1:54110_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1466689 INFO (OverseerStateUpdate-72144244571439117-127.0.0.1:54108_solr-n_0000000000) [n:127.0.0.1:54108_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"replacenodetest_coll",
[junit4] 2> "shard":"shard2",
[junit4] 2> "core":"replacenodetest_coll_shard2_replica_n6",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:54114/solr",
[junit4] 2> "node_name":"127.0.0.1:54114_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1466699 INFO (OverseerStateUpdate-72144244571439117-127.0.0.1:54108_solr-n_0000000000) [n:127.0.0.1:54108_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"replacenodetest_coll",
[junit4] 2> "shard":"shard3",
[junit4] 2> "core":"replacenodetest_coll_shard3_replica_n8",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:54109/solr",
[junit4] 2> "node_name":"127.0.0.1:54109_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1466707 INFO (OverseerStateUpdate-72144244571439117-127.0.0.1:54108_solr-n_0000000000) [n:127.0.0.1:54108_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"replacenodetest_coll",
[junit4] 2> "shard":"shard3",
[junit4] 2> "core":"replacenodetest_coll_shard3_replica_n10",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:54109/solr",
[junit4] 2> "node_name":"127.0.0.1:54109_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1466717 INFO (OverseerStateUpdate-72144244571439117-127.0.0.1:54108_solr-n_0000000000) [n:127.0.0.1:54108_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"replacenodetest_coll",
[junit4] 2> "shard":"shard4",
[junit4] 2> "core":"replacenodetest_coll_shard4_replica_n12",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:54114/solr",
[junit4] 2> "node_name":"127.0.0.1:54114_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1466729 INFO (OverseerStateUpdate-72144244571439117-127.0.0.1:54108_solr-n_0000000000) [n:127.0.0.1:54108_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"replacenodetest_coll",
[junit4] 2> "shard":"shard4",
[junit4] 2> "core":"replacenodetest_coll_shard4_replica_n14",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:54110/solr",
[junit4] 2> "node_name":"127.0.0.1:54110_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1466756 INFO (OverseerStateUpdate-72144244571439117-127.0.0.1:54108_solr-n_0000000000) [n:127.0.0.1:54108_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"replacenodetest_coll",
[junit4] 2> "shard":"shard5",
[junit4] 2> "core":"replacenodetest_coll_shard5_replica_n17",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:54117/solr",
[junit4] 2> "node_name":"127.0.0.1:54117_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1466778 INFO (OverseerStateUpdate-72144244571439117-127.0.0.1:54108_solr-n_0000000000) [n:127.0.0.1:54108_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"replacenodetest_coll",
[junit4] 2> "shard":"shard5",
[junit4] 2> "core":"replacenodetest_coll_shard5_replica_n19",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:54111/solr",
[junit4] 2> "node_name":"127.0.0.1:54111_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1466989 INFO (qtp2085005406-13152) [n:127.0.0.1:54111_solr x:replacenodetest_coll_shard1_replica_n1 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf1&newCollection=true&name=replacenodetest_coll_shard1_replica_n1&action=CREATE&numShards=5&collection=replacenodetest_coll&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1466990 INFO (qtp263460928-13179) [n:127.0.0.1:54117_solr x:replacenodetest_coll_shard1_replica_n2 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node5&collection.configName=conf1&newCollection=true&name=replacenodetest_coll_shard1_replica_n2&action=CREATE&numShards=5&collection=replacenodetest_coll&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1466990 INFO (qtp559504740-13145) [n:127.0.0.1:54109_solr x:replacenodetest_coll_shard3_replica_n8 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node11&collection.configName=conf1&newCollection=true&name=replacenodetest_coll_shard3_replica_n8&action=CREATE&numShards=5&collection=replacenodetest_coll&shard=shard3&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1466990 INFO (qtp1033298287-13176) [n:127.0.0.1:54114_solr x:replacenodetest_coll_shard2_replica_n6 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node9&collection.configName=conf1&newCollection=true&name=replacenodetest_coll_shard2_replica_n6&action=CREATE&numShards=5&collection=replacenodetest_coll&shard=shard2&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1466991 INFO (qtp1290493844-13159) [n:127.0.0.1:54110_solr x:replacenodetest_coll_shard2_replica_n4 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node7&collection.configName=conf1&newCollection=true&name=replacenodetest_coll_shard2_replica_n4&action=CREATE&numShards=5&collection=replacenodetest_coll&shard=shard2&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1466992 INFO (qtp1033298287-13175) [n:127.0.0.1:54114_solr x:replacenodetest_coll_shard4_replica_n12 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node15&collection.configName=conf1&newCollection=true&name=replacenodetest_coll_shard4_replica_n12&action=CREATE&numShards=5&collection=replacenodetest_coll&shard=shard4&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1466992 INFO (qtp559504740-13142) [n:127.0.0.1:54109_solr x:replacenodetest_coll_shard3_replica_n10 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node13&collection.configName=conf1&newCollection=true&name=replacenodetest_coll_shard3_replica_n10&action=CREATE&numShards=5&collection=replacenodetest_coll&shard=shard3&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1466992 INFO (qtp1290493844-13148) [n:127.0.0.1:54110_solr x:replacenodetest_coll_shard4_replica_n14 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node16&collection.configName=conf1&newCollection=true&name=replacenodetest_coll_shard4_replica_n14&action=CREATE&numShards=5&collection=replacenodetest_coll&shard=shard4&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1466993 INFO (qtp263460928-13156) [n:127.0.0.1:54117_solr x:replacenodetest_coll_shard5_replica_n17 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node18&collection.configName=conf1&newCollection=true&name=replacenodetest_coll_shard5_replica_n17&action=CREATE&numShards=5&collection=replacenodetest_coll&shard=shard5&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1466994 INFO (qtp2085005406-13135) [n:127.0.0.1:54111_solr x:replacenodetest_coll_shard5_replica_n19 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node20&collection.configName=conf1&newCollection=true&name=replacenodetest_coll_shard5_replica_n19&action=CREATE&numShards=5&collection=replacenodetest_coll&shard=shard5&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1467064 INFO (qtp1033298287-13175) [n:127.0.0.1:54114_solr c:replacenodetest_coll s:shard4 r:core_node15 x:replacenodetest_coll_shard4_replica_n12 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.6.0
[junit4] 2> 1467070 INFO (qtp263460928-13156) [n:127.0.0.1:54117_solr c:replacenodetest_coll s:shard5 r:core_node18 x:replacenodetest_coll_shard5_replica_n17 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.6.0
[junit4] 2> 1467071 INFO (qtp1290493844-13148) [n:127.0.0.1:54110_solr c:replacenodetest_coll s:shard4 r:core_node16 x:replacenodetest_coll_shard4_replica_n14 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.6.0
[junit4] 2> 1467072 INFO (qtp2085005406-13135) [n:127.0.0.1:54111_solr c:replacenodetest_coll s:shard5 r:core_node20 x:replacenodetest_coll_shard5_replica_n19 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.6.0
[junit4] 2> 1467091 INFO (qtp559504740-13142) [n:127.0.0.1:54109_solr c:replacenodetest_coll s:shard3 r:core_node13 x:replacenodetest_coll_shard3_replica_n10 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.6.0
[junit4] 2> 1467092 INFO (qtp1290493844-13159) [n:127.0.0.1:54110_solr c:replacenodetest_coll s:shard2 r:core_node7 x:replacenodetest_coll_shard2_replica_n4 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.6.0
[junit4] 2> 1467094 INFO (qtp559504740-13145) [n:127.0.0.1:54109_solr c:replacenodetest_coll s:shard3 r:core_node11 x:replacenodetest_coll_shard3_replica_n8 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.6.0
[junit4] 2> 1467094 INFO (qtp2085005406-13152) [n:127.0.0.1:54111_solr c:replacenodetest_coll s:shard1 r:core_node3 x:replacenodetest_coll_shard1_replica_n1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.6.0
[junit4] 2> 1467094 INFO (qtp263460928-13179) [n:127.0.0.1:54117_solr c:replacenodetest_coll s:shard1 r:core_node5 x:replacenodetest_coll_shard1_replica_n2 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.6.0
[junit4] 2> 1467097 INFO (qtp1290493844-13148) [n:127.0.0.1:54110_solr c:replacenodetest_coll s:shard4 r:core_node16 x:replacenodetest_coll_shard4_replica_n14 ] o.a.s.s.IndexSchema Schema name=cloud-dynamic
[junit4] 2> 1467113 INFO (qtp1033298287-13175) [n:127.0.0.1:54114_solr c:replacenodetest_coll s:shard4 r:core_node15 x:replacenodetest_coll_shard4_replica_n12 ] o.a.s.s.IndexSchema Schema name=cloud-dynamic
[junit4] 2> 1467113 INFO (qtp1033298287-13176) [n:127.0.0.1:54114_solr c:replacenodetest_coll s:shard2 r:core_node9 x:replacenodetest_coll_shard2_replica_n6 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.6.0
[junit4] 2> 1467125 INFO (qtp263460928-13156) [n:127.0.0.1:54117_solr c:replacenodetest_coll s:shard5 r:core_node18 x:replacenodetest_coll_shard5_replica_n17 ] o.a.s.s.IndexSchema Schema name=cloud-dynamic
[junit4] 2> 1467126 INFO (qtp2085005406-13135) [n:127.0.0.1:54111_solr c:replacenodetest_coll s:shard5 r:core_node20 x:replacenodetest_coll_shard5_replica_n19 ] o.a.s.s.IndexSchema Schema name=cloud-dynamic
[junit4] 2> 1467141 INFO (qtp1033298287-13175) [n:127.0.0.1:54114_solr c:replacenodetest_coll s:shard4 r:core_node15 x:replacenodetest_coll_shard4_replica_n12 ] o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id
[junit4] 2> 1467141 INFO (qtp1033298287-13175) [n:127.0.0.1:54114_solr c:replacenodetest_coll s:shard4 r:core_node15 x:replacenodetest_coll_shard4_replica_n12 ] o.a.s.c.CoreContainer Creating SolrCore 'replacenodetest_coll_shard4_replica_n12' using configuration from configset conf1, trusted=true
[junit4] 2> 1467145 INFO (qtp1290493844-13148) [n:127.0.0.1:54110_solr c:replacenodetest_coll s:shard4 r:core_node16 x:replacenodetest_coll_shard4_replica_n14 ] o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id
[junit4] 2> 1467145 INFO (qtp1290493844-13148) [n:127.0.0.1:54110_solr c:replacenodetest_coll s:shard4 r:core_node16 x:replacenodetest_coll_shard4_replica_n14 ] o.a.s.c.CoreContainer Creating SolrCore 'replacenodetest_coll_shard4_replica_n14' using configuration from configset conf1, trusted=true
[junit4] 2> 1467145 INFO (qtp1033298287-13176) [n:127.0.0.1:54114_solr c:replacenodetest_coll s:shard2 r:core_node9 x:replacenodetest_coll_shard2_replica_n6 ] o.a.s.s.IndexSchema Schema name=cloud-dynamic
[junit4] 2> 1467145 INFO (qtp559504740-13142) [n:127.0.0.1:54109_solr c:replacenodetest_coll s:shard3 r:core_node13 x:replacenodetest_coll_shard3_replica_n10 ] o.a.s.s.IndexSchema Schema name=cloud-dynamic
[junit4] 2> 1467145 INFO (qtp559504740-13145) [n:127.0.0.1:54109_solr c:replacenodetest_coll s:shard3 r:core_node11 x:replacenodetest_coll_shard3_replica_n8 ] o.a.s.s.IndexSchema Schema name=cloud-dynamic
[junit4] 2> 1467146 INFO (qtp1033298287-13175) [n:127.0.0.1:54114_solr c:replacenodetest_coll s:shard4 r:core_node15 x:replacenodetest_coll_shard4_replica_n12 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_54114.solr.core.replacenodetest_coll.shard4.replica_n12' (registry 'solr.core.replacenodetest_coll.shard4.replica_n12') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4660fde3
[junit4] 2> 1467148 INFO (qtp1290493844-13148) [n:127.0.0.1:54110_solr c:replacenodetest_coll s:shard4 r:core_node16 x:replacenodetest_coll_shard4_replica_n14 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_54110.solr.core.replacenodetest_coll.shard4.replica_n14' (registry 'solr.core.replacenodetest_coll.shard4.replica_n14') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4660fde3
[junit4] 2> 1467149 INFO (qtp1290493844-13148) [n:127.0.0.1:54110_solr c:replacenodetest_coll s:shard4 r:core_node16 x:replacenodetest_coll_shard4_replica_n14 ] o.a.s.c.SolrCore [[replacenodetest_coll_shard4_replica_n1
[...truncated too long message...]
concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 8 /solr/overseer/queue
[junit4] 2> 5 /solr/overseer/collection-queue-work
[junit4] 2> 3 /solr/live_nodes
[junit4] 2> 2 /solr/collections
[junit4] 2>
[junit4] 2> 1531374 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[60AA2D37950A1386]) [ ] o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:54485
[junit4] 2> 1531374 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[60AA2D37950A1386]) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:54485
[junit4] 2> 1531374 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[60AA2D37950A1386]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 54485
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=LeaderFailoverAfterPartitionTest -Dtests.method=test -Dtests.seed=60AA2D37950A1386 -Dtests.slow=true -Dtests.locale=de-CH -Dtests.timezone=America/Bogota -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
[junit4] ERROR 12.6s J1 | LeaderFailoverAfterPartitionTest.test <<<
[junit4] > Throwable #1: org.apache.solr.client.solrj.SolrServerException: Timeout occurred while waiting response from server at: http://127.0.0.1:54489
[junit4] > at __randomizedtesting.SeedInfo.seed([60AA2D37950A1386:E8FE12ED3BF67E7E]:0)
[junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:676)
[junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:265)
[junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:248)
[junit4] > at org.apache.solr.client.solrj.impl.LBSolrClient.doRequest(LBSolrClient.java:368)
[junit4] > at org.apache.solr.client.solrj.impl.LBSolrClient.request(LBSolrClient.java:296)
[junit4] > at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.sendRequest(BaseCloudSolrClient.java:1147)
[junit4] > at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.requestWithRetryOnStaleState(BaseCloudSolrClient.java:910)
[junit4] > at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.request(BaseCloudSolrClient.java:842)
[junit4] > at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:211)
[junit4] > at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:228)
[junit4] > at org.apache.solr.cloud.AbstractFullDistribZkTestBase.createServers(AbstractFullDistribZkTestBase.java:338)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:1079)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:1053)
[junit4] > at java.base/java.lang.Thread.run(Thread.java:834)
[junit4] > Caused by: java.net.SocketTimeoutException: Read timed out
[junit4] > at java.base/java.net.SocketInputStream.socketRead0(Native Method)
[junit4] > at java.base/java.net.SocketInputStream.socketRead(SocketInputStream.java:115)
[junit4] > at java.base/java.net.SocketInputStream.read(SocketInputStream.java:168)
[junit4] > at java.base/java.net.SocketInputStream.read(SocketInputStream.java:140)
[junit4] > at org.apache.http.impl.io.SessionInputBufferImpl.streamRead(SessionInputBufferImpl.java:137)
[junit4] > at org.apache.http.impl.io.SessionInputBufferImpl.fillBuffer(SessionInputBufferImpl.java:153)
[junit4] > at org.apache.http.impl.io.SessionInputBufferImpl.readLine(SessionInputBufferImpl.java:280)
[junit4] > at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:138)
[junit4] > at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:56)
[junit4] > at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:259)
[junit4] > at org.apache.http.impl.DefaultBHttpClientConnection.receiveResponseHeader(DefaultBHttpClientConnection.java:163)
[junit4] > at org.apache.http.impl.conn.CPoolProxy.receiveResponseHeader(CPoolProxy.java:157)
[junit4] > at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:273)
[junit4] > at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:125)
[junit4] > at org.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:272)
[junit4] > at org.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:186)
[junit4] > at org.apache.http.impl.execchain.RetryExec.execute(RetryExec.java:89)
[junit4] > at org.apache.http.impl.execchain.RedirectExec.execute(RedirectExec.java:110)
[junit4] > at org.apache.http.impl.client.InternalHttpClient.doExecute(InternalHttpClient.java:185)
[junit4] > at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:83)
[junit4] > at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:56)
[junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:564)
[junit4] > ... 42 more
[junit4] 2> NOTE: leaving temporary files on disk at: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderFailoverAfterPartitionTest_60AA2D37950A1386-001
[junit4] 2> May 01, 2020 8:54:06 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 1 leaked thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene84), sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@f5dd92f), locale=de-CH, timezone=America/Bogota
[junit4] 2> NOTE: Mac OS X 10.14.6 x86_64/AdoptOpenJDK 11.0.6 (64-bit)/cpus=6,threads=1,free=165303976,total=471859200
[junit4] 2> NOTE: All tests run in this JVM: [LeaderElectionIntegrationTest, TestMacroExpander, TestReloadDeadlock, TestIBSimilarityFactory, TestCollationField, TestSolrQueryResponse, NumberUtilsTest, TestTermsQParserPlugin, SolrPluginUtilsTest, RequiredFieldsTest, TestScoreJoinQPScore, SOLR749Test, BigEndianAscendingWordSerializerTest, TermsComponentTest, TestCaffeineCache, BasicFunctionalityTest, TestPartialUpdateDeduplication, ReturnFieldsTest, DistributedDebugComponentTest, TestSchemalessBufferedUpdates, TestStressCloudBlindAtomicUpdates, LargeFieldTest, MetricsHistoryHandlerTest, DeleteShardTest, TestManagedSchemaThreadSafety, TestLuceneIndexBackCompat, TestSortByMinMaxFunction, TestNestedUpdateProcessor, ConfigureRecoveryStrategyTest, MetricTriggerIntegrationTest, TestDownShardTolerantSearch, HdfsRestartWhileUpdatingTest, FullSolrCloudDistribCmdsTest, TestLegacyNumericRangeQueryBuilder, TestReRankQParserPlugin, TestPullReplica, TestSQLHandler, BasicDistributedZk2Test, ChaosMonkeySafeLeaderTest, SolrSlf4jReporterTest, SynonymTokenizerTest, AlternateDirectoryTest, TestSystemCollAutoCreate, TestNRTOpen, TestNoOpRegenerator, TestSubQueryTransformerCrossCore, OverseerStatusTest, DistributedFacetSimpleRefinementLongTailTest, RecoveryAfterSoftCommitTest, OverseerCollectionConfigSetProcessorTest, TestDistributedSearch, AnalysisErrorHandlingTest, HdfsDirectoryTest, TestCollectionAPIs, CoreAdminRequestStatusTest, TestBlobHandler, SyncSliceTest, SimpleMLTQParserTest, HdfsCollectionsAPIDistributedZkTest, TestJsonFacetErrors, SolrLogAuditLoggerPluginTest, UUIDFieldTest, TestRTimerTree, TestSolr4Spatial, ResponseBuilderTest, DistributedQueryComponentOptimizationTest, MaxSizeAutoCommitTest, PluginInfoTest, HdfsChaosMonkeyNothingIsSafeTest, JsonLoaderTest, ChangedSchemaMergeTest, JWTAuthPluginTest, DirectSolrConnectionTest, TestSizeLimitedDistributedMap, ZkSolrClientTest, TestCloudRecovery2, TestDeprecatedFilters, Tagger2Test, TestSimpleTextCodec, DistributedQueueTest, TestSolrJ, TestAnalyzedSuggestions, TestCollectionsAPIViaSolrCloudCluster, SolrMetricReporterTest, TestTestInjection, SpellCheckCollatorWithCollapseTest, TestRebalanceLeaders, ReplaceNodeTest, LeaderFailoverAfterPartitionTest]
[junit4] Completed [492/907 (2!)] on J1 in 18.18s, 1 test, 1 error <<< FAILURES!
[...truncated 49373 lines...]
[repro] Jenkins log URL: https://jenkins.thetaphi.de/job/Lucene-Solr-8.x-MacOSX/929/consoleText
[repro] Revision: 7388a81d7a4f5af4eafb4f7c3b5c27f3a3939567
[repro] Ant options: "-Dargs=-XX:+UseCompressedOops -XX:+UseParallelGC"
[repro] Repro line: ant test -Dtestcase=ReplaceNodeTest -Dtests.method=test -Dtests.seed=60AA2D37950A1386 -Dtests.slow=true -Dtests.locale=dz -Dtests.timezone=Australia/Eucla -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
[repro] Repro line: ant test -Dtestcase=LeaderFailoverAfterPartitionTest -Dtests.method=test -Dtests.seed=60AA2D37950A1386 -Dtests.slow=true -Dtests.locale=de-CH -Dtests.timezone=America/Bogota -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
[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] LeaderFailoverAfterPartitionTest
[repro] ReplaceNodeTest
[repro] ant compile-test
[...truncated 3484 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=10 -Dtests.class="*.LeaderFailoverAfterPartitionTest|*.ReplaceNodeTest" -Dtests.showOutput=onerror "-Dargs=-XX:+UseCompressedOops -XX:+UseParallelGC" -Dtests.seed=60AA2D37950A1386 -Dtests.slow=true -Dtests.locale=de-CH -Dtests.timezone=America/Bogota -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
[...truncated 101 lines...]
[repro] Failures w/original seeds:
[repro] 0/5 failed: org.apache.solr.cloud.LeaderFailoverAfterPartitionTest
[repro] 0/5 failed: org.apache.solr.cloud.ReplaceNodeTest
[repro] Exiting with code 0
[...truncated 73 lines...]