You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2018/08/09 17:50:27 UTC

[JENKINS-EA] Lucene-Solr-master-Linux (64bit/jdk-11-ea+25) - Build # 22636 - Still unstable!

Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/22636/
Java: 64bit/jdk-11-ea+25 -XX:+UseCompressedOops -XX:+UseParallelGC

3 tests failed.
FAILED:  org.apache.solr.cloud.autoscaling.AutoScalingHandlerTest.testConcurrentUpdates

Error Message:
Captured an uncaught exception in thread: Thread[id=298, name=Thread-65, state=RUNNABLE, group=TGRP-AutoScalingHandlerTest]

Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=298, name=Thread-65, state=RUNNABLE, group=TGRP-AutoScalingHandlerTest]
Caused by: java.lang.AssertionError: org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request:[https://127.0.0.1:38175/solr]
	at __randomizedtesting.SeedInfo.seed([DD41A705F29E1B81]:0)
	at org.junit.Assert.fail(Assert.java:93)
	at org.apache.solr.cloud.autoscaling.AutoScalingHandlerTest.lambda$testConcurrentUpdates$2(AutoScalingHandlerTest.java:880)
	at java.base/java.lang.Thread.run(Thread.java:834)


FAILED:  org.apache.solr.cloud.autoscaling.AutoScalingHandlerTest.testConcurrentUpdates

Error Message:
Captured an uncaught exception in thread: Thread[id=302, name=Thread-67, state=RUNNABLE, group=TGRP-AutoScalingHandlerTest]

Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=302, name=Thread-67, state=RUNNABLE, group=TGRP-AutoScalingHandlerTest]
Caused by: java.lang.AssertionError: org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request:[https://127.0.0.1:43395/solr]
	at __randomizedtesting.SeedInfo.seed([DD41A705F29E1B81]:0)
	at org.junit.Assert.fail(Assert.java:93)
	at org.apache.solr.cloud.autoscaling.AutoScalingHandlerTest.lambda$testConcurrentUpdates$2(AutoScalingHandlerTest.java:880)
	at java.base/java.lang.Thread.run(Thread.java:834)


FAILED:  org.apache.solr.cloud.autoscaling.AutoScalingHandlerTest.testReadApi

Error Message:
expected:<2> but was:<0>

Stack Trace:
java.lang.AssertionError: expected:<2> but was:<0>
	at __randomizedtesting.SeedInfo.seed([DD41A705F29E1B81:8A685CB0296CF99A]:0)
	at org.junit.Assert.fail(Assert.java:93)
	at org.junit.Assert.failNotEquals(Assert.java:647)
	at org.junit.Assert.assertEquals(Assert.java:128)
	at org.junit.Assert.assertEquals(Assert.java:472)
	at org.junit.Assert.assertEquals(Assert.java:456)
	at org.apache.solr.cloud.autoscaling.AutoScalingHandlerTest.testReadApi(AutoScalingHandlerTest.java:819)
	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:1737)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
	at java.base/java.lang.Thread.run(Thread.java:834)




