Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-MacOSX/314/
Java: 64bit/jdk1.8.0 -XX:-UseCompressedOops -XX:+UseConcMarkSweepGC

1 tests failed.
FAILED:  org.apache.solr.cloud.CollectionsAPISolrJTest.testCreateAndDeleteShard

Error Message:


Stack Trace:
java.lang.AssertionError
        at 
__randomizedtesting.SeedInfo.seed([FBED39E31DB3D9FB:3EB38DFF9B461306]:0)
        at org.junit.Assert.fail(Assert.java:92)
        at org.junit.Assert.assertTrue(Assert.java:43)
        at org.junit.Assert.assertTrue(Assert.java:54)
        at 
org.apache.solr.cloud.CollectionsAPISolrJTest.testCreateAndDeleteShard(CollectionsAPISolrJTest.java:160)
        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 13185 lines...]
   [junit4] Suite: org.apache.solr.cloud.CollectionsAPISolrJTest
   [junit4]   2> Creating dataDir: 
/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_FBED39E31DB3D9FB-001/init-core-data-001
   [junit4]   2> 2328203 WARN  
(SUITE-CollectionsAPISolrJTest-seed#[FBED39E31DB3D9FB]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=14 numCloses=14
   [junit4]   2> 2328204 INFO  
(SUITE-CollectionsAPISolrJTest-seed#[FBED39E31DB3D9FB]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 2328209 INFO  
(SUITE-CollectionsAPISolrJTest-seed#[FBED39E31DB3D9FB]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: 
@org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN) 
w/ MAC_OS_X supressed clientAuth
   [junit4]   2> 2328209 INFO  
(SUITE-CollectionsAPISolrJTest-seed#[FBED39E31DB3D9FB]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 2328210 INFO  
(SUITE-CollectionsAPISolrJTest-seed#[FBED39E31DB3D9FB]-worker) [    ] 
o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in 
/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_FBED39E31DB3D9FB-001/tempDir-001
   [junit4]   2> 2328210 INFO  
(SUITE-CollectionsAPISolrJTest-seed#[FBED39E31DB3D9FB]-worker) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 2328210 INFO  (Thread-3578) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 2328210 INFO  (Thread-3578) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 2328219 ERROR (Thread-3578) [    ] 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> 2328313 INFO  
(SUITE-CollectionsAPISolrJTest-seed#[FBED39E31DB3D9FB]-worker) [    ] 
o.a.s.c.ZkTestServer start zk server on port:61186
   [junit4]   2> 2328365 INFO  (jetty-launcher-3895-thread-1) [    ] 
o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 2328365 INFO  (jetty-launcher-3895-thread-2) [    ] 
o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 2328365 INFO  (jetty-launcher-3895-thread-3) [    ] 
o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 2328366 INFO  (jetty-launcher-3895-thread-4) [    ] 
o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 2328372 INFO  (jetty-launcher-3895-thread-1) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@1edb746e{/solr,null,AVAILABLE}
   [junit4]   2> 2328372 INFO  (jetty-launcher-3895-thread-4) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@60a15de5{/solr,null,AVAILABLE}
   [junit4]   2> 2328377 INFO  (jetty-launcher-3895-thread-3) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@5d3e654{/solr,null,AVAILABLE}
   [junit4]   2> 2328380 INFO  (jetty-launcher-3895-thread-3) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@23f2e8c{HTTP/1.1,[http/1.1]}{127.0.0.1:61190}
   [junit4]   2> 2328380 INFO  (jetty-launcher-3895-thread-2) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@2ea009c1{/solr,null,AVAILABLE}
   [junit4]   2> 2328380 INFO  (jetty-launcher-3895-thread-4) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@71264b21{HTTP/1.1,[http/1.1]}{127.0.0.1:61189}
   [junit4]   2> 2328380 INFO  (jetty-launcher-3895-thread-4) [    ] 
o.e.j.s.Server Started @2332243ms
   [junit4]   2> 2328380 INFO  (jetty-launcher-3895-thread-4) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=61189}
   [junit4]   2> 2328380 INFO  (jetty-launcher-3895-thread-3) [    ] 
o.e.j.s.Server Started @2332242ms
   [junit4]   2> 2328380 INFO  (jetty-launcher-3895-thread-2) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@3bbe520c{HTTP/1.1,[http/1.1]}{127.0.0.1:61191}
   [junit4]   2> 2328380 INFO  (jetty-launcher-3895-thread-3) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=61190}
   [junit4]   2> 2328380 ERROR (jetty-launcher-3895-thread-4) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 2328380 INFO  (jetty-launcher-3895-thread-2) [    ] 
o.e.j.s.Server Started @2332243ms
   [junit4]   2> 2328384 ERROR (jetty-launcher-3895-thread-3) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 2328380 INFO  (jetty-launcher-3895-thread-1) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@35cc3b8a{HTTP/1.1,[http/1.1]}{127.0.0.1:61188}
   [junit4]   2> 2328384 INFO  (jetty-launcher-3895-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
7.2.0
   [junit4]   2> 2328384 INFO  (jetty-launcher-3895-thread-1) [    ] 
o.e.j.s.Server Started @2332247ms
   [junit4]   2> 2328384 INFO  (jetty-launcher-3895-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
7.2.0
   [junit4]   2> 2328385 INFO  (jetty-launcher-3895-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=61188}
   [junit4]   2> 2328385 INFO  (jetty-launcher-3895-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 2328385 INFO  (jetty-launcher-3895-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 2328385 ERROR (jetty-launcher-3895-thread-1) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 2328384 INFO  (jetty-launcher-3895-thread-2) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=61191}
   [junit4]   2> 2328385 INFO  (jetty-launcher-3895-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
7.2.0
   [junit4]   2> 2328385 INFO  (jetty-launcher-3895-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 2328385 ERROR (jetty-launcher-3895-thread-2) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 2328385 INFO  (jetty-launcher-3895-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 2328385 INFO  (jetty-launcher-3895-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-11-19T09:17:52.988Z
   [junit4]   2> 2328385 INFO  (jetty-launcher-3895-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-11-19T09:17:52.988Z
   [junit4]   2> 2328385 INFO  (jetty-launcher-3895-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 2328386 INFO  (jetty-launcher-3895-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 2328386 INFO  (jetty-launcher-3895-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-11-19T09:17:52.989Z
   [junit4]   2> 2328385 INFO  (jetty-launcher-3895-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
7.2.0
   [junit4]   2> 2328386 INFO  (jetty-launcher-3895-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 2328386 INFO  (jetty-launcher-3895-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 2328386 INFO  (jetty-launcher-3895-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-11-19T09:17:52.989Z
   [junit4]   2> 2328389 INFO  (jetty-launcher-3895-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 2328389 INFO  (jetty-launcher-3895-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 2328390 INFO  (jetty-launcher-3895-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 2328390 INFO  (jetty-launcher-3895-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 2328413 INFO  (jetty-launcher-3895-thread-3) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:61186/solr
   [junit4]   2> 2328413 INFO  (jetty-launcher-3895-thread-2) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:61186/solr
   [junit4]   2> 2328415 INFO  (jetty-launcher-3895-thread-4) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:61186/solr
   [junit4]   2> 2328415 INFO  (jetty-launcher-3895-thread-1) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:61186/solr
   [junit4]   2> 2328623 INFO  (jetty-launcher-3895-thread-4) 
[n:127.0.0.1:61189_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 2328625 INFO  (jetty-launcher-3895-thread-2) 
[n:127.0.0.1:61191_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 2328625 INFO  (jetty-launcher-3895-thread-1) 
[n:127.0.0.1:61188_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 2328625 INFO  (jetty-launcher-3895-thread-3) 
[n:127.0.0.1:61190_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 2328626 INFO  (jetty-launcher-3895-thread-4) 
[n:127.0.0.1:61189_solr    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:61189_solr
   [junit4]   2> 2328627 INFO  (jetty-launcher-3895-thread-2) 
[n:127.0.0.1:61191_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:61191_solr
   [junit4]   2> 2328627 INFO  (jetty-launcher-3895-thread-1) 
[n:127.0.0.1:61188_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:61188_solr
   [junit4]   2> 2328627 INFO  (jetty-launcher-3895-thread-3) 
[n:127.0.0.1:61190_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:61190_solr
   [junit4]   2> 2328627 INFO  (jetty-launcher-3895-thread-4) 
[n:127.0.0.1:61189_solr    ] o.a.s.c.Overseer Overseer 
(id=99030340260200459-127.0.0.1:61189_solr-n_0000000000) starting
   [junit4]   2> 2328631 INFO  
(zkCallback-3917-thread-1-processing-n:127.0.0.1:61188_solr) 
[n:127.0.0.1:61188_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (2)
   [junit4]   2> 2328633 INFO  
(zkCallback-3914-thread-1-processing-n:127.0.0.1:61191_solr) 
[n:127.0.0.1:61191_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (2)
   [junit4]   2> 2328635 INFO  
(zkCallback-3915-thread-1-processing-n:127.0.0.1:61190_solr) 
[n:127.0.0.1:61190_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (2)
   [junit4]   2> 2328637 INFO  
(zkCallback-3916-thread-1-processing-n:127.0.0.1:61189_solr) 
[n:127.0.0.1:61189_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (2)
   [junit4]   2> 2328648 INFO  
(zkCallback-3917-thread-1-processing-n:127.0.0.1:61188_solr) 
[n:127.0.0.1:61188_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (2) -> (3)
   [junit4]   2> 2328649 INFO  
(zkCallback-3914-thread-1-processing-n:127.0.0.1:61191_solr) 
[n:127.0.0.1:61191_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (2) -> (3)
   [junit4]   2> 2328649 INFO  
(zkCallback-3915-thread-1-processing-n:127.0.0.1:61190_solr) 
[n:127.0.0.1:61190_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (2) -> (3)
   [junit4]   2> 2328649 INFO  
(zkCallback-3916-thread-1-processing-n:127.0.0.1:61189_solr) 
[n:127.0.0.1:61189_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (2) -> (3)
   [junit4]   2> 2328679 INFO  (jetty-launcher-3895-thread-4) 
[n:127.0.0.1:61189_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:61189_solr
   [junit4]   2> 2328682 INFO  
(zkCallback-3914-thread-1-processing-n:127.0.0.1:61191_solr) 
[n:127.0.0.1:61191_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (3) -> (4)
   [junit4]   2> 2328682 INFO  
(zkCallback-3917-thread-1-processing-n:127.0.0.1:61188_solr) 
[n:127.0.0.1:61188_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (3) -> (4)
   [junit4]   2> 2328682 INFO  
(zkCallback-3915-thread-1-processing-n:127.0.0.1:61190_solr) 
[n:127.0.0.1:61190_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (3) -> (4)
   [junit4]   2> 2328682 INFO  
(zkCallback-3916-thread-1-processing-n:127.0.0.1:61189_solr) 
[n:127.0.0.1:61189_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (3) -> (4)
   [junit4]   2> 2328819 INFO  (jetty-launcher-3895-thread-3) 
[n:127.0.0.1:61190_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_61190.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@45884cac
   [junit4]   2> 2328826 INFO  (jetty-launcher-3895-thread-1) 
[n:127.0.0.1:61188_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_61188.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@45884cac
   [junit4]   2> 2328832 INFO  (jetty-launcher-3895-thread-2) 
[n:127.0.0.1:61191_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_61191.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@45884cac
   [junit4]   2> 2328838 INFO  (jetty-launcher-3895-thread-4) 
[n:127.0.0.1:61189_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_61189.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@45884cac
   [junit4]   2> 2328880 INFO  (jetty-launcher-3895-thread-3) 
[n:127.0.0.1:61190_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_61190.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@45884cac
   [junit4]   2> 2328880 INFO  (jetty-launcher-3895-thread-3) 
[n:127.0.0.1:61190_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_61190.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@45884cac
   [junit4]   2> 2328884 INFO  (jetty-launcher-3895-thread-3) 
[n:127.0.0.1:61190_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_FBED39E31DB3D9FB-001/tempDir-001/node3/.
   [junit4]   2> 2328886 INFO  (jetty-launcher-3895-thread-1) 
[n:127.0.0.1:61188_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_61188.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@45884cac
   [junit4]   2> 2328886 INFO  (jetty-launcher-3895-thread-1) 
[n:127.0.0.1:61188_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_61188.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@45884cac
   [junit4]   2> 2328891 INFO  (jetty-launcher-3895-thread-1) 
[n:127.0.0.1:61188_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_FBED39E31DB3D9FB-001/tempDir-001/node1/.
   [junit4]   2> 2328891 INFO  (jetty-launcher-3895-thread-2) 
[n:127.0.0.1:61191_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_61191.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@45884cac
   [junit4]   2> 2328892 INFO  (jetty-launcher-3895-thread-2) 
[n:127.0.0.1:61191_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_61191.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@45884cac
   [junit4]   2> 2328892 INFO  (jetty-launcher-3895-thread-4) 
[n:127.0.0.1:61189_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_61189.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@45884cac
   [junit4]   2> 2328892 INFO  (jetty-launcher-3895-thread-4) 
[n:127.0.0.1:61189_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_61189.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@45884cac
   [junit4]   2> 2328893 INFO  (jetty-launcher-3895-thread-2) 
[n:127.0.0.1:61191_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_FBED39E31DB3D9FB-001/tempDir-001/node2/.
   [junit4]   2> 2328894 INFO  (jetty-launcher-3895-thread-4) 
[n:127.0.0.1:61189_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_FBED39E31DB3D9FB-001/tempDir-001/node4/.
   [junit4]   2> 2328998 INFO  
(SUITE-CollectionsAPISolrJTest-seed#[FBED39E31DB3D9FB]-worker) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
   [junit4]   2> 2328999 INFO  
(SUITE-CollectionsAPISolrJTest-seed#[FBED39E31DB3D9FB]-worker) [    ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:61186/solr ready
   [junit4]   2> 2329167 INFO  
(TEST-CollectionsAPISolrJTest.testCreateAndDeleteAlias-seed#[FBED39E31DB3D9FB]) 
[    ] o.a.s.SolrTestCaseJ4 ###Starting testCreateAndDeleteAlias
   [junit4]   2> 2329174 INFO  (qtp2009569809-20723) [n:127.0.0.1:61191_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
replicationFactor=1&collection.configName=conf&name=aliasedCollection&nrtReplicas=1&action=CREATE&numShards=1&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 2329181 INFO  
(OverseerThreadFactory-8745-thread-1-processing-n:127.0.0.1:61189_solr) 
[n:127.0.0.1:61189_solr    ] o.a.s.c.CreateCollectionCmd Create collection 
aliasedCollection
   [junit4]   2> 2329303 INFO  
(OverseerStateUpdate-99030340260200459-127.0.0.1:61189_solr-n_0000000000) 
[n:127.0.0.1:61189_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"aliasedCollection",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"aliasedCollection_shard1_replica_n1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:61188/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 2329523 INFO  (qtp1728699514-20713) [n:127.0.0.1:61188_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node2&collection.configName=conf&newCollection=true&name=aliasedCollection_shard1_replica_n1&action=CREATE&numShards=1&collection=aliasedCollection&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 2329524 INFO  (qtp1728699514-20713) [n:127.0.0.1:61188_solr    
] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 
2147483647 transient cores
   [junit4]   2> 2329643 INFO  
(zkCallback-3917-thread-1-processing-n:127.0.0.1:61188_solr) 
[n:127.0.0.1:61188_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/aliasedCollection/state.json] for collection 
[aliasedCollection] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2329643 INFO  
(zkCallback-3917-thread-2-processing-n:127.0.0.1:61188_solr) 
[n:127.0.0.1:61188_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/aliasedCollection/state.json] for collection 
[aliasedCollection] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2330573 INFO  (qtp1728699514-20713) [n:127.0.0.1:61188_solr 
c:aliasedCollection s:shard1 r:core_node2 
x:aliasedCollection_shard1_replica_n1] o.a.s.c.SolrConfig Using Lucene 
MatchVersion: 7.2.0
   [junit4]   2> 2330579 INFO  (qtp1728699514-20713) [n:127.0.0.1:61188_solr 
c:aliasedCollection s:shard1 r:core_node2 
x:aliasedCollection_shard1_replica_n1] o.a.s.s.IndexSchema 
[aliasedCollection_shard1_replica_n1] Schema name=minimal
   [junit4]   2> 2330583 INFO  (qtp1728699514-20713) [n:127.0.0.1:61188_solr 
c:aliasedCollection s:shard1 r:core_node2 
x:aliasedCollection_shard1_replica_n1] o.a.s.s.IndexSchema Loaded schema 
minimal/1.1 with uniqueid field id
   [junit4]   2> 2330583 INFO  (qtp1728699514-20713) [n:127.0.0.1:61188_solr 
c:aliasedCollection s:shard1 r:core_node2 
x:aliasedCollection_shard1_replica_n1] o.a.s.c.CoreContainer Creating SolrCore 
'aliasedCollection_shard1_replica_n1' using configuration from collection 
aliasedCollection, trusted=true
   [junit4]   2> 2330583 INFO  (qtp1728699514-20713) [n:127.0.0.1:61188_solr 
c:aliasedCollection s:shard1 r:core_node2 
x:aliasedCollection_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter JMX monitoring 
for 'solr_61188.solr.core.aliasedCollection.shard1.replica_n1' (registry 
'solr.core.aliasedCollection.shard1.replica_n1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@45884cac
   [junit4]   2> 2330583 INFO  (qtp1728699514-20713) [n:127.0.0.1:61188_solr 
c:aliasedCollection s:shard1 r:core_node2 
x:aliasedCollection_shard1_replica_n1] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 2330583 INFO  (qtp1728699514-20713) [n:127.0.0.1:61188_solr 
c:aliasedCollection s:shard1 r:core_node2 
x:aliasedCollection_shard1_replica_n1] o.a.s.c.SolrCore 
[[aliasedCollection_shard1_replica_n1] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_FBED39E31DB3D9FB-001/tempDir-001/node1/aliasedCollection_shard1_replica_n1],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_FBED39E31DB3D9FB-001/tempDir-001/node1/./aliasedCollection_shard1_replica_n1/data/]
   [junit4]   2> 2330633 INFO  (qtp1728699514-20713) [n:127.0.0.1:61188_solr 
c:aliasedCollection s:shard1 r:core_node2 
x:aliasedCollection_shard1_replica_n1] o.a.s.u.UpdateHandler Using UpdateLog 
implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 2330633 INFO  (qtp1728699514-20713) [n:127.0.0.1:61188_solr 
c:aliasedCollection s:shard1 r:core_node2 
x:aliasedCollection_shard1_replica_n1] o.a.s.u.UpdateLog Initializing 
UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 
maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2330634 INFO  (qtp1728699514-20713) [n:127.0.0.1:61188_solr 
c:aliasedCollection s:shard1 r:core_node2 
x:aliasedCollection_shard1_replica_n1] o.a.s.u.CommitTracker Hard AutoCommit: 
disabled
   [junit4]   2> 2330634 INFO  (qtp1728699514-20713) [n:127.0.0.1:61188_solr 
c:aliasedCollection s:shard1 r:core_node2 
x:aliasedCollection_shard1_replica_n1] o.a.s.u.CommitTracker Soft AutoCommit: 
disabled
   [junit4]   2> 2330635 INFO  (qtp1728699514-20713) [n:127.0.0.1:61188_solr 
c:aliasedCollection s:shard1 r:core_node2 
x:aliasedCollection_shard1_replica_n1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@333aa115[aliasedCollection_shard1_replica_n1] main]
   [junit4]   2> 2330636 INFO  (qtp1728699514-20713) [n:127.0.0.1:61188_solr 
c:aliasedCollection s:shard1 r:core_node2 
x:aliasedCollection_shard1_replica_n1] o.a.s.r.ManagedResourceStorage 
Configured ZooKeeperStorageIO with znodeBase: /configs/conf
   [junit4]   2> 2330636 INFO  (qtp1728699514-20713) [n:127.0.0.1:61188_solr 
c:aliasedCollection s:shard1 r:core_node2 
x:aliasedCollection_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Loaded 
null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 2330637 INFO  (qtp1728699514-20713) [n:127.0.0.1:61188_solr 
c:aliasedCollection s:shard1 r:core_node2 
x:aliasedCollection_shard1_replica_n1] o.a.s.h.ReplicationHandler Commits will 
be reserved for 10000ms.
   [junit4]   2> 2330637 INFO  (qtp1728699514-20713) [n:127.0.0.1:61188_solr 
c:aliasedCollection s:shard1 r:core_node2 
x:aliasedCollection_shard1_replica_n1] o.a.s.u.UpdateLog Could not find max 
version in index or recent updates, using new clock 1584485446702858240
   [junit4]   2> 2330637 INFO  
(searcherExecutor-8754-thread-1-processing-n:127.0.0.1:61188_solr 
x:aliasedCollection_shard1_replica_n1 s:shard1 c:aliasedCollection 
r:core_node2) [n:127.0.0.1:61188_solr c:aliasedCollection s:shard1 r:core_node2 
x:aliasedCollection_shard1_replica_n1] o.a.s.c.SolrCore 
[aliasedCollection_shard1_replica_n1] Registered new searcher 
Searcher@333aa115[aliasedCollection_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2330642 INFO  (qtp1728699514-20713) [n:127.0.0.1:61188_solr 
c:aliasedCollection s:shard1 r:core_node2 
x:aliasedCollection_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext 
Enough replicas found to continue.
   [junit4]   2> 2330642 INFO  (qtp1728699514-20713) [n:127.0.0.1:61188_solr 
c:aliasedCollection s:shard1 r:core_node2 
x:aliasedCollection_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I may 
be the new leader - try and sync
   [junit4]   2> 2330643 INFO  (qtp1728699514-20713) [n:127.0.0.1:61188_solr 
c:aliasedCollection s:shard1 r:core_node2 
x:aliasedCollection_shard1_replica_n1] o.a.s.c.SyncStrategy Sync replicas to 
http://127.0.0.1:61188/solr/aliasedCollection_shard1_replica_n1/
   [junit4]   2> 2330643 INFO  (qtp1728699514-20713) [n:127.0.0.1:61188_solr 
c:aliasedCollection s:shard1 r:core_node2 
x:aliasedCollection_shard1_replica_n1] o.a.s.c.SyncStrategy Sync Success - now 
sync replicas to me
   [junit4]   2> 2330643 INFO  (qtp1728699514-20713) [n:127.0.0.1:61188_solr 
c:aliasedCollection s:shard1 r:core_node2 
x:aliasedCollection_shard1_replica_n1] o.a.s.c.SyncStrategy 
http://127.0.0.1:61188/solr/aliasedCollection_shard1_replica_n1/ has no replicas
   [junit4]   2> 2330643 INFO  (qtp1728699514-20713) [n:127.0.0.1:61188_solr 
c:aliasedCollection s:shard1 r:core_node2 
x:aliasedCollection_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext Found 
all replicas participating in election, clear LIR
   [junit4]   2> 2330647 INFO  (qtp1728699514-20713) [n:127.0.0.1:61188_solr 
c:aliasedCollection s:shard1 r:core_node2 
x:aliasedCollection_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I am 
the new leader: 
http://127.0.0.1:61188/solr/aliasedCollection_shard1_replica_n1/ shard1
   [junit4]   2> 2330752 INFO  
(zkCallback-3917-thread-2-processing-n:127.0.0.1:61188_solr) 
[n:127.0.0.1:61188_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/aliasedCollection/state.json] for collection 
[aliasedCollection] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2330752 INFO  
(zkCallback-3917-thread-1-processing-n:127.0.0.1:61188_solr) 
[n:127.0.0.1:61188_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/aliasedCollection/state.json] for collection 
[aliasedCollection] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2330807 INFO  (qtp1728699514-20713) [n:127.0.0.1:61188_solr 
c:aliasedCollection s:shard1 r:core_node2 
x:aliasedCollection_shard1_replica_n1] o.a.s.c.ZkController I am the leader, no 
recovery necessary
   [junit4]   2> 2330812 INFO  (qtp1728699514-20713) [n:127.0.0.1:61188_solr 
c:aliasedCollection s:shard1 r:core_node2 
x:aliasedCollection_shard1_replica_n1] o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node2&collection.configName=conf&newCollection=true&name=aliasedCollection_shard1_replica_n1&action=CREATE&numShards=1&collection=aliasedCollection&shard=shard1&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=1289
   [junit4]   2> 2330823 INFO  (qtp2009569809-20723) [n:127.0.0.1:61191_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> 2330923 INFO  
(zkCallback-3917-thread-1-processing-n:127.0.0.1:61188_solr) 
[n:127.0.0.1:61188_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/aliasedCollection/state.json] for collection 
[aliasedCollection] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2330923 INFO  
(zkCallback-3917-thread-2-processing-n:127.0.0.1:61188_solr) 
[n:127.0.0.1:61188_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/aliasedCollection/state.json] for collection 
[aliasedCollection] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2331188 INFO  
(OverseerCollectionConfigSetProcessor-99030340260200459-127.0.0.1:61189_solr-n_0000000000)
 [n:127.0.0.1:61189_solr    ] o.a.s.c.OverseerTaskQueue Response ZK path: 
/overseer/collection-queue-work/qnr-0000000000 doesn't exist.  Requestor may 
have disconnected from ZooKeeper
   [junit4]   2> 2331833 INFO  (qtp2009569809-20723) [n:127.0.0.1:61191_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={replicationFactor=1&collection.configName=conf&name=aliasedCollection&nrtReplicas=1&action=CREATE&numShards=1&wt=javabin&version=2}
 status=0 QTime=2658
   [junit4]   2> 2331834 INFO  (qtp2009569809-20724) [n:127.0.0.1:61191_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :createalias with 
params 
collections=aliasedCollection&name=solrj_alias&action=CREATEALIAS&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 2331960 INFO  (qtp2009569809-20724) [n:127.0.0.1:61191_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={collections=aliasedCollection&name=solrj_alias&action=CREATEALIAS&wt=javabin&version=2}
 status=0 QTime=126
   [junit4]   2> 2331961 INFO  (qtp2009569809-20727) [n:127.0.0.1:61191_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :deletealias with 
params name=solrj_alias&action=DELETEALIAS&wt=javabin&version=2 and 
sendToOCPQueue=true
   [junit4]   2> 2331969 INFO  
(OverseerCollectionConfigSetProcessor-99030340260200459-127.0.0.1:61189_solr-n_0000000000)
 [n:127.0.0.1:61189_solr    ] 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> 2331974 INFO  (qtp2009569809-20727) [n:127.0.0.1:61191_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={name=solrj_alias&action=DELETEALIAS&wt=javabin&version=2} status=0 
QTime=12
   [junit4]   2> 2331974 INFO  
(TEST-CollectionsAPISolrJTest.testCreateAndDeleteAlias-seed#[FBED39E31DB3D9FB]) 
[    ] o.a.s.SolrTestCaseJ4 ###Ending testCreateAndDeleteAlias
   [junit4]   2> 2332181 INFO  
(TEST-CollectionsAPISolrJTest.testOverseerStatus-seed#[FBED39E31DB3D9FB]) [    
] o.a.s.SolrTestCaseJ4 ###Starting testOverseerStatus
   [junit4]   2> 2332182 INFO  (qtp2009569809-20739) [n:127.0.0.1:61191_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :overseerstatus with 
params action=OVERSEERSTATUS&wt=javabin&version=2 and sendToOCPQueue=true
   [junit4]   2> 2332186 INFO  
(OverseerCollectionConfigSetProcessor-99030340260200459-127.0.0.1:61189_solr-n_0000000000)
 [n:127.0.0.1:61189_solr    ] 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> 2332191 INFO  (qtp2009569809-20739) [n:127.0.0.1:61191_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={action=OVERSEERSTATUS&wt=javabin&version=2} status=0 QTime=8
   [junit4]   2> 2332191 INFO  
(TEST-CollectionsAPISolrJTest.testOverseerStatus-seed#[FBED39E31DB3D9FB]) [    
] o.a.s.SolrTestCaseJ4 ###Ending testOverseerStatus
   [junit4]   2> 2332364 INFO  
(TEST-CollectionsAPISolrJTest.testClusterProp-seed#[FBED39E31DB3D9FB]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testClusterProp
   [junit4]   2> 2332365 INFO  (qtp2009569809-20740) [n:127.0.0.1:61191_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :clusterprop with 
params val=true&name=legacyCloud&action=CLUSTERPROP&wt=javabin&version=2 and 
sendToOCPQueue=true
   [junit4]   2> 2332367 INFO  (qtp2009569809-20740) [n:127.0.0.1:61191_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={val=true&name=legacyCloud&action=CLUSTERPROP&wt=javabin&version=2} 
status=0 QTime=1
   [junit4]   2> 2332368 INFO  (qtp2009569809-20744) [n:127.0.0.1:61191_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :clusterprop with 
params name=legacyCloud&action=CLUSTERPROP&wt=javabin&version=2 and 
sendToOCPQueue=true
   [junit4]   2> 2332370 INFO  (qtp2009569809-20744) [n:127.0.0.1:61191_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={name=legacyCloud&action=CLUSTERPROP&wt=javabin&version=2} status=0 
QTime=1
   [junit4]   2> 2332371 INFO  (qtp2009569809-20715) [n:127.0.0.1:61191_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :clusterprop with 
params val=false&name=legacyCloud&action=CLUSTERPROP&wt=javabin&version=2 and 
sendToOCPQueue=true
   [junit4]   2> 2332373 INFO  (qtp2009569809-20715) [n:127.0.0.1:61191_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={val=false&name=legacyCloud&action=CLUSTERPROP&wt=javabin&version=2} 
status=0 QTime=1
   [junit4]   2> 2332374 INFO  
(TEST-CollectionsAPISolrJTest.testClusterProp-seed#[FBED39E31DB3D9FB]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testClusterProp
   [junit4]   2> 2332550 INFO  
(TEST-CollectionsAPISolrJTest.testBalanceShardUnique-seed#[FBED39E31DB3D9FB]) [ 
   ] o.a.s.SolrTestCaseJ4 ###Starting testBalanceShardUnique
   [junit4]   2> 2332550 INFO  (qtp2009569809-20723) [n:127.0.0.1:61191_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
replicationFactor=2&collection.configName=conf&name=balancedProperties&nrtReplicas=2&action=CREATE&numShards=2&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 2332554 INFO  
(OverseerThreadFactory-8745-thread-5-processing-n:127.0.0.1:61189_solr) 
[n:127.0.0.1:61189_solr    ] o.a.s.c.CreateCollectionCmd Create collection 
balancedProperties
   [junit4]   2> 2332555 INFO  
(OverseerCollectionConfigSetProcessor-99030340260200459-127.0.0.1:61189_solr-n_0000000000)
 [n:127.0.0.1:61189_solr    ] o.a.s.c.OverseerTaskQueue Response ZK path: 
/overseer/collection-queue-work/qnr-0000000006 doesn't exist.  Requestor may 
have disconnected from ZooKeeper
   [junit4]   2> 2332776 INFO  
(OverseerStateUpdate-99030340260200459-127.0.0.1:61189_solr-n_0000000000) 
[n:127.0.0.1:61189_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"balancedProperties",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"balancedProperties_shard1_replica_n1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:61190/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 2332784 INFO  
(OverseerStateUpdate-99030340260200459-127.0.0.1:61189_solr-n_0000000000) 
[n:127.0.0.1:61189_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"balancedProperties",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"balancedProperties_shard1_replica_n2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:61189/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 2332791 INFO  
(OverseerStateUpdate-99030340260200459-127.0.0.1:61189_solr-n_0000000000) 
[n:127.0.0.1:61189_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"balancedProperties",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "core":"balancedProperties_shard2_replica_n4",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:61188/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 2332797 INFO  
(OverseerStateUpdate-99030340260200459-127.0.0.1:61189_solr-n_0000000000) 
[n:127.0.0.1:61189_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"balancedProperties",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "core":"balancedProperties_shard2_replica_n6",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:61191/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 2333006 INFO  (qtp1728699514-20714) [n:127.0.0.1:61188_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node7&collection.configName=conf&newCollection=true&name=balancedProperties_shard2_replica_n4&action=CREATE&numShards=2&collection=balancedProperties&shard=shard2&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 2333018 INFO  (qtp2009569809-20727) [n:127.0.0.1:61191_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node8&collection.configName=conf&newCollection=true&name=balancedProperties_shard2_replica_n6&action=CREATE&numShards=2&collection=balancedProperties&shard=shard2&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 2333018 INFO  (qtp869933141-20728) [n:127.0.0.1:61190_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=balancedProperties_shard1_replica_n1&action=CREATE&numShards=2&collection=balancedProperties&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 2333023 INFO  (qtp1369937093-20725) [n:127.0.0.1:61189_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node5&collection.configName=conf&newCollection=true&name=balancedProperties_shard1_replica_n2&action=CREATE&numShards=2&collection=balancedProperties&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 2333023 INFO  (qtp2009569809-20727) [n:127.0.0.1:61191_solr    
] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 
2147483647 transient cores
   [junit4]   2> 2333024 INFO  (qtp1369937093-20725) [n:127.0.0.1:61189_solr    
] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 
2147483647 transient cores
   [junit4]   2> 2333025 INFO  (qtp869933141-20728) [n:127.0.0.1:61190_solr    
] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 
2147483647 transient cores
   [junit4]   2> 2333152 INFO  
(zkCallback-3917-thread-2-processing-n:127.0.0.1:61188_solr) 
[n:127.0.0.1:61188_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/balancedProperties/state.json] for collection 
[balancedProperties] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2333152 INFO  
(zkCallback-3914-thread-1-processing-n:127.0.0.1:61191_solr) 
[n:127.0.0.1:61191_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/balancedProperties/state.json] for collection 
[balancedProperties] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2333152 INFO  
(zkCallback-3916-thread-1-processing-n:127.0.0.1:61189_solr) 
[n:127.0.0.1:61189_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/balancedProperties/state.json] for collection 
[balancedProperties] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2333152 INFO  
(zkCallback-3915-thread-1-processing-n:127.0.0.1:61190_solr) 
[n:127.0.0.1:61190_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/balancedProperties/state.json] for collection 
[balancedProperties] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2333152 INFO  
(zkCallback-3917-thread-1-processing-n:127.0.0.1:61188_solr) 
[n:127.0.0.1:61188_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/balancedProperties/state.json] for collection 
[balancedProperties] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2333153 INFO  
(zkCallback-3915-thread-2-processing-n:127.0.0.1:61190_solr) 
[n:127.0.0.1:61190_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/balancedProperties/state.json] for collection 
[balancedProperties] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2333154 INFO  
(zkCallback-3916-thread-2-processing-n:127.0.0.1:61189_solr) 
[n:127.0.0.1:61189_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/balancedProperties/state.json] for collection 
[balancedProperties] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2333156 INFO  
(zkCallback-3914-thread-2-processing-n:127.0.0.1:61191_solr) 
[n:127.0.0.1:61191_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/balancedProperties/state.json] for collection 
[balancedProperties] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2334059 INFO  (qtp1728699514-20714) [n:127.0.0.1:61188_solr 
c:balancedProperties s:shard2 r:core_node7 
x:balancedProperties_shard2_replica_n4] o.a.s.c.SolrConfig Using Lucene 
MatchVersion: 7.2.0
   [junit4]   2> 2334059 INFO  (qtp1369937093-20725) [n:127.0.0.1:61189_solr 
c:balancedProperties s:shard1 r:core_node5 
x:balancedProperties_shard1_replica_n2] o.a.s.c.SolrConfig Using Lucene 
MatchVersion: 7.2.0
   [junit4]   2> 2334059 INFO  (qtp2009569809-20727) [n:127.0.0.1:61191_solr 
c:balancedProperties s:shard2 r:core_node8 
x:balancedProperties_shard2_replica_n6] o.a.s.c.SolrConfig Using Lucene 
MatchVersion: 7.2.0
   [junit4]   2> 2334076 INFO  (qtp869933141-20728) [n:127.0.0.1:61190_solr 
c:balancedProperties s:shard1 r:core_node3 
x:balancedProperties_shard1_replica_n1] o.a.s.c.SolrConfig Using Lucene 
MatchVersion: 7.2.0
   [junit4]   2> 2334077 INFO  (qtp2009569809-20727) [n:127.0.0.1:61191_solr 
c:balancedProperties s:shard2 r:core_node8 
x:balancedProperties_shard2_replica_n6] o.a.s.s.IndexSchema 
[balancedProperties_shard2_replica_n6] Schema name=minimal
   [junit4]   2> 2334078 INFO  (qtp1728699514-20714) [n:127.0.0.1:61188_solr 
c:balancedProperties s:shard2 r:core_node7 
x:balancedProperties_shard2_replica_n4] o.a.s.s.IndexSchema 
[balancedProperties_shard2_replica_n4] Schema name=minimal
   [junit4]   2> 2334081 INFO  (qtp1369937093-20725) [n:127.0.0.1:61189_solr 
c:balancedProperties s:shard1 r:core_node5 
x:balancedProperties_shard1_replica_n2] o.a.s.s.IndexSchema 
[balancedProperties_shard1_replica_n2] Schema name=minimal
   [junit4]   2> 2334082 INFO  (qtp869933141-20728) [n:127.0.0.1:61190_solr 
c:balancedProperties s:shard1 r:core_node3 
x:balancedProperties_shard1_replica_n1] o.a.s.s.IndexSchema 
[balancedProperties_shard1_replica_n1] Schema name=minimal
   [junit4]   2> 2334082 INFO  (qtp1369937093-20725) [n:127.0.0.1:61189_solr 
c:balancedProperties s:shard1 r:core_node5 
x:balancedProperties_shard1_replica_n2] o.a.s.s.IndexSchema Loaded schema 
minimal/1.1 with uniqueid field id
   [junit4]   2> 2334082 INFO  (qtp1369937093-20725) [n:127.0.0.1:61189_solr 
c:balancedProperties s:shard1 r:core_node5 
x:balancedProperties_shard1_replica_n2] o.a.s.c.CoreContainer Creating SolrCore 
'balancedProperties_shard1_replica_n2' using configuration from collection 
balancedProperties, trusted=true
   [junit4]   2> 2334083 INFO  (qtp1369937093-20725) [n:127.0.0.1:61189_solr 
c:balancedProperties s:shard1 r:core_node5 
x:balancedProperties_shard1_replica_n2] o.a.s.m.r.SolrJmxReporter JMX 
monitoring for 'solr_61189.solr.core.balancedProperties.shard1.replica_n2' 
(registry 'solr.core.balancedProperties.shard1.replica_n2') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@45884cac
   [junit4]   2> 2334083 INFO  (qtp1369937093-20725) [n:127.0.0.1:61189_solr 
c:balancedProperties s:shard1 r:core_node5 
x:balancedProperties_shard1_replica_n2] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 2334083 INFO  (qtp1369937093-20725) [n:127.0.0.1:61189_solr 
c:balancedProperties s:shard1 r:core_node5 
x:balancedProperties_shard1_replica_n2] o.a.s.c.SolrCore 
[[balancedProperties_shard1_replica_n2] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_FBED39E31DB3D9FB-001/tempDir-001/node4/balancedProperties_shard1_replica_n2],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_FBED39E31DB3D9FB-001/tempDir-001/node4/./balancedProperties_shard1_replica_n2/data/]
   [junit4]   2> 2334084 INFO  (qtp869933141-20728) [n:127.0.0.1:61190_solr 
c:balancedProperties s:shard1 r:core_node3 
x:balancedProperties_shard1_replica_n1] o.a.s.s.IndexSchema Loaded schema 
minimal/1.1 with uniqueid field id
   [junit4]   2> 2334084 INFO  (qtp869933141-20728) [n:127.0.0.1:61190_solr 
c:balancedProperties s:shard1 r:core_node3 
x:balancedProperties_shard1_replica_n1] o.a.s.c.CoreContainer Creating SolrCore 
'balancedProperties_shard1_replica_n1' using configuration from collection 
balancedProperties, trusted=true
   [junit4]   2> 2334084 INFO  (qtp869933141-20728) [n:127.0.0.1:61190_solr 
c:balancedProperties s:shard1 r:core_node3 
x:balancedProperties_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter JMX 
monitoring for 'solr_61190.solr.core.balancedProperties.shard1.replica_n1' 
(registry 'solr.core.balancedProperties.shard1.replica_n1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@45884cac
   [junit4]   2> 2334084 INFO  (qtp869933141-20728) [n:127.0.0.1:61190_solr 
c:balancedProperties s:shard1 r:core_node3 
x:balancedProperties_shard1_replica_n1] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 2334084 INFO  (qtp869933141-20728) [n:127.0.0.1:61190_solr 
c:balancedProperties s:shard1 r:core_node3 
x:balancedProperties_shard1_replica_n1] o.a.s.c.SolrCore 
[[balancedProperties_shard1_replica_n1] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_FBED39E31DB3D9FB-001/tempDir-001/node3/balancedProperties_shard1_replica_n1],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_FBED39E31DB3D9FB-001/tempDir-001/node3/./balancedProperties_shard1_replica_n1/data/]
   [junit4]   2> 2334085 INFO  (qtp2009569809-20727) [n:127.0.0.1:61191_solr 
c:balancedProperties s:shard2 r:core_node8 
x:balancedProperties_shard2_replica_n6] o.a.s.s.IndexSchema Loaded schema 
minimal/1.1 with uniqueid field id
   [junit4]   2> 2334086 INFO  (qtp2009569809-20727) [n:127.0.0.1:61191_solr 
c:balancedProperties s:shard2 r:core_node8 
x:balancedProperties_shard2_replica_n6] o.a.s.c.CoreContainer Creating SolrCore 
'balancedProperties_shard2_replica_n6' using configuration from collection 
balancedProperties, trusted=true
   [junit4]   2> 2334086 INFO  (qtp2009569809-20727) [n:127.0.0.1:61191_solr 
c:balancedProperties s:shard2 r:core_node8 
x:balancedProperties_shard2_replica_n6] o.a.s.m.r.SolrJmxReporter JMX 
monitoring for 'solr_61191.solr.core.balancedProperties.shard2.replica_n6' 
(registry 'solr.core.balancedProperties.shard2.replica_n6') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@45884cac
   [junit4]   2> 2334086 INFO  (qtp2009569809-20727) [n:127.0.0.1:61191_solr 
c:balancedProperties s:shard2 r:core_node8 
x:balancedProperties_shard2_replica_n6] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 2334086 INFO  (qtp2009569809-20727) [n:127.0.0.1:61191_solr 
c:balancedProperties s:shard2 r:core_node8 
x:balancedProperties_shard2_replica_n6] o.a.s.c.SolrCore 
[[balancedProperties_shard2_replica_n6] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_FBED39E31DB3D9FB-001/tempDir-001/node2/balancedProperties_shard2_replica_n6],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_FBED39E31DB3D9FB-001/tempDir-001/node2/./balancedProperties_shard2_replica_n6/data/]
   [junit4]   2> 2334098 INFO  (qtp1728699514-20714) [n:127.0.0.1:61188_solr 
c:balancedProperties s:shard2 r:core_node7 
x:balancedProperties_shard2_replica_n4] o.a.s.s.IndexSchema Loaded schema 
minimal/1.1 with uniqueid field id
   [junit4]   2> 2334098 INFO  (qtp1728699514-20714) [n:127.0.0.1:61188_solr 
c:balancedProperties s:shard2 r:core_node7 
x:balancedProperties_shard2_replica_n4] o.a.s.c.CoreContainer Creating SolrCore 
'balancedProperties_shard2_replica_n4' using configuration from collection 
balancedProperties, trusted=true
   [junit4]   2> 2334098 INFO  (qtp1728699514-20714) [n:127.0.0.1:61188_solr 
c:balancedProperties s:shard2 r:core_node7 
x:balancedProperties_shard2_replica_n4] o.a.s.m.r.SolrJmxReporter JMX 
monitoring for 'solr_61188.solr.core.balancedProperties.shard2.replica_n4' 
(registry 'solr.core.balancedProperties.shard2.replica_n4') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@45884cac
   [junit4]   2> 2334099 INFO  (qtp1728699514-20714) [n:127.0.0.1:61188_solr 
c:balancedProperties s:shard2 r:core_node7 
x:balancedProperties_shard2_replica_n4] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 2334099 INFO  (qtp1728699514-20714) [n:127.0.0.1:61188_solr 
c:balancedProperties s:shard2 r:core_node7 
x:balancedProperties_shard2_replica_n4] o.a.s.c.SolrCore 
[[balancedProperties_shard2_replica_n4] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_FBED39E31DB3D9FB-001/tempDir-001/node1/balancedProperties_shard2_replica_n4],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_FBED39E31DB3D9FB-001/tempDir-001/node1/./balancedProperties_shard2_replica_n4/data/]
   [junit4]   2> 2334179 INFO  (qtp2009569809-20727) [n:127.0.0.1:61191_solr 
c:balancedProperties s:shard2 r:core_node8 
x:balancedProperties_shard2_replica_n6] o.a.s.u.UpdateHandler Using UpdateLog 
implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 2334179 INFO  (qtp2009569809-20727) [n:127.0.0.1:61191_solr 
c:balancedProperties s:shard2 r:core_node8 
x:balancedProperties_shard2_replica_n6] o.a.s.u.UpdateLog Initializing 
UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 
maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2334180 INFO  (qtp2009569809-20727) [n:127.0.0.1:61191_solr 
c:balancedProperties s:shard2 r:core_node8 
x:balancedProperties_shard2_replica_n6] o.a.s.u.CommitTracker Hard AutoCommit: 
disabled
   [junit4]   2> 2334180 INFO  (qtp2009569809-20727) [n:127.0.0.1:61191_solr 
c:balancedProperties s:shard2 r:core_node8 
x:balancedProperties_shard2_replica_n6] o.a.s.u.CommitTracker Soft AutoCommit: 
disabled
   [junit4]   2> 2334190 INFO  (qtp1728699514-20714) [n:127.0.0.1:61188_solr 
c:balancedProperties s:shard2 r:core_node7 
x:balancedProperties_shard2_replica_n4] o.a.s.u.UpdateHandler Using UpdateLog 
implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 2334190 INFO  (qtp1728699514-20714) [n:127.0.0.1:61188_solr 
c:balancedProperties s:shard2 r:core_node7 
x:balancedProperties_shard2_replica_n4] o.a.s.u.UpdateLog Initializing 
UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 
maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2334190 INFO  (qtp1369937093-20725) [n:127.0.0.1:61189_solr 
c:balancedProperties s:shard1 r:core_node5 
x:balancedProperties_shard1_replica_n2] o.a.s.u.UpdateHandler Using UpdateLog 
implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 2334190 INFO  (qtp1369937093-20725) [n:127.0.0.1:61189_solr 
c:balancedProperties s:shard1 r:core_node5 
x:balancedProperties_shard1_replica_n2] o.a.s.u.UpdateLog Initializing 
UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 
maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2334191 INFO  (qtp1728699514-20714) [n:127.0.0.1:61188_solr 
c:balancedProperties s:shard2 r:core_node7 
x:balancedProperties_shard2_replica_n4] o.a.s.u.CommitTracker Hard AutoCommit: 
disabled
   [junit4]   2> 2334191 INFO  (qtp1728699514-20714) [n:127.0.0.1:61188_solr 
c:balancedProperties s:shard2 r:core_node7 
x:balancedProperties_shard2_replica_n4] o.a.s.u.CommitTracker Soft AutoCommit: 
disabled
   [junit4]   2> 2334191 INFO  (qtp1369937093-20725) [n:127.0.0.1:61189_solr 
c:balancedProperties s:shard1 r:core_node5 
x:balancedProperties_shard1_replica_n2] o.a.s.u.CommitTracker Hard AutoCommit: 
disabled
   [junit4]   2> 2334191 INFO  (qtp1369937093-20725) [n:127.0.0.1:61189_solr 
c:balancedProperties s:shard1 r:core_node5 
x:balancedProperties_shard1_replica_n2] o.a.s.u.CommitTracker Soft AutoCommit: 
disabled
   [junit4]   2> 2334195 INFO  (qtp869933141-20728) [n:127.0.0.1:61190_solr 
c:balancedProperties s:shard1 r:core_node3 
x:balancedProperties_shard1_replica_n1] o.a.s.u.UpdateHandler Using UpdateLog 
implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 2334195 INFO  (qtp869933141-20728) [n:127.0.0.1:61190_solr 
c:balancedProperties s:shard1 r:core_node3 
x:balancedProperties_shard1_replica_n1] o.a.s.u.UpdateLog Initializing 
UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 
maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2334197 INFO  (qtp869933141-20728) [n:127.0.0.1:61190_solr 
c:balancedProperties s:shard1 r:core_node3 
x:balancedProperties_shard1_replica_n1] o.a.s.u.CommitTracker Hard AutoCommit: 
disabled
   [junit4]   2> 2334197 INFO  (qtp869933141-20728) [n:127.0.0.1:61190_solr 
c:balancedProperties s:shard1 r:core_node3 
x:balancedProperties_shard1_replica_n1] o.a.s.u.CommitTracker Soft AutoCommit: 
disabled
   [junit4]   2> 2334198 INFO  (qtp2009569809-20727) [n:127.0.0.1:61191_solr 
c:balancedProperties s:shard2 r:core_node8 
x:balancedProperties_shard2_replica_n6] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@43cc5e1b[balancedProperties_shard2_replica_n6] main]
   [junit4]   2> 2334199 INFO  (qtp2009569809-20727) [n:127.0.0.1:61191_solr 
c:balancedProperties s:shard2 r:core_node8 
x:balancedProperties_shard2_replica_n6] o.a.s.r.ManagedResourceStorage 
Configured ZooKeeperStorageIO with znodeBase: /configs/conf
   [junit4]   2> 2334199 INFO  (qtp2009569809-20727) [n:127.0.0.1:61191_solr 
c:balancedProperties s:shard2 r:core_node8 
x:balancedProperties_shard2_replica_n6] o.a.s.r.ManagedResourceStorage Loaded 
null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 2334200 INFO  (qtp2009569809-20727) [n:127.0.0.1:61191_solr 
c:balancedProperties s:shard2 r:core_node8 
x:balancedProperties_shard2_replica_n6] o.a.s.h.ReplicationHandler Commits will 
be reserved for 10000ms.
   [junit4]   2> 2334200 INFO  (qtp2009569809-20727) [n:127.0.0.1:61191_solr 
c:balancedProperties s:shard2 r:core_node8 
x:balancedProperties_shard2_replica_n6] o.a.s.u.UpdateLog Could not find max 
version in index or recent updates, using new clock 1584485450438934528
   [junit4]   2> 2334200 INFO  
(searcherExecutor-8761-thread-1-processing-n:127.0.0.1:61191_solr 
x:balancedProperties_shard2_replica_n6 s:shard2 c:balancedProperties 
r:core_node8) [n:127.0.0.1:61191_solr c:balancedProperties s:shard2 
r:core_node8 x:balancedProperties_shard2_replica_n6] o.a.s.c.SolrCore 
[balancedProperties_shard2_replica_n6] Registered new searcher 
Searcher@43cc5e1b[balancedProperties_shard2_replica_n6] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2334204 INFO  (qtp1728699514-20714) [n:127.0.0.1:61188_solr 
c:balancedProperties s:shard2 r:core_node7 
x:balancedProperties_shard2_replica_n4] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@3079f923[balancedProperties_shard2_replica_n4] main]
   [junit4]   2> 2334205 INFO  (qtp1728699514-20714) [n:127.0.0.1:61188_solr 
c:balancedProperties s:shard2 r:core_node7 
x:balancedProperties_shard2_replica_n4] o.a.s.r.ManagedResourceStorage 
Configured ZooKeeperStorageIO with znodeBase: /configs/conf
   [junit4]   2> 2334206 INFO  (qtp1728699514-20714) [n:127.0.0.1:61188_solr 
c:balancedProperties s:shard2 r:core_node7 
x:balancedProperties_shard2_replica_n4] o.a.s.r.ManagedResourceStorage Loaded 
null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 2334206 INFO  (qtp1728699514-20714) [n:127.0.0.1:61188_solr 
c:balancedProperties s:shard2 r:core_node7 
x:balancedProperties_shard2_replica_n4] o.a.s.h.ReplicationHandler Commits will 
be reserved for 10000ms.
   [junit4]   2> 2334207 INFO  
(searcherExecutor-8762-thread-1-processing-n:127.0.0.1:61188_solr 
x:balancedProperties_shard2_replica_n4 s:shard2 c:balancedProperties 
r:core_node7) [n:127.0.0.1:61188_solr c:balancedProperties s:shard2 
r:core_node7 x:balancedProperties_shard2_replica_n4] o.a.s.c.SolrCore 
[balancedProperties_shard2_replica_n4] Registered new searcher 
Searcher@3079f923[balancedProperties_shard2_replica_n4] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2334207 INFO  (qtp1728699514-20714) [n:127.0.0.1:61188_solr 
c:balancedProperties s:shard2 r:core_node7 
x:balancedProperties_shard2_replica_n4] o.a.s.u.UpdateLog Could not find max 
version in index or recent updates, using new clock 1584485450446274560
   [junit4]   2> 2334207 INFO  (qtp2009569809-20727) [n:127.0.0.1:61191_solr 
c:balancedProperties s:shard2 r:core_node8 
x:balancedProperties_shard2_replica_n6] o.a.s.c.ShardLeaderElectionContext 
Waiting until we see more replicas up for shard shard2: total=2 found=1 
timeoutin=9999ms
   [junit4]   2> 2334210 INFO  (qtp1369937093-20725) [n:127.0.0.1:61189_solr 
c:balancedProperties s:shard1 r:core_node5 
x:balancedProperties_shard1_replica_n2] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@24a55840[balancedProperties_shard1_replica_n2] main]
   [junit4]   2> 2334210 INFO  (qtp869933141-20728) [n:127.0.0.1:61190_solr 
c:balancedProperties s:shard1 r:core_node3 
x:balancedProperties_shard1_replica_n1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@874919f[balancedProperties_shard1_replica_n1] main]
   [junit4]   2> 2334212 INFO  (qtp1369937093-20725) [n:127.0.0.1:61189_solr 
c:balancedProperties s:shard1 r:core_node5 
x:balancedProperties_shard1_replica_n2] o.a.s.r.ManagedResourceStorage 
Configured ZooKeeperStorageIO with znodeBase: /configs/conf
   [junit4]   2> 2334212 INFO  (qtp869933141-20728) [n:127.0.0.1:61190_solr 
c:balancedProperties s:shard1 r:core_node3 
x:balancedProperties_shard1_replica_n1] o.a.s.r.ManagedResourceStorage 
Configured ZooKeeperStorageIO with znodeBase: /configs/conf
   [junit4]   2> 2334212 INFO  (qtp869933141-20728) [n:127.0.0.1:61190_solr 
c:balancedProperties s:shard1 r:core_node3 
x:balancedProperties_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Loaded 
null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 2334212 INFO  (qtp1369937093-20725) [n:127.0.0.1:61189_solr 
c:balancedProperties s:shard1 r:core_node5 
x:balancedProperties_shard1_replica_n2] o.a.s.r.ManagedResourceStorage Loaded 
null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 2334213 INFO  (qtp1369937093-20725) [n:127.0.0.1:61189_solr 
c:balancedProperties s:shard1 r:core_node5 
x:balancedProperties_shard1_replica_n2] o.a.s.h.ReplicationHandler Commits will 
be reserved for 10000ms.
   [junit4]   2> 2334213 INFO  (qtp1369937093-20725) [n:127.0.0.1:61189_solr 
c:balancedProperties s:shard1 r:core_node5 
x:balancedProperties_shard1_replica_n2] o.a.s.u.UpdateLog Could not find max 
version in index or recent updates, using new clock 1584485450452566016
   [junit4]   2> 2334213 INFO  
(searcherExecutor-8759-thread-1-processing-n:127.0.0.1:61189_solr 
x:balancedProperties_shard1_replica_n2 s:shard1 c:balancedProperties 
r:core_node5) [n:127.0.0.1:61189_solr c:balancedProperties s:shard1 
r:core_node5 x:balancedProperties_shard1_replica_n2] o.a.s.c.SolrCore 
[balancedProperties_shard1_replica_n2] Registered new searcher 
Searcher@24a55840[balancedProperties_shard1_replica_n2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2334213 INFO  (qtp869933141-20728) [n:127.0.0.1:61190_solr 
c:balancedProperties s:shard1 r:core_node3 
x:balancedProperties_shard1_replica_n1] o.a.s.h.ReplicationHandler Commits will 
be reserved for 10000ms.
   [junit4]   2> 2334214 INFO  (qtp869933141-20728) [n:127.0.0.1:61190_solr 
c:balancedProperties s:shard1 r:core_node3 
x:balancedProperties_shard1_replica_n1] o.a.s.u.UpdateLog Could not find max 
version in index or recent updates, using new clock 1584485450453614592
   [junit4]   2> 2334214 INFO  
(searcherExecutor-8760-thread-1-processing-n:127.0.0.1:61190_solr 
x:balancedProperties_shard1_replica_n1 s:shard1 c:balancedProperties 
r:core_node3) [n:127.0.0.1:61190_solr c:balancedProperties s:shard1 
r:core_node3 x:balancedProperties_shard1_replica_n1] o.a.s.c.SolrCore 
[balancedProperties_shard1_replica_n1] Registered new searcher 
Searcher@874919f[balancedProperties_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2334245 INFO  (qtp869933141-20728) [n:127.0.0.1:61190_solr 
c:balancedProperties s:shard1 r:core_node3 
x:balancedProperties_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext 
Enough replicas found to continue.
   [junit4]   2> 2334245 INFO  (qtp869933141-20728) [n:127.0.0.1:61190_solr 
c:balancedProperties s:shard1 r:core_node3 
x:balancedProperties_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I 
may be the new leader - try and sync
   [junit4]   2> 2334245 INFO  (qtp869933141-20728) [n:127.0.0.1:61190_solr 
c:balancedProperties s:shard1 r:core_node3 
x:balancedProperties_shard1_replica_n1] o.a.s.c.SyncStrategy Sync replicas to 
http://127.0.0.1:61190/solr/balancedProperties_shard1_replica_n1/
   [junit4]   2> 2334246 INFO  (qtp869933141-20728) [n:127.0.0.1:61190_solr 
c:balancedProperties s:shard1 r:core_node3 
x:balancedProperties_shard1_replica_n1] o.a.s.u.PeerSync PeerSync: 
core=balancedProperties_shard1_replica_n1 url=http://127.0.0.1:61190/solr START 
replicas=[http://127.0.0.1:61189/solr/balancedProperties_shard1_replica_n2/] 
nUpdates=100
   [junit4]   2> 2334247 INFO  (qtp1369937093-20732) [n:127.0.0.1:61189_solr 
c:balancedProperties s:shard1 r:core_node5 
x:balancedProperties_shard1_replica_n2] o.a.s.c.S.Request 
[balancedProperties_shard1_replica_n2]  webapp=/solr path=/get 
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2334349 INFO  
(zkCallback-3915-thread-2-processing-n:127.0.0.1:61190_solr) 
[n:127.0.0.1:61190_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/balancedProperties/state.json] for collection 
[balancedProperties] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2334349 INFO  
(zkCallback-3915-thread-1-processing-n:127.0.0.1:61190_solr) 
[n:127.0.0.1:61190_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/balancedProperties/state.json] for collection 
[balancedProperties] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2334349 INFO  
(zkCallback-3914-thread-2-processing-n:127.0.0.1:61191_solr) 
[n:127.0.0.1:61191_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/balancedProperties/state.json] for collection 
[balancedProperties] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2334349 INFO  
(zkCallback-3916-thread-2-processing-n:127.0.0.1:61189_solr) 
[n:127.0.0.1:61189_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/balancedProperties/state.json] for collection 
[balancedProperties] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2334349 INFO  
(zkCallback-3916-thread-1-processing-n:127.0.0.1:61189_solr) 
[n:127.0.0.1:61189_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/balancedProperties/state.json] for collection 
[balancedProperties] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2334349 INFO  
(zkCallback-3914-thread-1-processing-n:127.0.0.1:61191_solr) 
[n:127.0.0.1:61191_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/balancedProperties/state.json] for collection 
[balancedProperties] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2334349 INFO  
(zkCallback-3917-thread-2-processing-n:127.0.0.1:61188_solr) 
[n:127.0.0.1:61188_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/balancedProperties/state.json] for collection 
[balancedProperties] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2334349 INFO  
(zkCallback-3917-thread-1-processing-n:127.0.0.1:61188_solr) 
[n:127.0.0.1:61188_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/balancedProperties/state.json] for collection 
[balancedProperties] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2334549 INFO  (qtp869933141-20728) [n:127.0.0.1:61190_solr 
c:balancedProperties s:shard1 r:core_node3 
x:balancedProperties_shard1_replica_n1] o.a.s.u.PeerSync PeerSync: 
core=balancedProperties_shard1_replica_n1 url=http://127.0.0.1:61190/solr DONE. 
 We have no versions.  sync failed.
   [junit4]   2> 2334549 INFO  (qtp869933141-20728) [n:127.0.0.1:61190_solr 
c:balancedProperties s:shard1 r:core_node3 
x:balancedProperties_shard1_replica_n1] o.a.s.c.SyncStrategy Leader's attempt 
to sync with shard failed, moving to the next candidate
   [junit4]   2> 2334549 INFO  (qtp869933141-20728) [n:127.0.0.1:61190_solr 
c:balancedProperties s:shard1 r:core_node3 
x:balancedProperties_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext We 
failed sync, but we have no versions - we can't sync in that case - we were 
active before, so become leader anyway
   [junit4]   2> 2334549 INFO  (qtp869933141-20728) [n:127.0.0.1:61190_solr 
c:balancedProperties s:shard1 r:core_node3 
x:balancedProperties_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext 
Found all replicas participating in election, clear LIR
   [junit4]   2> 2334556 INFO  (qtp869933141-20728) [n:127.0.0.1:61190_solr 
c:balancedProperties s:shard1 r:core_node3 
x:balancedProperties_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I am 
the new leader: 
http://127.0.0.1:61190/solr/balancedProperties_shard1_replica_n1/ shard1
   [junit4]   2> 2334663 INFO  
(zkCallback-3915-thread-1-processing-n:127.0.0.1:61190_solr) 
[n:127.0.0.1:61190_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/balancedProperties/state.json] for collection 
[balancedProperties] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2334663 INFO  
(zkCallback-3917-thread-1-processing-n:127.0.0.1:61188_solr) 
[n:127.0.0.1:61188_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/balancedProperties/state.json] for collection 
[balancedProperties] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2334663 INFO  
(zkCallback-3915-thread-2-processing-n:127.0.0.1:61190_solr) 
[n:127.0.0.1:61190_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/balancedProperties/state.json] for collection 
[balancedProperties] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2334663 INFO  
(zkCallback-3917-thread-2-processing-n:127.0.0.1:61188_solr) 
[n:127.0.0.1:61188_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/balancedProperties/state.json] for collection 
[balancedProperties] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2334663 INFO  
(zkCallback-3916-thread-1-processing-n:127.0.0.1:61189_solr) 
[n:127.0.0.1:61189_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/balancedProperties/state.json] for collection 
[balancedProperties] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2334663 INFO  
(zkCallback-3914-thread-1-processing-n:127.0.0.1:61191_solr) 
[n:127.0.0.1:61191_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/balancedProperties/state.json] for collection 
[balancedProperties] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2334663 INFO  
(zkCallback-3916-thread-2-processing-n:127.0.0.1:61189_solr) 
[n:127.0.0.1:61189_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/balancedProperties/state.json] for collection 
[balancedProperties] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2334663 INFO  
(zkCallback-3914-thread-2-processing-n:127.0.0.1:61191_solr) 
[n:127.0.0.1:61191_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/balancedProperties/state.json] for collection 
[balancedProperties] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2334669 INFO  (qtp869933141-20728) [n:127.0.0.1:61190_solr 
c:balancedProperties s:shard1 r:core_node3 
x:balancedProperties_shard1_replica_n1] o.a.s.c.ZkController I am the leader, 
no recovery necessary
   [junit4]   2> 2334674 INFO  (qtp869933141-20728) [n:127.0.0.1:61190_solr 
c:balancedProperties s:shard1 r:core_node3 
x:balancedProperties_shard1_replica_n1] o.a.s.s.HttpSolrCall [admin] 
webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=balancedProperties_shard1_replica_n1&action=CREATE&numShards=2&collection=balancedProperties&shard=shard1&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=1655
   [junit4]   2> 2334719 INFO  (qtp2009569809-20727) [n:127.0.0.1:61191_solr 
c:balancedProperties s:shard2 r:core_node8 
x:balancedProperties_shard2_replica_n6] o.a.s.c.ShardLeaderElectionContext 
Enough replicas found to continue.
   [junit4]   2> 2334719 INFO  (qtp2009569809-20727) [n:127.0.0.1:61191_solr 
c:balancedProperties s:shard2 r:core_node8 
x:balancedProperties_shard2_replica_n6] o.a.s.c.ShardLeaderElectionContext I 
may be the new leader - try and sync
   [junit4]   2> 2334719 INFO  (qtp2009569809-20727) [n:127.0.0.1:61191_solr 
c:balancedProperties s:shard2 r:core_node8 
x:balancedProperties_shard2_replica_n6] o.a.s.c.SyncStrategy Sync replicas to 
http://127.0.0.1:61191/solr/balancedProperties_shard2_replica_n6/
   [junit4]   2> 2334719 INFO  (qtp2009569809-20727) [n:127.0.0.1:61191_solr 
c:balancedProperties s:shard2 r:core_node8 
x:balancedProperties_shard2_replica_n6] o.a.s.u.PeerSync PeerSync: 
core=balancedProperties_shard2_replica_n6 url=http://127.0.0.1:61191/solr START 
replicas=[http://127.0.0.1:61188/solr/balancedProperties_shard2_replica_n4/] 
nUpdates=100
   [junit4]   2> 2334722 INFO  (qtp1728699514-20718) [n:127.0.0.1:61188_solr 
c:balancedProperties s:shard2 r:core_node7 
x:balancedProperties_shard2_replica_n4] o.a.s.c.S.Request 
[balancedProperties_shard2_replica_n4]  webapp=/solr path=/get 
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2334802 INFO  
(zkCallback-3917-thread-2-processing-n:127.0.0.1:61188_solr) 
[n:127.0.0.1:61188_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/balancedProperties/state.json] for collection 
[balancedProperties] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2334802 INFO  
(zkCallback-3915-thread-1-processing-n:127.0.0.1:61190_solr) 
[n:127.0.0.1:61190_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/balancedProperties/state.json] for collection 
[balancedProperties] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2334803 INFO  
(zkCallback-3914-thread-2-processing-n:127.0.0.1:61191_solr) 
[n:127.0.0.1:61191_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/balancedProperties/state.json] for collection 
[balancedProperties] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2334803 INFO  
(zkCallback-3914-thread-1-processing-n:127.0.0.1:61191_solr) 
[n:127.0.0.1:61191_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/balancedProperties/state.json] for collection 
[balancedProperties] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2334803 INFO  
(zkCallback-3916-thread-3-processing-n:127.0.0.1:61189_solr) 
[n:127.0.0.1:61189_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/balancedProperties/state.json] for collection 
[balancedProperties] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2334803 INFO  
(zkCallback-3916-thread-2-processing-n:127.0.0.1:61189_solr) 
[n:127.0.0.1:61189_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/balancedProperties/state.json] for collection 
[balancedProperties] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2334802 INFO  
(zkCallback-3917-thread-1-processing-n:127.0.0.1:61188_solr) 
[n:127.0.0.1:61188_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/balancedProperties/state.json] for collection 
[balancedProperties] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2334802 INFO  
(zkCallback-3915-thread-2-processing-n:127.0.0.1:61190_solr) 
[n:127.0.0.1:61190_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/balancedProperties/state.json] for collection 
[balancedProperties] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2335022 INFO  (qtp2009569809-20727) [n:127.0.0.1:61191_solr 
c:balancedProperties s:shard2 r:core_node8 
x:balancedProperties_shard2_replica_n6] o.a.s.u.PeerSync PeerSync: 
core=balancedProperties_shard2_replica_n6 url=http://127.0.0.1:61191/solr DONE. 
 We have no versions.  sync failed.
   [junit4]   2> 2335022 INFO  (qtp2009569809-20727) [n:127.0.0.1:61191_solr 
c:balancedProperties s:shard2 r:core_node8 
x:balancedProperties_shard2_replica_n6] o.a.s.c.SyncStrategy Leader's attempt 
to sync with shard failed, moving to the next candidate
   [junit4]   2> 2335022 INFO  (qtp2009569809-20727) [n:127.0.0.1:61191_solr 
c:balancedProperties s:shard2 r:core_node8 
x:balancedProperties_shard2_replica_n6] o.a.s.c.ShardLeaderElectionContext We 
failed sync, but we have no versions - we can't sync in that case - we were 
active before, so become leader anyway
   [junit4]   2> 2335022 INFO  (qtp2009569809-20727) [n:127.0.0.1:61191_solr 
c:balancedProperties s:shard2 r:core_node8 
x:balancedProperties_shard2_replica_n6] o.a.s.c.ShardLeaderElectionContext 
Found all replicas participating in election, clear LIR
   [junit4]   2> 2335030 INFO  (qtp2009569809-20727) [n:127.0.0.1:61191_solr 
c:balancedProperties s:shard2 r:core_node8 
x:balancedProperties_shard2_replica_n6] o.a.s.c.ShardLeaderElectionContext I am 
the new leader: 
http://127.0.0.1:61191/solr/balancedProperties_shard2_replica_n6/ shard2
   [junit4]   2> 2335141 INFO  
(zkCallback-3917-thread-1-processing-n:127.0.0.1:61188_solr) 
[n:127.0.0.1:61188_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/balancedProperties/state.json] for collection 
[balancedProperties] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2335142 INFO  
(zkCallback-3917-thread-2-processing-n:127.0.0.1:61188_solr) 
[n:127.0.0.1:61188_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/balancedProperties/state.json] for collection 
[balancedProperties] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2335142 INFO  
(zkCallback-3915-thread-2-processing-n:127.0.0.1:61190_solr) 
[n:127.0.0.1:61190_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/balancedProperties/state.json] for collection 
[balancedProperties] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2335142 INFO  
(zkCallback-3915-thread-1-processing-n:127.0.0.1:61190_solr) 
[n:127.0.0.1:61190_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/balancedProperties/state.json] for collection 
[balancedProperties] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2335142 INFO  
(zkCallback-3914-thread-1-processing-n:127.0.0.1:61191_solr) 
[n:127.0.0.1:61191_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/balancedProperties/state.json] for collection 
[balancedProperties] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2335142 INFO  
(zkCallback-3914-thread-2-processing-n:127.0.0.1:61191_solr) 
[n:127.0.0.1:61191_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/balancedProperties/state.json] for collection 
[balancedProperties] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2335142 INFO  
(zkCallback-3916-thread-2-processing-n:127.0.0.1:61189_solr) 
[n:127.0.0.1:61189_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/balancedProperties/state.json] for collection 
[balancedProperties] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2335142 INFO  
(zkCallback-3916-thread-1-processing-n:127.0.0.1:61189_solr) 
[n:127.0.0.1:61189_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/balancedProperties/state.json] for collection 
[balancedProperties] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2335186 INFO  (qtp2009569809-20727) [n:127.0.0.1:61191_solr 
c:balancedProperties s:shard2 r:core_node8 
x:balancedProperties_shard2_replica_n6] o.a.s.c.ZkController I am the leader, 
no recovery necessary
   [junit4]   2> 2335189 INFO  (qtp2009569809-20727) [n:127.0.0.1:61191_solr 
c:balancedProperties s:shard2 r:core_node8 
x:balancedProperties_shard2_replica_n6] o.a.s.s.HttpSolrCall [admin] 
webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node8&collection.configName=conf&newCollection=true&name=balancedProperties_shard2_replica_n6&action=CREATE&numShards=2&collection=balancedProperties&shard=shard2&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=2170
   [junit4]   2> 2335214 INFO  (qtp1728699514-20714) [n:127.0.0.1:61188_solr 
c:balancedProperties s:shard2 r:core_node7 
x:balancedProperties_shard2_replica_n4] o.a.s.s.HttpSolrCall [admin] 
webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node7&collection.configName=conf&newCollection=true&name=balancedProperties_shard2_replica_n4&action=CREATE&numShards=2&collection=balancedProperties&shard=shard2&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=2208
   [junit4]   2> 2335248 INFO  (qtp1369937093-20725) [n:127.0.0.1:61189_solr 
c:balancedProperties s:shard1 r:core_node5 
x:balancedProperties_shard1_replica_n2] o.a.s.s.HttpSolrCall [admin] 
webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node5&collection.configName=conf&newCollection=true&name=balancedProperties_shard1_replica_n2&action=CREATE&numShards=2&collection=balancedProperties&shard=shard1&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=2225
   [junit4]   2> 2335250 INFO  (qtp2009569809-20723) [n:127.0.0.1:61191_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> 2335357 INFO  
(zkCallback-3917-thread-2-processing-n:127.0.0.1:61188_solr) 
[n:127.0.0.1:61188_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/balancedProperties/state.json] for collection 
[balancedProperties] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2335357 INFO  
(zkCallback-3916-thread-3-processing-n:127.0.0.1:61189_solr) 
[n:127.0.0.1:61189_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/balancedProperties/state.json] for collection 
[balancedProperties] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2335357 INFO  
(zkCallback-3915-thread-1-processing-n:127.0.0.1:61190_solr) 
[n:127.0.0.1:61190_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/balancedProperties/state.json] for collection 
[balancedProperties] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2335357 INFO  
(zkCallback-3915-thread-2-processing-n:127.0.0.1:61190_solr) 
[n:127.0.0.1:61190_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/balancedProperties/state.json] for collection 
[balancedProperties] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2335357 INFO  
(zkCallback-3914-thread-1-processing-n:127.0.0.1:61191_solr) 
[n:127.0.0.1:61191_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/balancedProperties/state.json] for collection 
[balancedProperties] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2335357 INFO  
(zkCallback-3914-thread-2-processing-n:127.0.0.1:61191_solr) 
[n:127.0.0.1:61191_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/balancedProperties/state.json] for collection 
[balancedProperties] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2335357 INFO  
(zkCallback-3916-thread-1-processing-n:127.0.0.1:61189_solr) 
[n:127.0.0.1:61189_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/balancedProperties/state.json] for collection 
[balancedProperties] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2335357 INFO  
(zkCallback-3917-thread-1-processing-n:127.0.0.1:61188_solr) 
[n:127.0.0.1:61188_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/balancedProperties/state.json] for collection 
[balancedProperties] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2336260 INFO  (qtp2009569809-20723) [n:127.0.0.1:61191_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={replicationFactor=2&collection.configName=conf&name=balancedProperties&nrtReplicas=2&action=CREATE&numShards=2&wt=javabin&version=2}
 status=0 QTime=3710
   [junit4]   2> 2336268 INFO  (qtp2009569809-20739) [n:127.0.0.1:61191_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :balanceshardunique 
with params 
property=preferredLeader&action=BALANCESHARDUNIQUE&collection=balancedProperties&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 2336276 INFO  
(OverseerCollectionConfigSetProcessor-99030340260200459-127.0.0.1:61189_solr-n_0000000000)
 [n:127.0.0.1:61189_solr    ] o.a.s.c.OverseerTaskQueue Response ZK path: 
/overseer/collection-queue-work/qnr-0000000008 doesn't exist.  Requestor may 
have 

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

or-8946-thread-10) [n:127.0.0.1:61188_solr c:solrj_test_splitshard s:shard1_0_2 
r:core_node14 x:solrj_test_splitshard_shard1_0_2_replica_n11] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.solrj_test_splitshard.shard1_0_2.replica_n11, tag=1088393158
   [junit4]   2> 2413849 INFO  (coreCloseExecutor-8946-thread-10) 
[n:127.0.0.1:61188_solr c:solrj_test_splitshard s:shard1_0_2 r:core_node14 
x:solrj_test_splitshard_shard1_0_2_replica_n11] o.a.s.m.r.SolrJmxReporter 
Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@6f3cc6d6: 
rootName = solr_61188, domain = 
solr.core.solrj_test_splitshard.shard1_0_2.replica_n11, service url = null, 
agent id = null] for registry 
solr.core.solrj_test_splitshard.shard1_0_2.replica_n11 / 
com.codahale.metrics.MetricRegistry@7b865daf
   [junit4]   2> 2413856 INFO  (coreCloseExecutor-8946-thread-10) 
[n:127.0.0.1:61188_solr c:solrj_test_splitshard s:shard1_0_2 r:core_node14 
x:solrj_test_splitshard_shard1_0_2_replica_n11] o.a.s.m.SolrMetricManager 
Closing metric reporters for 
registry=solr.collection.solrj_test_splitshard.shard1_0_2.leader, tag=1088393158
   [junit4]   2> 2413856 INFO  (coreCloseExecutor-8946-thread-11) 
[n:127.0.0.1:61188_solr c:corestatus_test s:shard2 r:core_node8 
x:corestatus_test_shard2_replica_n6] o.a.s.m.SolrMetricManager Closing metric 
reporters for registry=solr.core.corestatus_test.shard2.replica_n6, 
tag=704290724
   [junit4]   2> 2413856 INFO  (coreCloseExecutor-8946-thread-11) 
[n:127.0.0.1:61188_solr c:corestatus_test s:shard2 r:core_node8 
x:corestatus_test_shard2_replica_n6] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@89a728a: rootName = 
solr_61188, domain = solr.core.corestatus_test.shard2.replica_n6, service url = 
null, agent id = null] for registry solr.core.corestatus_test.shard2.replica_n6 
/ com.codahale.metrics.MetricRegistry@4fe5ba45
   [junit4]   2> 2413862 INFO  (coreCloseExecutor-8946-thread-11) 
[n:127.0.0.1:61188_solr c:corestatus_test s:shard2 r:core_node8 
x:corestatus_test_shard2_replica_n6] o.a.s.m.SolrMetricManager Closing metric 
reporters for registry=solr.collection.corestatus_test.shard2.leader, 
tag=704290724
   [junit4]   2> 2413866 INFO  (jetty-closer-3896-thread-2) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@1edb746e{/solr,null,UNAVAILABLE}
   [junit4]   2> 2413867 ERROR 
(SUITE-CollectionsAPISolrJTest-seed#[FBED39E31DB3D9FB]-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> 2413868 INFO  
(SUITE-CollectionsAPISolrJTest-seed#[FBED39E31DB3D9FB]-worker) [    ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1:61186 61186
   [junit4]   2> 2413917 INFO  (Thread-3578) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:61186 61186
   [junit4]   2> 2414858 WARN  (Thread-3578) [    ] o.a.s.c.ZkTestServer Watch 
limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2>        9       /solr/collections/solrj_test/state.json
   [junit4]   2>        8       /solr/collections/corestatus_test/state.json
   [junit4]   2>        5       /solr/aliases.json
   [junit4]   2>        5       /solr/clusterprops.json
   [junit4]   2>        4       /solr/configs/solrj_default_configset
   [junit4]   2>        4       /solr/collections/solrj_implicit/state.json
   [junit4]   2>        4       
/solr/configs/solrj_default_configset/managed-schema
   [junit4]   2>        4       /solr/security.json
   [junit4]   2>        4       /solr/configs/conf
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2>        61      
/solr/collections/solrj_test_splitshard/state.json
   [junit4]   2>        47      /solr/collections/replicaProperties/state.json
   [junit4]   2>        41      /solr/collections/balancedProperties/state.json
   [junit4]   2>        37      
/solr/collections/solrj_newstateformat/state.json
   [junit4]   2>        36      
/solr/collections/solrj_default_configset/state.json
   [junit4]   2>        26      /solr/collections/solrj_replicatests/state.json
   [junit4]   2>        12      /solr/collections/solrj_implicit/state.json
   [junit4]   2>        6       /solr/collections/aliasedCollection/state.json
   [junit4]   2>        6       
/solr/collections/solrj_test_core_props/state.json
   [junit4]   2>        5       /solr/clusterprops.json
   [junit4]   2>        5       /solr/clusterstate.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2>        5       /solr/live_nodes
   [junit4]   2>        5       /solr/collections
   [junit4]   2> 
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_FBED39E31DB3D9FB-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): {}, 
docValues:{}, maxPointsInLeafNode=1097, maxMBSortInHeap=6.147732588302148, 
sim=RandomSimilarity(queryNorm=false): {}, locale=zh-HK, timezone=Asia/Aden
   [junit4]   2> NOTE: Mac OS X 10.11.6 x86_64/Oracle Corporation 1.8.0_144 
(64-bit)/cpus=3,threads=1,free=170511400,total=469303296
   [junit4]   2> NOTE: All tests run in this JVM: [TestCoreContainer, 
TestSchemaManager, JsonLoaderTest, TestOnReconnectListenerSupport, 
InfoHandlerTest, DistributedFacetPivotSmallTest, ExternalFileFieldSortTest, 
TestRetrieveFieldsOptimizer, WrapperMergePolicyFactoryTest, TestStressReorder, 
CloudExitableDirectoryReaderTest, PropertiesRequestHandlerTest, UtilsToolTest, 
SimplePostToolTest, CollectionStateFormat2Test, AnalysisAfterCoreReloadTest, 
NodeLostTriggerTest, CursorMarkTest, TestDocSet, SolrIndexSplitterTest, 
TestSolrFieldCacheBean, FullHLLTest, DistributedQueueTest, 
DistributedSuggestComponentTest, TestElisionMultitermQuery, 
TestSQLHandlerNonCloud, MoveReplicaHDFSTest, OpenCloseCoreStressTest, 
TestAuthenticationFramework, LukeRequestHandlerTest, AutoScalingHandlerTest, 
PreAnalyzedFieldTest, TestExactSharedStatsCache, 
CollectionsAPIAsyncDistributedZkTest, BasicAuthStandaloneTest, 
TestSchemaResource, QueryElevationComponentTest, SimpleFacetsTest, 
TestNumericTerms32, TestDynamicFieldResource, LegacyCloudClusterPropTest, 
TestCloudManagedSchema, TestCloudInspectUtil, ConjunctionSolrSpellCheckerTest, 
TestCSVLoader, BitVectorTest, TestSolrDeletionPolicy1, TestQueryUtils, 
DOMUtilTest, HttpSolrCallGetCoreTest, TestStreamBody, CopyFieldTest, 
TestSolrCLIRunExample, TermVectorComponentDistributedTest, DocumentBuilderTest, 
TestFieldCacheReopen, TestQueryTypes, TestFastOutputStream, 
TestWordDelimiterFilterFactory, DeleteStatusTest, HdfsDirectoryTest, 
TestCryptoKeys, TestHashPartitioner, CollectionsAPIDistributedZkTest, 
UpdateLogTest, TestRandomFaceting, HdfsChaosMonkeyNothingIsSafeTest, 
SchemaVersionSpecificBehaviorTest, DistributedFacetExistsSmallTest, 
SimpleCollectionCreateDeleteTest, StatelessScriptUpdateProcessorFactoryTest, 
TestLegacyField, TestConfig, TestBackupRepositoryFactory, 
TestRawResponseWriter, TestReload, TestSort, 
IgnoreCommitOptimizeUpdateProcessorFactoryTest, MBeansHandlerTest, 
ZkStateReaderTest, TestShortCircuitedRequests, CdcrBidirectionalTest, 
RulesTest, AnalysisErrorHandlingTest, TestSystemIdResolver, TestPullReplica, 
SynonymTokenizerTest, MoreLikeThisHandlerTest, 
LeaderInitiatedRecoveryOnCommitTest, TestLuceneMatchVersion, 
HdfsBasicDistributedZk2Test, TestManagedResource, ExecutePlanActionTest, 
BasicDistributedZk2Test, TestReplicationHandlerBackup, TestValueSourceCache, 
TestTolerantUpdateProcessorCloud, TestLRUStatsCache, 
TimePartitionedUpdateProcessorTest, FileBasedSpellCheckerTest, 
ZkSolrClientTest, StressHdfsTest, DocumentAnalysisRequestHandlerTest, 
TestReloadDeadlock, TestDistributedMissingSort, SolrMetricManagerTest, 
TestJavabinTupleStreamParser, TestExtendedDismaxParser, 
TestNumericRangeQuery64, VMParamsZkACLAndCredentialsProvidersTest, 
TestStressLucene, HLLUtilTest, TestSkipOverseerOperations, PolyFieldTest, 
UpdateParamsTest, AutoAddReplicasIntegrationTest, SolrCloudExampleTest, 
TestCloudPivotFacet, TestInitParams, TestRandomCollapseQParserPlugin, 
TestHttpShardHandlerFactory, HdfsUnloadDistributedZkTest, SOLR749Test, 
TestLeaderElectionWithEmptyReplica, TestZkChroot, 
TestPayloadScoreQParserPlugin, TestRTGBase, FieldMutatingUpdateProcessorTest, 
MissingSegmentRecoveryTest, TestCloudRecovery, TestSolrCloudWithKerberosAlt, 
ConnectionManagerTest, RestartWhileUpdatingTest, TestTrie, 
SolrCloudReportersTest, TestFastLRUCache, TestGroupingSearch, FileUtilsTest, 
TestIndexSearcher, NumberUtilsTest, TestCustomDocTransformer, 
TestStressCloudBlindAtomicUpdates, SSLMigrationTest, ChaosMonkeySafeLeaderTest, 
TestFunctionQuery, TestDefaultStatsCache, QueryEqualityTest, 
TestSlowCompositeReaderWrapper, AliasIntegrationTest, 
UUIDUpdateProcessorFallbackTest, TestSchemaVersionResource, 
CdcrRequestHandlerTest, PluginInfoTest, TestDocTermOrds, BlockDirectoryTest, 
TestCloudNestedDocsSort, TestCollationFieldDocValues, ReplaceNodeTest, 
TestEmbeddedSolrServerConstructors, TestLegacyNumericUtils, 
TestJettySolrRunner, TestMinMaxOnMultiValuedField, SystemLogListenerTest, 
TestJsonRequest, ShardSplitTest, TestUseDocValuesAsStored, TestInitQParser, 
TestRestoreCore, TestLRUCache, TestHighFrequencyDictionaryFactory, 
SpatialRPTFieldTypeTest, AnalyticsMergeStrategyTest, TestBadConfig, 
TestUniqueKeyFieldResource, FullSolrCloudDistribCmdsTest, 
AutoscalingHistoryHandlerTest, BasicZkTest, TestRebalanceLeaders, 
SimpleMLTQParserTest, DistributedIntervalFacetingTest, LoggingHandlerTest, 
ConfigureRecoveryStrategyTest, DeleteReplicaTest, SystemInfoHandlerTest, 
RecoveryZkTest, ShardRoutingCustomTest, TestDistributedGrouping, TestFaceting, 
TestRecovery, ZkControllerTest, TestJoin, TestStressVersions, TestSolr4Spatial, 
SolrCoreTest, PeerSyncTest, TestFiltering, BasicFunctionalityTest, 
SoftAutoCommitTest, AssignTest, CleanupOldIndexTest, CollectionReloadTest, 
CollectionTooManyReplicasTest, CollectionsAPISolrJTest]
   [junit4] Completed [506/749 (1!)] on J1 in 86.68s, 13 tests, 1 failure <<< 
FAILURES!

[...truncated 48179 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org

Reply via email to