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/04/17 04:52:21 UTC

[JENKINS] Lucene-Solr-master-MacOSX (64bit/jdk-11.0.6) - Build # 5892 - Unstable!

Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-MacOSX/5892/
Java: 64bit/jdk-11.0.6 -XX:+UseCompressedOops -XX:+UseParallelGC

1 tests failed.
FAILED:  org.apache.solr.cloud.autoscaling.ComputePlanActionTest.testSelectedCollections

Error Message:
Trigger was not fired even after 5 seconds

Stack Trace:
java.lang.AssertionError: Trigger was not fired even after 5 seconds
	at __randomizedtesting.SeedInfo.seed([E1EC4355B660FE62:DB42A68C8804270C]:0)
	at org.junit.Assert.fail(Assert.java:88)
	at org.junit.Assert.assertTrue(Assert.java:41)
	at org.apache.solr.cloud.autoscaling.ComputePlanActionTest.testSelectedCollections(ComputePlanActionTest.java:507)
	at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
	at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.base/java.lang.reflect.Method.invoke(Method.java:566)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1754)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:942)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:978)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:992)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:370)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:819)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:470)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:951)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:836)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:887)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:898)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:370)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.lambda$forkTimeoutingTask$0(ThreadLeakControl.java:826)
	at java.base/java.lang.Thread.run(Thread.java:834)