Build Log:
[...truncated 14245 lines...]
   [junit4] Suite: org.apache.solr.cloud.autoscaling.AutoScalingHandlerTest
   [junit4]   2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.autoscaling.AutoScalingHandlerTest_DD41A705F29E1B81-001/init-core-data-001
   [junit4]   2> 1580192 WARN  (SUITE-AutoScalingHandlerTest-seed#[DD41A705F29E1B81]-worker) [    ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=12 numCloses=12
   [junit4]   2> 1580192 INFO  (SUITE-AutoScalingHandlerTest-seed#[DD41A705F29E1B81]-worker) [    ] o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 1580192 INFO  (SUITE-AutoScalingHandlerTest-seed#[DD41A705F29E1B81]-worker) [    ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason="", value=0.0/0.0, ssl=0.0/0.0, clientAuth=0.0/0.0)
   [junit4]   2> 1580193 INFO  (SUITE-AutoScalingHandlerTest-seed#[DD41A705F29E1B81]-worker) [    ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 1580193 INFO  (SUITE-AutoScalingHandlerTest-seed#[DD41A705F29E1B81]-worker) [    ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.autoscaling.AutoScalingHandlerTest_DD41A705F29E1B81-001/tempDir-001
   [junit4]   2> 1580193 INFO  (SUITE-AutoScalingHandlerTest-seed#[DD41A705F29E1B81]-worker) [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1580193 INFO  (Thread-5243) [    ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 1580193 INFO  (Thread-5243) [    ] o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 1580194 ERROR (Thread-5243) [    ] o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
   [junit4]   2> 1580293 INFO  (SUITE-AutoScalingHandlerTest-seed#[DD41A705F29E1B81]-worker) [    ] o.a.s.c.ZkTestServer start zk server on port:44439
   [junit4]   2> 1580294 INFO  (zkConnectionManagerCallback-8465-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1580297 INFO  (jetty-launcher-8462-thread-2) [    ] o.e.j.s.Server jetty-9.4.11.v20180605; built: 2018-06-05T18:24:03.829Z; git: d5fc0523cfa96bfebfbda19606cad384d772f04c; jvm 11-ea+25
   [junit4]   2> 1580297 INFO  (jetty-launcher-8462-thread-1) [    ] o.e.j.s.Server jetty-9.4.11.v20180605; built: 2018-06-05T18:24:03.829Z; git: d5fc0523cfa96bfebfbda19606cad384d772f04c; jvm 11-ea+25
   [junit4]   2> 1580298 INFO  (jetty-launcher-8462-thread-1) [    ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1580298 INFO  (jetty-launcher-8462-thread-1) [    ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1580298 INFO  (jetty-launcher-8462-thread-2) [    ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1580298 INFO  (jetty-launcher-8462-thread-2) [    ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1580298 INFO  (jetty-launcher-8462-thread-1) [    ] o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 1580298 INFO  (jetty-launcher-8462-thread-2) [    ] o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 1580298 INFO  (jetty-launcher-8462-thread-1) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@4c19d2be{/solr,null,AVAILABLE}
   [junit4]   2> 1580298 INFO  (jetty-launcher-8462-thread-2) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@82b7d02{/solr,null,AVAILABLE}
   [junit4]   2> 1580299 INFO  (jetty-launcher-8462-thread-1) [    ] o.e.j.s.AbstractConnector Started ServerConnector@d01e3a5{SSL,[ssl, http/1.1]}{127.0.0.1:37327}
   [junit4]   2> 1580299 INFO  (jetty-launcher-8462-thread-2) [    ] o.e.j.s.AbstractConnector Started ServerConnector@2014b5cf{SSL,[ssl, http/1.1]}{127.0.0.1:36603}
   [junit4]   2> 1580299 INFO  (jetty-launcher-8462-thread-1) [    ] o.e.j.s.Server Started @1580340ms
   [junit4]   2> 1580299 INFO  (jetty-launcher-8462-thread-2) [    ] o.e.j.s.Server Started @1580340ms
   [junit4]   2> 1580299 INFO  (jetty-launcher-8462-thread-1) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=37327}
   [junit4]   2> 1580299 INFO  (jetty-launcher-8462-thread-2) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=36603}
   [junit4]   2> 1580299 ERROR (jetty-launcher-8462-thread-1) [    ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 1580299 ERROR (jetty-launcher-8462-thread-2) [    ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 1580299 INFO  (jetty-launcher-8462-thread-1) [    ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1580299 INFO  (jetty-launcher-8462-thread-2) [    ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1580299 INFO  (jetty-launcher-8462-thread-1) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 8.0.0
   [junit4]   2> 1580299 INFO  (jetty-launcher-8462-thread-2) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 8.0.0
   [junit4]   2> 1580299 INFO  (jetty-launcher-8462-thread-1) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1580299 INFO  (jetty-launcher-8462-thread-2) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1580299 INFO  (jetty-launcher-8462-thread-1) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1580299 INFO  (jetty-launcher-8462-thread-2) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1580299 INFO  (jetty-launcher-8462-thread-1) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2018-08-09T17:25:10.858394Z
   [junit4]   2> 1580299 INFO  (jetty-launcher-8462-thread-2) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2018-08-09T17:25:10.858401Z
   [junit4]   2> 1580300 INFO  (zkConnectionManagerCallback-8469-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1580300 INFO  (zkConnectionManagerCallback-8467-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1580300 INFO  (jetty-launcher-8462-thread-1) [    ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1580300 INFO  (jetty-launcher-8462-thread-2) [    ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1580302 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 0x10043d162240001, likely client has closed socket
   [junit4]   2> 1580445 INFO  (jetty-launcher-8462-thread-2) [    ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:44439/solr
   [junit4]   2> 1580445 INFO  (zkConnectionManagerCallback-8473-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1580446 INFO  (zkConnectionManagerCallback-8475-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1580454 INFO  (jetty-launcher-8462-thread-1) [    ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:44439/solr
   [junit4]   2> 1580454 INFO  (zkConnectionManagerCallback-8481-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1580455 INFO  (zkConnectionManagerCallback-8483-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1580459 INFO  (jetty-launcher-8462-thread-1) [n:127.0.0.1:37327_solr    ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:37327_solr
   [junit4]   2> 1580459 INFO  (jetty-launcher-8462-thread-1) [n:127.0.0.1:37327_solr    ] o.a.s.c.Overseer Overseer (id=72132160611680262-127.0.0.1:37327_solr-n_0000000000) starting
   [junit4]   2> 1580462 INFO  (zkConnectionManagerCallback-8490-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1580463 INFO  (jetty-launcher-8462-thread-1) [n:127.0.0.1:37327_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:44439/solr ready
   [junit4]   2> 1580463 INFO  (OverseerStateUpdate-72132160611680262-127.0.0.1:37327_solr-n_0000000000) [    ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:37327_solr
   [junit4]   2> 1580463 INFO  (jetty-launcher-8462-thread-1) [n:127.0.0.1:37327_solr    ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:37327_solr
   [junit4]   2> 1580464 INFO  (zkCallback-8482-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 1580464 INFO  (zkCallback-8489-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 1580473 INFO  (jetty-launcher-8462-thread-1) [n:127.0.0.1:37327_solr    ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
   [junit4]   2> 1580479 INFO  (jetty-launcher-8462-thread-2) [n:127.0.0.1:36603_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 1580480 INFO  (jetty-launcher-8462-thread-2) [n:127.0.0.1:36603_solr    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
   [junit4]   2> 1580481 INFO  (jetty-launcher-8462-thread-2) [n:127.0.0.1:36603_solr    ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:36603_solr
   [junit4]   2> 1580481 INFO  (zkCallback-8482-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 1580481 INFO  (zkCallback-8489-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 1580481 INFO  (zkCallback-8474-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 1580485 INFO  (jetty-launcher-8462-thread-1) [n:127.0.0.1:37327_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_37327.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@749da5e5
   [junit4]   2> 1580489 INFO  (zkConnectionManagerCallback-8496-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1580490 INFO  (jetty-launcher-8462-thread-2) [n:127.0.0.1:36603_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 1580490 INFO  (jetty-launcher-8462-thread-1) [n:127.0.0.1:37327_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_37327.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@749da5e5
   [junit4]   2> 1580490 INFO  (jetty-launcher-8462-thread-2) [n:127.0.0.1:36603_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:44439/solr ready
   [junit4]   2> 1580490 INFO  (jetty-launcher-8462-thread-1) [n:127.0.0.1:37327_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_37327.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@749da5e5
   [junit4]   2> 1580490 INFO  (jetty-launcher-8462-thread-2) [n:127.0.0.1:36603_solr    ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
   [junit4]   2> 1580491 INFO  (jetty-launcher-8462-thread-1) [n:127.0.0.1:37327_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.autoscaling.AutoScalingHandlerTest_DD41A705F29E1B81-001/tempDir-001/node1/.
   [junit4]   2> 1580499 INFO  (jetty-launcher-8462-thread-2) [n:127.0.0.1:36603_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_36603.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@749da5e5
   [junit4]   2> 1580503 INFO  (jetty-launcher-8462-thread-2) [n:127.0.0.1:36603_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_36603.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@749da5e5
   [junit4]   2> 1580503 INFO  (jetty-launcher-8462-thread-2) [n:127.0.0.1:36603_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_36603.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@749da5e5
   [junit4]   2> 1580504 INFO  (jetty-launcher-8462-thread-2) [n:127.0.0.1:36603_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.autoscaling.AutoScalingHandlerTest_DD41A705F29E1B81-001/tempDir-001/node2/.
   [junit4]   2> 1580516 INFO  (zkConnectionManagerCallback-8499-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1580518 INFO  (zkConnectionManagerCallback-8504-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1580519 INFO  (SUITE-AutoScalingHandlerTest-seed#[DD41A705F29E1B81]-worker) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 1580520 INFO  (SUITE-AutoScalingHandlerTest-seed#[DD41A705F29E1B81]-worker) [    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:44439/solr ready
   [junit4]   2> 1580528 INFO  (TEST-AutoScalingHandlerTest.testUpdatePolicy-seed#[DD41A705F29E1B81]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testUpdatePolicy
   [junit4]   2> 1580546 INFO  (qtp1266561621-26472) [n:127.0.0.1:36603_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> 1580554 INFO  (qtp1437819510-26473) [n:127.0.0.1:37327_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> 1580555 INFO  (qtp1437819510-26471) [n:127.0.0.1:37327_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling params={wt=javabin&version=2} status=0 QTime=17
   [junit4]   2> 1580556 INFO  (qtp1437819510-26469) [n:127.0.0.1:37327_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling params={wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 1580557 INFO  (qtp1266561621-26470) [n:127.0.0.1:36603_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> 1580557 INFO  (qtp1437819510-26536) [n:127.0.0.1:37327_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> 1580558 INFO  (qtp1437819510-26471) [n:127.0.0.1:37327_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling params={wt=javabin&version=2} status=0 QTime=1
   [junit4]   2> 1580558 INFO  (qtp1437819510-26469) [n:127.0.0.1:37327_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling params={wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 1580559 INFO  (TEST-AutoScalingHandlerTest.testUpdatePolicy-seed#[DD41A705F29E1B81]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testUpdatePolicy
   [junit4]   2> 1580568 INFO  (TEST-AutoScalingHandlerTest.testErrorHandling-seed#[DD41A705F29E1B81]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testErrorHandling
   [junit4]   2> 1580569 ERROR (qtp1437819510-26471) [n:127.0.0.1:37327_solr    ] o.a.s.h.RequestHandlerBase org.apache.solr.api.ApiBag$ExceptionWithErrObject: Error in command payload, errors: [{set-cluster-policy=[{cores=<10, node=#ANY}, {shard=#EACH, node=#ANY}, {nodeRole=overseer, replica=0}], errorMessages=[replica is required in {
   [junit4]   2>   "shard":"#EACH",
   [junit4]   2>   "node":"#ANY"}]}], 
   [junit4]   2> 	at org.apache.solr.cloud.autoscaling.AutoScalingHandler.processOps(AutoScalingHandler.java:210)
   [junit4]   2> 	at org.apache.solr.cloud.autoscaling.AutoScalingHandler.handleRequestBody(AutoScalingHandler.java:148)
   [junit4]   2> 	at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:199)
   [junit4]   2> 	at org.apache.solr.servlet.HttpSolrCall.handleAdmin(HttpSolrCall.java:734)
   [junit4]   2> 	at org.apache.solr.servlet.HttpSolrCall.handleAdminRequest(HttpSolrCall.java:715)
   [junit4]   2> 	at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:496)
   [junit4]   2> 	at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:377)
   [junit4]   2> 	at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:323)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1642)
   [junit4]   2> 	at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:139)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1642)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:533)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:255)
   [junit4]   2> 	at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:1595)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:255)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1317)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:203)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:473)
   [junit4]   2> 	at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:1564)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:201)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1219)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:144)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:674)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:132)
   [junit4]   2> 	at org.eclipse.jetty.server.Server.handle(Server.java:531)
   [junit4]   2> 	at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:352)
   [junit4]   2> 	at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:260)
   [junit4]   2> 	at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:281)
   [junit4]   2> 	at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:102)
   [junit4]   2> 	at org.eclipse.jetty.io.ssl.SslConnection.onFillable(SslConnection.java:291)
   [junit4]   2> 	at org.eclipse.jetty.io.ssl.SslConnection$3.succeeded(SslConnection.java:151)
   [junit4]   2> 	at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:102)
   [junit4]   2> 	at org.eclipse.jetty.io.ChannelEndPoint$2.run(ChannelEndPoint.java:118)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.runTask(EatWhatYouKill.java:333)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:310)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.tryProduce(EatWhatYouKill.java:168)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.run(EatWhatYouKill.java:126)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:366)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:762)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:680)
   [junit4]   2> 	at java.base/java.lang.Thread.run(Thread.java:834)
   [junit4]   2> 
   [junit4]   2> 1580570 INFO  (qtp1437819510-26471) [n:127.0.0.1:37327_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling params={wt=javabin&version=2} status=400 QTime=0
   [junit4]   2> 1580570 INFO  (TEST-AutoScalingHandlerTest.testErrorHandling-seed#[DD41A705F29E1B81]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testErrorHandling
   [junit4]   2> 1580580 INFO  (TEST-AutoScalingHandlerTest.testConcurrentUpdates-seed#[DD41A705F29E1B81]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testConcurrentUpdates
   [junit4]   2> 1580586 INFO  (qtp1266561621-26472) [n:127.0.0.1:36603_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> 1580587 INFO  (qtp1437819510-26473) [n:127.0.0.1:37327_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> 1580587 INFO  (qtp1437819510-26469) [n:127.0.0.1:37327_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling params={wt=javabin&version=2} status=0 QTime=5
   [junit4]   2> 1580600 INFO  (qtp1437819510-26469) [n:127.0.0.1:37327_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> 1580603 INFO  (qtp1437819510-26473) [n:127.0.0.1:37327_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> 1580608 INFO  (qtp1266561621-26462) [n:127.0.0.1:36603_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> 1580609 INFO  (qtp1266561621-26474) [n:127.0.0.1:36603_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling params={wt=javabin&version=2} status=0 QTime=18
   [junit4]   2> 1580610 INFO  (qtp1437819510-26469) [n:127.0.0.1:37327_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> 1580610 INFO  (qtp1266561621-26542) [n:127.0.0.1:36603_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> 1580611 INFO  (qtp1266561621-26472) [n:127.0.0.1:36603_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling params={wt=javabin&version=2} status=0 QTime=1
   [junit4]   2> 1580612 INFO  (qtp1437819510-26473) [n:127.0.0.1:37327_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> 1580612 INFO  (qtp1266561621-26470) [n:127.0.0.1:36603_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> 1580613 INFO  (qtp1266561621-26474) [n:127.0.0.1:36603_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling params={wt=javabin&version=2} status=0 QTime=1
   [junit4]   2> 1580613 INFO  (qtp1266561621-26466) [n:127.0.0.1:36603_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> 1580614 INFO  (qtp1266561621-26462) [n:127.0.0.1:36603_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> 1580614 INFO  (qtp1437819510-26469) [n:127.0.0.1:37327_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> 1580615 INFO  (qtp1437819510-26536) [n:127.0.0.1:37327_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> 1580615 INFO  (qtp1266561621-26466) [n:127.0.0.1:36603_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> 1580615 INFO  (qtp1437819510-26471) [n:127.0.0.1:37327_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling params={wt=javabin&version=2} status=0 QTime=1
   [junit4]   2> 1580616 INFO  (qtp1437819510-26461) [n:127.0.0.1:37327_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> 1580616 INFO  (qtp1266561621-26462) [n:127.0.0.1:36603_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> 1580617 INFO  (qtp1266561621-26539) [n:127.0.0.1:36603_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling params={wt=javabin&version=2} status=0 QTime=15
   [junit4]   2> 1580618 INFO  (qtp1437819510-26471) [n:127.0.0.1:37327_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> 1580619 INFO  (qtp1266561621-26474) [n:127.0.0.1:36603_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> 1580619 INFO  (qtp1266561621-26464) [n:127.0.0.1:36603_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling params={wt=javabin&version=2} status=0 QTime=1
   [junit4]   2> 1580620 INFO  (qtp1266561621-26462) [n:127.0.0.1:36603_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> 1580621 INFO  (qtp1437819510-26536) [n:127.0.0.1:37327_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> 1580621 INFO  (qtp1437819510-26473) [n:127.0.0.1:37327_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling params={wt=javabin&version=2} status=0 QTime=2
   [junit4]   2> 1580622 INFO  (qtp1266561621-26464) [n:127.0.0.1:36603_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> 1580623 INFO  (qtp1437819510-26541) [n:127.0.0.1:37327_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> 1580623 INFO  (qtp1437819510-26471) [n:127.0.0.1:37327_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling params={wt=javabin&version=2} status=0 QTime=1
   [junit4]   2> 1580625 INFO  (qtp1437819510-26469) [n:127.0.0.1:37327_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> 1580625 INFO  (qtp1437819510-26461) [n:127.0.0.1:37327_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> 1580625 INFO  (qtp1266561621-26542) [n:127.0.0.1:36603_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> 1580625 INFO  (qtp1266561621-26462) [n:127.0.0.1:36603_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> 1580626 INFO  (qtp1266561621-26539) [n:127.0.0.1:36603_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling params={wt=javabin&version=2} status=0 QTime=2
   [junit4]   2> 1580627 INFO  (qtp1437819510-26471) [n:127.0.0.1:37327_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> 1580627 INFO  (qtp1266561621-26474) [n:127.0.0.1:36603_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> 1580627 INFO  (qtp1266561621-26539) [n:127.0.0.1:36603_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> 1580627 INFO  (qtp1437819510-26536) [n:127.0.0.1:37327_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> 1580627 INFO  (qtp1266561621-26472) [n:127.0.0.1:36603_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling params={wt=javabin&version=2} status=0 QTime=12
   [junit4]   2> 1580628 INFO  (qtp1437819510-26461) [n:127.0.0.1:37327_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> 1580628 INFO  (qtp1266561621-26462) [n:127.0.0.1:36603_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> 1580629 INFO  (qtp1266561621-26539) [n:127.0.0.1:36603_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> 1580629 INFO  (qtp1437819510-26471) [n:127.0.0.1:37327_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> 1580629 INFO  (qtp1266561621-26466) [n:127.0.0.1:36603_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling params={wt=javabin&version=2} status=0 QTime=1
   [junit4]   2> 1580630 INFO  (qtp1266561621-26462) [n:127.0.0.1:36603_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> 1580631 INFO  (qtp1437819510-26461) [n:127.0.0.1:37327_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> 1580631 INFO  (qtp1437819510-26473) [n:127.0.0.1:37327_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling params={wt=javabin&version=2} status=0 QTime=4
   [junit4]   2> 1580632 INFO  (qtp1266561621-26466) [n:127.0.0.1:36603_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> 1580632 INFO  (qtp1437819510-26471) [n:127.0.0.1:37327_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> 1580633 INFO  (qtp1437819510-26465) [n:127.0.0.1:37327_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling params={wt=javabin&version=2} status=0 QTime=1
   [junit4]   2> 1580634 INFO  (qtp1266561621-26462) [n:127.0.0.1:36603_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> 1580634 INFO  (qtp1437819510-26461) [n:127.0.0.1:37327_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> 1580635 INFO  (qtp1437819510-26473) [n:127.0.0.1:37327_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling params={wt=javabin&version=2} status=0 QTime=1
   [junit4]   2> 1580636 INFO  (qtp1266561621-26466) [n:127.0.0.1:36603_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> 1580636 INFO  (qtp1437819510-26471) [n:127.0.0.1:37327_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> 1580637 INFO  (qtp1437819510-26465) [n:127.0.0.1:37327_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling params={wt=javabin&version=2} status=0 QTime=1
   [junit4]   2> 1580638 INFO  (qtp1266561621-26462) [n:127.0.0.1:36603_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> 1580638 INFO  (qtp1437819510-26473) [n:127.0.0.1:37327_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> 1580639 INFO  (qtp1437819510-26465) [n:127.0.0.1:37327_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling params={wt=javabin&version=2} status=0 QTime=2
   [junit4]   2> 1580640 INFO  (qtp1266561621-26466) [n:127.0.0.1:36603_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> 1580641 INFO  (qtp1437819510-26461) [n:127.0.0.1:37327_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> 1580641 INFO  (qtp1437819510-26471) [n:127.0.0.1:37327_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling params={wt=javabin&version=2} status=0 QTime=1
   [junit4]   2> 1580642 INFO  (qtp1266561621-26462) [n:127.0.0.1:36603_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> 1580643 INFO  (qtp1437819510-26473) [n:127.0.0.1:37327_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> 1580643 INFO  (qtp1437819510-26465) [n:127.0.0.1:37327_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling params={wt=javabin&version=2} status=0 QTime=1
   [junit4]   2> 1580644 INFO  (qtp1266561621-26466) [n:127.0.0.1:36603_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> 1580645 INFO  (qtp1437819510-26461) [n:127.0.0.1:37327_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> 1580645 INFO  (qtp1437819510-26471) [n:127.0.0.1:37327_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling params={wt=javabin&version=2} status=0 QTime=1
   [junit4]   2> 1580646 INFO  (qtp1266561621-26539) [n:127.0.0.1:36603_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> 1580646 INFO  (qtp1266561621-26472) [n:127.0.0.1:36603_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> 1580646 INFO  (qtp1437819510-26473) [n:127.0.0.1:37327_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> 1580648 INFO  (qtp1266561621-26462) [n:127.0.0.1:36603_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> 1580648 INFO  (qtp1437819510-26473) [n:127.0.0.1:37327_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> 1580649 INFO  (qtp1437819510-26469) [n:127.0.0.1:37327_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling params={wt=javabin&version=2} status=0 QTime=11
   [junit4]   2> 1580650 INFO  (qtp1266561621-26472) [n:127.0.0.1:36603_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> 1580650 INFO  (qtp1437819510-26460) [n:127.0.0.1:37327_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> 1580651 INFO  (qtp1437819510-26471) [n:127.0.0.1:37327_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling params={wt=javabin&version=2} status=0 QTime=2
   [junit4]   2> 1580652 INFO  (qtp1266561621-26462) [n:127.0.0.1:36603_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> 1580653 INFO  (qtp1437819510-26473) [n:127.0.0.1:37327_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> 1580653 INFO  (qtp1437819510-26469) [n:127.0.0.1:37327_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling params={wt=javabin&version=2} status=0 QTime=1
   [junit4]   2> 1580654 INFO  (qtp1266561621-26472) [n:127.0.0.1:36603_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> 1580654 INFO  (qtp1437819510-26461) [n:127.0.0.1:37327_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> 1580655 INFO  (qtp1437819510-26473) [n:127.0.0.1:37327_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> 1580655 INFO  (qtp1437819510-26471) [n:127.0.0.1:37327_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling params={wt=javabin&version=2} status=0 QTime=1
   [junit4]   2> 1580656 INFO  (qtp1266561621-26462) [n:127.0.0.1:36603_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> 1580656 INFO  (qtp1437819510-26536) [n:127.0.0.1:37327_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> 1580656 INFO  (qtp1437819510-26461) [n:127.0.0.1:37327_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> 1580657 INFO  (qtp1266561621-26462) [n:127.0.0.1:36603_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> 1580657 INFO  (qtp1266561621-26466) [n:127.0.0.1:36603_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling params={wt=javabin&version=2} status=0 QTime=1
   [junit4]   2> 1580657 INFO  (qtp1266561621-26472) [n:127.0.0.1:36603_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> 1580658 INFO  (qtp1437819510-26473) [n:127.0.0.1:37327_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> 1580658 INFO  (qtp1266561621-26474) [n:127.0.0.1:36603_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> 1580659 INFO  (qtp1266561621-26472) [n:127.0.0.1:36603_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> 1580659 INFO  (qtp1437819510-26536) [n:127.0.0.1:37327_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> 1580659 INFO  (qtp1437819510-26469) [n:127.0.0.1:37327_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling params={wt=javabin&version=2} status=0 QTime=1
   [junit4]   2> 1580659 INFO  (qtp1437819510-26473) [n:127.0.0.1:37327_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> 1580661 INFO  (qtp1266561621-26474) [n:127.0.0.1:36603_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> 1580661 INFO  (qtp1266561621-26539) [n:127.0.0.1:36603_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> 1580661 INFO  (qtp1437819510-26460) [n:127.0.0.1:37327_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> 1580661 INFO  (qtp1437819510-26469) [n:127.0.0.1:37327_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> 1580662 INFO  (qtp1437819510-26461) [n:127.0.0.1:37327_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling params={wt=javabin&version=2} status=0 QTime=2
   [junit4]   2> 1580663 INFO  (qtp1266561621-26472) [n:127.0.0.1:36603_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> 1580663 INFO  (qtp1266561621-26539) [n:127.0.0.1:36603_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> 1580663 INFO  (qtp1437819510-26536) [n:127.0.0.1:37327_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> 1580663 INFO  (qtp1437819510-26469) [n:127.0.0.1:37327_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> 1580664 INFO  (qtp1437819510-26473) [n:127.0.0.1:37327_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling params={wt=javabin&version=2} status=0 QTime=1
   [junit4]   2> 1580665 INFO  (qtp1266561621-26466) [n:127.0.0.1:36603_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> 1580665 INFO  (qtp1266561621-26474) [n:127.0.0.1:36603_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> 1580665 INFO  (qtp1437819510-26536) [n:127.0.0.1:37327_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> 1580665 INFO  (qtp1437819510-26460) [n:127.0.0.1:37327_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> 1580666 INFO  (qtp1437819510-26461) [n:127.0.0.1:37327_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling params={wt=javabin&version=2} status=0 QTime=1
   [junit4]   2> 1580667 INFO  (qtp1266561621-26539) [n:127.0.0.1:36603_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> 1580667 INFO  (qtp1266561621-26472) [n:127.0.0.1:36603_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> 1580667 INFO  (qtp1437819510-26469) [n:127.0.0.1:37327_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> 1580667 INFO  (qtp1437819510-26460) [n:127.0.0.1:37327_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> 1580668 INFO  (qtp1437819510-26465) [n:127.0.0.1:37327_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling params={wt=javabin&version=2} status=0 QTime=22
   [junit4]   2> 1580668 INFO  (qtp1266561621-26466) [n:127.0.0.1:36603_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> 1580669 INFO  (qtp1437819510-26469) [n:127.0.0.1:37327_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> 1580669 INFO  (qtp1266561621-26466) [n:127.0.0.1:36603_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> 1580670 INFO  (qtp1437819510-26473) [n:127.0.0.1:37327_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling params={wt=javabin&version=2} status=0 QTime=3
   [junit4]   2> 1580670 INFO  (qtp1437819510-26536) [n:127.0.0.1:37327_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> 1580671 INFO  (qtp1437819510-26471) [n:127.0.0.1:37327_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> 1580671 INFO  (qtp1266561621-26472) [n:127.0.0.1:36603_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> 1580672 INFO  (qtp1437819510-26469) [n:127.0.0.1:37327_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> 1580672 INFO  (qtp1266561621-26539) [n:127.0.0.1:36603_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> 1580672 INFO  (qtp1266561621-26474) [n:127.0.0.1:36603_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling params={wt=javabin&version=2} status=0 QTime=2
   [junit4]   2> 1580673 INFO  (qtp1266561621-26466) [n:127.0.0.1:36603_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> 1580673 INFO  (qtp1266561621-26472) [n:127.0.0.1:36603_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> 1580674 INFO  (qtp1437819510-26471) [n:127.0.0.1:37327_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> 1580674 INFO  (qtp1437819510-26473) [n:127.0.0.1:37327_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> 1580674 INFO  (qtp1437819510-26461) [n:127.0.0.1:37327_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling params={wt=javabin&version=2} status=0 QTime=1
   [junit4]   2> 1580675 INFO  (qtp1266561621-26539) [n:127.0.0.1:36603_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> 1580675 INFO  (qtp1266561621-26474) [n:127.0.0.1:36603_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> 1580676 INFO  (qtp1437819510-26471) [n:127.0.0.1:37327_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> 1580676 INFO  (qtp1437819510-26460) [n:127.0.0.1:37327_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> 1580677 INFO  (qtp1437819510-26469) [n:127.0.0.1:37327_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling params={wt=javabin&version=2} status=0 QTime=1
   [junit4]   2> 1580678 INFO  (qtp1266561621-26472) [n:127.0.0.1:36603_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> 1580678 INFO  (qtp1437819510-26536) [n:127.0.0.1:37327_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> 1580678 INFO  (qtp1437819510-26473) [n:127.0.0.1:37327_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> 1580678 INFO  (qtp1266561621-26539) [n:127.0.0.1:36603_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> 1580679 INFO  (qtp1437819510-26465) [n:127.0.0.1:37327_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling params={wt=javabin&version=2} status=0 QTime=10
   [junit4]   2> 1580679 INFO  (qtp1437819510-26469) [n:127.0.0.1:37327_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> 1580680 INFO  (qtp1266561621-26472) [n:127.0.0.1:36603_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> 1580680 INFO  (qtp1266561621-26539) [n:127.0.0.1:36603_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> 1580680 INFO  (qtp1266561621-26466) [n:127.0.0.1:36603_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling params={wt=javabin&version=2} status=0 QTime=3
   [junit4]   2> 1580681 INFO  (qtp1437819510-26536) [n:127.0.0.1:37327_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> 1580682 INFO  (qtp1266561621-26462) [n:127.0.0.1:36603_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> 1580682 INFO  (qtp1437819510-26473) [n:127.0.0.1:37327_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> 1580682 INFO  (qtp1266561621-26466) [n:127.0.0.1:36603_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> 1580682 INFO  (qtp1437819510-26465) [n:127.0.0.1:37327_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling params={wt=javabin&version=2} status=0 QTime=1
   [junit4]   2> 1580683 INFO  (qtp1437819510-26536) [n:127.0.0.1:37327_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> 1580684 INFO  (qtp1437819510-26469) [n:127.0.0.1:37327_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> 1580684 INFO  (qtp1266561621-26462) [n:127.0.0.1:36603_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> 1580684 INFO  (qtp1266561621-26539) [n:127.0.0.1:36603_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> 1580684 INFO  (qtp1437819510-26473) [n:127.0.0.1:37327_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> 1580685 INFO  (qtp1266561621-26474) [n:127.0.0.1:36603_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling params={wt=javabin&version=2} status=0 QTime=1
   [junit4]   2> 1580685 INFO  (qtp1266561621-26462) [n:127.0.0.1:36603_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> 1580686 INFO  (qtp1266561621-26466) [n:127.0.0.1:36603_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> 1580686 INFO  (qtp1437819510-26469) [n:127.0.0.1:37327_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> 1580686 INFO  (qtp1437819510-26465) [n:127.0.0.1:37327_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> 1580686 INFO  (qtp1437819510-26461) [n:127.0.0.1:37327_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling params={wt=javabin&version=2} status=0 QTime=7
   [junit4]   2> 1580687 INFO  (qtp1266561621-26466) [n:127.0.0.1:36603_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> 1580687 INFO  (qtp1437819510-26536) [n:127.0.0.1:37327_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> 1580688 INFO  (qtp1437819510-26471) [n:127.0.0.1:37327_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> 1580688 INFO  (qtp1266561621-26474) [n:127.0.0.1:36603_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> 1580688 INFO  (qtp1437819510-26460) [n:127.0.0.1:37327_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling params={wt=javabin&version=2} status=0 QTime=3
   [junit4]   2> 1580689 INFO  (qtp1437819510-26461) [n:127.0.0.1:37327_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> 1580689 INFO  (qtp1437819510-26541) [n:127.0.0.1:37327_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> 1580690 INFO  (qtp1266561621-26470) [n:127.0.0.1:36603_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> 1580690 INFO  (qtp1266561621-26466) [n:127.0.0.1:36603_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> 1580690 INFO  (qtp1266561621-26539) [n:127.0.0.1:36603_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling params={wt=javabin&version=2} status=0 QTime=3
   [junit4]   2> 1580691 INFO  (qtp1437819510-26460) [n:127.0.0.1:37327_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> 1580691 INFO  (qtp1266561621-26462) [n:127.0.0.1:36603_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> 1580691 INFO  (qtp1266561621-26472) [n:127.0.0.1:36603_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> 1580692 INFO  (qtp1437819510-26465) [n:127.0.0.1:37327_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> 1580692 INFO  (qtp1266561621-26464) [n:127.0.0.1:36603_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling params={wt=javabin&version=2} status=0 QTime=3
   [junit4]   2> 1580693 INFO  (qtp1266561621-26539) [n:127.0.0.1:36603_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> 1580694 INFO  (qtp1437819510-26460) [n:127.0.0.1:37327_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> 1580694 INFO  (qtp1266561621-26466) [n:127.0.0.1:36603_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> 1580694 INFO  (qtp1437819510-26473) [n:127.0.0.1:37327_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling params={wt=javabin&version=2} status=0 QTime=3
   [junit4]   2> 1580695 INFO  (qtp1437819510-26536) [n:127.0.0.1:37327_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> 1580695 INFO  (qtp1437819510-26461) [n:127.0.0.1:37327_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> 1580696 INFO  (qtp1266561621-26472) [n:127.0.0.1:36603_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> 1580696 INFO  (qtp1266561621-26472) [n:127.0.0.1:36603_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> 1580696 INFO  (qtp1266561621-26474) [n:127.0.0.1:36603_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling params={wt=javabin&version=2} status=0 QTime=1
   [junit4]   2> 1580697 INFO  (qtp1437819510-26473) [n:127.0.0.1:37327_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> 1580703 INFO  (qtp1266561621-26472) [n:127.0.0.1:36603_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=5
   [junit4]   2> 1580703 INFO  (qtp1266561621-26464) [n:127.0.0.1:36603_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> 1580704 INFO  (qtp1437819510-26461) [n:127.0.0.1:37327_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> 1580704 INFO  (qtp1437819510-26473) [n:127.0.0.1:37327_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> 1580704 INFO  (qtp1437819510-26465) [n:127.0.0.1:37327_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling params={wt=javabin&version=2} status=0 QTime=7
   [junit4]   2> 1580705 INFO  (qtp1266561621-26539) [n:127.0.0.1:36603_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> 1580705 INFO  (qtp1437819510-26536) [n:127.0.0.1:37327_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> 1580706 INFO  (qtp1437819510-26469) [n:127.0.0.1:37327_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> 1580706 INFO  (qtp1266561621-26474) [n:127.0.0.1:36603_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> 1580706 INFO  (qtp1437819510-26541) [n:127.0.0.1:37327_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling params={wt=javabin&version=2} status=0 QTime=14
   [junit4]   2> 1580707 INFO  (qtp1437819510-26465) [n:127.0.0.1:37327_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> 1580707 INFO  (qtp1266561621-26472) [n:127.0.0.1:36603_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> 1580708 INFO  (qtp1437819510-26469) [n:127.0.0.1:37327_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> 1580708 INFO  (qtp1266561621-26539) [n:127.0.0.1:36603_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> 1580709 INFO  (qtp1437819510-26460) [n:127.0.0.1:37327_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling params={wt=javabin&version=2} status=0 QTime=1
   [junit4]   2> 1580710 INFO  (qtp1437819510-26473) [n:127.0.0.1:37327_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> 1580710 INFO  (qtp1266561621-26472) [n:127.0.0.1:36603_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> 1580711 INFO  (qtp1266561621-26474) [n:127.0.0.1:36603_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> 1580712 INFO  (qtp1437819510-26465) [n:127.0.0.1:37327_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> 1580712 INFO  (qtp1266561621-26466) [n:127.0.0.1:36603_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling params={wt=javabin&version=2} status=0 QTime=7
   [junit4]   2> 1580714 INFO  (qtp1266561621-26472) [n:127.0.0.1:36603_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> 1580714 INFO  (qtp1437819510-26473) [n:127.0.0.1:37327_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> 1580714 INFO  (qtp1266561621-26466) [n:127.0.0.1:36603_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> 1580715 INFO  (qtp1437819510-26473) [n:127.0.0.1:37327_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> 1580716 INFO  (qtp1437819510-26541) [n:127.0.0.1:37327_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling params={wt=javabin&version=2} status=0 QTime=5
   [junit4]   2> 1580717 INFO  (qtp1266561621-26472) [n:127.0.0.1:36603_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> 1580718 INFO  (qtp1437819510-26473) [n:127.0.0.1:37327_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> 1580718 INFO  (qtp1437819510-26465) [n:127.0.0.1:37327_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling params={wt=javabin&version=2} status=0 QTime=2
   [junit4]   2> 1580720 INFO  (qtp1437819510-26460) [n:127.0.0.1:37327_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> 1580722 INFO  (qtp1266561621-26474) [n:127.0.0.1:36603_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> 1580722 INFO  (qtp1266561621-26539) [n:127.0.0.1:36603_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> 1580722 INFO  (qtp1266561621-26464) [n:127.0.0.1:36603_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling params={wt=javabin&version=2} status=0 QTime=3
   [junit4]   2> 1580723 INFO  (qtp1437819510-26473) [n:127.0.0.1:37327_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> 1580724 INFO  (qtp1266561621-26462) [n:127.0.0.1:36603_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> 1580725 INFO  (qtp1437819510-26536) [n:127.0.0.1:37327_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> 1580725 INFO  (qtp1266561621-26462) [n:127.0.0.1:36603_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> 1580726 INFO  (qtp1437819510-26541) [n:127.0.0.1:37327_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling params={wt=javabin&version=2} status=0 QTime=3
   [junit4]   2> 1580727 INFO  (qtp1437819510-26473) [n:127.0.0.1:37327_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> 1580728 INFO  (qtp1266561621-26466) [n:127.0.0.1:36603_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> 1580728 INFO  (qtp1266561621-26464) [n:127.0.0.1:36603_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> 1580729 INFO  (qtp1437819510-26536) [n:127.0.0.1:37327_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> 1580730 INFO  (qtp1437819510-26536) [n:127.0.0.1:37327_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> 1580735 INFO  (qtp1437819510-26465) [n:127.0.0.1:37327_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling params={wt=javabin&version=2} status=0 QTime=8
   [junit4]   2> 1580736 INFO  (qtp1266561621-26462) [n:127.0.0.1:36603_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> 1580737 INFO  (qtp1266561621-26462) [n:127.0.0.1:36603_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> 1580737 INFO  (qtp1437819510-26536) [n:127.0.0.1:37327_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> 1580738 INFO  (qtp1437819510-26469) [n:127.0.0.1:37327_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling params={wt=javabin&version=2} status=0 QTime=25
   [junit4]   2> 1580738 INFO  (qtp1437819510-26541) [n:127.0.0.1:37327_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CONTAI

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

unit4]   2> 89978 INFO  (coreCloseExecutor-139-thread-3) [n:127.0.0.1:43395_solr c:readApiTestViolations s:shard1 r:core_node9 x:readApiTestViolations_shard1_replica_n6] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.readApiTestViolations.shard1.replica_n6, tag=6e59fe3d
   [junit4]   2> 89978 INFO  (coreCloseExecutor-139-thread-3) [n:127.0.0.1:43395_solr c:readApiTestViolations s:shard1 r:core_node9 x:readApiTestViolations_shard1_replica_n6] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@3724d68: rootName = solr_43395, domain = solr.core.readApiTestViolations.shard1.replica_n6, service url = null, agent id = null] for registry solr.core.readApiTestViolations.shard1.replica_n6 / com.codahale.metrics.MetricRegistry@15320ea5
   [junit4]   2> 89979 INFO  (coreCloseExecutor-138-thread-3) [n:127.0.0.1:35441_solr c:readApiTestViolations s:shard1 r:core_node5 x:readApiTestViolations_shard1_replica_n2] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.readApiTestViolations.shard1.replica_n2, tag=1f4bd6e
   [junit4]   2> 89979 INFO  (coreCloseExecutor-138-thread-3) [n:127.0.0.1:35441_solr c:readApiTestViolations s:shard1 r:core_node5 x:readApiTestViolations_shard1_replica_n2] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@7f161953: rootName = solr_35441, domain = solr.core.readApiTestViolations.shard1.replica_n2, service url = null, agent id = null] for registry solr.core.readApiTestViolations.shard1.replica_n2 / com.codahale.metrics.MetricRegistry@1b3bc437
   [junit4]   2> 89986 INFO  (coreCloseExecutor-139-thread-2) [n:127.0.0.1:43395_solr c:readApiTestViolations s:shard1 r:core_node3 x:readApiTestViolations_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.readApiTestViolations.shard1.replica_n1, tag=28c8130
   [junit4]   2> 89987 INFO  (coreCloseExecutor-139-thread-2) [n:127.0.0.1:43395_solr c:readApiTestViolations s:shard1 r:core_node3 x:readApiTestViolations_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@440eac6: rootName = solr_43395, domain = solr.core.readApiTestViolations.shard1.replica_n1, service url = null, agent id = null] for registry solr.core.readApiTestViolations.shard1.replica_n1 / com.codahale.metrics.MetricRegistry@7d2d39da
   [junit4]   2> 89989 INFO  (coreCloseExecutor-138-thread-2) [n:127.0.0.1:35441_solr c:readApiTestViolations s:shard1 r:core_node7 x:readApiTestViolations_shard1_replica_n4] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.readApiTestViolations.shard1.leader, tag=63315186
   [junit4]   2> 89989 INFO  (coreCloseExecutor-138-thread-1) [n:127.0.0.1:35441_solr c:readApiTestViolations s:shard1 r:core_node12 x:readApiTestViolations_shard1_replica_n10] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.readApiTestViolations.shard1.leader, tag=2523e79e
   [junit4]   2> 89989 INFO  (coreCloseExecutor-138-thread-3) [n:127.0.0.1:35441_solr c:readApiTestViolations s:shard1 r:core_node5 x:readApiTestViolations_shard1_replica_n2] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.readApiTestViolations.shard1.leader, tag=1f4bd6e
   [junit4]   2> 89999 INFO  (coreCloseExecutor-139-thread-2) [n:127.0.0.1:43395_solr c:readApiTestViolations s:shard1 r:core_node3 x:readApiTestViolations_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.readApiTestViolations.shard1.leader, tag=28c8130
   [junit4]   2> 89999 INFO  (coreCloseExecutor-139-thread-1) [n:127.0.0.1:43395_solr c:readApiTestViolations s:shard1 r:core_node11 x:readApiTestViolations_shard1_replica_n8] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.readApiTestViolations.shard1.leader, tag=5a024826
   [junit4]   2> 89999 INFO  (coreCloseExecutor-139-thread-3) [n:127.0.0.1:43395_solr c:readApiTestViolations s:shard1 r:core_node9 x:readApiTestViolations_shard1_replica_n6] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.readApiTestViolations.shard1.leader, tag=6e59fe3d
   [junit4]   2> 90028 INFO  (jetty-closer-63-thread-1) [    ] o.a.s.c.Overseer Overseer (id=72132234949361670-127.0.0.1:35441_solr-n_0000000000) closing
   [junit4]   2> 90028 INFO  (OverseerStateUpdate-72132234949361670-127.0.0.1:35441_solr-n_0000000000) [    ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:35441_solr
   [junit4]   2> 90028 WARN  (OverseerAutoScalingTriggerThread-72132234949361670-127.0.0.1:35441_solr-n_0000000000) [    ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we are closed, exiting.
   [junit4]   2> 90033 INFO  (jetty-closer-63-thread-1) [    ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@77e6b2b{/solr,null,UNAVAILABLE}
   [junit4]   2> 90033 INFO  (jetty-closer-63-thread-1) [    ] o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 91527 INFO  (jetty-closer-63-thread-2) [    ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@6301191e{/solr,null,UNAVAILABLE}
   [junit4]   2> 91527 INFO  (jetty-closer-63-thread-2) [    ] o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 91528 ERROR (SUITE-AutoScalingHandlerTest-seed#[DD41A705F29E1B81]-worker) [    ] o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
   [junit4]   2> 91528 INFO  (SUITE-AutoScalingHandlerTest-seed#[DD41A705F29E1B81]-worker) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:34519 34519
   [junit4]   2> 91656 INFO  (Thread-46) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:34519 34519
   [junit4]   2> 91657 WARN  (Thread-46) [    ] o.a.s.c.ZkTestServer Watch limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2> 	11	/solr/collections/readApiTestViolations/terms/shard1
   [junit4]   2> 	7	/solr/aliases.json
   [junit4]   2> 	3	/solr/security.json
   [junit4]   2> 	3	/solr/configs/conf
   [junit4]   2> 	3	/solr/collections/COLL1/terms/shard1
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2> 	8	/solr/collections/readApiTestViolations/state.json
   [junit4]   2> 	7	/solr/clusterprops.json
   [junit4]   2> 	7	/solr/clusterstate.json
   [junit4]   2> 	2	/solr/collections/readApiTestViolations/leader_elect/shard1/election/72132234949361670-core_node7-n_0000000001
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2> 	7	/solr/live_nodes
   [junit4]   2> 	7	/solr/collections
   [junit4]   2> 	4	/solr/autoscaling/events/node_lost_trigger
   [junit4]   2> 	2	/solr/autoscaling/events/node_added_trigger
   [junit4]   2> 	2	/solr/autoscaling/events/node_added_trigger1
   [junit4]   2> 
   [junit4]   2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.AutoScalingHandlerTest_DD41A705F29E1B81-001
   [junit4]   2> Aug 09, 2018 5:45:14 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 1 leaked thread(s).
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): {}, docValues:{}, maxPointsInLeafNode=758, maxMBSortInHeap=5.587011221594467, sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@2cb17931), locale=zh-CN, timezone=Canada/Mountain
   [junit4]   2> NOTE: Linux 4.15.0-29-generic amd64/Oracle Corporation 11-ea (64-bit)/cpus=8,threads=1,free=401505400,total=514326528
   [junit4]   2> NOTE: All tests run in this JVM: [AutoScalingHandlerTest, AutoScalingHandlerTest]
   [junit4] Completed [5/5 (3!)] on J1 in 70.15s, 10 tests, 1 error <<< FAILURES!

[...truncated 13 lines...]
BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/common-build.xml:1568: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/common-build.xml:1092: There were test failures: 5 suites, 50 tests, 2 errors, 1 failure [seed: DD41A705F29E1B81]

Total time: 1 minute 34 seconds

[repro] Setting last failure code to 256

[repro] Failures:
[repro]   3/5 failed: org.apache.solr.cloud.autoscaling.AutoScalingHandlerTest
[repro] Exiting with code 256
+ mv lucene/build lucene/build.repro
+ mv solr/build solr/build.repro
+ mv lucene/build.orig lucene/build
+ mv solr/build.orig solr/build
Archiving artifacts
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
[WARNINGS] Parsing warnings in console log with parser Java Compiler (javac)
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
<Git Blamer> Using GitBlamer to create author and commit information for all warnings.
<Git Blamer> GIT_COMMIT=6c11284e7c46bac110b1915719907d647d490091, workspace=/var/lib/jenkins/workspace/Lucene-Solr-master-Linux
[WARNINGS] Computing warning deltas based on reference build #22628
Recording test results
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Build step 'Publish JUnit test result report' changed build result to UNSTABLE
Email was triggered for: Unstable (Test Failures)
Sending email for trigger: Unstable (Test Failures)
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2

[JENKINS] Lucene-Solr-master-Linux (64bit/jdk1.8.0_172) - Build # 22637 - Still Unstable!

Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/22637/
Java: 64bit/jdk1.8.0_172 -XX:-UseCompressedOops -XX:+UseG1GC

2 tests failed.
FAILED:  org.apache.solr.cloud.TestWithCollection.testDeleteWithCollection

Error Message:
Error from server at http://127.0.0.1:36533/solr: Could not find collection : testDeleteWithCollection_abc

Stack Trace:
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:36533/solr: Could not find collection : testDeleteWithCollection_abc
	at __randomizedtesting.SeedInfo.seed([2BDE00AA2F54FE2D:5007F74776CE2C93]:0)
	at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:643)
	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:255)
	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:244)
	at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:483)
	at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:413)
	at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1106)
	at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:886)
	at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:819)
	at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:194)
	at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:211)
	at org.apache.solr.cloud.TestWithCollection.testDeleteWithCollection(TestWithCollection.java:197)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:498)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
	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 com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
	at java.lang.Thread.run(Thread.java:748)


FAILED:  org.apache.solr.cloud.TestWithCollection.testDeleteWithCollection

Error Message:
Error from server at http://127.0.0.1:33013/solr: Could not find collection : testDeleteWithCollection_abc_2

Stack Trace:
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:33013/solr: Could not find collection : testDeleteWithCollection_abc_2
	at __randomizedtesting.SeedInfo.seed([2BDE00AA2F54FE2D:5007F74776CE2C93]:0)
	at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:643)
	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:255)
	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:244)
	at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:483)
	at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:413)
	at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1106)
	at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:886)
	at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:819)
	at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:194)
	at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:211)
	at org.apache.solr.cloud.TestWithCollection.testDeleteWithCollection(TestWithCollection.java:224)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:498)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
	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 com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
	at java.lang.Thread.run(Thread.java:748)




Build Log:
[...truncated 13040 lines...]
   [junit4] Suite: org.apache.solr.cloud.TestWithCollection
   [junit4]   2> 546042 INFO  (SUITE-TestWithCollection-seed#[2BDE00AA2F54FE2D]-worker) [    ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestWithCollection_2BDE00AA2F54FE2D-001/init-core-data-001
   [junit4]   2> 546043 WARN  (SUITE-TestWithCollection-seed#[2BDE00AA2F54FE2D]-worker) [    ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=2 numCloses=2
   [junit4]   2> 546043 INFO  (SUITE-TestWithCollection-seed#[2BDE00AA2F54FE2D]-worker) [    ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 546044 INFO  (SUITE-TestWithCollection-seed#[2BDE00AA2F54FE2D]-worker) [    ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
   [junit4]   2> 546045 INFO  (SUITE-TestWithCollection-seed#[2BDE00AA2F54FE2D]-worker) [    ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestWithCollection_2BDE00AA2F54FE2D-001/tempDir-001
   [junit4]   2> 546045 INFO  (SUITE-TestWithCollection-seed#[2BDE00AA2F54FE2D]-worker) [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 546045 INFO  (Thread-1164) [    ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 546045 INFO  (Thread-1164) [    ] o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 546046 ERROR (Thread-1164) [    ] o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
   [junit4]   2> 546145 INFO  (SUITE-TestWithCollection-seed#[2BDE00AA2F54FE2D]-worker) [    ] o.a.s.c.ZkTestServer start zk server on port:43029
   [junit4]   2> 546147 INFO  (zkConnectionManagerCallback-1341-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 546150 INFO  (jetty-launcher-1338-thread-2) [    ] o.e.j.s.Server jetty-9.4.11.v20180605; built: 2018-06-05T18:24:03.829Z; git: d5fc0523cfa96bfebfbda19606cad384d772f04c; jvm 1.8.0_172-b11
   [junit4]   2> 546150 INFO  (jetty-launcher-1338-thread-1) [    ] o.e.j.s.Server jetty-9.4.11.v20180605; built: 2018-06-05T18:24:03.829Z; git: d5fc0523cfa96bfebfbda19606cad384d772f04c; jvm 1.8.0_172-b11
   [junit4]   2> 546151 INFO  (jetty-launcher-1338-thread-1) [    ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 546151 INFO  (jetty-launcher-1338-thread-2) [    ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 546151 INFO  (jetty-launcher-1338-thread-1) [    ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 546151 INFO  (jetty-launcher-1338-thread-2) [    ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 546151 INFO  (jetty-launcher-1338-thread-1) [    ] o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 546151 INFO  (jetty-launcher-1338-thread-2) [    ] o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 546151 INFO  (jetty-launcher-1338-thread-2) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@567a158c{/solr,null,AVAILABLE}
   [junit4]   2> 546151 INFO  (jetty-launcher-1338-thread-1) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@13417be2{/solr,null,AVAILABLE}
   [junit4]   2> 546155 INFO  (jetty-launcher-1338-thread-2) [    ] o.e.j.s.AbstractConnector Started ServerConnector@f3a7ec9{HTTP/1.1,[http/1.1]}{127.0.0.1:33013}
   [junit4]   2> 546155 INFO  (jetty-launcher-1338-thread-2) [    ] o.e.j.s.Server Started @546187ms
   [junit4]   2> 546155 INFO  (jetty-launcher-1338-thread-2) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=33013}
   [junit4]   2> 546156 ERROR (jetty-launcher-1338-thread-2) [    ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 546156 INFO  (jetty-launcher-1338-thread-2) [    ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 546156 INFO  (jetty-launcher-1338-thread-2) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 8.0.0
   [junit4]   2> 546156 INFO  (jetty-launcher-1338-thread-2) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 546156 INFO  (jetty-launcher-1338-thread-2) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 546156 INFO  (jetty-launcher-1338-thread-2) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2018-08-09T20:08:30.101Z
   [junit4]   2> 546156 INFO  (jetty-launcher-1338-thread-1) [    ] o.e.j.s.AbstractConnector Started ServerConnector@4f64768f{HTTP/1.1,[http/1.1]}{127.0.0.1:38495}
   [junit4]   2> 546156 INFO  (jetty-launcher-1338-thread-1) [    ] o.e.j.s.Server Started @546188ms
   [junit4]   2> 546156 INFO  (jetty-launcher-1338-thread-1) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=38495}
   [junit4]   2> 546157 ERROR (jetty-launcher-1338-thread-1) [    ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 546157 INFO  (jetty-launcher-1338-thread-1) [    ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 546157 INFO  (jetty-launcher-1338-thread-1) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 8.0.0
   [junit4]   2> 546157 INFO  (jetty-launcher-1338-thread-1) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 546157 INFO  (jetty-launcher-1338-thread-1) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 546157 INFO  (jetty-launcher-1338-thread-1) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2018-08-09T20:08:30.102Z
   [junit4]   2> 546157 INFO  (zkConnectionManagerCallback-1343-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 546157 INFO  (jetty-launcher-1338-thread-2) [    ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 546158 INFO  (zkConnectionManagerCallback-1345-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 546158 INFO  (jetty-launcher-1338-thread-1) [    ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 546226 INFO  (jetty-launcher-1338-thread-1) [    ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:43029/solr
   [junit4]   2> 546227 INFO  (zkConnectionManagerCallback-1349-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 546228 INFO  (zkConnectionManagerCallback-1351-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 546251 INFO  (jetty-launcher-1338-thread-2) [    ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:43029/solr
   [junit4]   2> 546252 INFO  (zkConnectionManagerCallback-1357-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 546253 INFO  (zkConnectionManagerCallback-1359-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 546258 INFO  (jetty-launcher-1338-thread-2) [n:127.0.0.1:33013_solr    ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:33013_solr
   [junit4]   2> 546258 INFO  (jetty-launcher-1338-thread-2) [n:127.0.0.1:33013_solr    ] o.a.s.c.Overseer Overseer (id=72132802814541830-127.0.0.1:33013_solr-n_0000000000) starting
   [junit4]   2> 546262 INFO  (zkConnectionManagerCallback-1366-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 546262 INFO  (jetty-launcher-1338-thread-2) [n:127.0.0.1:33013_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:43029/solr ready
   [junit4]   2> 546263 INFO  (OverseerStateUpdate-72132802814541830-127.0.0.1:33013_solr-n_0000000000) [    ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:33013_solr
   [junit4]   2> 546264 INFO  (jetty-launcher-1338-thread-2) [n:127.0.0.1:33013_solr    ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:33013_solr
   [junit4]   2> 546264 DEBUG (OverseerAutoScalingTriggerThread-72132802814541830-127.0.0.1:33013_solr-n_0000000000) [    ] o.a.s.c.a.OverseerTriggerThread Adding .auto_add_replicas and .scheduled_maintenance triggers
   [junit4]   2> 546264 INFO  (zkCallback-1358-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 546265 INFO  (zkCallback-1365-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 546265 DEBUG (OverseerAutoScalingTriggerThread-72132802814541830-127.0.0.1:33013_solr-n_0000000000) [    ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 1
   [junit4]   2> 546266 DEBUG (OverseerAutoScalingTriggerThread-72132802814541830-127.0.0.1:33013_solr-n_0000000000) [    ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion -1
   [junit4]   2> 546266 DEBUG (OverseerAutoScalingTriggerThread-72132802814541830-127.0.0.1:33013_solr-n_0000000000) [    ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 1
   [junit4]   2> 546268 INFO  (jetty-launcher-1338-thread-1) [n:127.0.0.1:38495_solr    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
   [junit4]   2> 546268 INFO  (jetty-launcher-1338-thread-1) [n:127.0.0.1:38495_solr    ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:38495_solr
   [junit4]   2> 546269 DEBUG (OverseerAutoScalingTriggerThread-72132802814541830-127.0.0.1:33013_solr-n_0000000000) [    ] o.a.s.c.a.NodeLostTrigger NodeLostTrigger .auto_add_replicas - Initial livenodes: [127.0.0.1:33013_solr]
   [junit4]   2> 546272 INFO  (zkCallback-1350-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 546272 DEBUG (OverseerAutoScalingTriggerThread-72132802814541830-127.0.0.1:33013_solr-n_0000000000) [    ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 546272 DEBUG (OverseerAutoScalingTriggerThread-72132802814541830-127.0.0.1:33013_solr-n_0000000000) [    ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion 1
   [junit4]   2> 546272 DEBUG (ScheduledTrigger-2204-thread-1) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2
   [junit4]   2> 546275 INFO  (zkCallback-1365-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 546275 INFO  (zkCallback-1358-thread-2) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 546277 INFO  (zkCallback-1350-thread-2) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 546279 INFO  (zkConnectionManagerCallback-1371-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 546280 INFO  (jetty-launcher-1338-thread-1) [n:127.0.0.1:38495_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 546280 INFO  (jetty-launcher-1338-thread-1) [n:127.0.0.1:38495_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:43029/solr ready
   [junit4]   2> 546280 INFO  (jetty-launcher-1338-thread-1) [n:127.0.0.1:38495_solr    ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
   [junit4]   2> 546280 INFO  (jetty-launcher-1338-thread-2) [n:127.0.0.1:33013_solr    ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
   [junit4]   2> 546300 INFO  (jetty-launcher-1338-thread-1) [n:127.0.0.1:38495_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_38495.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6043de05
   [junit4]   2> 546302 INFO  (jetty-launcher-1338-thread-2) [n:127.0.0.1:33013_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_33013.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6043de05
   [junit4]   2> 546304 INFO  (jetty-launcher-1338-thread-1) [n:127.0.0.1:38495_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_38495.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6043de05
   [junit4]   2> 546304 INFO  (jetty-launcher-1338-thread-1) [n:127.0.0.1:38495_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_38495.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6043de05
   [junit4]   2> 546305 INFO  (jetty-launcher-1338-thread-1) [n:127.0.0.1:38495_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestWithCollection_2BDE00AA2F54FE2D-001/tempDir-001/node1/.
   [junit4]   2> 546307 INFO  (jetty-launcher-1338-thread-2) [n:127.0.0.1:33013_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_33013.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6043de05
   [junit4]   2> 546307 INFO  (jetty-launcher-1338-thread-2) [n:127.0.0.1:33013_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_33013.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6043de05
   [junit4]   2> 546308 INFO  (jetty-launcher-1338-thread-2) [n:127.0.0.1:33013_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestWithCollection_2BDE00AA2F54FE2D-001/tempDir-001/node2/.
   [junit4]   2> 546330 INFO  (zkConnectionManagerCallback-1375-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 546338 INFO  (zkConnectionManagerCallback-1380-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 546339 INFO  (SUITE-TestWithCollection-seed#[2BDE00AA2F54FE2D]-worker) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 546339 INFO  (SUITE-TestWithCollection-seed#[2BDE00AA2F54FE2D]-worker) [    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:43029/solr ready
   [junit4]   2> 546369 INFO  (TEST-TestWithCollection.testCreateCollectionNoWithCollection-seed#[2BDE00AA2F54FE2D]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testCreateCollectionNoWithCollection
   [junit4]   2> 546372 INFO  (TEST-TestWithCollection.testCreateCollectionNoWithCollection-seed#[2BDE00AA2F54FE2D]) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 546372 DEBUG (zkCallback-1365-thread-1) [    ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 2
   [junit4]   2> 546372 DEBUG (OverseerAutoScalingTriggerThread-72132802814541830-127.0.0.1:33013_solr-n_0000000000) [    ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 2
   [junit4]   2> 546375 DEBUG (OverseerAutoScalingTriggerThread-72132802814541830-127.0.0.1:33013_solr-n_0000000000) [    ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeLost markers
   [junit4]   2> 546375 DEBUG (OverseerAutoScalingTriggerThread-72132802814541830-127.0.0.1:33013_solr-n_0000000000) [    ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 546376 DEBUG (OverseerAutoScalingTriggerThread-72132802814541830-127.0.0.1:33013_solr-n_0000000000) [    ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 2, lastZnodeVersion 2
   [junit4]   2> 546380 INFO  (qtp817129056-5559) [n:127.0.0.1:33013_solr    ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params pullReplicas=0&withCollection=testCreateCollectionNoWithCollection_abc&name=testCreateCollectionNoWithCollection_xyz&nrtReplicas=1&action=CREATE&numShards=1&tlogReplicas=0&wt=javabin&version=2 and sendToOCPQueue=true
   [junit4]   2> 546381 INFO  (OverseerThreadFactory-2206-thread-1) [    ] o.a.s.c.a.c.CreateCollectionCmd Create collection testCreateCollectionNoWithCollection_xyz
   [junit4]   2> 546381 ERROR (OverseerThreadFactory-2206-thread-1) [    ] o.a.s.c.a.c.OverseerCollectionMessageHandler Collection: testCreateCollectionNoWithCollection_xyz operation: create failed:org.apache.solr.common.SolrException: The 'withCollection' does not exist: testCreateCollectionNoWithCollection_abc
   [junit4]   2> 	at org.apache.solr.cloud.api.collections.CreateCollectionCmd.call(CreateCollectionCmd.java:115)
   [junit4]   2> 	at org.apache.solr.cloud.api.collections.OverseerCollectionMessageHandler.processMessage(OverseerCollectionMessageHandler.java:259)
   [junit4]   2> 	at org.apache.solr.cloud.OverseerTaskProcessor$Runner.run(OverseerTaskProcessor.java:473)
   [junit4]   2> 	at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209)
   [junit4]   2> 	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
   [junit4]   2> 	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
   [junit4]   2> 	at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> 
   [junit4]   2> 546389 INFO  (qtp817129056-5559) [n:127.0.0.1:33013_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={pullReplicas=0&withCollection=testCreateCollectionNoWithCollection_abc&name=testCreateCollectionNoWithCollection_xyz&nrtReplicas=1&action=CREATE&numShards=1&tlogReplicas=0&wt=javabin&version=2} status=400 QTime=8
   [junit4]   2> 546395 INFO  (qtp817129056-5547) [n:127.0.0.1:33013_solr    ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params pullReplicas=0&name=testCreateCollectionNoWithCollection_abc&nrtReplicas=1&action=CREATE&numShards=2&tlogReplicas=0&wt=javabin&version=2 and sendToOCPQueue=true
   [junit4]   2> 546397 INFO  (OverseerThreadFactory-2206-thread-2) [    ] o.a.s.c.a.c.CreateCollectionCmd Create collection testCreateCollectionNoWithCollection_abc
   [junit4]   2> 546397 INFO  (OverseerCollectionConfigSetProcessor-72132802814541830-127.0.0.1:33013_solr-n_0000000000) [    ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000000 doesn't exist.  Requestor may have disconnected from ZooKeeper
   [junit4]   2> 546398 INFO  (OverseerThreadFactory-2206-thread-2) [    ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/protwords.txt to /configs/testCreateCollectionNoWithCollection_abc.AUTOCREATED/protwords.txt
   [junit4]   2> 546398 INFO  (OverseerThreadFactory-2206-thread-2) [    ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/managed-schema to /configs/testCreateCollectionNoWithCollection_abc.AUTOCREATED/managed-schema
   [junit4]   2> 546399 INFO  (OverseerThreadFactory-2206-thread-2) [    ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/solrconfig.xml to /configs/testCreateCollectionNoWithCollection_abc.AUTOCREATED/solrconfig.xml
   [junit4]   2> 546400 INFO  (OverseerThreadFactory-2206-thread-2) [    ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/synonyms.txt to /configs/testCreateCollectionNoWithCollection_abc.AUTOCREATED/synonyms.txt
   [junit4]   2> 546401 INFO  (OverseerThreadFactory-2206-thread-2) [    ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/stopwords.txt to /configs/testCreateCollectionNoWithCollection_abc.AUTOCREATED/stopwords.txt
   [junit4]   2> 546401 INFO  (OverseerThreadFactory-2206-thread-2) [    ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/contractions_it.txt to /configs/testCreateCollectionNoWithCollection_abc.AUTOCREATED/lang/contractions_it.txt
   [junit4]   2> 546403 INFO  (OverseerThreadFactory-2206-thread-2) [    ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stemdict_nl.txt to /configs/testCreateCollectionNoWithCollection_abc.AUTOCREATED/lang/stemdict_nl.txt
   [junit4]   2> 546405 INFO  (OverseerThreadFactory-2206-thread-2) [    ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_hy.txt to /configs/testCreateCollectionNoWithCollection_abc.AUTOCREATED/lang/stopwords_hy.txt
   [junit4]   2> 546406 INFO  (OverseerThreadFactory-2206-thread-2) [    ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_no.txt to /configs/testCreateCollectionNoWithCollection_abc.AUTOCREATED/lang/stopwords_no.txt
   [junit4]   2> 546407 INFO  (OverseerThreadFactory-2206-thread-2) [    ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/contractions_ca.txt to /configs/testCreateCollectionNoWithCollection_abc.AUTOCREATED/lang/contractions_ca.txt
   [junit4]   2> 546409 INFO  (OverseerThreadFactory-2206-thread-2) [    ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_id.txt to /configs/testCreateCollectionNoWithCollection_abc.AUTOCREATED/lang/stopwords_id.txt
   [junit4]   2> 546409 INFO  (OverseerThreadFactory-2206-thread-2) [    ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ga.txt to /configs/testCreateCollectionNoWithCollection_abc.AUTOCREATED/lang/stopwords_ga.txt
   [junit4]   2> 546410 INFO  (OverseerThreadFactory-2206-thread-2) [    ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_hi.txt to /configs/testCreateCollectionNoWithCollection_abc.AUTOCREATED/lang/stopwords_hi.txt
   [junit4]   2> 546411 INFO  (OverseerThreadFactory-2206-thread-2) [    ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_da.txt to /configs/testCreateCollectionNoWithCollection_abc.AUTOCREATED/lang/stopwords_da.txt
   [junit4]   2> 546416 INFO  (OverseerThreadFactory-2206-thread-2) [    ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ja.txt to /configs/testCreateCollectionNoWithCollection_abc.AUTOCREATED/lang/stopwords_ja.txt
   [junit4]   2> 546417 INFO  (OverseerThreadFactory-2206-thread-2) [    ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_pt.txt to /configs/testCreateCollectionNoWithCollection_abc.AUTOCREATED/lang/stopwords_pt.txt
   [junit4]   2> 546418 INFO  (OverseerThreadFactory-2206-thread-2) [    ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_hu.txt to /configs/testCreateCollectionNoWithCollection_abc.AUTOCREATED/lang/stopwords_hu.txt
   [junit4]   2> 546418 INFO  (OverseerThreadFactory-2206-thread-2) [    ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_el.txt to /configs/testCreateCollectionNoWithCollection_abc.AUTOCREATED/lang/stopwords_el.txt
   [junit4]   2> 546419 INFO  (OverseerThreadFactory-2206-thread-2) [    ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ru.txt to /configs/testCreateCollectionNoWithCollection_abc.AUTOCREATED/lang/stopwords_ru.txt
   [junit4]   2> 546424 INFO  (OverseerThreadFactory-2206-thread-2) [    ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_tr.txt to /configs/testCreateCollectionNoWithCollection_abc.AUTOCREATED/lang/stopwords_tr.txt
   [junit4]   2> 546425 INFO  (OverseerThreadFactory-2206-thread-2) [    ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ar.txt to /configs/testCreateCollectionNoWithCollection_abc.AUTOCREATED/lang/stopwords_ar.txt
   [junit4]   2> 546425 INFO  (OverseerThreadFactory-2206-thread-2) [    ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/userdict_ja.txt to /configs/testCreateCollectionNoWithCollection_abc.AUTOCREATED/lang/userdict_ja.txt
   [junit4]   2> 546426 INFO  (OverseerThreadFactory-2206-thread-2) [    ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_eu.txt to /configs/testCreateCollectionNoWithCollection_abc.AUTOCREATED/lang/stopwords_eu.txt
   [junit4]   2> 546427 INFO  (OverseerThreadFactory-2206-thread-2) [    ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_it.txt to /configs/testCreateCollectionNoWithCollection_abc.AUTOCREATED/lang/stopwords_it.txt
   [junit4]   2> 546428 INFO  (OverseerThreadFactory-2206-thread-2) [    ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_cz.txt to /configs/testCreateCollectionNoWithCollection_abc.AUTOCREATED/lang/stopwords_cz.txt
   [junit4]   2> 546429 INFO  (OverseerThreadFactory-2206-thread-2) [    ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stoptags_ja.txt to /configs/testCreateCollectionNoWithCollection_abc.AUTOCREATED/lang/stoptags_ja.txt
   [junit4]   2> 546439 INFO  (OverseerThreadFactory-2206-thread-2) [    ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/contractions_fr.txt to /configs/testCreateCollectionNoWithCollection_abc.AUTOCREATED/lang/contractions_fr.txt
   [junit4]   2> 546439 INFO  (OverseerThreadFactory-2206-thread-2) [    ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_de.txt to /configs/testCreateCollectionNoWithCollection_abc.AUTOCREATED/lang/stopwords_de.txt
   [junit4]   2> 546440 INFO  (OverseerThreadFactory-2206-thread-2) [    ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_fa.txt to /configs/testCreateCollectionNoWithCollection_abc.AUTOCREATED/lang/stopwords_fa.txt
   [junit4]   2> 546441 INFO  (OverseerThreadFactory-2206-thread-2) [    ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/contractions_ga.txt to /configs/testCreateCollectionNoWithCollection_abc.AUTOCREATED/lang/contractions_ga.txt
   [junit4]   2> 546442 INFO  (OverseerThreadFactory-2206-thread-2) [    ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ca.txt to /configs/testCreateCollectionNoWithCollection_abc.AUTOCREATED/lang/stopwords_ca.txt
   [junit4]   2> 546444 INFO  (OverseerThreadFactory-2206-thread-2) [    ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_nl.txt to /configs/testCreateCollectionNoWithCollection_abc.AUTOCREATED/lang/stopwords_nl.txt
   [junit4]   2> 546445 INFO  (OverseerThreadFactory-2206-thread-2) [    ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_bg.txt to /configs/testCreateCollectionNoWithCollection_abc.AUTOCREATED/lang/stopwords_bg.txt
   [junit4]   2> 546446 INFO  (OverseerThreadFactory-2206-thread-2) [    ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_lv.txt to /configs/testCreateCollectionNoWithCollection_abc.AUTOCREATED/lang/stopwords_lv.txt
   [junit4]   2> 546446 INFO  (OverseerThreadFactory-2206-thread-2) [    ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_en.txt to /configs/testCreateCollectionNoWithCollection_abc.AUTOCREATED/lang/stopwords_en.txt
   [junit4]   2> 546447 INFO  (OverseerThreadFactory-2206-thread-2) [    ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_es.txt to /configs/testCreateCollectionNoWithCollection_abc.AUTOCREATED/lang/stopwords_es.txt
   [junit4]   2> 546448 INFO  (OverseerThreadFactory-2206-thread-2) [    ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_th.txt to /configs/testCreateCollectionNoWithCollection_abc.AUTOCREATED/lang/stopwords_th.txt
   [junit4]   2> 546449 INFO  (OverseerThreadFactory-2206-thread-2) [    ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ro.txt to /configs/testCreateCollectionNoWithCollection_abc.AUTOCREATED/lang/stopwords_ro.txt
   [junit4]   2> 546450 INFO  (OverseerThreadFactory-2206-thread-2) [    ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_fr.txt to /configs/testCreateCollectionNoWithCollection_abc.AUTOCREATED/lang/stopwords_fr.txt
   [junit4]   2> 546451 INFO  (OverseerThreadFactory-2206-thread-2) [    ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_sv.txt to /configs/testCreateCollectionNoWithCollection_abc.AUTOCREATED/lang/stopwords_sv.txt
   [junit4]   2> 546452 INFO  (OverseerThreadFactory-2206-thread-2) [    ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_fi.txt to /configs/testCreateCollectionNoWithCollection_abc.AUTOCREATED/lang/stopwords_fi.txt
   [junit4]   2> 546456 INFO  (OverseerThreadFactory-2206-thread-2) [    ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/hyphenations_ga.txt to /configs/testCreateCollectionNoWithCollection_abc.AUTOCREATED/lang/hyphenations_ga.txt
   [junit4]   2> 546457 INFO  (OverseerThreadFactory-2206-thread-2) [    ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_gl.txt to /configs/testCreateCollectionNoWithCollection_abc.AUTOCREATED/lang/stopwords_gl.txt
   [junit4]   2> 546457 INFO  (OverseerThreadFactory-2206-thread-2) [    ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/params.json to /configs/testCreateCollectionNoWithCollection_abc.AUTOCREATED/params.json
   [junit4]   2> 546582 INFO  (OverseerStateUpdate-72132802814541830-127.0.0.1:33013_solr-n_0000000000) [    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"testCreateCollectionNoWithCollection_abc",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"testCreateCollectionNoWithCollection_abc_shard1_replica_n1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:33013/solr",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 546583 INFO  (OverseerStateUpdate-72132802814541830-127.0.0.1:33013_solr-n_0000000000) [    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"testCreateCollectionNoWithCollection_abc",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "core":"testCreateCollectionNoWithCollection_abc_shard2_replica_n2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:38495/solr",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 546786 INFO  (qtp817129056-5549) [n:127.0.0.1:33013_solr    x:testCreateCollectionNoWithCollection_abc_shard1_replica_n1] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node3&collection.configName=testCreateCollectionNoWithCollection_abc.AUTOCREATED&newCollection=true&name=testCreateCollectionNoWithCollection_abc_shard1_replica_n1&action=CREATE&numShards=2&collection=testCreateCollectionNoWithCollection_abc&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 546786 INFO  (qtp817129056-5549) [n:127.0.0.1:33013_solr    x:testCreateCollectionNoWithCollection_abc_shard1_replica_n1] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
   [junit4]   2> 546787 INFO  (qtp59279434-5560) [n:127.0.0.1:38495_solr    x:testCreateCollectionNoWithCollection_abc_shard2_replica_n2] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node4&collection.configName=testCreateCollectionNoWithCollection_abc.AUTOCREATED&newCollection=true&name=testCreateCollectionNoWithCollection_abc_shard2_replica_n2&action=CREATE&numShards=2&collection=testCreateCollectionNoWithCollection_abc&shard=shard2&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 547803 INFO  (qtp817129056-5549) [n:127.0.0.1:33013_solr c:testCreateCollectionNoWithCollection_abc s:shard1 r:core_node3 x:testCreateCollectionNoWithCollection_abc_shard1_replica_n1] o.a.s.c.RequestParams conf resource params.json loaded . version : 0 
   [junit4]   2> 547803 INFO  (qtp817129056-5549) [n:127.0.0.1:33013_solr c:testCreateCollectionNoWithCollection_abc s:shard1 r:core_node3 x:testCreateCollectionNoWithCollection_abc_shard1_replica_n1] o.a.s.c.RequestParams request params refreshed to version 0
   [junit4]   2> 547803 INFO  (qtp59279434-5560) [n:127.0.0.1:38495_solr c:testCreateCollectionNoWithCollection_abc s:shard2 r:core_node4 x:testCreateCollectionNoWithCollection_abc_shard2_replica_n2] o.a.s.c.RequestParams conf resource params.json loaded . version : 0 
   [junit4]   2> 547803 INFO  (qtp59279434-5560) [n:127.0.0.1:38495_solr c:testCreateCollectionNoWithCollection_abc s:shard2 r:core_node4 x:testCreateCollectionNoWithCollection_abc_shard2_replica_n2] o.a.s.c.RequestParams request params refreshed to version 0
   [junit4]   2> 547803 WARN  (qtp817129056-5549) [n:127.0.0.1:33013_solr c:testCreateCollectionNoWithCollection_abc s:shard1 r:core_node3 x:testCreateCollectionNoWithCollection_abc_shard1_replica_n1] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestWithCollection_2BDE00AA2F54FE2D-001/tempDir-001/node2/testCreateCollectionNoWithCollection_abc_shard1_replica_n1/../../../../contrib/extraction/lib filtered by .*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestWithCollection_2BDE00AA2F54FE2D-001/tempDir-001/node2/testCreateCollectionNoWithCollection_abc_shard1_replica_n1/../../../../contrib/extraction/lib
   [junit4]   2> 547805 WARN  (qtp59279434-5560) [n:127.0.0.1:38495_solr c:testCreateCollectionNoWithCollection_abc s:shard2 r:core_node4 x:testCreateCollectionNoWithCollection_abc_shard2_replica_n2] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestWithCollection_2BDE00AA2F54FE2D-001/tempDir-001/node1/testCreateCollectionNoWithCollection_abc_shard2_replica_n2/../../../../contrib/extraction/lib filtered by .*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestWithCollection_2BDE00AA2F54FE2D-001/tempDir-001/node1/testCreateCollectionNoWithCollection_abc_shard2_replica_n2/../../../../contrib/extraction/lib
   [junit4]   2> 547805 WARN  (qtp817129056-5549) [n:127.0.0.1:33013_solr c:testCreateCollectionNoWithCollection_abc s:shard1 r:core_node3 x:testCreateCollectionNoWithCollection_abc_shard1_replica_n1] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestWithCollection_2BDE00AA2F54FE2D-001/tempDir-001/node2/testCreateCollectionNoWithCollection_abc_shard1_replica_n1/../../../../dist filtered by solr-cell-\d.*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestWithCollection_2BDE00AA2F54FE2D-001/tempDir-001/node2/testCreateCollectionNoWithCollection_abc_shard1_replica_n1/../../../../dist
   [junit4]   2> 547806 WARN  (qtp817129056-5549) [n:127.0.0.1:33013_solr c:testCreateCollectionNoWithCollection_abc s:shard1 r:core_node3 x:testCreateCollectionNoWithCollection_abc_shard1_replica_n1] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestWithCollection_2BDE00AA2F54FE2D-001/tempDir-001/node2/testCreateCollectionNoWithCollection_abc_shard1_replica_n1/../../../../contrib/clustering/lib filtered by .*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestWithCollection_2BDE00AA2F54FE2D-001/tempDir-001/node2/testCreateCollectionNoWithCollection_abc_shard1_replica_n1/../../../../contrib/clustering/lib
   [junit4]   2> 547806 WARN  (qtp59279434-5560) [n:127.0.0.1:38495_solr c:testCreateCollectionNoWithCollection_abc s:shard2 r:core_node4 x:testCreateCollectionNoWithCollection_abc_shard2_replica_n2] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestWithCollection_2BDE00AA2F54FE2D-001/tempDir-001/node1/testCreateCollectionNoWithCollection_abc_shard2_replica_n2/../../../../dist filtered by solr-cell-\d.*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestWithCollection_2BDE00AA2F54FE2D-001/tempDir-001/node1/testCreateCollectionNoWithCollection_abc_shard2_replica_n2/../../../../dist
   [junit4]   2> 547806 WARN  (qtp817129056-5549) [n:127.0.0.1:33013_solr c:testCreateCollectionNoWithCollection_abc s:shard1 r:core_node3 x:testCreateCollectionNoWithCollection_abc_shard1_replica_n1] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestWithCollection_2BDE00AA2F54FE2D-001/tempDir-001/node2/testCreateCollectionNoWithCollection_abc_shard1_replica_n1/../../../../dist filtered by solr-clustering-\d.*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestWithCollection_2BDE00AA2F54FE2D-001/tempDir-001/node2/testCreateCollectionNoWithCollection_abc_shard1_replica_n1/../../../../dist
   [junit4]   2> 547806 WARN  (qtp59279434-5560) [n:127.0.0.1:38495_solr c:testCreateCollectionNoWithCollection_abc s:shard2 r:core_node4 x:testCreateCollectionNoWithCollection_abc_shard2_replica_n2] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestWithCollection_2BDE00AA2F54FE2D-001/tempDir-001/node1/testCreateCollectionNoWithCollection_abc_shard2_replica_n2/../../../../contrib/clustering/lib filtered by .*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestWithCollection_2BDE00AA2F54FE2D-001/tempDir-001/node1/testCreateCollectionNoWithCollection_abc_shard2_replica_n2/../../../../contrib/clustering/lib
   [junit4]   2> 547806 WARN  (qtp817129056-5549) [n:127.0.0.1:33013_solr c:testCreateCollectionNoWithCollection_abc s:shard1 r:core_node3 x:testCreateCollectionNoWithCollection_abc_shard1_replica_n1] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestWithCollection_2BDE00AA2F54FE2D-001/tempDir-001/node2/testCreateCollectionNoWithCollection_abc_shard1_replica_n1/../../../../contrib/langid/lib filtered by .*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestWithCollection_2BDE00AA2F54FE2D-001/tempDir-001/node2/testCreateCollectionNoWithCollection_abc_shard1_replica_n1/../../../../contrib/langid/lib
   [junit4]   2> 547806 WARN  (qtp59279434-5560) [n:127.0.0.1:38495_solr c:testCreateCollectionNoWithCollection_abc s:shard2 r:core_node4 x:testCreateCollectionNoWithCollection_abc_shard2_replica_n2] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestWithCollection_2BDE00AA2F54FE2D-001/tempDir-001/node1/testCreateCollectionNoWithCollection_abc_shard2_replica_n2/../../../../dist filtered by solr-clustering-\d.*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestWithCollection_2BDE00AA2F54FE2D-001/tempDir-001/node1/testCreateCollectionNoWithCollection_abc_shard2_replica_n2/../../../../dist
   [junit4]   2> 547806 WARN  (qtp817129056-5549) [n:127.0.0.1:33013_solr c:testCreateCollectionNoWithCollection_abc s:shard1 r:core_node3 x:testCreateCollectionNoWithCollection_abc_shard1_replica_n1] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestWithCollection_2BDE00AA2F54FE2D-001/tempDir-001/node2/testCreateCollectionNoWithCollection_abc_shard1_replica_n1/../../../../dist filtered by solr-langid-\d.*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestWithCollection_2BDE00AA2F54FE2D-001/tempDir-001/node2/testCreateCollectionNoWithCollection_abc_shard1_replica_n1/../../../../dist
   [junit4]   2> 547806 WARN  (qtp59279434-5560) [n:127.0.0.1:38495_solr c:testCreateCollectionNoWithCollection_abc s:shard2 r:core_node4 x:testCreateCollectionNoWithCollection_abc_shard2_replica_n2] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestWithCollection_2BDE00AA2F54FE2D-001/tempDir-001/node1/testCreateCollectionNoWithCollection_abc_shard2_replica_n2/../../../../contrib/langid/lib filtered by .*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestWithCollection_2BDE00AA2F54FE2D-001/tempDir-001/node1/testCreateCollectionNoWithCollection_abc_shard2_replica_n2/../../../../contrib/langid/lib
   [junit4]   2> 547806 WARN  (qtp59279434-5560) [n:127.0.0.1:38495_solr c:testCreateCollectionNoWithCollection_abc s:shard2 r:core_node4 x:testCreateCollectionNoWithCollection_abc_shard2_replica_n2] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestWithCollection_2BDE00AA2F54FE2D-001/tempDir-001/node1/testCreateCollectionNoWithCollection_abc_shard2_replica_n2/../../../../dist filtered by solr-langid-\d.*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestWithCollection_2BDE00AA2F54FE2D-001/tempDir-001/node1/testCreateCollectionNoWithCollection_abc_shard2_replica_n2/../../../../dist
   [junit4]   2> 547806 WARN  (qtp817129056-5549) [n:127.0.0.1:33013_solr c:testCreateCollectionNoWithCollection_abc s:shard1 r:core_node3 x:testCreateCollectionNoWithCollection_abc_shard1_replica_n1] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestWithCollection_2BDE00AA2F54FE2D-001/tempDir-001/node2/testCreateCollectionNoWithCollection_abc_shard1_replica_n1/../../../../contrib/velocity/lib filtered by .*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestWithCollection_2BDE00AA2F54FE2D-001/tempDir-001/node2/testCreateCollectionNoWithCollection_abc_shard1_replica_n1/../../../../contrib/velocity/lib
   [junit4]   2> 547807 WARN  (qtp59279434-5560) [n:127.0.0.1:38495_solr c:testCreateCollectionNoWithCollection_abc s:shard2 r:core_node4 x:testCreateCollectionNoWithCollection_abc_shard2_replica_n2] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestWithCollection_2BDE00AA2F54FE2D-001/tempDir-001/node1/testCreateCollectionNoWithCollection_abc_shard2_replica_n2/../../../../contrib/velocity/lib filtered by .*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestWithCollection_2BDE00AA2F54FE2D-001/tempDir-001/node1/testCreateCollectionNoWithCollection_abc_shard2_replica_n2/../../../../contrib/velocity/lib
   [junit4]   2> 547807 WARN  (qtp817129056-5549) [n:127.0.0.1:33013_solr c:testCreateCollectionNoWithCollection_abc s:shard1 r:core_node3 x:testCreateCollectionNoWithCollection_abc_shard1_replica_n1] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestWithCollection_2BDE00AA2F54FE2D-001/tempDir-001/node2/testCreateCollectionNoWithCollection_abc_shard1_replica_n1/../../../../dist filtered by solr-velocity-\d.*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestWithCollection_2BDE00AA2F54FE2D-001/tempDir-001/node2/testCreateCollectionNoWithCollection_abc_shard1_replica_n1/../../../../dist
   [junit4]   2> 547807 WARN  (qtp59279434-5560) [n:127.0.0.1:38495_solr c:testCreateCollectionNoWithCollection_abc s:shard2 r:core_node4 x:testCreateCollectionNoWithCollection_abc_shard2_replica_n2] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestWithCollection_2BDE00AA2F54FE2D-001/tempDir-001/node1/testCreateCollectionNoWithCollection_abc_shard2_replica_n2/../../../../dist filtered by solr-velocity-\d.*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestWithCollection_2BDE00AA2F54FE2D-001/tempDir-001/node1/testCreateCollectionNoWithCollection_abc_shard2_replica_n2/../../../../dist
   [junit4]   2> 547807 WARN  (qtp817129056-5549) [n:127.0.0.1:33013_solr c:testCreateCollectionNoWithCollection_abc s:shard1 r:core_node3 x:testCreateCollectionNoWithCollection_abc_shard1_replica_n1] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestWithCollection_2BDE00AA2F54FE2D-001/tempDir-001/node2/testCreateCollectionNoWithCollection_abc_shard1_replica_n1/../../../../dist filtered by solr-ltr-\d.*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestWithCollection_2BDE00AA2F54FE2D-001/tempDir-001/node2/testCreateCollectionNoWithCollection_abc_shard1_replica_n1/../../../../dist
   [junit4]   2> 547807 WARN  (qtp59279434-5560) [n:127.0.0.1:38495_solr c:testCreateCollectionNoWithCollection_abc s:shard2 r:core_node4 x:testCreateCollectionNoWithCollection_abc_shard2_replica_n2] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestWithCollection_2BDE00AA2F54FE2D-001/tempDir-001/node1/testCreateCollectionNoWithCollection_abc_shard2_replica_n2/../../../../dist filtered by solr-ltr-\d.*\.jar to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestWithCollection_2BDE00AA2F54FE2D-001/tempDir-001/node1/testCreateCollectionNoWithCollection_abc_shard2_replica_n2/../../../../dist
   [junit4]   2> 547811 INFO  (qtp59279434-5560) [n:127.0.0.1:38495_solr c:testCreateCollectionNoWithCollection_abc s:shard2 r:core_node4 x:testCreateCollectionNoWithCollection_abc_shard2_replica_n2] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 547813 INFO  (qtp817129056-5549) [n:127.0.0.1:33013_solr c:testCreateCollectionNoWithCollection_abc s:shard1 r:core_node3 x:testCreateCollectionNoWithCollection_abc_shard1_replica_n1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 547848 INFO  (qtp59279434-5560) [n:127.0.0.1:38495_solr c:testCreateCollectionNoWithCollection_abc s:shard2 r:core_node4 x:testCreateCollectionNoWithCollection_abc_shard2_replica_n2] o.a.s.s.IndexSchema [testCreateCollectionNoWithCollection_abc_shard2_replica_n2] Schema name=default-config
   [junit4]   2> 547854 INFO  (qtp817129056-5549) [n:127.0.0.1:33013_solr c:testCreateCollectionNoWithCollection_abc s:shard1 r:core_node3 x:testCreateCollectionNoWithCollection_abc_shard1_replica_n1] o.a.s.s.IndexSchema [testCreateCollectionNoWithCollection_abc_shard1_replica_n1] Schema name=default-config
   [junit4]   2> 547980 INFO  (qtp59279434-5560) [n:127.0.0.1:38495_solr c:testCreateCollectionNoWithCollection_abc s:shard2 r:core_node4 x:testCreateCollectionNoWithCollection_abc_shard2_replica_n2] o.a.s.s.IndexSchema Loaded schema default-config/1.6 with uniqueid field id
   [junit4]   2> 547996 INFO  (qtp59279434-5560) [n:127.0.0.1:38495_solr c:testCreateCollectionNoWithCollection_abc s:shard2 r:core_node4 x:testCreateCollectionNoWithCollection_abc_shard2_replica_n2] o.a.s.c.CoreContainer Creating SolrCore 'testCreateCollectionNoWithCollection_abc_shard2_replica_n2' using configuration from collection testCreateCollectionNoWithCollection_abc, trusted=true
   [junit4]   2> 547997 INFO  (qtp59279434-5560) [n:127.0.0.1:38495_solr c:testCreateCollectionNoWithCollection_abc s:shard2 r:core_node4 x:testCreateCollectionNoWithCollection_abc_shard2_replica_n2] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_38495.solr.core.testCreateCollectionNoWithCollection_abc.shard2.replica_n2' (registry 'solr.core.testCreateCollectionNoWithCollection_abc.shard2.replica_n2') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6043de05
   [junit4]   2> 547997 INFO  (qtp59279434-5560) [n:127.0.0.1:38495_solr c:testCreateCollectionNoWithCollection_abc s:shard2 r:core_node4 x:testCreateCollectionNoWithCollection_abc_shard2_replica_n2] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 547997 INFO  (qtp59279434-5560) [n:127.0.0.1:38495_solr c:testCreateCollectionNoWithCollection_abc s:shard2 r:core_node4 x:testCreateCollectionNoWithCollection_abc_shard2_replica_n2] o.a.s.c.SolrCore [[testCreateCollectionNoWithCollection_abc_shard2_replica_n2] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestWithCollection_2BDE00AA2F54FE2D-001/tempDir-001/node1/testCreateCollectionNoWithCollection_abc_shard2_replica_n2], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestWithCollection_2BDE00AA2F54FE2D-001/tempDir-001/node1/./testCreateCollectionNoWithCollection_abc_shard2_replica_n2/data/]
   [junit4]   2> 548000 INFO  (qtp59279434-5560) [n:127.0.0.1:38495_solr c:testCreateCollectionNoWithCollection_abc s:shard2 r:core_node4 x:testCreateCollectionNoWithCollection_abc_shard2_replica_n2] o.a.s.r.XSLTResponseWriter xsltCacheLifetimeSeconds=5
   [junit4]   2> 548010 INFO  (qtp817129056-5549) [n:127.0.0.1:33013_solr c:testCreateCollectionNoWithCollection_abc s:shard1 r:core_node3 x:testCreateCollectionNoWithCollection_abc_shard1_replica_n1] o.a.s.s.IndexSchema Loaded schema default-config/1.6 with uniqueid field id
   [junit4]   2> 548026 INFO  (qtp817129056-5549) [n:127.0.0.1:33013_solr c:testCreateCollectionNoWithCollection_abc s:shard1 r:core_node3 x:testCreateCollectionNoWithCollection_abc_shard1_replica_n1] o.a.s.c.CoreContainer Creating SolrCore 'testCreateCollectionNoWithCollection_abc_shard1_replica_n1' using configuration from collection testCreateCollectionNoWithCollection_abc, trusted=true
   [junit4]   2> 548026 INFO  (qtp817129056-5549) [n:127.0.0.1:33013_solr c:testCreateCollectionNoWithCollection_abc s:shard1 r:core_node3 x:testCreateCollectionNoWithCollection_abc_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_33013.solr.core.testCreateCollectionNoWithCollection_abc.shard1.replica_n1' (registry 'solr.core.testCreateCollectionNoWithCollection_abc.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6043de05
   [junit4]   2> 548026 INFO  (qtp817129056-5549) [n:127.0.0.1:33013_solr c:testCreateCollectionNoWithCollection_abc s:shard1 r:core_node3 x:testCreateCollectionNoWithCollection_abc_shard1_replica_n1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 548026 INFO  (qtp817129056-5549) [n:127.0.0.1:33013_solr c:testCreateCollectionNoWithCollection_abc s:shard1 r:core_node3 x:testCreateCollectionNoWithCollection_abc_shard1_replica_n1] o.a.s.c.SolrCore [[testCreateCollectionNoWithCollection_abc_shard1_replica_n1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestWithCollection_2BDE00AA2F54FE2D-001/tempDir-001/node2/testCreateCollectionNoWithCollection_abc_shard1_replica_n1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestWithCollection_2BDE00AA2F54FE2D-001/tempDir-001/node2/./testCreateCollectionNoWithCollection_abc_shard1_replica_n1/data/]
   [junit4]   2> 548029 INFO  (qtp817129056-5549) [n:127.0.0.1:33013_solr c:testCreateCollectionNoWithCollection_abc s:shard1 r:core_node3 x:testCreateCollectionNoWithCollection_abc_shard1_replica_n1] o.a.s.r.XSLTResponseWriter xsltCacheLifetimeSeconds=5
   [junit4]   2> 548088 INFO  (qtp59279434-5560) [n:127.0.0.1:38495_solr c:testCreateCollectionNoWithCollection_abc s:shard2 r:core_node4 x:testCreateCollectionNoWithCollection_abc_shard2_replica_n2] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 548088 INFO  (qtp59279434-5560) [n:127.0.0.1:38495_solr c:testCreateCollectionNoWithCollection_abc s:shard2 r:core_node4 x:testCreateCollectionNoWithCollection_abc_shard2_replica_n2] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 548090 INFO  (qtp59279434-5560) [n:127.0.0.1:38495_solr c:testCreateCollectionNoWithCollection_abc s:shard2 r:core_node4 x:testCreateCollectionNoWithCollection_abc_shard2_replica_n2] o.a.s.u.CommitTracker Hard AutoCommit: if uncommited for 15000ms; 
   [junit4]   2> 548090 INFO  (qtp59279434-5560) [n:127.0.0.1:38495_solr c:testCreateCollectionNoWithCollection_abc s:shard2 r:core_node4 x:testCreateCollectionNoWithCollection_abc_shard2_replica_n2] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 548091 INFO  (qtp59279434-5560) [n:127.0.0.1:38495_solr c:testCreateCollectionNoWithCollection_abc s:shard2 r:core_node4 x:testCreateCollectionNoWithCollection_abc_shard2_replica_n2] o.a.s.s.SolrIndexSearcher Opening [Searcher@4f0ed70b[testCreateCollectionNoWithCollection_abc_shard2_replica_n2] main]
   [junit4]   2> 548092 INFO  (qtp59279434-5560) [n:127.0.0.1:38495_solr c:testCreateCollectionNoWithCollection_abc s:shard2 r:core_node4 x:testCreateCollectionNoWithCollection_abc_shard2_replica_n2] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/testCreateCollectionNoWithCollection_abc.AUTOCREATED
   [junit4]   2> 548092 INFO  (qtp59279434-5560) [n:127.0.0.1:38495_solr c:testCreateCollectionNoWithCollection_abc s:shard2 r:core_node4 x:testCreateCollectionNoWithCollection_abc_shard2_replica_n2] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/testCreateCollectionNoWithCollection_abc.AUTOCREATED
   [junit4]   2> 548093 INFO  (qtp59279434-5560) [n:127.0.0.1:38495_solr c:testCreateCollectionNoWithCollection_abc s:shard2 r:core_node4 x:testCreateCollectionNoWithCollection_abc_shard2_replica_n2] o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at /configs/testCreateCollectionNoWithCollection_abc.AUTOCREATED/managed-schema
   [junit4]   2> 548093 INFO  (qtp59279434-5560) [n:127.0.0.1:38495_solr c:testCreateCollectionNoWithCollection_abc s:shard2 r:core_node4 x:testCreateCollectionNoWithCollection_abc_shard2_replica_n2] o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
   [junit4]   2> 548093 INFO  (qtp59279434-5560) [n:127.0.0.1:38495_solr c:testCreateCollectionNoWithCollection_abc s:shard2 r:core_node4 x:testCreateCollectionNoWithCollection_abc_shard2_replica_n2] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 548094 INFO  (qtp59279434-5560) [n:127.0.0.1:38495_solr c:testCreateCollectionNoWithCollection_abc s:shard2 r:core_node4 x:testCreateCollectionNoWithCollection_abc_shard2_replica_n2] o.a.s.s.DirectSolrSpellChecker init: {name=default,field=_text_,classname=solr.DirectSolrSpellChecker,distanceMeasure=internal,accuracy=0.5,maxEdits=2,minPrefix=1,maxInspections=5,minQueryLength=4,maxQueryFrequency=0.01}
   [junit4]   2> 548095 INFO  (qtp59279434-5560) [n:127.0.0.1:38495_solr c:testCreateCollectionNoWithCollection_abc s:shard2 r:core_node4 x:testCreateCollectionNoWithCollection_abc_shard2_replica_n2] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 548095 INFO  (searcherExecutor-2215-thread-1-processing-n:127.0.0.1:38495_solr x:testCreateCollectionNoWithCollection_abc_shard2_replica_n2 c:testCreateCollectionNoWithCollection_abc s:shard2 r:core_node4) [n:127.0.0.1:38495_solr c:testCreateCollectionNoWithCollection_abc s:shard2 r:core_node4 x:testCreateCollectionNoWithCollection_abc_shard2_replica_n2] o.a.s.c.QuerySenderListener QuerySenderListener sending requests to Searcher@4f0ed70b[testCreateCollectionNoWithCollection_abc_shard2_replica_n2] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 548095 INFO  (searcherExecutor-2215-thread-1-processing-n:127.0.0.1:38495_solr x:testCreateCollectionNoWithCollection_abc_shard2_replica_n2 c:testCreateCollectionNoWithCollection_abc s:shard2 r:core_node4) [n:127.0.0.1:38495_solr c:testCreateCollectionNoWithCollection_abc s:shard2 r:core_node4 x:testCreateCollectionNoWithCollection_abc_shard2_replica_n2] o.a.s.c.QuerySenderListener QuerySenderListener done.
   [junit4]   2> 548095 INFO  (searcherExecutor-2215-thread-1-processing-n:127.0.0.1:38495_solr x:testCreateCollectionNoWithCollection_abc_shard2_replica_n2 c:testCreateCollectionNoWithCollection_abc s:shard2 r:core_node4) [n:127.0.0.1:38495_solr c:testCreateCollectionNoWithCollection_abc s:shard2 r:core_node4 x:testCreateCollectionNoWithCollection_abc_shard2_replica_n2] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 548096 INFO  (qtp59279434-5560) [n:127.0.0.1:38495_solr c:testCreateCollectionNoWithCollection_abc s:shard2 r:core_node4 x:testCreateCollectionNoWithCollection_abc_shard2_replica_n2] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1608353381918703616
   [junit4]   2> 548096 INFO  (searcherExecutor-2215-thread-1-processing-n:127.0.0.1:38495_solr x:testCreateCollectionNoWithCollection_abc_shard2_replica_n2 c:testCreateCollectionNoWithCollection_abc s:shard2 r:core_node4) [n:127.0.0.1:38495_solr c:testCreateCollectionNoWithCollection_abc s:shard2 r:core_node4 x:testCreateCollectionNoWithCollection_abc_shard2_replica_n2] o.a.s.c.SolrCore [testCreateCollectionNoWithCollection_abc_shard2_replica_n2] Registered new searcher Searcher@4f0ed70b[testCreateCollectionNoWithCollection_abc_shard2_replica_n2] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 548099 INFO  (qtp59279434-5560) [n:127.0.0.1:38495_solr c:testCreateCollectionNoWithCollection_abc s:shard2 r:core_node4 x:testCreateCollectionNoWithCollection_abc_shard2_replica_n2] o.a.s.c.ZkShardTerms Successful update of terms at /collections/testCreateCollectionNoWithCollection_abc/terms/shard2 to Terms{values={core_node4=0}, version=0}
   [junit4]   2> 548100 INFO  (qtp59279434-5560) [n:127.0.0.1:38495_solr c:testCreateCollectionNoWithCollection_abc s:shard2 r:core_node4 x:testCreateCollectionNoWithCollection_abc_shard2_replica_n2] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 548100 INFO  (qtp59279434-5560) [n:127.0.0.1:38495_solr c:testCreateCollectionNoWithCollection_abc s:shard2 r:core_node4 x:testCreateCollectionNoWithCollection_abc_shard2_replica_n2] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 548100 INFO  (qtp59279434-5560) [n:127.0.0.1:38495_solr c:testCreateCollectionNoWithCollection_abc s:shard2 r:core_node4 x:testCreateCollectionNoWithCollection_abc_shard2_replica_n2] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:38495/solr/testCreateCollectionNoWithCollection_abc_shard2_replica_n2/
   [junit4]   2> 548101 INFO  (qtp59279434-5560) [n:127.0.0.1:38495_solr c:testCreateCollectionNoWithCollection_abc s:shard2 r:core_node4 x:testCreateCollectionNoWithCollection_abc_shard2_replica_n2] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
   [junit4]   2> 548101 INFO  (qtp59279434-5560) [n:127.0.0.1:38495_solr c:testCreateCollectionNoWithCollection_abc s:shard2 r:core_node4 x:testCreateCollectionNoWithCollection_abc_shard2_replica_n2] o.a.s.c.SyncStrategy http://127.0.0.1:38495/solr/testCreateCollectionNoWithCollection_abc_shard2_replica_n2/ has no replicas
   [junit4]   2> 548101 INFO  (qtp59279434-5560) [n:127.0.0.1:38495_solr c:testCreateCollectionNoWithCollection_abc s:shard2 r:core_node4 x:testCreateCollectionNoWithCollection_abc_shard2_replica_n2] o.a.s.c.ShardLeaderElectionContext Found all replicas participating in election, clear LIR
   [junit4]   2> 548102 INFO  (qtp817129056-5549) [n:127.0.0.1:33013_solr c:testCreateCollectionNoWithCollection_abc s:shard1 r:core_node3 x:testCreateCollectionNoWithCollection_abc_shard1_replica_n1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 548102 INFO  (qtp817129056-5549) [n:127.0.0.1:33013_solr c:testCreateCollectionNoWithCollection_abc s:shard1 r:core_node3 x:testCreateCollectionNoWithCollection_abc_shard1_replica_n1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 548103 INFO  (qtp59279434-5560) [n:127.0.0.1:38495_solr c:testCreateCollectionNoWithCollection_abc s:shard2 r:core_node4 x:testCreateCollectionNoWithCollection_abc_shard2_replica_n2] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:38495/solr/testCreateCollectionNoWithCollection_abc_shard2_replica_n2/ shard2
   [junit4]   2> 548104 INFO  (qtp817129056-5549) [n:127.0.0.1:33013_solr c:testCreateCollectionNoWithCollection_abc s:shard1 r:core_node3 x:testCreateCollectionNoWithCollection_abc_shard1_replica_n1] o.a.s.u.CommitTracker Hard AutoCommit: if uncommited for 15000ms; 
   [junit4]   2> 548104 INFO  (qtp817129056-5549) [n:127.0.0.1:33013_solr c:testCreateCollectionNoWithCollection_abc s:shard1 r:core_node3 x:testCreateCollectionNoWithCollection_abc_shard1_replica_n1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 548105 INFO  (qtp817129056-5549) [n:127.0.0.1:33013_solr c:testCreateCollectionNoWithCollection_abc s:shard1 r:core_node3 x:testCreateCollectionNoWithCollection_abc_shard1_replica_n1] o.a.s.s.SolrIndexSearcher Opening [Searcher@22550fbc[testCreateCollectionNoWithCollection_abc_shard1_replica_n1] main]
   [junit4]   2> 548105 INFO  (qtp817129056-5549) [n:127.0.0.1:33013_solr c:testCreateCollectionNoWithCollection_abc s:shard1 r:core_node3 x:testCreateCollectionNoWithCollection_abc_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/testCreateCollectionNoWithCollection_abc.AUTOCREATED
   [junit4]   2> 548106 INFO  (qtp817129056-5549) [n:127.0.0.1:33013_solr c:testCreateCollectionNoWithCollection_abc s:shard1 r:core_node3 x:testCreateCollectionNoWithCollection_abc_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/testCreateCollectionNoWithCollection_abc.AUTOCREATED
   [junit4]   2> 548106 INFO  (qtp817129056-5549) [n:127.0.0.1:33013_solr c:testCreateCollectionNoWithCollection_abc s:shard1 r:core_node3 x:testCreateCollectionNoWithCollection_abc_shard1_replica_n1] o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at /configs/testCreateCollectionNoWithCollection_abc.AUTOCREATED/managed-schema
   [junit4]   2> 548106 INFO  (qtp817129056-5549) [n:127.0.0.1:33013_solr c:testCreateCollectionNoWithCollection_abc s:shard1 r:core_node3 x:testCreateCollectionNoWithCollection_abc_shard1_replica_n1] o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
   [junit4]   2> 548107 INFO  (qtp817129056-5549) [n:127.0.0.1:33013_solr c:testCreateCollectionNoWithCollection_abc s:shard1 r:core_node3 x:testCreateCollectionNoWithCollection_abc_shard1_replica_n1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 548107 INFO  (qtp817129056-5549) [n:127.0.0.1:33013_solr c:testCreateCollectionNoWithCollection_abc s:shard1 r:core_node3 x:testCreateCollectionNoWithCollection_abc_shard1_replica_n1] o.a.s.s.DirectSolrSpellChecker init: {name=default,field=_text_,classname=solr.DirectSolrSpellChecker,distanceMeasure=internal,accuracy=0.5,maxEdits=2,minPrefix=1,maxInspections=5,minQueryLength=4,maxQueryFrequency=0.01}
   [junit4]   2> 548108 INFO  (qtp817129056-5549) [n:127.0.0.1:33013_solr c:testCreateCollectionNoWithCollection_abc s:shard1 r:core_node3 x:testCreateCollectionNoWithCollection_abc_shard1_replica_n1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 548108 INFO  (searcherExecutor-2216-thread-1-processing-n:127.0.0.1:33013_solr x:testCreateCollectionNoWithCollection_abc_shard1_replica_n1 c:testCreateCollectionNoWithCollection_abc s:shard1 r:core_node3) [n:127.0.0.1:33013_solr c:testCreateCollectionNoWithCollection_abc s:shard1 r:core_node3 x:testCreateCollectionNoWithCollection_abc_shard1_replica_n1] o.a.s.c.QuerySenderListener QuerySenderListener sending requests to Searcher@22550fbc[testCreateCollectionNoWithCollection_abc_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 548108 INFO  (searcherExecutor-2216-thread-1-processing-n:127.0.0.1:33013_solr x:testCreateCollectionNoWithCollection_abc_shard1_replica_n1 c:testCreateCollectionNoWithCollection_abc s:shard1 r:core_node3) [n:127.0.0.1:33013_solr c:testCreateCollectionNoWithCollection_abc s:shard1 r:core_node3 x:testCreateCollectionNoWithCollection_abc_shard1_replica_n1] o.a.s.c.QuerySenderListener QuerySenderListener done.
   [junit4]   2> 548108 INFO  (qtp817129056-5549) [n:127.0.0.1:33013_solr c:testCreateCollectionNoWithCollection_abc s:shard1 r:core_node3 x:testCreateCollectionNoWithCollection_abc_shard1_replica_n1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1608353381931286528
   [junit4]   2> 548108 INFO  (searcherExecutor-2216-thread-1-processing-n:127.0.0.1:33013_solr x:testCreateCollectionNoWithCollection_abc_shard1_replica_n1 c:testCreateCollectionNoWithCollection_abc s:shard1 r:core_node3) [n:127.0.0.1:33013_solr c:testCreateCollectionNoWithCollection_abc s:shard1 r:core_node3 x:testCreateCollectionNoWithCollection_abc_shard1_replica_n1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 548109 INFO  (searcherExecutor-2216-thread-1-processing-n:127.0.0.1:33013_solr x:testCreateCollectionNoWithCollection_abc_shard1_replica_n1 c:testCreateCollectionNoWithCollection_abc s:shard1 r:core_node3) [n:127.0.0.1:33013_solr c:testCreateCollectionNoWithCollection_abc s:shard1 r:core_node3 x:testCreateCollectionNoWithCollection_abc_shard1_replica_n1] o.a.s.c.SolrCore [testCreateCollectionNoWithCollection_abc_shard1_replica_n1] Registered new searcher Searcher@22550fbc[testCreateCollectionNoWithCollection_abc_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 548112 INFO  (qtp817129056-5549) [n:127.0.0.1:33013_solr c:testCreateCollectionNoWithCollection_abc s:shard1 r:core_node3 x:testCreateCollectionNoWithCollection_abc_shard1_replica_n1] o.a.s.c.ZkShardTerms Successful update of terms at /collections/testCreateCollectionNoWithCollection_abc/terms/shard1 to Terms{values={core_node3=0}, version=0}
   [junit4]   2> 548114 INFO  (qtp817129056-5549) [n:127.0.0.1:33013_solr c:testCreateCollectionNoWithCollection_abc s:shard1 r:core_node3 x:testCreateCollectionNoWithCollection_abc_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 548114 INFO  (qtp817129056-5549) [n:127.0.0.1:33013_solr c:testCreateCollectionNoWithCollection_abc s:shard1 r:core_node3 x:testCreateCollectionNoWithCollection_abc_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 548114 INFO  (qtp817129056-5549) [n:127.0.0.1:33013_solr c:testCreateCollectionNoWithCollection_abc s:shard1 r:core_node3 x:testCreateCollectionNoWithCollection_abc_shard1_replica_n1] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:33013/solr/testCreateCollectionNoWithCollection_abc_shard1_replica_n1/
   [junit4]   2> 548114 INFO  (qtp817129056-5549) [n:127.0.0.1:33013_solr c:testCreateCollectionNoWithCollection_abc s:shard1 r:core_node3 x:testCreateCollectionNoWithCollection_abc_shard1_replica_n1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
   [junit4]   2> 548114 INFO  (qtp817129056-5549) [n:127.0.0.1:33013_solr c:testCreateCollectionNoWithCollection_abc s:shard1 r:core_node3 x:testCreateCollectionNoWithCollection_abc_shard1_replica_n1] o.a.s.c.SyncStrategy http://127.0.0.1:33013/solr/testCreateCollectionNoWithCollection_abc_shard1_replica_n1/ has no replicas
   [junit4]   2> 548114 INFO  (qtp817129056-5549) [n:127.0.0.1:33013_solr c:testCreateCollectionNoWithCollection_abc s:shard1 r:core_node3 x:testCreateCollectionNoWithCollection_abc_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext Found all replicas participating in election, clear LIR
   [junit4]   2> 548116 INFO  (qtp817129056-5549) [n:127.0.0.1:33013_solr c:testCreateCollectionNoWithCollection_abc s:shard1 r:core_node3 x:testCreateCollectionNoWithCollection_abc_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:33013/solr/testCreateCollectionNoWithCollection_abc_shard1_replica_n1/ shard1
   [junit4]   2> 548255 INFO  (qtp59279434-5560) [n:127.0.0.1:38495_solr c:testCreateCollectionNoWithCollection_abc s:shard2 r:core_node4 x:testCreateCollectionNoWithCollection_abc_shard2_replica_n2] o.a.s.c.ZkController I am the leader, no recovery necessary
   [junit4]   2> 548268 INFO  (qtp817129056-5549) [n:127.0.0.1:33013_solr c:testCreateCollectionNoWithCollection_abc s:shard1 r:core_node3 x:testCreateCollectionNoWithCollection_abc_shard1_replica_n1] o.a.s.c.ZkController I am the leader, no recovery necessary
   [junit4]   2> 548369 INFO  (zkCallback-1358-thread-2) [    ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testCreateCollectionNoWithCollection_abc/state.json] for collection [testCreateCollectionNoWithCollection_abc] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 548369 INFO  (zkCallback-1350-thread-2) [    ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testCreateCollectionNoWithCollection_abc/state.json] for collection [testCreateCollectionNoWithCollection_abc] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 548418 INFO  (qtp59279434-5560) [n:127.0.0.1:38495_solr c:testCreateCollectionNoWithCollection_abc s:shard2 r:core_node4 x:testCreateCollectionNoWithCollection_abc_shard2_replica_n2] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node4&collection.configName=testCreateCollectionNoWithCollection_abc.AUTOCREATED&newCollection=true&name=testCreateCollectionNoWithCollection_abc_shard2_replica_n2&action=CREATE&numShards=2&collection=testCreateCollectionNoWithCollection_abc&shard=shard2&wt=javabin&version=2&replicaType=NRT} status=0 QTime=1630
   [junit4]   2> 548418 INFO  (qtp817129056-5549) [n:127.0.0.1:33013_solr c:testCreateCollectionNoWithCollection_abc s:shard1 r:core_node3 x:testCreateCollectionNoWithCollection_abc_shard1_replica_n1] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node3&collection.configName=testCreateCollectionNoWithCollection_abc.AUTOCREATED&newCollection=true&name=testCreateCollectionNoWithCollection_abc_shard1_replica_n1&action=CREATE&numShards=2&collection=testCreateCollectionNoWithCollection_abc&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=1632
   [junit4]   2> 548420 INFO  (qtp817129056-5547) [n:127.0.0.1:33013_solr    ] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 30 seconds. Check all shard replicas
   [junit4]   2> 548420 INFO  (qtp817129056-5547) [n:127.0.0.1:33013_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={pullReplicas=0&name=testCreateCollectionNoWithCollection_abc&nrtReplicas=1&action=CREATE&numShards=2&tlogReplicas=0&wt=javabin&version=2} status=0 QTime=2024
   [junit4]   2> 548420 INFO  (qtp817129056-5557) [n:127.0.0.1:33013_solr    ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params pullReplicas=0&withCollection=testCreateCollectionNoWithCollection_abc&name=testCreateCollectionNoWithCollection_xyz&nrtReplicas=1&action=CREATE&numShards=1&tlogReplicas=0&wt=javabin&version=2 and sendToOCPQueue=true
   [junit4]   2> 548421 INFO  (OverseerThreadFactory-2206-thread-3) [    ] o.a.s.c.a.c.CreateCollectionCmd Create collection testCreateCollectionNoWithCollection_xyz
   [junit4]   2> 548421 INFO  (OverseerCollectionConfigSetProcessor-72132802814541830-127.0.0.1:33013_solr-n_0000000000) [    ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000002 doesn't exist.  Requestor may have disconnected from ZooKeeper
   [junit4]   2> 548422 ERROR (OverseerThreadFactory-2206-thread-3) [    ] o.a.s.c.a.c.OverseerCollectionMessageHandler Collection: testCreateCollectionNoWithCollection_xyz operation: create failed:org.apache.solr.common.SolrException: The `withCollection` must have only one shard, found: 2
   [junit4]   2> 	at org.apache.solr.cloud.api.collections.CreateCollectionCmd.call(CreateCollectionCmd.java:119)
   [junit4]   2> 	at org.apache.solr.cloud.api.collections.OverseerCollectionMessageHandler.processMessage(OverseerCollectionMessageHandler.java:259)
   [junit4]   2> 	at org.apache.solr.cloud.OverseerTaskProcessor$Runner.run(OverseerTaskProcessor.java:473)
   [junit4]   2> 	at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209)
   [junit4]   2> 	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
   [junit4]   2> 	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
   [junit4]   2> 	at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> 
   [junit4]   2> 548423 INFO  (qtp817129056-5557) [n:127.0.0.1:33013_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={pullReplicas=0&withCollection=testCreateCollectionNoWithCollection_abc&name=testCreateCollectionNoWithCollection_xyz&nrtReplicas=1&action=CREATE&numShards=1&tlogReplicas=0&wt=javabin&version=2} status=400 QTime=2
   [junit4]   2> 548424 INFO  (TEST-TestWithCollection.testCreateCollectionNoWithCollection-seed#[2BDE00AA2F54FE2D]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testCreateCollectionNoWithCollection
   [junit4]   2> 548459 INFO  (TEST-TestWithCollection.testMultipleWithCollections-seed#[2BDE00AA2F54FE2D]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testMultipleWithCollections
   [junit4]   2> 548459 DEBUG (zkCallback-1365-thread-1) [    ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 3
   [junit4]   2> 548459 DEBUG (OverseerAutoScalingTriggerThread-72132802814541830-127.0.0.1:33013_solr-n_0000000000) [    ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 3
   [junit4]   2> 548459 DEBUG (OverseerAutoScalingTriggerThread-72132802814541830-127.0.0.1:33013_solr-n_0000000000) [    ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeLost markers
   [junit4]   2> 548459 DEBUG (OverseerAutoScalingTriggerThread-72132802814541830-127.0.0.1:33013_solr-n_0000000000) [    ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 548460 DEBUG (OverseerAutoScalingTriggerThread-72132802814541830-127.0.0.1:33013_solr-n_0000000000) [    ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 3, lastZnodeVersion 3
   [junit4]   2> 548460 INFO  (TEST-TestWithCollection.testMultipleWithCollections-seed#[2BDE00AA2F54FE2D]) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 548461 INFO  (qtp817129056-5630) [n:127.0.0.1:33013_solr    ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :delete with params name=testCreateCollectionNoWithCollection_abc&action=DELETE&wt=javabin&version=2 and sendToOCPQueue=true
   [junit4]   2> 548463 INFO  (OverseerThreadFactory-2206-thread-4) [    ] o.a.s.c.a.c.OverseerCollectionMessageHandler Executing Collection Cmd=action=UNLOAD&deleteInstanceDir=true&deleteDataDir=true&deleteMetricsHistory=true, asyncId=null
   [junit4]   2> 548463 INFO  (OverseerCollectionConfigSetProcessor-72132802814541830-127.0.0.1:33013_solr-n_0000000000) [    ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000004 doesn't exist.  Requestor may have disconnected from ZooKeeper
   [junit4]   2> 548463 INFO  (qtp817129056-5555) [n:127.0.0.1:33013_solr    x:testCreateCollectionNoWithCollection_abc_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.testCreateCollectionNoWithCollection_abc.shard1.replica_n1, tag=null
   [junit4]   2> 548463 INFO  (qtp59279434-5548) [n:127.0.0.1:38495_solr    x:testCreateCollectionNoWithCollection_abc_shard2_replica_n2] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.testCreateCollectionNoWithCollection_abc.shard2.replica_n2, tag=null
   [junit4]   2> 548463 INFO  (qtp817129056-5555) [n:127.0.0.1:33013_solr    x:testCreateCollectionNoWithCollection_abc_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@60cf0675: rootName = solr_33013, domain = solr.core.testCreateCollectionNoWithCollection_abc.shard1.replica_n1, service url = null, agent id = null] for registry solr.core.testCreateCollectionNoWithCollection_abc.shard1.replica_n1 / com.codahale.metrics.MetricRegistry@2edaf417
   [junit4]   2> 548463 INFO  (qtp59279434-5548) [n:127.0.0.1:38495_solr    x:testCreateCollectionNoWithCollection_abc_shard2_replica_n2] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@11aa529: rootName = solr_38495, domain = solr.core.testCreateCollectionNoWithCollection_abc.shard2.replica_n2, service url = null, agent id = null] for registry solr.core.testCreateCollectionNoWithCollection_abc.shard2.replica_n2 / com.codahale.metrics.MetricRegistry@37c0b4cc
   [junit4]   2> 548472 INFO  (qtp817129056-5555) [n:127.0.0.1:33013_solr    x:testCreateCollectionNoWithCollection_abc_shard1_replica_n1] o.a.s.c.SolrCore [testCreateCollectionNoWithCollection_abc_shard1_replica_n1]  CLOSING SolrCore org.apache.solr.core.SolrCore@6a0f7b56
   [junit4]   2> 548472 INFO  (qtp817129056-5555) [n:127.0.0.1:33013_solr    x:testCreateCollectionNoWithCollection_abc_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric reporters

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

   [junit4]   2> 207605 WARN  (Thread-62) [    ] o.a.s.c.ZkTestServer Watch limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2> 	25	/solr/collections/testNodeAdded_xyz/terms/shard1
   [junit4]   2> 	25	/solr/collections/testNodeAdded_abc/terms/shard1
   [junit4]   2> 	20	/solr/aliases.json
   [junit4]   2> 	20	/solr/clusterprops.json
   [junit4]   2> 	12	/solr/collections/testMultipleWithCollections_abc2/terms/shard1
   [junit4]   2> 	12	/solr/collections/testAddReplicaWithPolicy_abc/terms/shard1
   [junit4]   2> 	12	/solr/collections/testMultipleWithCollections_abc/terms/shard1
   [junit4]   2> 	12	/solr/collections/testAddReplica_abc/terms/shard1
   [junit4]   2> 	12	/solr/collections/testDeleteWithCollection_abc/terms/shard1
   [junit4]   2> 	12	/solr/collections/testMultipleWithCollections_xyz/terms/shard1
   [junit4]   2> 	11	/solr/collections/testMoveReplicaMainCollection_xyz/terms/shard1
   [junit4]   2> 	10	/solr/collections/testMultipleWithCollections_xyz2/terms/shard1
   [junit4]   2> 	10	/solr/collections/testAddReplica_xyz/terms/shard1
   [junit4]   2> 	10	/solr/collections/testAddReplicaWithPolicy_xyz/terms/shard1
   [junit4]   2> 	9	/solr/collections/testMoveReplicaMainCollection_abc/terms/shard1
   [junit4]   2> 	5	/solr/security.json
   [junit4]   2> 	3	/solr/configs/testNodeAdded_xyz.AUTOCREATED
   [junit4]   2> 	3	/solr/collections/testCreateCollection_abc/terms/shard1
   [junit4]   2> 	3	/solr/configs/testNodeAdded_abc.AUTOCREATED/managed-schema
   [junit4]   2> 	3	/solr/collections/testCreateCollectionNoWithCollection_abc/terms/shard2
   [junit4]   2> 	3	/solr/collections/testMoveReplicaWithCollection_abc/terms/shard1
   [junit4]   2> 	3	/solr/collections/testCreateCollectionNoWithCollection_abc/terms/shard1
   [junit4]   2> 	3	/solr/configs/testNodeAdded_xyz.AUTOCREATED/managed-schema
   [junit4]   2> 	3	/solr/collections/testCreateCollection_xyz/terms/shard1
   [junit4]   2> 	3	/solr/configs/testNodeAdded_abc.AUTOCREATED
   [junit4]   2> 	3	/solr/collections/testMoveReplicaWithCollection_xyz/terms/shard1
   [junit4]   2> 	3	/solr/collections/testDeleteWithCollection_xyz/terms/shard1
   [junit4]   2> 	2	/solr/configs/testAddReplicaWithPolicy_xyz.AUTOCREATED
   [junit4]   2> 	2	/solr/configs/testAddReplica_abc.AUTOCREATED
   [junit4]   2> 	2	/solr/configs/testCreateCollectionNoWithCollection_abc.AUTOCREATED
   [junit4]   2> 	2	/solr/configs/testMultipleWithCollections_xyz2.AUTOCREATED
   [junit4]   2> 	2	/solr/configs/testMoveReplicaMainCollection_xyz.AUTOCREATED
   [junit4]   2> 	2	/solr/configs/testAddReplica_abc.AUTOCREATED/managed-schema
   [junit4]   2> 	2	/solr/configs/testMultipleWithCollections_abc2.AUTOCREATED/managed-schema
   [junit4]   2> 	2	/solr/configs/testAddReplicaWithPolicy_abc.AUTOCREATED/managed-schema
   [junit4]   2> 	2	/solr/configs/testAddReplicaWithPolicy_abc.AUTOCREATED
   [junit4]   2> 	2	/solr/configs/testMultipleWithCollections_abc.AUTOCREATED/managed-schema
   [junit4]   2> 	2	/solr/configs/testMultipleWithCollections_abc2.AUTOCREATED
   [junit4]   2> 	2	/solr/configs/testMultipleWithCollections_xyz.AUTOCREATED/managed-schema
   [junit4]   2> 	2	/solr/configs/testMoveReplicaMainCollection_abc.AUTOCREATED
   [junit4]   2> 	2	/solr/configs/testDeleteWithCollection_abc.AUTOCREATED/managed-schema
   [junit4]   2> 	2	/solr/configs/testAddReplica_xyz.AUTOCREATED/managed-schema
   [junit4]   2> 	2	/solr/configs/testAddReplicaWithPolicy_xyz.AUTOCREATED/managed-schema
   [junit4]   2> 	2	/solr/configs/testAddReplica_xyz.AUTOCREATED
   [junit4]   2> 	2	/solr/configs/testDeleteWithCollection_abc.AUTOCREATED
   [junit4]   2> 	2	/solr/configs/testCreateCollectionNoWithCollection_abc.AUTOCREATED/managed-schema
   [junit4]   2> 	2	/solr/configs/testMoveReplicaMainCollection_abc.AUTOCREATED/managed-schema
   [junit4]   2> 	2	/solr/configs/testMultipleWithCollections_abc.AUTOCREATED
   [junit4]   2> 	2	/solr/configs/testMultipleWithCollections_xyz2.AUTOCREATED/managed-schema
   [junit4]   2> 	2	/solr/configs/testMultipleWithCollections_xyz.AUTOCREATED
   [junit4]   2> 	2	/solr/configs/testMoveReplicaMainCollection_xyz.AUTOCREATED/managed-schema
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2> 	45	/solr/aliases.json
   [junit4]   2> 	20	/solr/clusterstate.json
   [junit4]   2> 	6	/solr/collections/testNodeAdded_xyz/state.json
   [junit4]   2> 	6	/solr/collections/testMoveReplicaMainCollection_xyz/state.json
   [junit4]   2> 	6	/solr/collections/testMultipleWithCollections_abc2/state.json
   [junit4]   2> 	6	/solr/collections/testNodeAdded_abc/state.json
   [junit4]   2> 	5	/solr/collections/testMoveReplicaMainCollection_abc/state.json
   [junit4]   2> 	5	/solr/collections/testMultipleWithCollections_abc/state.json
   [junit4]   2> 	5	/solr/collections/testMultipleWithCollections_xyz/state.json
   [junit4]   2> 	4	/solr/collections/testMultipleWithCollections_xyz2/state.json
   [junit4]   2> 	3	/solr/collections/testAddReplica_xyz/state.json
   [junit4]   2> 	3	/solr/collections/testAddReplicaWithPolicy_xyz/state.json
   [junit4]   2> 	2	/solr/collections/testAddReplica_abc/state.json
   [junit4]   2> 	2	/solr/collections/testNodeAdded_xyz/leader_elect/shard1/election/72132976132096007-core_node2-n_0000000000
   [junit4]   2> 	2	/solr/overseer_elect/election/72132976132096007-127.0.0.1:45109_solr-n_0000000001
   [junit4]   2> 	2	/solr/collections/testCreateCollectionNoWithCollection_abc/state.json
   [junit4]   2> 	2	/solr/collections/testAddReplicaWithPolicy_abc/state.json
   [junit4]   2> 	2	/solr/collections/testDeleteWithCollection_abc/state.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2> 	196	/solr/collections
   [junit4]   2> 	37	/solr/live_nodes
   [junit4]   2> 
   [junit4]   2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.TestWithCollection_2BDE00AA2F54FE2D-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): {}, docValues:{}, maxPointsInLeafNode=1367, maxMBSortInHeap=6.596166473283786, sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@385400cd), locale=hu-HU, timezone=Asia/Gaza
   [junit4]   2> NOTE: Linux 4.15.0-29-generic amd64/Oracle Corporation 1.8.0_172 (64-bit)/cpus=8,threads=1,free=271248808,total=536870912
   [junit4]   2> NOTE: All tests run in this JVM: [TestWithCollection, TestWithCollection]
   [junit4] Completed [4/5 (2!)] on J1 in 93.00s, 9 tests, 1 error <<< FAILURES!
   [junit4] 
   [junit4] Suite: org.apache.solr.cloud.TestWithCollection
   [junit4] OK      2.77s J0 | TestWithCollection.testCreateCollectionNoWithCollection
   [junit4] OK      17.2s J0 | TestWithCollection.testMultipleWithCollections
   [junit4] OK      17.8s J0 | TestWithCollection.testNodeAdded
   [junit4] OK      7.14s J0 | TestWithCollection.testMoveReplicaWithCollection
   [junit4] OK      6.97s J0 | TestWithCollection.testCreateCollection
   [junit4] OK      8.69s J0 | TestWithCollection.testAddReplicaWithPolicy
   [junit4] OK      18.3s J0 | TestWithCollection.testDeleteWithCollection
   [junit4] OK      8.62s J0 | TestWithCollection.testAddReplicaSimple
   [junit4] OK      11.4s J0 | TestWithCollection.testMoveReplicaMainCollection
   [junit4] Completed [5/5 (2!)] on J0 in 102.31s, 9 tests
   [junit4] 
   [junit4] 
   [junit4] Tests with failures [seed: 2BDE00AA2F54FE2D]:
   [junit4]   - org.apache.solr.cloud.TestWithCollection.testMoveReplicaWithCollection
   [junit4]   - org.apache.solr.cloud.TestWithCollection.testDeleteWithCollection
   [junit4] 
   [junit4] 
   [junit4] JVM J0:     0.92 ..   215.51 =   214.59s
   [junit4] JVM J1:     0.94 ..   208.39 =   207.46s
   [junit4] JVM J2:     0.91 ..   115.85 =   114.94s
   [junit4] Execution time total: 3 minutes 35 seconds
   [junit4] Tests summary: 5 suites, 45 tests, 1 error, 1 failure

BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/common-build.xml:1568: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/common-build.xml:1092: There were test failures: 5 suites, 45 tests, 1 error, 1 failure [seed: 2BDE00AA2F54FE2D]

Total time: 3 minutes 37 seconds

[repro] Setting last failure code to 256

[repro] Failures:
[repro]   2/5 failed: org.apache.solr.cloud.TestWithCollection
[repro] Exiting with code 256
+ mv lucene/build lucene/build.repro
+ mv solr/build solr/build.repro
+ mv lucene/build.orig lucene/build
+ mv solr/build.orig solr/build
Archiving artifacts
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
[WARNINGS] Parsing warnings in console log with parser Java Compiler (javac)
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
<Git Blamer> Using GitBlamer to create author and commit information for all warnings.
<Git Blamer> GIT_COMMIT=63fc1246f7d30c73bff0fdbf344216a34efdc554, workspace=/var/lib/jenkins/workspace/Lucene-Solr-master-Linux
[WARNINGS] Computing warning deltas based on reference build #22636
Recording test results
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Build step 'Publish JUnit test result report' changed build result to UNSTABLE
Email was triggered for: Unstable (Test Failures)
Sending email for trigger: Unstable (Test Failures)
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2