Build Log:
[...truncated 13253 lines...]
   [junit4] Suite: org.apache.solr.cloud.autoscaling.ComputePlanActionTest
   [junit4]   2> 320172 INFO  (SUITE-ComputePlanActionTest-seed#[E1EC4355B660FE62]-worker) [     ] o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to test-framework derived value of '/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/server/solr/configsets/_default/conf'
   [junit4]   2> 320172 INFO  (SUITE-ComputePlanActionTest-seed#[E1EC4355B660FE62]-worker) [     ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 320174 INFO  (SUITE-ComputePlanActionTest-seed#[E1EC4355B660FE62]-worker) [     ] o.a.s.SolrTestCaseJ4 Created dataDir: /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.ComputePlanActionTest_E1EC4355B660FE62-001/data-dir-16-001
   [junit4]   2> 320179 WARN  (SUITE-ComputePlanActionTest-seed#[E1EC4355B660FE62]-worker) [     ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=64 numCloses=64
   [junit4]   2> 320180 INFO  (SUITE-ComputePlanActionTest-seed#[E1EC4355B660FE62]-worker) [     ] o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 320182 INFO  (SUITE-ComputePlanActionTest-seed#[E1EC4355B660FE62]-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> 320183 INFO  (SUITE-ComputePlanActionTest-seed#[E1EC4355B660FE62]-worker) [     ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 1 servers in /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.ComputePlanActionTest_E1EC4355B660FE62-001/tempDir-001
   [junit4]   2> 320183 INFO  (SUITE-ComputePlanActionTest-seed#[E1EC4355B660FE62]-worker) [     ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 320184 INFO  (ZkTestServer Run Thread) [     ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 320184 INFO  (ZkTestServer Run Thread) [     ] o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 320296 INFO  (SUITE-ComputePlanActionTest-seed#[E1EC4355B660FE62]-worker) [     ] o.a.s.c.ZkTestServer start zk server on port:53470
   [junit4]   2> 320296 INFO  (SUITE-ComputePlanActionTest-seed#[E1EC4355B660FE62]-worker) [     ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:53470
   [junit4]   2> 320296 INFO  (SUITE-ComputePlanActionTest-seed#[E1EC4355B660FE62]-worker) [     ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:53470
   [junit4]   2> 320296 INFO  (SUITE-ComputePlanActionTest-seed#[E1EC4355B660FE62]-worker) [     ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 53470
   [junit4]   2> 320302 INFO  (SUITE-ComputePlanActionTest-seed#[E1EC4355B660FE62]-worker) [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 320308 INFO  (zkConnectionManagerCallback-1357-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 320308 INFO  (SUITE-ComputePlanActionTest-seed#[E1EC4355B660FE62]-worker) [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 320316 INFO  (SUITE-ComputePlanActionTest-seed#[E1EC4355B660FE62]-worker) [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 320322 INFO  (zkConnectionManagerCallback-1359-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 320323 INFO  (SUITE-ComputePlanActionTest-seed#[E1EC4355B660FE62]-worker) [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 320325 INFO  (SUITE-ComputePlanActionTest-seed#[E1EC4355B660FE62]-worker) [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 320333 INFO  (zkConnectionManagerCallback-1361-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 320333 INFO  (SUITE-ComputePlanActionTest-seed#[E1EC4355B660FE62]-worker) [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 320442 INFO  (jetty-launcher-1362-thread-1) [     ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 320442 INFO  (jetty-launcher-1362-thread-1) [     ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 320443 INFO  (jetty-launcher-1362-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> 320445 INFO  (jetty-launcher-1362-thread-1) [     ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 320445 INFO  (jetty-launcher-1362-thread-1) [     ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 320445 INFO  (jetty-launcher-1362-thread-1) [     ] o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 320445 INFO  (jetty-launcher-1362-thread-1) [     ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@735be916{/solr,null,AVAILABLE}
   [junit4]   2> 320446 INFO  (jetty-launcher-1362-thread-1) [     ] o.e.j.s.AbstractConnector Started ServerConnector@27c46e3{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:53475}
   [junit4]   2> 320446 INFO  (jetty-launcher-1362-thread-1) [     ] o.e.j.s.Server Started @320522ms
   [junit4]   2> 320446 INFO  (jetty-launcher-1362-thread-1) [     ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=53475}
   [junit4]   2> 320446 ERROR (jetty-launcher-1362-thread-1) [     ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 320447 INFO  (jetty-launcher-1362-thread-1) [     ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 320447 INFO  (jetty-launcher-1362-thread-1) [     ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 9.0.0
   [junit4]   2> 320447 INFO  (jetty-launcher-1362-thread-1) [     ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 320447 INFO  (jetty-launcher-1362-thread-1) [     ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr
   [junit4]   2> 320447 INFO  (jetty-launcher-1362-thread-1) [     ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2020-04-17T03:53:41.735164Z
   [junit4]   2> 320448 INFO  (jetty-launcher-1362-thread-1) [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 320452 INFO  (zkConnectionManagerCallback-1364-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 320452 INFO  (jetty-launcher-1362-thread-1) [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 320454 INFO  (jetty-launcher-1362-thread-1) [     ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 320562 INFO  (jetty-launcher-1362-thread-1) [     ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 320565 WARN  (jetty-launcher-1362-thread-1) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@6d9b70eb[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 320565 WARN  (jetty-launcher-1362-thread-1) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@6d9b70eb[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 320569 WARN  (jetty-launcher-1362-thread-1) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@36c26666[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 320569 WARN  (jetty-launcher-1362-thread-1) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@36c26666[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 320570 INFO  (jetty-launcher-1362-thread-1) [     ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:53470/solr
   [junit4]   2> 320572 INFO  (jetty-launcher-1362-thread-1) [n:127.0.0.1:53475_solr     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 320580 INFO  (zkConnectionManagerCallback-1375-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 320580 INFO  (jetty-launcher-1362-thread-1) [n:127.0.0.1:53475_solr     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 320801 INFO  (jetty-launcher-1362-thread-1) [n:127.0.0.1:53475_solr     ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:53475_solr
   [junit4]   2> 320802 INFO  (jetty-launcher-1362-thread-1) [n:127.0.0.1:53475_solr     ] o.a.s.c.Overseer Overseer (id=72060964311007236-127.0.0.1:53475_solr-n_0000000000) starting
   [junit4]   2> 320825 INFO  (OverseerStateUpdate-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [n:127.0.0.1:53475_solr     ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:53475_solr
   [junit4]   2> 320826 INFO  (jetty-launcher-1362-thread-1) [n:127.0.0.1:53475_solr     ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:53475_solr
   [junit4]   2> 320826 DEBUG (OverseerAutoScalingTriggerThread-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [     ] o.a.s.c.a.OverseerTriggerThread Adding .auto_add_replicas and .scheduled_maintenance triggers
   [junit4]   2> 320833 DEBUG (OverseerAutoScalingTriggerThread-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [     ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 1
   [junit4]   2> 320833 INFO  (OverseerStateUpdate-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [n:127.0.0.1:53475_solr     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 320834 DEBUG (OverseerAutoScalingTriggerThread-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [     ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion 0
   [junit4]   2> 320835 DEBUG (OverseerAutoScalingTriggerThread-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [     ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 1
   [junit4]   2> 320842 INFO  (jetty-launcher-1362-thread-1) [n:127.0.0.1:53475_solr     ] o.a.s.p.PackageLoader /packages.json updated to version -1
   [junit4]   2> 320843 WARN  (jetty-launcher-1362-thread-1) [n:127.0.0.1:53475_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> 320849 DEBUG (OverseerAutoScalingTriggerThread-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [     ] o.a.s.c.a.NodeLostTrigger NodeLostTrigger .auto_add_replicas - Initial livenodes: [127.0.0.1:53475_solr]
   [junit4]   2> 320851 DEBUG (OverseerAutoScalingTriggerThread-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [     ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost / nodeAdded markers
   [junit4]   2> 320854 DEBUG (OverseerAutoScalingTriggerThread-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [     ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion 1
   [junit4]   2> 320854 DEBUG (ScheduledTrigger-1380-thread-1) [     ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 and last live nodes: 1
   [junit4]   2> 320864 INFO  (jetty-launcher-1362-thread-1) [n:127.0.0.1:53475_solr     ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
   [junit4]   2> 320900 INFO  (jetty-launcher-1362-thread-1) [n:127.0.0.1:53475_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_53475.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7baa0d93
   [junit4]   2> 320907 INFO  (jetty-launcher-1362-thread-1) [n:127.0.0.1:53475_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_53475.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7baa0d93
   [junit4]   2> 320908 INFO  (jetty-launcher-1362-thread-1) [n:127.0.0.1:53475_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_53475.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7baa0d93
   [junit4]   2> 320909 INFO  (jetty-launcher-1362-thread-1) [n:127.0.0.1:53475_solr     ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.ComputePlanActionTest_E1EC4355B660FE62-001/tempDir-001/node1/.
   [junit4]   2> 320924 INFO  (SUITE-ComputePlanActionTest-seed#[E1EC4355B660FE62]-worker) [     ] o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=1
   [junit4]   2> 320925 INFO  (SUITE-ComputePlanActionTest-seed#[E1EC4355B660FE62]-worker) [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 320927 INFO  (zkConnectionManagerCallback-1392-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 320927 INFO  (SUITE-ComputePlanActionTest-seed#[E1EC4355B660FE62]-worker) [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 320930 INFO  (SUITE-ComputePlanActionTest-seed#[E1EC4355B660FE62]-worker) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 320933 INFO  (SUITE-ComputePlanActionTest-seed#[E1EC4355B660FE62]-worker) [     ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:53470/solr ready
   [junit4] IGNOR/A 0.00s J0 | ComputePlanActionTest.testNodeLost
   [junit4]    > Assumption #1: 'awaitsfix' test group is disabled (@AwaitsFix(bugUrl="https://issues.apache.org/jira/browse/SOLR-12028"))
   [junit4]   2> 320956 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.a.s.SolrTestCaseJ4 ###Starting testSelectedCollections
   [junit4]   2> 320958 DEBUG (zkCallback-1374-thread-1) [     ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 2
   [junit4]   2> 320958 DEBUG (OverseerAutoScalingTriggerThread-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [     ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 2
   [junit4]   2> 320960 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 320967 DEBUG (OverseerAutoScalingTriggerThread-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [     ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost / nodeAdded markers
   [junit4]   2> 320968 DEBUG (OverseerAutoScalingTriggerThread-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [     ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 2, lastZnodeVersion 2
   [junit4]   2> 320974 INFO  (qtp213625092-3619) [n:127.0.0.1:53475_solr     ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=0
   [junit4]   2> 320974 DEBUG (qtp213625092-3617) [n:127.0.0.1:53475_solr     ] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
   [junit4]   2> 320975 INFO  (qtp213625092-3617) [n:127.0.0.1:53475_solr     ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling params={wt=javabin&version=2} status=0 QTime=7
   [junit4]   2> 320977 DEBUG (zkCallback-1374-thread-1) [     ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 3
   [junit4]   2> 320977 DEBUG (OverseerAutoScalingTriggerThread-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [     ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 3
   [junit4]   2> 320977 DEBUG (OverseerAutoScalingTriggerThread-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [     ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost / nodeAdded markers
   [junit4]   2> 320979 DEBUG (OverseerAutoScalingTriggerThread-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [     ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 3, lastZnodeVersion 3
   [junit4]   2> 320981 INFO  (qtp213625092-3618) [n:127.0.0.1:53475_solr     ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=0
   [junit4]   2> 320982 DEBUG (qtp213625092-3616) [n:127.0.0.1:53475_solr     ] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
   [junit4]   2> 320982 INFO  (qtp213625092-3616) [n:127.0.0.1:53475_solr     ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling params={wt=javabin&version=2} status=0 QTime=5
   [junit4]   2> 320983 DEBUG (zkCallback-1374-thread-1) [     ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 4
   [junit4]   2> 320983 DEBUG (OverseerAutoScalingTriggerThread-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [     ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 4
   [junit4]   2> 320983 DEBUG (OverseerAutoScalingTriggerThread-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [     ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost / nodeAdded markers
   [junit4]   2> 320986 DEBUG (OverseerAutoScalingTriggerThread-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [     ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 4, lastZnodeVersion 4
   [junit4]   2> 320988 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.a.s.c.a.ComputePlanActionTest Found number of jetties: 1
   [junit4]   2> 320988 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 320988 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 320988 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] 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> 320990 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 320990 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 320990 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 320990 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@3bdd0d1b{/solr,null,AVAILABLE}
   [junit4]   2> 320992 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.e.j.s.AbstractConnector Started ServerConnector@43493fb9{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:53481}
   [junit4]   2> 320992 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.e.j.s.Server Started @321068ms
   [junit4]   2> 320992 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=53481}
   [junit4]   2> 320992 ERROR (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 320992 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 320992 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 9.0.0
   [junit4]   2> 320992 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 320992 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr
   [junit4]   2> 320992 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2020-04-17T03:53:42.280924Z
   [junit4]   2> 320993 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 320998 INFO  (zkConnectionManagerCallback-1396-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 320998 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 321000 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 321115 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 321117 WARN  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@45174e2c[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 321117 WARN  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@45174e2c[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 321121 WARN  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@621151fc[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 321121 WARN  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@621151fc[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 321122 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:53470/solr
   [junit4]   2> 321123 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [n:127.0.0.1:53481_solr     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 321126 INFO  (zkConnectionManagerCallback-1407-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 321126 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [n:127.0.0.1:53481_solr     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 321144 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [n:127.0.0.1:53481_solr     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 321159 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [n:127.0.0.1:53481_solr     ] o.a.s.c.ZkController Publish node=127.0.0.1:53481_solr as DOWN
   [junit4]   2> 321162 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [n:127.0.0.1:53481_solr     ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 1000 transient cores
   [junit4]   2> 321162 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [n:127.0.0.1:53481_solr     ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:53481_solr
   [junit4]   2> 321164 DEBUG (OverseerStateUpdate-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [n:127.0.0.1:53475_solr     ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
   [junit4]   2>   "operation":"downnode",
   [junit4]   2>   "node_name":"127.0.0.1:53481_solr"} current state version: 0
   [junit4]   2> 321164 DEBUG (OverseerStateUpdate-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [n:127.0.0.1:53475_solr     ] o.a.s.c.o.NodeMutator DownNode state invoked for node: 127.0.0.1:53481_solr
   [junit4]   2> 321166 INFO  (zkCallback-1374-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 321166 INFO  (zkCallback-1391-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 321166 INFO  (zkCallback-1406-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 321166 INFO  (zkCallback-1391-thread-2) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 321170 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [n:127.0.0.1:53481_solr     ] o.a.s.p.PackageLoader /packages.json updated to version -1
   [junit4]   2> 321170 WARN  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [n:127.0.0.1:53481_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> 321199 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [n:127.0.0.1:53481_solr     ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
   [junit4]   2> 321226 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [n:127.0.0.1:53481_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_53481.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7baa0d93
   [junit4]   2> 321236 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [n:127.0.0.1:53481_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_53481.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7baa0d93
   [junit4]   2> 321236 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [n:127.0.0.1:53481_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_53481.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7baa0d93
   [junit4]   2> 321237 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [n:127.0.0.1:53481_solr     ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.ComputePlanActionTest_E1EC4355B660FE62-001/tempDir-001/node2/.
   [junit4]   2> 321244 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 321244 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 321244 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] 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> 321246 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 321246 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 321246 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 321247 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@4b21a5e1{/solr,null,AVAILABLE}
   [junit4]   2> 321248 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.e.j.s.AbstractConnector Started ServerConnector@1b794851{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:53488}
   [junit4]   2> 321248 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.e.j.s.Server Started @321324ms
   [junit4]   2> 321248 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=53488}
   [junit4]   2> 321248 ERROR (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 321248 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 321248 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 9.0.0
   [junit4]   2> 321248 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 321248 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr
   [junit4]   2> 321248 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2020-04-17T03:53:42.536836Z
   [junit4]   2> 321250 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 321252 INFO  (zkConnectionManagerCallback-1417-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 321252 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 321254 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 321364 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 321366 WARN  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@713f38d3[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 321366 WARN  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@713f38d3[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 321369 WARN  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@54727c3e[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 321369 WARN  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@54727c3e[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 321371 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:53470/solr
   [junit4]   2> 321373 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [n:127.0.0.1:53488_solr     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 321375 INFO  (zkConnectionManagerCallback-1428-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 321375 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [n:127.0.0.1:53488_solr     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 321390 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [n:127.0.0.1:53488_solr     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 321406 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [n:127.0.0.1:53488_solr     ] o.a.s.c.ZkController Publish node=127.0.0.1:53488_solr as DOWN
   [junit4]   2> 321410 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [n:127.0.0.1:53488_solr     ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 1000 transient cores
   [junit4]   2> 321410 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [n:127.0.0.1:53488_solr     ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:53488_solr
   [junit4]   2> 321412 DEBUG (OverseerStateUpdate-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [n:127.0.0.1:53475_solr     ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
   [junit4]   2>   "operation":"downnode",
   [junit4]   2>   "node_name":"127.0.0.1:53488_solr"} current state version: 0
   [junit4]   2> 321412 DEBUG (OverseerStateUpdate-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [n:127.0.0.1:53475_solr     ] o.a.s.c.o.NodeMutator DownNode state invoked for node: 127.0.0.1:53488_solr
   [junit4]   2> 321416 INFO  (zkCallback-1391-thread-2) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 321416 INFO  (zkCallback-1391-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 321417 INFO  (zkCallback-1374-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 321417 INFO  (zkCallback-1427-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 321418 INFO  (zkCallback-1406-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 321424 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [n:127.0.0.1:53488_solr     ] o.a.s.p.PackageLoader /packages.json updated to version -1
   [junit4]   2> 321425 WARN  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [n:127.0.0.1:53488_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> 321446 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [n:127.0.0.1:53488_solr     ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
   [junit4]   2> 321472 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [n:127.0.0.1:53488_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_53488.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7baa0d93
   [junit4]   2> 321481 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [n:127.0.0.1:53488_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_53488.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7baa0d93
   [junit4]   2> 321482 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [n:127.0.0.1:53488_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_53488.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7baa0d93
   [junit4]   2> 321483 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [n:127.0.0.1:53488_solr     ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.ComputePlanActionTest_E1EC4355B660FE62-001/tempDir-001/node3/.
   [junit4]   2> 321497 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 321497 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 321497 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] 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> 321501 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 321501 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 321501 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 321502 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@45d551a6{/solr,null,AVAILABLE}
   [junit4]   2> 321504 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.e.j.s.AbstractConnector Started ServerConnector@7ca36a61{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:53491}
   [junit4]   2> 321504 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.e.j.s.Server Started @321580ms
   [junit4]   2> 321504 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=53491}
   [junit4]   2> 321505 ERROR (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 321505 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 321505 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 9.0.0
   [junit4]   2> 321505 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 321505 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr
   [junit4]   2> 321505 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2020-04-17T03:53:42.793346Z
   [junit4]   2> 321506 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 321511 INFO  (zkConnectionManagerCallback-1438-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 321511 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 321512 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 321630 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 321633 WARN  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@1d75f127[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 321633 WARN  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@1d75f127[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 321639 WARN  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@40b4d16d[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 321639 WARN  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@40b4d16d[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 321640 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:53470/solr
   [junit4]   2> 321642 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [n:127.0.0.1:53491_solr     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 321645 INFO  (zkConnectionManagerCallback-1449-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 321645 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [n:127.0.0.1:53491_solr     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 321676 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [n:127.0.0.1:53491_solr     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
   [junit4]   2> 321694 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [n:127.0.0.1:53491_solr     ] o.a.s.c.ZkController Publish node=127.0.0.1:53491_solr as DOWN
   [junit4]   2> 321698 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [n:127.0.0.1:53491_solr     ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 1000 transient cores
   [junit4]   2> 321698 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [n:127.0.0.1:53491_solr     ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:53491_solr
   [junit4]   2> 321704 DEBUG (OverseerStateUpdate-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [n:127.0.0.1:53475_solr     ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
   [junit4]   2>   "operation":"downnode",
   [junit4]   2>   "node_name":"127.0.0.1:53491_solr"} current state version: 0
   [junit4]   2> 321705 DEBUG (OverseerStateUpdate-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [n:127.0.0.1:53475_solr     ] o.a.s.c.o.NodeMutator DownNode state invoked for node: 127.0.0.1:53491_solr
   [junit4]   2> 321707 INFO  (zkCallback-1374-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 321708 INFO  (zkCallback-1406-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 321708 INFO  (zkCallback-1391-thread-2) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 321708 INFO  (zkCallback-1391-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 321709 INFO  (zkCallback-1427-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 321709 INFO  (zkCallback-1448-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 321713 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [n:127.0.0.1:53491_solr     ] o.a.s.p.PackageLoader /packages.json updated to version -1
   [junit4]   2> 321714 WARN  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [n:127.0.0.1:53491_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> 321739 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [n:127.0.0.1:53491_solr     ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
   [junit4]   2> 321770 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [n:127.0.0.1:53491_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_53491.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7baa0d93
   [junit4]   2> 321783 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [n:127.0.0.1:53491_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_53491.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7baa0d93
   [junit4]   2> 321784 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [n:127.0.0.1:53491_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_53491.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7baa0d93
   [junit4]   2> 321785 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [n:127.0.0.1:53491_solr     ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.ComputePlanActionTest_E1EC4355B660FE62-001/tempDir-001/node4/.
   [junit4]   2> 321805 INFO  (TEST-ComputePlanActionTest.testSelectedCollections-seed#[E1EC4355B660FE62]) [     ] o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=4
   [junit4]   2> 321820 INFO  (qtp213625092-3617) [n:127.0.0.1:53475_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> 321826 INFO  (qtp85362706-3655) [n:127.0.0.1:53481_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> 321830 INFO  (qtp943504459-3679) [n:127.0.0.1:53488_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> 321834 INFO  (qtp130645154-3703) [n:127.0.0.1:53491_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=1
   [junit4]   2> 321835 DEBUG (qtp213625092-3619) [n:127.0.0.1:53475_solr     ] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
   [junit4]   2> 321838 INFO  (qtp213625092-3619) [n:127.0.0.1:53475_solr     ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling params={wt=javabin&version=2} status=0 QTime=32
   [junit4]   2> 321840 DEBUG (zkCallback-1374-thread-1) [     ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 5
   [junit4]   2> 321842 DEBUG (OverseerAutoScalingTriggerThread-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [     ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 5
   [junit4]   2> 321842 INFO  (qtp213625092-3618) [n:127.0.0.1:53475_solr     ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params collection.configName=conf&name=testSelected1&nrtReplicas=2&action=CREATE&numShards=2&wt=javabin&version=2 and sendToOCPQueue=true
   [junit4]   2> 321856 DEBUG (OverseerAutoScalingTriggerThread-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [     ] o.a.s.c.a.NodeLostTrigger NodeLostTrigger node_lost_trigger - Initial livenodes: [127.0.0.1:53488_solr, 127.0.0.1:53475_solr, 127.0.0.1:53481_solr, 127.0.0.1:53491_solr]
   [junit4]   2> 321857 DEBUG (OverseerAutoScalingTriggerThread-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [     ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost / nodeAdded markers
   [junit4]   2> 321862 DEBUG (OverseerAutoScalingTriggerThread-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [     ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 5, lastZnodeVersion 5
   [junit4]   2> 321862 DEBUG (ScheduledTrigger-1380-thread-3) [     ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: node_lost_trigger with currently live nodes: 4 and last live nodes: 4
   [junit4]   2> 321867 INFO  (OverseerThreadFactory-1382-thread-1-processing-n:127.0.0.1:53475_solr) [n:127.0.0.1:53475_solr     ] o.a.s.c.a.c.CreateCollectionCmd Create collection testSelected1
   [junit4]   2> 321882 DEBUG (OverseerStateUpdate-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [n:127.0.0.1:53475_solr     ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
   [junit4]   2>   "name":"testSelected1",
   [junit4]   2>   "fromApi":"true",
   [junit4]   2>   "collection.configName":"conf",
   [junit4]   2>   "numShards":"2",
   [junit4]   2>   "nrtReplicas":"2",
   [junit4]   2>   "stateFormat":"2",
   [junit4]   2>   "replicationFactor":"2",
   [junit4]   2>   "operation":"create"} current state version: 0
   [junit4]   2> 321882 DEBUG (OverseerStateUpdate-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [n:127.0.0.1:53475_solr     ] o.a.s.c.o.ClusterStateMutator building a new cName: testSelected1
   [junit4]   2> 321883 DEBUG (OverseerStateUpdate-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [n:127.0.0.1:53475_solr     ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/testSelected1/state.json
   [junit4]   2> 322003 INFO  (qtp943504459-3680) [n:127.0.0.1:53488_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> 322004 INFO  (qtp213625092-3616) [n:127.0.0.1:53475_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> 322007 INFO  (qtp85362706-3656) [n:127.0.0.1:53481_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> 322010 INFO  (qtp130645154-3704) [n:127.0.0.1:53491_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> 322015 INFO  (qtp943504459-3681) [n:127.0.0.1:53488_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> 322016 INFO  (qtp213625092-3617) [n:127.0.0.1:53475_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> 322020 INFO  (qtp85362706-3657) [n:127.0.0.1:53481_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> 322022 INFO  (qtp130645154-3705) [n:127.0.0.1:53491_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> 322052 DEBUG (OverseerStateUpdate-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [n:127.0.0.1:53475_solr     ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"testSelected1",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"testSelected1_shard1_replica_n1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:53491/solr",
   [junit4]   2>   "node_name":"127.0.0.1:53491_solr",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} current state version: 0
   [junit4]   2> 322052 INFO  (OverseerStateUpdate-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [n:127.0.0.1:53475_solr     ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"testSelected1",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"testSelected1_shard1_replica_n1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:53491/solr",
   [junit4]   2>   "node_name":"127.0.0.1:53491_solr",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 322064 DEBUG (OverseerStateUpdate-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [n:127.0.0.1:53475_solr     ] o.a.s.c.o.SliceMutator Old Slice: shard1:{
   [junit4]   2>   "range":"80000000-ffffffff",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "replicas":{}}
   [junit4]   2> 322065 DEBUG (OverseerStateUpdate-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [n:127.0.0.1:53475_solr     ] o.a.s.c.o.SliceMutator New Slice: shard1:{
   [junit4]   2>   "range":"80000000-ffffffff",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "replicas":{"core_node3":{
   [junit4]   2>       "core":"testSelected1_shard1_replica_n1",
   [junit4]   2>       "base_url":"http://127.0.0.1:53491/solr",
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":"127.0.0.1:53491_solr",
   [junit4]   2>       "type":"NRT"}}}
   [junit4]   2> 322069 DEBUG (OverseerStateUpdate-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [n:127.0.0.1:53475_solr     ] o.a.s.c.Overseer processMessage: queueSize: 2, message = {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"testSelected1",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"testSelected1_shard1_replica_n2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:53481/solr",
   [junit4]   2>   "node_name":"127.0.0.1:53481_solr",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} current state version: 0
   [junit4]   2> 322069 INFO  (OverseerStateUpdate-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [n:127.0.0.1:53475_solr     ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"testSelected1",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"testSelected1_shard1_replica_n2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:53481/solr",
   [junit4]   2>   "node_name":"127.0.0.1:53481_solr",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 322073 DEBUG (OverseerStateUpdate-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [n:127.0.0.1:53475_solr     ] o.a.s.c.o.SliceMutator Old Slice: shard1:{
   [junit4]   2>   "range":"80000000-ffffffff",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "replicas":{"core_node3":{
   [junit4]   2>       "core":"testSelected1_shard1_replica_n1",
   [junit4]   2>       "base_url":"http://127.0.0.1:53491/solr",
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":"127.0.0.1:53491_solr",
   [junit4]   2>       "type":"NRT"}}}
   [junit4]   2> 322073 DEBUG (OverseerStateUpdate-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [n:127.0.0.1:53475_solr     ] o.a.s.c.o.SliceMutator New Slice: shard1:{
   [junit4]   2>   "range":"80000000-ffffffff",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "replicas":{
   [junit4]   2>     "core_node3":{
   [junit4]   2>       "core":"testSelected1_shard1_replica_n1",
   [junit4]   2>       "base_url":"http://127.0.0.1:53491/solr",
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":"127.0.0.1:53491_solr",
   [junit4]   2>       "type":"NRT"},
   [junit4]   2>     "core_node5":{
   [junit4]   2>       "core":"testSelected1_shard1_replica_n2",
   [junit4]   2>       "base_url":"http://127.0.0.1:53481/solr",
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":"127.0.0.1:53481_solr",
   [junit4]   2>       "type":"NRT"}}}
   [junit4]   2> 322078 DEBUG (OverseerStateUpdate-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [n:127.0.0.1:53475_solr     ] o.a.s.c.Overseer processMessage: queueSize: 3, message = {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"testSelected1",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "core":"testSelected1_shard2_replica_n4",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:53475/solr",
   [junit4]   2>   "node_name":"127.0.0.1:53475_solr",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} current state version: 0
   [junit4]   2> 322078 INFO  (OverseerStateUpdate-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [n:127.0.0.1:53475_solr     ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"testSelected1",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "core":"testSelected1_shard2_replica_n4",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:53475/solr",
   [junit4]   2>   "node_name":"127.0.0.1:53475_solr",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 322089 DEBUG (OverseerStateUpdate-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [n:127.0.0.1:53475_solr     ] o.a.s.c.o.SliceMutator Old Slice: shard2:{
   [junit4]   2>   "range":"0-7fffffff",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "replicas":{}}
   [junit4]   2> 322089 DEBUG (OverseerStateUpdate-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [n:127.0.0.1:53475_solr     ] o.a.s.c.o.SliceMutator New Slice: shard2:{
   [junit4]   2>   "range":"0-7fffffff",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "replicas":{"core_node7":{
   [junit4]   2>       "core":"testSelected1_shard2_replica_n4",
   [junit4]   2>       "base_url":"http://127.0.0.1:53475/solr",
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":"127.0.0.1:53475_solr",
   [junit4]   2>       "type":"NRT"}}}
   [junit4]   2> 322092 DEBUG (OverseerStateUpdate-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [n:127.0.0.1:53475_solr     ] o.a.s.c.Overseer processMessage: queueSize: 4, message = {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"testSelected1",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "core":"testSelected1_shard2_replica_n6",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:53488/solr",
   [junit4]   2>   "node_name":"127.0.0.1:53488_solr",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} current state version: 0
   [junit4]   2> 322092 INFO  (OverseerStateUpdate-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [n:127.0.0.1:53475_solr     ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"testSelected1",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "core":"testSelected1_shard2_replica_n6",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:53488/solr",
   [junit4]   2>   "node_name":"127.0.0.1:53488_solr",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 322096 DEBUG (OverseerStateUpdate-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [n:127.0.0.1:53475_solr     ] o.a.s.c.o.SliceMutator Old Slice: shard2:{
   [junit4]   2>   "range":"0-7fffffff",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "replicas":{"core_node7":{
   [junit4]   2>       "core":"testSelected1_shard2_replica_n4",
   [junit4]   2>       "base_url":"http://127.0.0.1:53475/solr",
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":"127.0.0.1:53475_solr",
   [junit4]   2>       "type":"NRT"}}}
   [junit4]   2> 322096 DEBUG (OverseerStateUpdate-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [n:127.0.0.1:53475_solr     ] o.a.s.c.o.SliceMutator New Slice: shard2:{
   [junit4]   2>   "range":"0-7fffffff",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "replicas":{
   [junit4]   2>     "core_node7":{
   [junit4]   2>       "core":"testSelected1_shard2_replica_n4",
   [junit4]   2>       "base_url":"http://127.0.0.1:53475/solr",
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":"127.0.0.1:53475_solr",
   [junit4]   2>       "type":"NRT"},
   [junit4]   2>     "core_node8":{
   [junit4]   2>       "core":"testSelected1_shard2_replica_n6",
   [junit4]   2>       "base_url":"http://127.0.0.1:53488/solr",
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":"127.0.0.1:53488_solr",
   [junit4]   2>       "type":"NRT"}}}
   [junit4]   2> 322202 DEBUG (OverseerStateUpdate-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [n:127.0.0.1:53475_solr     ] o.a.s.c.o.ZkStateWriter going to update_collection /collections/testSelected1/state.json version: 0
   [junit4]   2> 322307 INFO  (qtp213625092-3619) [n:127.0.0.1:53475_solr    x:testSelected1_shard2_replica_n4 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node7&collection.configName=conf&newCollection=true&name=testSelected1_shard2_replica_n4&action=CREATE&numShards=2&collection=testSelected1&shard=shard2&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 322307 INFO  (qtp85362706-3654) [n:127.0.0.1:53481_solr    x:testSelected1_shard1_replica_n2 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node5&collection.configName=conf&newCollection=true&name=testSelected1_shard1_replica_n2&action=CREATE&numShards=2&collection=testSelected1&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 322307 INFO  (qtp213625092-3619) [n:127.0.0.1:53475_solr    x:testSelected1_shard2_replica_n4 ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 1000 transient cores
   [junit4]   2> 322307 INFO  (qtp130645154-3702) [n:127.0.0.1:53491_solr    x:testSelected1_shard1_replica_n1 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=testSelected1_shard1_replica_n1&action=CREATE&numShards=2&collection=testSelected1&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 322309 INFO  (qtp943504459-3678) [n:127.0.0.1:53488_solr    x:testSelected1_shard2_replica_n6 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node8&collection.configName=conf&newCollection=true&name=testSelected1_shard2_replica_n6&action=CREATE&numShards=2&collection=testSelected1&shard=shard2&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 322325 DEBUG (OverseerStateUpdate-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [n:127.0.0.1:53475_solr     ] o.a.s.c.Overseer processMessage: queueSize: 2, message = {
   [junit4]   2>   "core":"testSelected1_shard1_replica_n2",
   [junit4]   2>   "core_node_name":"core_node5",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"http://127.0.0.1:53481/solr",
   [junit4]   2>   "node_name":"127.0.0.1:53481_solr",
   [junit4]   2>   "numShards":"2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"testSelected1",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "force_set_state":"false",
   [junit4]   2>   "operation":"state"} current state version: 0
   [junit4]   2> 322325 DEBUG (OverseerStateUpdate-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [n:127.0.0.1:53475_solr     ] o.a.s.c.o.ReplicaMutator Update state numShards=2 message={
   [junit4]   2>   "core":"testSelected1_shard1_replica_n2",
   [junit4]   2>   "core_node_name":"core_node5",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"http://127.0.0.1:53481/solr",
   [junit4]   2>   "node_name":"127.0.0.1:53481_solr",
   [junit4]   2>   "numShards":"2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"testSelected1",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "force_set_state":"false",
   [junit4]   2>   "operation":"state"}
   [junit4]   2> 322325 DEBUG (OverseerStateUpdate-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [n:127.0.0.1:53475_solr     ] o.a.s.c.o.ReplicaMutator Will update state for replica: core_node5:{
   [junit4]   2>   "core":"testSelected1_shard1_replica_n2",
   [junit4]   2>   "base_url":"http://127.0.0.1:53481/solr",
   [junit4]   2>   "node_name":"127.0.0.1:53481_solr",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "force_set_state":"false"}
   [junit4]   2> 322325 DEBUG (OverseerStateUpdate-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [n:127.0.0.1:53475_solr     ] o.a.s.c.o.ReplicaMutator Collection is now: DocCollection(testSelected1//collections/testSelected1/state.json/1)={
   [junit4]   2>   "pullReplicas":"0",
   [junit4]   2>   "replicationFactor":"2",
   [junit4]   2>   "router":{"name":"compositeId"},
   [junit4]   2>   "maxShardsPerNode":"1",
   [junit4]   2>   "autoAddReplicas":"false",
   [junit4]   2>   "nrtReplicas":"2",
   [junit4]   2>   "tlogReplicas":"0",
   [junit4]   2>   "shards":{
   [junit4]   2>     "shard1":{
   [junit4]   2>       "range":"80000000-ffffffff",
   [junit4]   2>       "state":"active",
   [junit4]   2>       "replicas":{
   [junit4]   2>         "core_node3":{
   [junit4]   2>           "core":"testSelected1_shard1_replica_n1",
   [junit4]   2>           "base_url":"http://127.0.0.1:53491/solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "node_name":"127.0.0.1:53491_solr",
   [junit4]   2>           "type":"NRT"},
   [junit4]   2>         "core_node5":{
   [junit4]   2>           "core":"testSelected1_shard1_replica_n2",
   [junit4]   2>           "base_url":"http://127.0.0.1:53481/solr",
   [junit4]   2>           "node_name":"127.0.0.1:53481_solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "force_set_state":"false"}}},
   [junit4]   2>     "shard2":{
   [junit4]   2>       "range":"0-7fffffff",
   [junit4]   2>       "state":"active",
   [junit4]   2>       "replicas":{
   [junit4]   2>         "core_node7":{
   [junit4]   2>           "core":"testSelected1_shard2_replica_n4",
   [junit4]   2>           "base_url":"http://127.0.0.1:53475/solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "node_name":"127.0.0.1:53475_solr",
   [junit4]   2>           "type":"NRT"},
   [junit4]   2>         "core_node8":{
   [junit4]   2>           "core":"testSelected1_shard2_replica_n6",
   [junit4]   2>           "base_url":"http://127.0.0.1:53488/solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "node_name":"127.0.0.1:53488_solr",
   [junit4]   2>           "type":"NRT"}}}}}
   [junit4]   2> 322325 DEBUG (OverseerStateUpdate-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [n:127.0.0.1:53475_solr     ] o.a.s.c.Overseer processMessage: queueSize: 2, message = {
   [junit4]   2>   "core":"testSelected1_shard2_replica_n6",
   [junit4]   2>   "core_node_name":"core_node8",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"http://127.0.0.1:53488/solr",
   [junit4]   2>   "node_name":"127.0.0.1:53488_solr",
   [junit4]   2>   "numShards":"2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "collection":"testSelected1",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "force_set_state":"false",
   [junit4]   2>   "operation":"state"} current state version: 0
   [junit4]   2> 322325 DEBUG (OverseerStateUpdate-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [n:127.0.0.1:53475_solr     ] o.a.s.c.o.ReplicaMutator Update state numShards=2 message={
   [junit4]   2>   "core":"testSelected1_shard2_replica_n6",
   [junit4]   2>   "core_node_name":"core_node8",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"http://127.0.0.1:53488/solr",
   [junit4]   2>   "node_name":"127.0.0.1:53488_solr",
   [junit4]   2>   "numShards":"2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "collection":"testSelected1",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "force_set_state":"false",
   [junit4]   2>   "operation":"state"}
   [junit4]   2> 322325 DEBUG (OverseerStateUpdate-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [n:127.0.0.1:53475_solr     ] o.a.s.c.o.ReplicaMutator Will update state for replica: core_node8:{
   [junit4]   2>   "core":"testSelected1_shard2_replica_n6",
   [junit4]   2>   "base_url":"http://127.0.0.1:53488/solr",
   [junit4]   2>   "node_name":"127.0.0.1:53488_solr",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "force_set_state":"false"}
   [junit4]   2> 322325 DEBUG (OverseerStateUpdate-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [n:127.0.0.1:53475_solr     ] o.a.s.c.o.ReplicaMutator Collection is now: DocCollection(testSelected1//collections/testSelected1/state.json/1)={
   [junit4]   2>   "pullReplicas":"0",
   [junit4]   2>   "replicationFactor":"2",
   [junit4]   2>   "router":{"name":"compositeId"},
   [junit4]   2>   "maxShardsPerNode":"1",
   [junit4]   2>   "autoAddReplicas":"false",
   [junit4]   2>   "nrtReplicas":"2",
   [junit4]   2>   "tlogReplicas":"0",
   [junit4]   2>   "shards":{
   [junit4]   2>     "shard1":{
   [junit4]   2>       "range":"80000000-ffffffff",
   [junit4]   2>       "state":"active",
   [junit4]   2>       "replicas":{
   [junit4]   2>         "core_node3":{
   [junit4]   2>           "core":"testSelected1_shard1_replica_n1",
   [junit4]   2>           "base_url":"http://127.0.0.1:53491/solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "node_name":"127.0.0.1:53491_solr",
   [junit4]   2>           "type":"NRT"},
   [junit4]   2>         "core_node5":{
   [junit4]   2>           "core":"testSelected1_shard1_replica_n2",
   [junit4]   2>           "base_url":"http://127.0.0.1:53481/solr",
   [junit4]   2>           "node_name":"127.0.0.1:53481_solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "force_set_state":"false"}}},
   [junit4]   2>     "shard2":{
   [junit4]   2>       "range":"0-7fffffff",
   [junit4]   2>       "state":"active",
   [junit4]   2>       "replicas":{
   [junit4]   2>         "core_node7":{
   [junit4]   2>           "core":"testSelected1_shard2_replica_n4",
   [junit4]   2>           "base_url":"http://127.0.0.1:53475/solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "node_name":"127.0.0.1:53475_solr",
   [junit4]   2>           "type":"NRT"},
   [junit4]   2>         "core_node8":{
   [junit4]   2>           "core":"testSelected1_shard2_replica_n6",
   [junit4]   2>           "base_url":"http://127.0.0.1:53488/solr",
   [junit4]   2>           "node_name":"127.0.0.1:53488_solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "force_set_state":"false"}}}}}
   [junit4]   2> 322332 DEBUG (OverseerStateUpdate-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [n:127.0.0.1:53475_solr     ] o.a.s.c.Overseer processMessage: queueSize: 4, message = {
   [junit4]   2>   "core":"testSelected1_shard1_replica_n1",
   [junit4]   2>   "core_node_name":"core_node3",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"http://127.0.0.1:53491/solr",
   [junit4]   2>   "node_name":"127.0.0.1:53491_solr",
   [junit4]   2>   "numShards":"2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"testSelected1",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "force_set_state":"false",
   [junit4]   2>   "operation":"state"} current state version: 0
   [junit4]   2> 322332 DEBUG (OverseerStateUpdate-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [n:127.0.0.1:53475_solr     ] o.a.s.c.o.ReplicaMutator Update state numShards=2 message={
   [junit4]   2>   "core":"testSelected1_shard1_replica_n1",
   [junit4]   2>   "core_node_name":"core_node3",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"http://127.0.0.1:53491/solr",
   [junit4]   2>   "node_name":"127.0.0.1:53491_solr",
   [junit4]   2>   "numShards":"2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"testSelected1",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "force_set_state":"false",
   [junit4]   2>   "operation":"state"}
   [junit4]   2> 322332 DEBUG (OverseerStateUpdate-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [n:127.0.0.1:53475_solr     ] o.a.s.c.o.ReplicaMutator Will update state for replica: core_node3:{
   [junit4]   2>   "core":"testSelected1_shard1_replica_n1",
   [junit4]   2>   "base_url":"http://127.0.0.1:53491/solr",
   [junit4]   2>   "node_name":"127.0.0.1:53491_solr",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "force_set_state":"false"}
   [junit4]   2> 322332 DEBUG (OverseerStateUpdate-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [n:127.0.0.1:53475_solr     ] o.a.s.c.o.ReplicaMutator Collection is now: DocCollection(testSelected1//collections/testSelected1/state.json/1)={
   [junit4]   2>   "pullReplicas":"0",
   [junit4]   2>   "replicationFactor":"2",
   [junit4]   2>   "router":{"name":"compositeId"},
   [junit4]   2>   "maxShardsPerNode":"1",
   [junit4]   2>   "autoAddReplicas":"false",
   [junit4]   2>   "nrtReplicas":"2",
   [junit4]   2>   "tlogReplicas":"0",
   [junit4]   2>   "shards":{
   [junit4]   2>     "shard1":{
   [junit4]   2>       "range":"80000000-ffffffff",
   [junit4]   2>       "state":"active",
   [junit4]   2>       "replicas":{
   [junit4]   2>         "core_node3":{
   [junit4]   2>           "core":"testSelected1_shard1_replica_n1",
   [junit4]   2>           "base_url":"http://127.0.0.1:53491/solr",
   [junit4]   2>           "node_name":"127.0.0.1:53491_solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "force_set_state":"false"},
   [junit4]   2>         "core_node5":{
   [junit4]   2>           "core":"testSelected1_shard1_replica_n2",
   [junit4]   2>           "base_url":"http://127.0.0.1:53481/solr",
   [junit4]   2>           "node_name":"127.0.0.1:53481_solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "force_set_state":"false"}}},
   [junit4]   2>     "shard2":{
   [junit4]   2>       "range":"0-7fffffff",
   [junit4]   2>       "state":"active",
   [junit4]   2>       "replicas":{
   [junit4]   2>         "core_node7":{
   [junit4]   2>           "core":"testSelected1_shard2_replica_n4",
   [junit4]   2>           "base_url":"http://127.0.0.1:53475/solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "node_name":"127.0.0.1:53475_solr",
   [junit4]   2>           "type":"NRT"},
   [junit4]   2>         "core_node8":{
   [junit4]   2>           "core":"testSelected1_shard2_replica_n6",
   [junit4]   2>           "base_url":"http://127.0.0.1:53488/solr",
   [junit4]   2>           "node_name":"127.0.0.1:53488_solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "force_set_state":"false"}}}}}
   [junit4]   2> 322332 DEBUG (OverseerStateUpdate-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [n:127.0.0.1:53475_solr     ] o.a.s.c.Overseer processMessage: queueSize: 4, message = {
   [junit4]   2>   "core":"testSelected1_shard2_replica_n4",
   [junit4]   2>   "core_node_name":"core_node7",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"http://127.0.0.1:53475/solr",
   [junit4]   2>   "node_name":"127.0.0.1:53475_solr",
   [junit4]   2>   "numShards":"2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "collection":"testSelected1",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "force_set_state":"false",
   [junit4]   2>   "operation":"state"} current state version: 0
   [junit4]   2> 322332 DEBUG (OverseerStateUpdate-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [n:127.0.0.1:53475_solr     ] o.a.s.c.o.ReplicaMutator Update state numShards=2 message={
   [junit4]   2>   "core":"testSelected1_shard2_replica_n4",
   [junit4]   2>   "core_node_name":"core_node7",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"http://127.0.0.1:53475/solr",
   [junit4]   2>   "node_name":"127.0.0.1:53475_solr",
   [junit4]   2>   "numShards":"2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "collection":"testSelected1",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "force_set_state":"false",
   [junit4]   2>   "operation":"state"}
   [junit4]   2> 322332 DEBUG (OverseerStateUpdate-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [n:127.0.0.1:53475_solr     ] o.a.s.c.o.ReplicaMutator Will update state for replica: core_node7:{
   [junit4]   2>   "core":"testSelected1_shard2_replica_n4",
   [junit4]   2>   "base_url":"http://127.0.0.1:53475/solr",
   [junit4]   2>   "node_name":"127.0.0.1:53475_solr",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "force_set_state":"false"}
   [junit4]   2> 322332 DEBUG (OverseerStateUpdate-72060964311007236-127.0.0.1:53475_solr-n_0000000000) [n:127.0.0.1:53475_solr     ] o.a.s.c.o.ReplicaMutator Collection is now: DocCollection(testSelected1//collections/testSelected1/state.json/1)={
   [junit4]   2>   "pullReplicas":"0",
   [junit4]   2>   "replicationFactor":"2",
   [junit4]   2>   "router":{"name":"compositeId"},
   [junit4]   2>   "maxShardsPerNode":"1",
   [junit4]   2>   "autoAddReplicas":"false",
   [junit4]   2>   "nrtReplicas":"2",
   [junit4]   2>   "tlogReplicas":"0",
   [junit4]   2>   "shards":{
   [junit4]   2>     "shard1":{
   [junit4]   2>       "range":"80000000-ffffffff",
   [junit4]   2>       "state":"active",
   [junit4]   2>       "replicas":{
   [junit4]   2>         "core_node3":{
   [junit4]   2>           "core":"testSelected1_shard1_replica_n1",
   [junit4]   2>           "base_url":"http://127.0.0.1:53491/solr",
   [junit4]   2>           "node_name":"127.0.0.1:53491_solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "force_set_state":"false"},
   [junit4]   2>         "core_node5":{
   [junit4]   2>           "core":"testSelected1_shard1_replica_n2",
   [junit4]   2>           "base_url":"http://127.0.0.1:53481/solr",
   [junit4]   2>           "node_name":"127.0.0.1:53481_solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "force_set_state":"false"}}},
   [junit4]   2>     "shard2":{
   [junit4]   2>       "range":"0-7fffffff",
   [junit4]   2>       "state":"active",
   [junit4]   2>       "replicas":{
   [junit4]   2>         "core_node7":{
   [junit4]   2>           "core":"testSelected1_shard2_replica_n4",
   [junit4]   2>           "base_url":"http://127.0.0.1:53475/solr",
   [junit4]   2>           "node_name":"127.0.0.1:53475_solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "force_set_state":"false"},
   [junit4]   2>         "core_node8":{
   [junit4]   2>           "core":"testSelected1_shard2_replica_n6",
   [junit4]   2>           "base_url":"http://127.0.0.1:53488/solr",
   [junit4]   2>           "node_name":"127.0.0.1:53488_solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "force_set_state":"false"}}}}}
   [junit4]   2> 322345 INFO  (qtp943504459-3678) [n:127.0.0.1:53488_solr c:testSelected1 s:shard2 r:core_node8 x:testSelected1_shard2_replica_n6 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0
   [junit4]   2> 322345 INFO  (qtp85362706-3654) [n:127.0.0.1:53481_solr c:testSelected1 s:shard1 r:core_node5 x:testSelected1_shard1_replica_n2 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0
   [junit4]   2> 322347 INFO  (qtp130645154-3702) [n:127.0.0.1:53491_solr c:testSelected1 s:shard1 r:core_node3 x:testSelected1_shard1_replica_n1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0
   [junit4]   2> 322347 INFO  (qtp213625092-3619) [n:127.0.0.1:53475_solr c:testSelected1 s:shard2 r:core_node7 x:testSelected1_shard2_replica_n4 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0
   [junit4]   2> 322362 INFO  (qtp943504459-3678) [n:127.0.0.1:53488_solr c:testSelected1 s:shard2 r:core_node8 x:testSelected1_shard2_replica_n6 ] o.a.s.s.IndexSchema Schema name=minimal
   [junit4]   2> 322362 INFO  (qtp85362706-3654) [n:127.0.0.1:53481_solr c:testSelected1 s:shard1 r:core_node5 x:testSelected1_shard1_replica_n2 ] o.a.s.s.IndexSchema Schema name=minimal
   [junit4]   2> 322363 INFO  (qtp130645154-3702) [n:127.0.0.1:53491_solr c:testSelected1 s:shard1 r:core_node3 x:testSelected1_shard1_replica_n1 ] o.a.s.s.IndexSchema Schema name=minimal
   [junit4]   2> 322364 INFO  (qtp213625092-3619) [n:127.0.0.1:53475_solr c:testSelected1 s:shard2 r:core_node7 x:testSelected1_shard2_replica_n4 ] o.a.s.s.IndexSchema Schema name=minimal
   [junit4]   2> 322364 INFO  (qtp943504459-3678) [n:127.0.0.1:53488_solr c:testSelected1 s:shard2 r:core_node8 x:tes

[...truncated too long message...]

 [junit4]   2> 	6	/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOpReplicaType_1Shard_4/terms/shard1
   [junit4]   2> 	6	/solr/collections/testSelected1/terms/shard2
   [junit4]   2> 	6	/solr/collections/testSelected2/terms/shard1
   [junit4]   2> 	6	/solr/collections/testSelected1/terms/shard1
   [junit4]   2> 	6	/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOp_2Shard_1/terms/shard1
   [junit4]   2> 	6	/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOp_2Shard_2/terms/shard1
   [junit4]   2> 	6	/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOp_2Shard_2/terms/shard2
   [junit4]   2> 	6	/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOp_1Shard_2/terms/shard1
   [junit4]   2> 	5	/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOp_2Shard_3/terms/shard2
   [junit4]   2> 	5	/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOpReplicaType_1Shard_1/terms/shard1
   [junit4]   2> 	5	/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOpReplicaType_1Shard_2/terms/shard1
   [junit4]   2> 	5	/solr/collections/testSelected2/terms/shard2
   [junit4]   2> 	5	/solr/collections/testSelected3/terms/shard2
   [junit4]   2> 	5	/solr/collections/testSelected3/terms/shard1
   [junit4]   2> 	5	/solr/collections/testNodeLostTriggerWithDeleteNodePreferredOp_0/terms/shard3
   [junit4]   2> 	5	/solr/collections/testNodeLostTriggerWithDeleteNodePreferredOp_0/terms/shard1
   [junit4]   2> 	5	/solr/collections/testNodeLostTriggerWithDeleteNodePreferredOp_0/terms/shard2
   [junit4]   2> 	3	/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOp_1Shard_4/state.json
   [junit4]   2> 	3	/solr/collections/testSelected1/state.json
   [junit4]   2> 	3	/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOp_2Shard_1/state.json
   [junit4]   2> 	3	/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOp_2Shard_0/terms/shard2
   [junit4]   2> 	3	/solr/collections/testSelected3/state.json
   [junit4]   2> 	3	/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOp_2Shard_0/terms/shard1
   [junit4]   2> 	3	/solr/collections/testNodeAdded/terms/shard1
   [junit4]   2> 	3	/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOp_1Shard_0/terms/shard1
   [junit4]   2> 	3	/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOp_1Shard_0/state.json
   [junit4]   2> 	3	/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOp_1Shard_3/state.json
   [junit4]   2> 	3	/solr/collections/testNodeWithMultipleReplicasLost/state.json
   [junit4]   2> 	3	/solr/collections/testNodeLostTriggerWithDeleteNodePreferredOp_0/state.json
   [junit4]   2> 	2	/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOp_1Shard_1/state.json
   [junit4]   2> 	2	/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOpReplicaType_1Shard_0/terms/shard1
   [junit4]   2> 	2	/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOp_1Shard_2/state.json
   [junit4]   2> 	2	/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOp_2Shard_4/state.json
   [junit4]   2> 	2	/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOp_2Shard_3/state.json
   [junit4]   2> 	2	/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOp_2Shard_2/state.json
   [junit4]   2> 	2	/solr/collections/testSelected2/state.json
   [junit4]   2> 	2	/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOp_2Shard_0/state.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2> 	67	/solr/collections/testSelected3/state.json
   [junit4]   2> 	63	/solr/collections/testSelected1/state.json
   [junit4]   2> 	61	/solr/collections/testNodeWithMultipleReplicasLost/state.json
   [junit4]   2> 	60	/solr/collections/testSelected2/state.json
   [junit4]   2> 	42	/solr/aliases.json
   [junit4]   2> 	40	/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOp_2Shard_1/state.json
   [junit4]   2> 	40	/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOp_2Shard_2/state.json
   [junit4]   2> 	37	/solr/autoscaling.json
   [junit4]   2> 	35	/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOp_2Shard_4/state.json
   [junit4]   2> 	35	/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOp_2Shard_3/state.json
   [junit4]   2> 	35	/solr/collections/testNodeLostTriggerWithDeleteNodePreferredOp_0/state.json
   [junit4]   2> 	29	/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOpReplicaType_1Shard_3/state.json
   [junit4]   2> 	29	/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOpReplicaType_1Shard_4/state.json
   [junit4]   2> 	28	/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOp_1Shard_1/state.json
   [junit4]   2> 	27	/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOp_1Shard_3/state.json
   [junit4]   2> 	24	/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOp_1Shard_4/state.json
   [junit4]   2> 	24	/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOpReplicaType_1Shard_2/state.json
   [junit4]   2> 	24	/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOpReplicaType_1Shard_1/state.json
   [junit4]   2> 	23	/solr/collections/testNodeAdded/state.json
   [junit4]   2> 	23	/solr/clusterstate.json
   [junit4]   2> 	20	/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOp_1Shard_2/state.json
   [junit4]   2> 	10	/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOp_1Shard_0/state.json
   [junit4]   2> 	10	/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOpReplicaType_1Shard_0/state.json
   [junit4]   2> 	9	/solr/collections/testNodeAddedTriggerWithAddReplicaPreferredOp_2Shard_0/state.json
   [junit4]   2> 	5	/solr/overseer_elect/election/72060964311007249-127.0.0.1:53711_solr-n_0000000006
   [junit4]   2> 	3	/solr/overseer_elect/election/72060964311007239-127.0.0.1:53481_solr-n_0000000001
   [junit4]   2> 	2	/solr/collections/testNodeWithMultipleReplicasLost/leader_elect/shard1/election/72060964311007251-core_node3-n_0000000000
   [junit4]   2> 	2	/solr/overseer_elect/election/72060964311007245-127.0.0.1:53566_solr-n_0000000004
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2> 	491	/solr/overseer/queue
   [junit4]   2> 	213	/solr/live_nodes
   [junit4]   2> 	138	/solr/collections
   [junit4]   2> 	128	/solr/overseer/collection-queue-work
   [junit4]   2> 	11	/solr/autoscaling/events/node_added_trigger
   [junit4]   2> 	6	/solr/autoscaling/events/node_lost_trigger
   [junit4]   2> 	4	/solr/autoscaling/events/.scheduled_maintenance
   [junit4]   2> 	4	/solr/autoscaling/events/.auto_add_replicas
   [junit4]   2> 	4	/solr/overseer/queue-work
   [junit4]   2> 
   [junit4]   2> 406670 INFO  (SUITE-ComputePlanActionTest-seed#[E1EC4355B660FE62]-worker) [     ] o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:53470
   [junit4]   2> 406670 INFO  (SUITE-ComputePlanActionTest-seed#[E1EC4355B660FE62]-worker) [     ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:53470
   [junit4]   2> 406670 INFO  (SUITE-ComputePlanActionTest-seed#[E1EC4355B660FE62]-worker) [     ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 53470
   [junit4]   2> NOTE: leaving temporary files on disk at: /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.ComputePlanActionTest_E1EC4355B660FE62-001
   [junit4]   2> Apr 17, 2020 3:55:07 AM 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): {}, docValues:{}, maxPointsInLeafNode=911, maxMBSortInHeap=6.5302258362531695, sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@eefbb79), locale=ar-EH, timezone=Asia/Macau
   [junit4]   2> NOTE: Mac OS X 10.14.6 x86_64/AdoptOpenJDK 11.0.6 (64-bit)/cpus=6,threads=1,free=194134656,total=368574464
   [junit4]   2> NOTE: All tests run in this JVM: [TestLegacyTerms, OpenExchangeRatesOrgProviderTest, TestSnapshotCloudManager, TestSimNodeLostTrigger, CloudExitableDirectoryReaderTest, FullHLLTest, TestSimExecutePlanAction, TestRandomFlRTGCloud, ConcurrentDeleteAndCreateCollectionTest, TestJoin, AtomicUpdatesTest, CoreAdminOperationTest, ResourceLoaderTest, SplitByPrefixTest, TestHdfsUpdateLog, TermsComponentTest, FileUtilsTest, ChaosMonkeyNothingIsSafeWithPullReplicasTest, TestBulkSchemaAPI, ComputePlanActionTest]
   [junit4] Completed [145/908 (1!)] on J0 in 86.86s, 8 tests, 1 failure, 1 skipped <<< FAILURES!

[...truncated 55228 lines...]
[repro] Jenkins log URL: https://jenkins.thetaphi.de/job/Lucene-Solr-master-MacOSX/5892/consoleText

[repro] Revision: 74ecc13816fb6aae6e512e2e9d815459e235a120

[repro] Ant options: "-Dargs=-XX:+UseCompressedOops -XX:+UseParallelGC"
[repro] Repro line:  ant test  -Dtestcase=ComputePlanActionTest -Dtests.method=testSelectedCollections -Dtests.seed=E1EC4355B660FE62 -Dtests.slow=true -Dtests.locale=ar-EH -Dtests.timezone=Asia/Macau -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]       ComputePlanActionTest
[repro] ant compile-test

[...truncated 3150 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5 -Dtests.class="*.ComputePlanActionTest" -Dtests.showOutput=onerror "-Dargs=-XX:+UseCompressedOops -XX:+UseParallelGC" -Dtests.seed=E1EC4355B660FE62 -Dtests.slow=true -Dtests.locale=ar-EH -Dtests.timezone=Asia/Macau -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1

[...truncated 121 lines...]
[repro] Failures w/original seeds:
[repro]   0/5 failed: org.apache.solr.cloud.autoscaling.ComputePlanActionTest
[repro] Exiting with code 0

[...truncated 73 lines...]